builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1459207116.24 results: success (0) buildid: 20160328141409 builduid: 9e7ac608ff2544dfb9ec80eebdf6b991 revision: 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.244395) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.244822) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.245156) ========= 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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005617 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.271981) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.272391) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.290777) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.291163) ========= 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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005265 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.339687) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.339999) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.340359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.340629) ========= 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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-28 16:18:36-- 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% 48.9M=0s 2016-03-28 16:18:36 (48.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.541123) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.541431) ========= 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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.029731 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:36.589698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-28 16:18:36.590054) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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-28 16:18:36,674 truncating revision to first 12 chars 2016-03-28 16:18:36,674 Setting DEBUG logging. 2016-03-28 16:18:36,674 attempt 1/10 2016-03-28 16:18:36,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e9a6e6cbacd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-28 16:18:38,370 unpacking tar archive at: mozilla-aurora-8e9a6e6cbacd/testing/mozharness/ program finished with exit code 0 elapsedTime=2.097275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-28 16:18:38.707269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:38.707615) ========= echo 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 program finished with exit code 0 elapsedTime=0.005412 script_repo_revision: '8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:38.763595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:38.763919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-28 16:18:38.780695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-28 16:18:38.781041) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:18:38 INFO - MultiFileLogger online at 20160328 16:18:38 in /builds/slave/test 16:18:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:18:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:18:38 INFO - {'append_to_log': False, 16:18:38 INFO - 'base_work_dir': '/builds/slave/test', 16:18:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:18:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:18:38 INFO - 'branch': 'Mozilla-Aurora', 16:18:38 INFO - 'buildbot_json_path': 'buildprops.json', 16:18:38 INFO - 'config_files': ('talos/mac_config.py',), 16:18:38 INFO - 'default_actions': ('clobber', 16:18:38 INFO - 'read-buildbot-config', 16:18:38 INFO - 'download-and-extract', 16:18:38 INFO - 'populate-webroot', 16:18:38 INFO - 'create-virtualenv', 16:18:38 INFO - 'install', 16:18:38 INFO - 'run-tests'), 16:18:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:18:38 INFO - 'download_minidump_stackwalk': True, 16:18:38 INFO - 'download_symbols': 'ondemand', 16:18:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:18:38 INFO - 'tooltool.py': '/tools/tooltool.py', 16:18:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:18:38 INFO - '/tools/misc-python/virtualenv.py')}, 16:18:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:18:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:18:38 INFO - 'installer_path': 'installer.exe', 16:18:38 INFO - 'log_level': 'info', 16:18:38 INFO - 'log_name': 'talos', 16:18:38 INFO - 'log_to_console': True, 16:18:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:18:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:18:38 INFO - 'opt_config_files': (), 16:18:38 INFO - 'pip_index': False, 16:18:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:38 INFO - 'cmd': ('bash', 16:18:38 INFO - '-c', 16:18:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:38 INFO - 'enabled': True, 16:18:38 INFO - 'halt_on_failure': False, 16:18:38 INFO - 'name': 'check_screen_resolution'},), 16:18:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:18:38 INFO - 'cmd': ('bash', 16:18:38 INFO - '-c', 16:18:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:18:38 INFO - 'enabled': True, 16:18:38 INFO - 'halt_on_failure': False, 16:18:38 INFO - 'name': 'check_screen_resolution'},), 16:18:38 INFO - 'run_cmd_checks_enabled': True, 16:18:38 INFO - 'sps_profile': False, 16:18:38 INFO - 'sps_profile_interval': 0, 16:18:38 INFO - 'suite': 'dromaeojs', 16:18:38 INFO - 'system_bits': '32', 16:18:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:18:38 INFO - 'title': 't-yosemite-r7-0066', 16:18:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:18:38 INFO - 'use_talos_json': True, 16:18:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:18:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:18:38 INFO - 'work_dir': 'build'} 16:18:38 INFO - ##### 16:18:38 INFO - ##### Running clobber step. 16:18:38 INFO - ##### 16:18:38 INFO - Running pre-action listener: _resource_record_pre_action 16:18:38 INFO - Running main action method: clobber 16:18:38 INFO - rmtree: /builds/slave/test/build 16:18:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:18:40 INFO - Running post-action listener: _resource_record_post_action 16:18:40 INFO - ##### 16:18:40 INFO - ##### Running read-buildbot-config step. 16:18:40 INFO - ##### 16:18:40 INFO - Running pre-action listener: _resource_record_pre_action 16:18:40 INFO - Running main action method: read_buildbot_config 16:18:40 INFO - Using buildbot properties: 16:18:40 INFO - { 16:18:40 INFO - "project": "", 16:18:40 INFO - "product": "firefox", 16:18:40 INFO - "script_repo_revision": "production", 16:18:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:18:40 INFO - "repository": "", 16:18:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:18:40 INFO - "buildid": "20160328141409", 16:18:40 INFO - "pgo_build": "False", 16:18:40 INFO - "basedir": "/builds/slave/test", 16:18:40 INFO - "buildnumber": 246, 16:18:40 INFO - "slavename": "t-yosemite-r7-0066", 16:18:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:18:40 INFO - "platform": "yosemite_r7", 16:18:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:18:40 INFO - "branch": "mozilla-aurora", 16:18:40 INFO - "repo_path": "releases/mozilla-aurora", 16:18:40 INFO - "revision": "8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244", 16:18:40 INFO - "stage_platform": "macosx64", 16:18:40 INFO - "builduid": "9e7ac608ff2544dfb9ec80eebdf6b991", 16:18:40 INFO - "slavebuilddir": "test" 16:18:40 INFO - } 16:18:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 16:18:40 INFO - Running post-action listener: _resource_record_post_action 16:18:40 INFO - ##### 16:18:40 INFO - ##### Running download-and-extract step. 16:18:40 INFO - ##### 16:18:40 INFO - Running pre-action listener: _resource_record_pre_action 16:18:40 INFO - Running main action method: download_and_extract 16:18:40 INFO - mkdir: /builds/slave/test/build/tests 16:18: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')]} 16:18:40 INFO - https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 16:18:42 INFO - Downloaded 1277 bytes. 16:18:42 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:18:42 INFO - Using the following test package requirements: 16:18:42 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:18:42 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 16:18:42 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 16:18:42 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'jsshell-mac.zip'], 16:18:42 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 16:18:42 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:18:42 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 16:18:42 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 16:18:42 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 16:18:42 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:18:42 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:18:42 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 16:18:42 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:18:42 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')]} 16:18:42 INFO - https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:18:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:18:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:18:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:18:43 INFO - Downloaded 17869653 bytes. 16:18:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:18:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:18:46 INFO - Return code: 0 16:18:46 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:46 INFO - https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:18:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:18:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:18:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:18:47 INFO - Downloaded 17869653 bytes. 16:18:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:18:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:18:50 INFO - Return code: 0 16:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:50 INFO - https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:18:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:18:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:18:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:18:51 INFO - Downloaded 10845161 bytes. 16:18:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:18:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:18:52 INFO - Return code: 0 16:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:18:52 INFO - https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:18:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:18:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:18:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 16:18:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 16:18:56 INFO - Downloaded 114983725 bytes. 16:18:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:18:56 INFO - mkdir: /builds/slave/test/properties 16:18:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:56 INFO - Contents: 16:18:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:18:57 INFO - Running post-action listener: _resource_record_post_action 16:18:57 INFO - Running post-action listener: set_extra_try_arguments 16:18:57 INFO - ##### 16:18:57 INFO - ##### Running populate-webroot step. 16:18:57 INFO - ##### 16:18:57 INFO - Running pre-action listener: _resource_record_pre_action 16:18:57 INFO - Running main action method: populate_webroot 16:18:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:57 INFO - '--tppagecycles', 16:18:57 INFO - '7'], 16:18:57 INFO - 'tests': ['tsvgm']}}, 16:18:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:18:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:18:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'tests': ['damp', 'tps']}, 16:18:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['damp', 'tps']}, 16:18:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:18:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:57 INFO - 'other': {'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other_l64': {'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'other_nol64': {'tests': ['a11yr', 16:18:57 INFO - 'ts_paint', 16:18:57 INFO - 'tpaint', 16:18:57 INFO - 'sessionrestore', 16:18:57 INFO - 'sessionrestore_no_auto_restore', 16:18:57 INFO - 'tabpaint']}, 16:18:57 INFO - 'svgr': {'tests': ['tsvgx', 16:18:57 INFO - 'tsvgr_opacity', 16:18:57 INFO - 'tart', 16:18:57 INFO - 'tscrollx', 16:18:57 INFO - 'cart']}, 16:18:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['tsvgx', 16:18:57 INFO - 'tsvgr_opacity', 16:18:57 INFO - 'tart', 16:18:57 INFO - 'tscrollx', 16:18:57 INFO - 'cart']}, 16:18:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'tests': ['tp5o']}, 16:18:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--e10s'], 16:18:57 INFO - 'tests': ['tp5o']}, 16:18:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--xperf_path', 16:18:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:57 INFO - 'tests': ['tp5n']}, 16:18:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:57 INFO - 'talos_options': ['--e10s', 16:18:57 INFO - '--xperf_path', 16:18:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:57 INFO - 'tests': ['tp5n']}}, 16:18:57 INFO - 'talos.zip': {'path': '', 16:18:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:57 INFO - Running post-action listener: _resource_record_post_action 16:18:57 INFO - ##### 16:18:57 INFO - ##### Running create-virtualenv step. 16:18:57 INFO - ##### 16:18:57 INFO - Running pre-action listener: _resource_record_pre_action 16:18:57 INFO - Running main action method: create_virtualenv 16:18:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:57 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 16:18:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:57 INFO - Using real prefix '/tools/python27' 16:18:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:01 INFO - Installing pip.................done. 16:19:01 INFO - Return code: 0 16:19:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:01 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 16:19:01 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 16:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:01 INFO - 'HOME': '/Users/cltbld', 16:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:01 INFO - 'LOGNAME': 'cltbld', 16:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:01 INFO - 'MOZ_NO_REMOTE': '1', 16:19:01 INFO - 'NO_EM_RESTART': '1', 16:19:01 INFO - 'PAGER': '/bin/cat', 16:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:01 INFO - 'PWD': '/builds/slave/test', 16:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:01 INFO - 'SHELL': '/bin/bash', 16:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:01 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:01 INFO - 'USER': 'cltbld', 16:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:01 INFO - 'XPC_FLAGS': '0x0', 16:19:01 INFO - 'XPC_SERVICE_NAME': '0', 16:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:01 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 16:19:01 INFO - Cleaning up... 16:19:01 INFO - Return code: 0 16:19:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:01 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:01 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 16:19:01 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 16:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:01 INFO - 'HOME': '/Users/cltbld', 16:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:01 INFO - 'LOGNAME': 'cltbld', 16:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:01 INFO - 'MOZ_NO_REMOTE': '1', 16:19:01 INFO - 'NO_EM_RESTART': '1', 16:19:01 INFO - 'PAGER': '/bin/cat', 16:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:01 INFO - 'PWD': '/builds/slave/test', 16:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:01 INFO - 'SHELL': '/bin/bash', 16:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:01 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:01 INFO - 'USER': 'cltbld', 16:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:01 INFO - 'XPC_FLAGS': '0x0', 16:19:01 INFO - 'XPC_SERVICE_NAME': '0', 16:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:01 INFO - Downloading/unpacking psutil>=0.7.1 16:19:01 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 16:19:01 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 16:19:01 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 16:19:01 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 16:19:01 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 16:19:01 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 16:19:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:05 INFO - Installing collected packages: psutil 16:19:05 INFO - Running setup.py install for psutil 16:19:05 INFO - building 'psutil._psutil_osx' extension 16:19:05 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 16:19:05 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 16:19:05 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 16:19:05 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 16:19:05 INFO - building 'psutil._psutil_posix' extension 16:19:05 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 16:19:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:19:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:19:06 INFO - ^ 16:19:06 INFO - 1 warning generated. 16:19:06 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 16:19:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:06 INFO - Successfully installed psutil 16:19:06 INFO - Cleaning up... 16:19:06 INFO - Return code: 0 16:19:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:19:06 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')]} 16:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:06 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')]} 16:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:06 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:06 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 16:19:06 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 16:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:06 INFO - 'HOME': '/Users/cltbld', 16:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:06 INFO - 'LOGNAME': 'cltbld', 16:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:06 INFO - 'MOZ_NO_REMOTE': '1', 16:19:06 INFO - 'NO_EM_RESTART': '1', 16:19:06 INFO - 'PAGER': '/bin/cat', 16:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:06 INFO - 'PWD': '/builds/slave/test', 16:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:06 INFO - 'SHELL': '/bin/bash', 16:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:06 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:06 INFO - 'USER': 'cltbld', 16:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:06 INFO - 'XPC_FLAGS': '0x0', 16:19:06 INFO - 'XPC_SERVICE_NAME': '0', 16:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:19:09 INFO - Installing collected packages: mozsystemmonitor 16:19:09 INFO - Running setup.py install for mozsystemmonitor 16:19:09 INFO - Successfully installed mozsystemmonitor 16:19:09 INFO - Cleaning up... 16:19:09 INFO - Return code: 0 16:19:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:19:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:09 INFO - 'HOME': '/Users/cltbld', 16:19:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:09 INFO - 'LOGNAME': 'cltbld', 16:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:09 INFO - 'MOZ_NO_REMOTE': '1', 16:19:09 INFO - 'NO_EM_RESTART': '1', 16:19:09 INFO - 'PAGER': '/bin/cat', 16:19:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:09 INFO - 'PWD': '/builds/slave/test', 16:19:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:09 INFO - 'SHELL': '/bin/bash', 16:19:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:09 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:09 INFO - 'USER': 'cltbld', 16:19:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:09 INFO - 'XPC_FLAGS': '0x0', 16:19:09 INFO - 'XPC_SERVICE_NAME': '0', 16:19:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:19:09 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 16:19:09 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 16:19:09 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 16:19:09 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 16:19:09 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 16:19:09 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 16:19:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:19:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:19:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 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 16:19:12 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 16:19:13 INFO - Downloading docopt-0.6.1.tar.gz 16:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:19:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:19:13 INFO - Running setup.py install for blobuploader 16:19:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:19:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:19:13 INFO - Running setup.py install for requests 16:19:13 INFO - Running setup.py install for docopt 16:19:14 INFO - Successfully installed blobuploader requests docopt 16:19:14 INFO - Cleaning up... 16:19:14 INFO - Return code: 0 16:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:14 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:14 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 16:19:14 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 16:19:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:14 INFO - 'HOME': '/Users/cltbld', 16:19:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:14 INFO - 'LOGNAME': 'cltbld', 16:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:14 INFO - 'MOZ_NO_REMOTE': '1', 16:19:14 INFO - 'NO_EM_RESTART': '1', 16:19:14 INFO - 'PAGER': '/bin/cat', 16:19:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:14 INFO - 'PWD': '/builds/slave/test', 16:19:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:14 INFO - 'SHELL': '/bin/bash', 16:19:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:14 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:14 INFO - 'USER': 'cltbld', 16:19:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:14 INFO - 'XPC_FLAGS': '0x0', 16:19:14 INFO - 'XPC_SERVICE_NAME': '0', 16:19:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-TjGC9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jL0Lff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-C1CJfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-8DntxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:14 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-oBgFVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:14 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-UP9ioI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-_LdKvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-DwuOSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-g843WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-AJzrIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-gjFxs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-7Y74qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BFeDTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ZVrOZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:15 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-_89m5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:16 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-4CPd_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:16 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-VB07sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:19:16 INFO - Running setup.py install for manifestparser 16:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:19:16 INFO - Running setup.py install for mozcrash 16:19:16 INFO - Running setup.py install for mozdebug 16:19:16 INFO - Running setup.py install for mozdevice 16:19:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:19:16 INFO - Running setup.py install for mozfile 16:19:16 INFO - Running setup.py install for mozhttpd 16:19:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Running setup.py install for mozinfo 16:19:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Running setup.py install for mozInstall 16:19:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Running setup.py install for mozleak 16:19:17 INFO - Running setup.py install for mozlog 16:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Running setup.py install for moznetwork 16:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:19:17 INFO - Running setup.py install for mozprocess 16:19:18 INFO - Running setup.py install for mozprofile 16:19:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:19:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:19:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:19:18 INFO - Running setup.py install for mozrunner 16:19:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:19:18 INFO - Running setup.py install for mozscreenshot 16:19:18 INFO - Running setup.py install for moztest 16:19:18 INFO - Running setup.py install for mozversion 16:19:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:19:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:19:18 INFO - Cleaning up... 16:19:18 INFO - Return code: 0 16:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:18 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')]} 16:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:18 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')]} 16:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:18 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:18 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 16:19:18 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 16:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:18 INFO - 'HOME': '/Users/cltbld', 16:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:18 INFO - 'LOGNAME': 'cltbld', 16:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:18 INFO - 'MOZ_NO_REMOTE': '1', 16:19:18 INFO - 'NO_EM_RESTART': '1', 16:19:18 INFO - 'PAGER': '/bin/cat', 16:19:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:18 INFO - 'PWD': '/builds/slave/test', 16:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:18 INFO - 'SHELL': '/bin/bash', 16:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:18 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:18 INFO - 'USER': 'cltbld', 16:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:18 INFO - 'XPC_FLAGS': '0x0', 16:19:18 INFO - 'XPC_SERVICE_NAME': '0', 16:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-4LEOjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ckF66x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Zfr7e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-S6nWNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-x5ieyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-uu4b_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-SL7IwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-kCbV9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-bP6W0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:19:19 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)) 16:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:19:19 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-pahPkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-KXPxoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-DKUaL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-tmwXqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-FL0p0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-MqPkvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-qKHACD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:19:20 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)) 16:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:19:20 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-5OLlna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:19:20 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)) 16:19:20 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)) 16:19:20 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)) 16:19:20 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)) 16:19:20 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)) 16:19:20 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)) 16:19:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:23 INFO - Downloading blessings-1.6.tar.gz 16:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:19:23 INFO - Installing collected packages: blessings 16:19:23 INFO - Running setup.py install for blessings 16:19:23 INFO - Successfully installed blessings 16:19:23 INFO - Cleaning up... 16:19:23 INFO - Return code: 0 16:19:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:23 INFO - Reading from file tmpfile_stdout 16:19:23 INFO - Current package versions: 16:19:23 INFO - blessings == 1.6 16:19:23 INFO - blobuploader == 1.2.4 16:19:23 INFO - docopt == 0.6.1 16:19:23 INFO - manifestparser == 1.1 16:19:23 INFO - mozInstall == 1.12 16:19:23 INFO - mozcrash == 0.17 16:19:23 INFO - mozdebug == 0.1 16:19:23 INFO - mozdevice == 0.48 16:19:23 INFO - mozfile == 1.2 16:19:23 INFO - mozhttpd == 0.7 16:19:23 INFO - mozinfo == 0.9 16:19:23 INFO - mozleak == 0.1 16:19:23 INFO - mozlog == 3.1 16:19:23 INFO - moznetwork == 0.27 16:19:23 INFO - mozprocess == 0.22 16:19:23 INFO - mozprofile == 0.28 16:19:23 INFO - mozrunner == 6.11 16:19:23 INFO - mozscreenshot == 0.1 16:19:23 INFO - mozsystemmonitor == 0.0 16:19:23 INFO - moztest == 0.7 16:19:23 INFO - mozversion == 1.4 16:19:23 INFO - psutil == 3.1.1 16:19:23 INFO - requests == 1.2.3 16:19:23 INFO - wsgiref == 0.1.2 16:19:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:23 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:23 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 16:19:23 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 16:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:23 INFO - 'HOME': '/Users/cltbld', 16:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:23 INFO - 'LOGNAME': 'cltbld', 16:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:23 INFO - 'MOZ_NO_REMOTE': '1', 16:19:23 INFO - 'NO_EM_RESTART': '1', 16:19:23 INFO - 'PAGER': '/bin/cat', 16:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:23 INFO - 'PWD': '/builds/slave/test', 16:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:23 INFO - 'SHELL': '/bin/bash', 16:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:23 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:23 INFO - 'USER': 'cltbld', 16:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:23 INFO - 'XPC_FLAGS': '0x0', 16:19:23 INFO - 'XPC_SERVICE_NAME': '0', 16:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 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)) 16:19:24 INFO - Cleaning up... 16:19:24 INFO - Return code: 0 16:19:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:19:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:24 INFO - 'HOME': '/Users/cltbld', 16:19:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:24 INFO - 'LOGNAME': 'cltbld', 16:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:24 INFO - 'MOZ_NO_REMOTE': '1', 16:19:24 INFO - 'NO_EM_RESTART': '1', 16:19:24 INFO - 'PAGER': '/bin/cat', 16:19:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:24 INFO - 'PWD': '/builds/slave/test', 16:19:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:24 INFO - 'SHELL': '/bin/bash', 16:19:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:24 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:24 INFO - 'USER': 'cltbld', 16:19:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:24 INFO - 'XPC_FLAGS': '0x0', 16:19:24 INFO - 'XPC_SERVICE_NAME': '0', 16:19:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:24 INFO - Downloading/unpacking jsonschema 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19: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 16:19:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:19:26 INFO - Downloading/unpacking functools32 (from jsonschema) 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:26 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 16:19:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:19:27 INFO - warning: no files found matching '*.txt' 16:19:27 INFO - no previously-included directories found matching 'build' 16:19:27 INFO - no previously-included directories found matching 'dist' 16:19:27 INFO - no previously-included directories found matching '.git*' 16:19:27 INFO - Installing collected packages: jsonschema, functools32 16:19:27 INFO - Running setup.py install for functools32 16:19:27 INFO - warning: no files found matching '*.txt' 16:19:27 INFO - no previously-included directories found matching 'build' 16:19:27 INFO - no previously-included directories found matching 'dist' 16:19:27 INFO - no previously-included directories found matching '.git*' 16:19:27 INFO - Successfully installed jsonschema functools32 16:19:27 INFO - Cleaning up... 16:19:27 INFO - Return code: 0 16:19:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:19:27 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 0x10252ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1025354c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6cbd52050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, '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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 16:19:27 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 16:19:27 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 16:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:27 INFO - 'HOME': '/Users/cltbld', 16:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:27 INFO - 'LOGNAME': 'cltbld', 16:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:27 INFO - 'MOZ_NO_REMOTE': '1', 16:19:27 INFO - 'NO_EM_RESTART': '1', 16:19:27 INFO - 'PAGER': '/bin/cat', 16:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:27 INFO - 'PWD': '/builds/slave/test', 16:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:27 INFO - 'SHELL': '/bin/bash', 16:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:19:27 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:27 INFO - 'USER': 'cltbld', 16:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:27 INFO - 'XPC_FLAGS': '0x0', 16:19:27 INFO - 'XPC_SERVICE_NAME': '0', 16:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:27 INFO - Downloading/unpacking flake8 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:19:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:19:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:30 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 16:19:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:31 INFO - no previously-included directories found matching 'docs/_build' 16:19:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:19:31 INFO - Running setup.py install for pep8 16:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:19:31 INFO - no previously-included directories found matching 'docs/_build' 16:19:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:19:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:19:31 INFO - Cleaning up... 16:19:32 INFO - Return code: 0 16:19:32 INFO - Running post-action listener: _resource_record_post_action 16:19:32 INFO - Running post-action listener: _start_resource_monitoring 16:19:32 INFO - Starting resource monitoring. 16:19:32 INFO - ##### 16:19:32 INFO - ##### Running install step. 16:19:32 INFO - ##### 16:19:32 INFO - Running pre-action listener: _resource_record_pre_action 16:19:32 INFO - Running main action method: install 16:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:19:32 INFO - Reading from file tmpfile_stdout 16:19:32 INFO - Detecting whether we're running mozinstall >=1.0... 16:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:19:32 INFO - Reading from file tmpfile_stdout 16:19:32 INFO - Output received: 16:19:32 INFO - Usage: mozinstall [options] installer 16:19:32 INFO - Options: 16:19:32 INFO - -h, --help show this help message and exit 16:19:32 INFO - -d DEST, --destination=DEST 16:19:32 INFO - Directory to install application into. [default: 16:19:32 INFO - "/builds/slave/test"] 16:19:32 INFO - --app=APP Application being installed. [default: firefox] 16:19:32 INFO - mkdir: /builds/slave/test/build/application 16:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:20:04 INFO - Reading from file tmpfile_stdout 16:20:04 INFO - Output received: 16:20:04 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:20:04 INFO - Running post-action listener: _resource_record_post_action 16:20:04 INFO - ##### 16:20:04 INFO - ##### Running run-tests step. 16:20:04 INFO - ##### 16:20:04 INFO - Running pre-action listener: _resource_record_pre_action 16:20:04 INFO - Running main action method: run_tests 16:20:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:20:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:20:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:20:04 INFO - 2016-03-28 16:20:04.324 screenresolution[1642:7485] starting screenresolution argv=screenresolution get 16:20:04 INFO - 2016-03-28 16:20:04.327 screenresolution[1642:7485] Display 0: 1600x1200x32@60 16:20:04 INFO - 2016-03-28 16:20:04.333 screenresolution[1643:7487] starting screenresolution argv=screenresolution list 16:20:04 INFO - Available Modes on Display 0 16:20:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:20:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:20:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:20:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:20:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:20:04 INFO - Intel Iris: 16:20:04 INFO - Chipset Model: Intel Iris 16:20:04 INFO - Type: GPU 16:20:04 INFO - Bus: Built-In 16:20:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:20:04 INFO - Vendor: Intel (0x8086) 16:20:04 INFO - Device ID: 0x0a2e 16:20:04 INFO - Revision ID: 0x0009 16:20:04 INFO - Displays: 16:20:04 INFO - Display: 16:20:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:20:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:20:04 INFO - Display Serial Number: 1600x1200 60 16:20:04 INFO - Main Display: Yes 16:20:04 INFO - Mirror: Off 16:20:04 INFO - Online: Yes 16:20:04 INFO - Rotation: Supported 16:20:04 INFO - Return code: 0 16:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:04 INFO - Python 2.7.3 16:20:04 INFO - Return code: 0 16:20:04 INFO - grabbing minidump binary from tooltool 16:20: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')]} 16:20:04 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 0x1023d2d30>, '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 0x102236db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023c9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:04 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 16:20:04 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 16:20:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:04 INFO - Return code: 0 16:20:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:20:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:20:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:20:05 INFO - Return code: 0 16:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 16:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 16:20:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TUZGEBi2XY/Render', 16:20:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:05 INFO - 'HOME': '/Users/cltbld', 16:20:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:05 INFO - 'LOGNAME': 'cltbld', 16:20:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:05 INFO - 'MOZ_NO_REMOTE': '1', 16:20:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:05 INFO - 'NO_EM_RESTART': '1', 16:20:05 INFO - 'PAGER': '/bin/cat', 16:20:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:05 INFO - 'PWD': '/builds/slave/test', 16:20:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:05 INFO - 'SHELL': '/bin/bash', 16:20:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6GRPp5jtJm/Listeners', 16:20:05 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 16:20:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:05 INFO - 'USER': 'cltbld', 16:20:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:05 INFO - 'XPC_FLAGS': '0x0', 16:20:05 INFO - 'XPC_SERVICE_NAME': '0', 16:20:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:20:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 16:20:06 INFO - mozversion application_buildid: 20160328141409 16:20:06 INFO - mozversion application_changeset: 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 16:20:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:20:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:06 INFO - mozversion application_name: Firefox 16:20:06 INFO - mozversion application_remotingname: firefox-dev 16:20:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:20:06 INFO - mozversion application_vendor: Mozilla 16:20:06 INFO - mozversion application_version: 47.0a2 16:20:06 INFO - mozversion platform_buildid: 20160328141409 16:20:06 INFO - mozversion platform_changeset: 8e9a6e6cbacd7f8c2be068acb0b59a8b175eb244 16:20:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:20:06 INFO - mozversion platform_version: 47.0a2 16:20:06 INFO - using testdate: 1459207206 16:20:06 INFO - actual date: 1459207206 16:20:06 INFO - starting webserver on 'localhost:49276' 16:20:06 INFO - SUITE-START | Running 2 tests 16:20:06 INFO - TEST-START | dromaeo_css 16:20:06 INFO - operating with platform_type : mac_ 16:20:06 INFO - Initialising browser for dromaeo_css test... 16:20:06 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmp1WqfMB/profile http://localhost:49276/getInfo.html) 16:20:08 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 16:20:08 INFO - PROCESS | 1661 | colorDepth:24 16:20:08 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 16:20:08 INFO - PROCESS | 1661 | __metrics 16:20:08 INFO - PROCESS | 1661 | 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" 16:20:08 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:20:08 INFO - TEST-INFO | 1661: exit 0 16:20:08 INFO - Browser initialized. 16:20:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:08 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmp1WqfMB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:20 INFO - PROCESS | 1663 | RSS: Main: 210673664 16:20:20 INFO - PROCESS | 1663 | 16:21:11 INFO - PROCESS | 1663 | 1459207271957 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] 16:23:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 16:23:23 INFO - PROCESS | 1663 | RSS: Main: 332673024 16:23:23 INFO - PROCESS | 1663 | 16:26:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 16:26:26 INFO - PROCESS | 1663 | RSS: Main: 343601152 16:26:26 INFO - PROCESS | 1663 | 16:29:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 16:29:28 INFO - PROCESS | 1663 | RSS: Main: 352444416 16:29:28 INFO - PROCESS | 1663 | 16:32:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 16:32:31 INFO - PROCESS | 1663 | RSS: Main: 304529408 16:32:31 INFO - PROCESS | 1663 | 16:35:34 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 16:35:34 INFO - PROCESS | 1663 | RSS: Main: 307548160 16:35:34 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 16:38:37 INFO - PROCESS | 1663 | RSS: Main: 356081664 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | __start_tp_report 16:38:37 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:38:37 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:38:37 INFO - PROCESS | 1663 | |i|pagename|runs| 16:38:37 INFO - PROCESS | 1663 | |0;dojo.html;3464.3590935676903;3537.363274610569;3550.236699109691;3578.713702903768;3612.6026137124913;5772.249607551023;5805.535557155428;5821;5821.53427725782;5868.50117739992;5794.68129252892;5847;5852.590318677694;5853.619514731539;5855.0046492096335;5152.845414637567;5193.610479214055;5206.088934436459;5219.112750832349;5266;5271.4464981177;5278;5279.762410691528;5282.049231138393;5287.894242115155;5204.167333226685;5264.684118952856;5285.445028272034;5301.151815709487;5302.973485132569;4714.38712967312;5298.23175639532;5331.360236771593;5341.786328546854;5382.085045542267;5136.666116702402;5182.844514664566;5201.479852014806;5217.973910130425;5227.163653815409;5684.658920464744;5700.201971723962;5706.885862282773;5736.713164341808;5741.88516229673;5171.793128274864;6182.319944806068;6243.687815609202;6255.468285195764;6313.084602732578;6225.564210505267;6248.562600617958;6296.622202667854;6297.307296197415;6302.275238347557;5905.995980683251;5909.497692696169;5925.822225333247;5937.495312898365;5954.4938680212235;6219.875602487925;6349.777757778455;6371.362863713592;6398.2641996170105;6460.741570337228;6246.500279977591;6289.591176573508;6291.02489114188;6295.307516173218;6300.1494798202575;6244.1570387997035;6270.905936410957;6277.089821975788;6279.843003924847;6294.150289710922;5220.321358223407;6111.13596929516;6199.907001394983;6277.591956522811;6290.308066112724;6229.501639868799;6248.781292654826;6272;6273.247210334698;6282.277538083087;4958.330625365602;4984.177610694195;4990.72551009698;4991.351124353883;5009.273655320031;4406.537313582092;4438.667099967515;4487.887802804956;4525;4554.20301447252;5868.471837534557;5878.118282257696;5879.559033072536;5901.911471327933;5915.40845915405;5199.324087868553;6226.719797609027;6253.624782513064;6266.404691554295;6268.937310626927;5593.216949627055;5722;5857.297124345106;5880.117982302603;5880.8235752927485;5415.783368665209;5431.8098866539485;5437.891242175135;5447.972760136174;5449.972750136303;6381.744730210925;6471.7734879279;6511.8697626047215;6545.2800191979795;6553.672316384257;6202.627842329474;6228.719707613259;6265.216847894013;6269.74921003173;6272;6513.316101809241;6549.8690026200165;6549.967250163719;6553.344665533408;6568.9014664781025;6108.402780883668;6210.068489726577;6284.24589049317;6295.433410993032;6306.243250809932;6203.4416902479;6236.158118653923;6259.718312675849;6269.4984401246875;6283.748650053946;6211.596246243979;6228.937710623017;6239.875202495834;6241.251049874044;6245.594036387621;5905.4685078343155;6081.5742897996715;6119.350229749377;6223.813285601439;6243.43809057187;5105.744712764421;5865.589408741518;6145.170401995673;6145.555794388226;6167.660778657217;6190.350013248724;6201.81394558164;6205.03821907605;6209.782657606962;6216.2540495140875;5972.044472884491;6034.21555197839;6081.817545473643;6104.236970378703;6107.969460152671 16:38:37 INFO - PROCESS | 1663 | |1;ext.html;440.0319297545399;551.3356405531335;606.5056978562471;628.9465395441388;643.8776632439836;29831.105066848002;41645.79177104114;41913.95215119624;41986.16027679444;42309.7884510577;44567.554324456745;45210.773946130306;45214.09571808562;45305;45325.773371133095;9683.515824208778;9936.900630993707;9940.751481212956;9946.204303655726;9952.701418957442;9616.759581010461;9743.951280243624;9754.609815607368;9756.707298781048;9772.169365603932;8541.572921353938;9722.319437639368;9935.254855885802;9945.602175912954;9952.303338766289;9846.310758246926;9895.554700038516;9903.851442228372;9907.108360247541;9922.107010369065;9844.01559844017;10020.59917603295;10023.097921187054;10032.548535315927;10034.448105354202;43640.781796090814;44047.33928991068;44096.33855492138;44133.33799993002;44147;3244.9837750811093;3274.3942370661266;3325.8503367348526;3395.1172695099203;3753.962460375416;29930.802767889258;29972.8501357494;30098.849505752332;30727.2318192047;30915.690843091506;2792.3577577157166;2810.1007677543193;2822.449622323648;2844.9715502844915;2882.20739296693;499702;500553.99999999633;500765.98468030436;502356;503304;70211.29788702048;70604.29395705977;70866.64566677134;71077;71122;74780;79634.60182699165;80614.79077813837;80851;80911;18326.63346733058;18509.259629614935;18512.537186570175;18518.722219166724;18562.44312670622;13756.793648095287;13782.862171378158;13784.379702913393;13843.723125537434;13850.792238116437;19962.600747984958;21906.6855988638;23105.53788924212;23333.533329333317;23343.88328058349;9672.903270967341;9895.505224738734;9975.800483990279;9978.151857092083;10007.849882251772;964.1756298364937;1006.5571148694551;1016.7458135466134;1113.752597091263;1124.4490199802037;25935.351616209744;30999.380012399626;31087;31177;31890.535325054512;1130.8134157864024;1167.8832116788253;1172.783035138502;1185.466540056978;1209.5343292832322;13740.5572414897;15414.537563873102;15708.528744137695;16016.599585010468;16149.596260093356;568968;568974;572411;577873;579557;56162.15756763652;56740.58148546237;62984;63336.68331658404;63435.68282158652;1299.7660421124099;1344.515974249289;1533.854283843033;1557.509384543865;1564.2022568490152;30082.3983520324;30858.382832342777;30874;30955;31347.84326078355;51433.48566514437;51974;52063;52065.21902171395;52117.47882521126;362890.1855490706;373832.13083935494;373933;374273;374659;29796.85101574478;34723.30553388969;35016.64983350134;35451.29097418089;35493.46759798553;44232;45192.644220673435;45376;45858.54141458676;46658.533414666774;36489.905302840954;37190;37596;37784;38392;37171.7594739174;38318.80840595779;38495.615043849204;38999.41500877546;39106.02234944149;37781.86654400372;38384.808075959445;38514.229715406094;39503.60496395114;39505.407418888164;32883.34233315368;34198.65801342054;34263.972080837615;34332.656673432946;34345.96962091141;26947.191584252505;27199.728002720512;27201.72798271992;27207.59188612133;27221 16:38:37 INFO - PROCESS | 1663 | |2;jquery.html;373.712241573988;380.9409541521064;391.19268977324765;396.2906397548389;398.6432143231809;20180.39458816234;21386.46533836655;21508.56982860342;21994;21997.010134543943;20865.895670521626;21039.47401314968;21195.258165964195;21206.363809085753;21725.782742172574;5974.5220382369525;6026.0960855871535;6129.111278864562;6199;6229.314775374705;6116.938830611703;6160.6611636359985;6171.938280617203;6173.753049878022;6180.165677633507;6026.668533230692;6045.758169673208;6139;6153.7846175383875;6160.845978850542;5985.5810093293485;6058.273007239138;6143.4470897618985;6178.443940045418;6183.9381606183815;5269.209618557209;5323.520883120537;5331.253624492574;5349.7592608332325;5363.839084827461;26671.73328266712;26683.799229034546;27128.59307110395;27306.86346568274;27375;2053.260826102602;2176.434127126958;2311.8959646815933;2878.675809127783;2965.7034296570387;10256.948715256376;10338.638147664871;10396.740081498023;11236;15634.9218253908;1790.95229290865;1817.391173956726;1823.7264410338423;1834.385480863912;1854.9907250463662;84274.05678258628;89737.55131224367;90776;91230;92069.01551399137;11751.706207344714;11921.34432606215;11949.88050119505;11953.864382883612;11971.880281197251;14666.486672966395;14688.632784180267;14708.264586770618;14715.852841471662;14736.263186840615;9009.054049324726;9033.864492032624;9040.954795225982;9094.226990705863;9131.908680913106;7908.367330613537;8769.21077103051;9196.264298856075;9258.490783006999;9286.024967378464;4071.8395257351513;4426.468823741172;4547.113312904018;4656.185167595657;4701.318308845267;1896.544829241;1932.3236867096405;1935.9709604355946;1937.6609093408597;1979.9505012374807;921.3136213520836;971.3734641156415;991.8643153589101;1017.97455063624;1050.3172937590627;16843;19399.4180174595;20203.989800509917;20650.690239646417;20739.481512961996;1005.6775340427315;1016.7661437869332;1024.6874703215442;1075.6504136155781;1077.2620754783;9680.27397945157;11075.72310692239;11203.43982800873;11251.94374028141;11330.206885518099;660886;676128;680892;688863;702358;61584;84803.5759821197;102150;118581;122527;841.705403108907;1005.4721271332463;1023.3910823060268;1033.3231733214757;1037.6160820496314;17819.732704009708;18069.909650451664;18097.909510452362;18205.726914096034;18618.16218270154;50709;51385.74307128441;53432.198517023055;53538.46461535335;53683.44129212487;72778;73283;75965.62017189879;77400.6129969369;77934;8160.183981601793;8282.71010514629;8381.455205411628;8424.915750842412;8544.718292256211;8570.4000719949;11357.772844542898;13230.669233269246;13576;13643.86356136426;11397.461342718627;11496.137789665641;11505.252158609663;11698.005669518187;11818.645440636794;11041.116710662967;11219.775604488028;11473.36896470702;11653.883461165618;11745.647630570755;11603.6518904433;11759;11853.76292474163;11876.703082423008;12020.879791201976;8122.7157049502985;8227.382946278933;8324.417290789586;8337.166283371615;8436.704715334934;9680.661176858775;10630.52162652698;11647.242929209575;11862.822057669315;11887.465064071965 16:38:37 INFO - PROCESS | 1663 | |3;mootools.html;1427.3291552970113;1620.2303905644817;1653.37998250656;1978.8812671239718;2068.5656012237437;8132.837343253139;8713.259372953298;8867.246284065863;8872.778180545489;8880.91119088809;8528.91471085289;8769.56152192391;8786.86819697705;8797.1202879712;8797.384183107186;2248.336740661509;2487.6019836826113;2531.810114241435;2555.8849851756718;2568.8073394495395;2534.9746502535017;2572.62696908949;2581.2514370832528;2582.496413199427;2585.9741402586014;2554.118829004;2557;2557.8209525333236;2562.192909233595;2565.6536367590415;2482.726900040994;2557.462932784099;2558.48830233953;2559.987200064006;2561.6669832921693;2509.4855554611263;2544.8854801533976;2552.476742267849;2556.309796354992;2561.782248508879;8945.01604823469;9023.593938272794;9027.684031058881;9032.954835225848;9034.277257819358;5291.3121294231505;5402.540784033362;5404.189371594253;5405.999890020319;5408.513233808937;3671.0822294426393;3703.3889408247605;3754.1177823211797;3831.8658846940225;3840.36633955397;1093.0272057868503;1094.7700982793542;1095.45774841454;1100.0539535999035;1108.2353176308322;12097.576584819577;12138.028957683364;12142.87857121435;12171.513139474411;12181.208221465577;4969.850904472872;5045.495450454925;5084.516970887834;5086.847394578169;5122.231665250168;8587.441816282048;10250.538725757358;10340.844887326695;10344.37933723979;10348.275620706478;5000.374953130859;5558.166275058774;5662.348829884533;5663.971680141655;5668.631538950038;4555.954440455619;4912.189488734391;5012.774425150877;5025.39695236574;5081.2632168335385;4034.619574451088;4093.3859921012086;4099.85650502231;4110.17796440713;4124.505059392892;1205.698575356161;1336.7126067895256;1367.3915107777143;1370.4244217428704;1373.9931300343635;1244.2161438293817;1245.1159676629695;1273.1342686972948;1365.481117175467;1465.7361674898407;8288.917110828936;8305.211004954519;8312.044114926739;8338;8353.122922093215;517.7825313368394;524.4152769661875;525.1230445156598;526.5471694342862;536.9946300536944;6177.96911015442;6200.224971878515;6256.405641464054;6263.404976527223;6268.655223962726;8997.685081022133;10498.790024199474;10712;10858.968398002176;11021.944890275498;10048.648297309559;10801.189910756724;10822.729431764268;10869;10877.67366978992;8249.216324449168;8363.95818020906;8413.62138703772;8436.957815210884;8462.02686691026;8106.148854370206;8173.060098088558;8176.305014073871;8244.876326855221;8272.669093236203;9370.344075914893;9448.48033358172;9505.477198753859;9547.093026162504;9656.517174141125;8233.83532329362;9731.659391921248;9742.90120837925;9953.054459826304;10239.129673977795;6822.897656535057;7020.262872398324;7522.887156692764;7685.807854803451;7785.883211751715;8278.71024514139;8365.288950439037;8368.665253389796;8374.87437688423;8375.41372103947;7261.5280006799385;7387.372073373824;7418.36943859778;7507.887381689388;7561.432892533192;6740.561863478858;7064.222935476991;7087.50387472872;7134.964325178341;7185.317394847481;7169.247229041084;7601.847963040597;7792.337651299476;7813.882791758015;7839.843203135792;7144.928550714426;7159;7200.099987501562;7205.675744591401;7206.855862882818;7176.820579485555;7249.130104387507;7303.561786292839;7319.5242309249725;7321.121465424183 16:38:37 INFO - PROCESS | 1663 | |4;prototype.html;339.6348924905726;344.87584469590945;349.4688074127326;350.7439569114548;355.4685744811509;6470.611763294206;6471.061696054069;6493.675316234193;6506.707198176087;6599.010148477719;6487.7729279475225;6490.156279683646;6494.44797192238;6501.674916254192;6505.90241146382;4567.977160114195;4733.431988161408;4739.2654138608395;4744.288356746481;4839.395075615557;3953.5651078381356;4073.5926407359175;4597.816087356502;4787.880302992418;4803.270822503896;4792.209285467894;4795.424549054118;4833.226683730604;4842.9031419371595;4848.00615873745;4807.230843065093;4813.350197723297;4820.156472617278;4831.9275210871865;4838.903221935541;3948.4077388391684;4044.312466880637;4114.835406583733;4119.464469618931;4134.111166099273;6154.63072215664;6156.168162645188;6210.441060304594;6222.844428889269;6258.092576576371;5723.685197314146;5731.627444216154;5736.196932429463;5737.82786516401;5740.13897915316;6992.440604751659;7077.5753454792875;7082;7094.609796461193;7099.538529995534;4550.658700597469;4693.95306046942;4697.694649847749;4702.200625893606;4706.858794236178;7276.8544629107655;7297.562146271188;7305.3790427813165;7324.01125848009;7335.4131669466315;4764.190087685102;4818.204996175662;4820.228763397839;4831.758412079382;4833.9033219335415;4894.216925291937;4906.779194936236;4913.410390753133;4914.557689807934;4925.1381008324115;5691.630044047207;5694.914576281359;5705.5720820938595;5710.600257981984;5716.342620598602;6711.3288671132495;6937.653117344113;6949.316862063115;6956.269591692901;6967.198772141167;1674.380479222671;1694.7712908141498;1709.623882745794;1712.2808420463434;1716.064744714134;957.8467445208872;1093.4314156638504;1109.9778004439866;1117.6982214801958;1123.5168877382803;6237.594556353823;6371;6526.184226971629;6539.757446085228;6557.245916719638;7112.395446387011;7299.19708832028;7316.5001174759045;7319.41444684424;7329.230430804795;6581.769638062645;6585.5719378240265;6594.901076483857;6595.373439523238;6603.339666033455;3775.8300876460626;3821.770693758328;3824;3826.426036094608;3828.6408325044763;6126.479249263773;7391.6673749681395;7639.197884222188;7667.424943129287;7685.385169186452;7094.290570942864;7218.819529511699;7436.516626419266;7468.477206595595;7511.962440187874;7626.313631773167;7627.275408836152;7642.121156067013;7644.312011919065;7644.617769111634;6074.754675291643;7002.859942801014;7230.276972302938;7267.890981635385;7268.236835132447;6923.757668481579;7114.679839407343;7122.287771222836;7135.357817796424;7169.3906017986965;7621.428392870446;7637.923620763721;7659.846803064019;7662.655180517002;7667.463277570517;4835.29888166221;4836.95163048365;4845.370101886732;4856.1987272099705;4856.975715121402;7222.133343998754;7235.023271858232;7241.384482319062;7247.746328878675;7265.382442492236;6751.459883209233;6986.126734158231;7008.929910700827;7013.333733295329;7013.473989450709;5695.658260504218;5973.835102155038;6659;6935.029095926473;6980.406665433495;6841.350071743176;6852.6916288768125;6859.142607174103;6870.793876183722;6877.071595334766;6981.301869812978;6987.685554150177;6994.6852391643515;6999.650017499206;7006;5995.760169593342;6157.692115394302;6800.217974932946;6836.248012718497;6840.657967101525 16:38:37 INFO - PROCESS | 1663 | |5;yui.html;730.7734602273296;777.9105402878668;793.4564823096176;793.765839077472;826.5784449930534;15144.697106057873;15245.085294882301;15430.537083887473;15450.4592339268;15458;14454.710905781878;14553.981221314485;14575.854241457582;14579.489717859877;14602;774.4772278711876;784.419529548136;975.7121649113528;986.9506524673774;1011.3072545306452;1023.8617786598826;1027.8972102789699;1028.6913925822262;1029.3926583315879;1029.53156313877;1075.7256899490658;1084.4198353880674;1085.2620218251625;1087.7335052912008;1090.5637744902024;792.065362871811;931.5994122527311;1039.521819962818;1064.4677661169414;1071.7481391872905;768.5388766739967;793.8809178623195;796.3828033274201;797.9521228726295;800.0799081056773;15286.312115954697;15347.462838800588;15368.385264589402;15368.924175307733;15382.846171538253;13127.79316070212;13220.33898305081;13429.798553021616;13699.589012329647;13732.65668358289;10254.846177307347;10455.94772026135;10459.110975567086;10605.469726513644;10733.624323148651;3538.9469157962653;3568.2506673598577;3583.4087375583;3616.3671357512594;3793.430985352192;81831;81920.59039704764;82084.58957705233;84960.57519712424;85358.57320713357;9787.657431989846;9918.40489570628;10045.547950342252;10062.647807326855;10085.193184545218;21948;22235.332940011827;22247.22134725277;22258.332250032527;22289.331320060424;7657.63292282959;7790.376769858398;7827.765167044998;7897.131315555284;7995.600219988977;4230.238557059759;4257.936130958038;4259.936100958488;4274.081072569413;4353.172897149531;3126.577911981899;3816.637419445148;3821.7324787264624;3824.770513769183;3827.61723827615;590.5570821883588;688.786476192382;699.720111955222;704.2886684448744;712.8431745016088;576.6684156609966;612.3723183736705;628.84593274648;642.5983760149907;664.8703502816904;8106.878396824052;8492;8526.616302266413;8600;8606.182412670787;536.4849744245568;549.4148731600833;609.186735707835;614.9016157414792;632.8576070384127;3671;3783.697304215656;4072.552019277877;4112.91774164515;4114.526829414595;97949.51025244828;98147;99232;100062.99937000683;100169.49915250378;83005;83185.58407207925;83568;84705;85606.14393855982;30563;38428.615713843064;70743.6462817693;71673;71875.64062179656;8549.914500854911;8640.654373824977;8821.603027863634;8863;8864.42381245217;52899;53441.732791335795;53882.191767124306;54027.91944161173;54999.90000199893;73478;73557.6322118386;73568;73941;74530.06485654516;11267.985881270724;11711.824322634997;11742.471588778355;11756.823647645464;11887.643370698894;12069;12117.454714538044;12298.077644176901;12304.323262220305;12573.371331433575;11639.59261425846;11955.282683039046;12183.939080304895;12196.329201893626;12322.445489952794;11698.47356868926;11794.705132371417;11880.702982425508;12160.939195303967;12572.434240459384;11432.657020289405;11470.483828227583;12024.939875300917;12048.939755301168;12105.33420661872;9818.45998470091;9898.851517227391;10066;10111.443870587189;10171.23715721309;9989.500524973868;10068.798624027624;10074.899251007397;10108.39349639024;10115 16:38:37 INFO - PROCESS | 1663 | __end_tp_report 16:38:37 INFO - PROCESS | 1663 | __start_cc_report 16:38:37 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1058 16:38:37 INFO - PROCESS | 1663 | __end_cc_report 16:38:37 INFO - PROCESS | 1663 | __startTimestamp1459208317500__endTimestamp 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:38:37 INFO - PROCESS | 1663 | Number of tests: 6 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5800.66 Median:6034.22 stddev:643.83 (10.7%) stddev-sans-first:619.17 16:38:37 INFO - PROCESS | 1663 | Values: 3464.4 3537.4 3550.2 3578.7 3612.6 5772.2 5805.5 5821.0 5821.5 5868.5 5794.7 5847.0 5852.6 5853.6 5855.0 5152.8 5193.6 5206.1 5219.1 5266.0 5271.4 5278.0 5279.8 5282.0 5287.9 5204.2 5264.7 5285.4 5301.2 5303.0 4714.4 5298.2 5331.4 5341.8 5382.1 5136.7 5182.8 5201.5 5218.0 5227.2 5684.7 5700.2 5706.9 5736.7 5741.9 5171.8 6182.3 6243.7 6255.5 6313.1 6225.6 6248.6 6296.6 6297.3 6302.3 5906.0 5909.5 5925.8 5937.5 5954.5 6219.9 6349.8 6371.4 6398.3 6460.7 6246.5 6289.6 6291.0 6295.3 6300.1 6244.2 6270.9 6277.1 6279.8 6294.2 5220.3 6111.1 6199.9 6277.6 6290.3 6229.5 6248.8 6272.0 6273.2 6282.3 4958.3 4984.2 4990.7 4991.4 5009.3 4406.5 4438.7 4487.9 4525.0 4554.2 5868.5 5878.1 5879.6 5901.9 5915.4 5199.3 6226.7 6253.6 6266.4 6268.9 5593.2 5722.0 5857.3 5880.1 5880.8 5415.8 5431.8 5437.9 5448.0 5450.0 6381.7 6471.8 6511.9 6545.3 6553.7 6202.6 6228.7 6265.2 6269.7 6272.0 6513.3 6549.9 6550.0 6553.3 6568.9 6108.4 6210.1 6284.2 6295.4 6306.2 6203.4 6236.2 6259.7 6269.5 6283.7 6211.6 6228.9 6239.9 6241.3 6245.6 5905.5 6081.6 6119.4 6223.8 6243.4 5105.7 5865.6 6145.2 6145.6 6167.7 6190.4 6201.8 6205.0 6209.8 6216.3 5972.0 6034.2 6081.8 6104.2 6108.0 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:64565.55 Median:38051.40 stddev:130107.18 (341.9%) stddev-sans-first:130383.08 16:38:37 INFO - PROCESS | 1663 | Values: 440.0 551.3 606.5 628.9 643.9 29831.1 41645.8 41914.0 41986.2 42309.8 44567.6 45210.8 45214.1 45305.0 45325.8 9683.5 9936.9 9940.8 9946.2 9952.7 9616.8 9744.0 9754.6 9756.7 9772.2 8541.6 9722.3 9935.3 9945.6 9952.3 9846.3 9895.6 9903.9 9907.1 9922.1 9844.0 10020.6 10023.1 10032.5 10034.4 43640.8 44047.3 44096.3 44133.3 44147.0 3245.0 3274.4 3325.9 3395.1 3754.0 29930.8 29972.9 30098.8 30727.2 30915.7 2792.4 2810.1 2822.4 2845.0 2882.2 499702.0 500554.0 500766.0 502356.0 503304.0 70211.3 70604.3 70866.6 71077.0 71122.0 74780.0 79634.6 80614.8 80851.0 80911.0 18326.6 18509.3 18512.5 18518.7 18562.4 13756.8 13782.9 13784.4 13843.7 13850.8 19962.6 21906.7 23105.5 23333.5 23343.9 9672.9 9895.5 9975.8 9978.2 10007.8 964.2 1006.6 1016.7 1113.8 1124.4 25935.4 30999.4 31087.0 31177.0 31890.5 1130.8 1167.9 1172.8 1185.5 1209.5 13740.6 15414.5 15708.5 16016.6 16149.6 568968.0 568974.0 572411.0 577873.0 579557.0 56162.2 56740.6 62984.0 63336.7 63435.7 1299.8 1344.5 1533.9 1557.5 1564.2 30082.4 30858.4 30874.0 30955.0 31347.8 51433.5 51974.0 52063.0 52065.2 52117.5 362890.2 373832.1 373933.0 374273.0 374659.0 29796.9 34723.3 35016.6 35451.3 35493.5 44232.0 45192.6 45376.0 45858.5 46658.5 36489.9 37190.0 37596.0 37784.0 38392.0 37171.8 38318.8 38495.6 38999.4 39106.0 37781.9 38384.8 38514.2 39503.6 39505.4 32883.3 34198.7 34264.0 34332.7 34346.0 26947.2 27199.7 27201.7 27207.6 27221.0 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35845.98 Median:26906.20 stddev:112063.19 (416.5%) stddev-sans-first:112345.91 16:38:37 INFO - PROCESS | 1663 | Values: 373.7 380.9 391.2 396.3 398.6 20180.4 21386.5 21508.6 21994.0 21997.0 20865.9 21039.5 21195.3 21206.4 21725.8 5974.5 6026.1 6129.1 6199.0 6229.3 6116.9 6160.7 6171.9 6173.8 6180.2 6026.7 6045.8 6139.0 6153.8 6160.8 5985.6 6058.3 6143.4 6178.4 6183.9 5269.2 5323.5 5331.3 5349.8 5363.8 26671.7 26683.8 27128.6 27306.9 27375.0 2053.3 2176.4 2311.9 2878.7 2965.7 10256.9 10338.6 10396.7 11236.0 15634.9 1791.0 1817.4 1823.7 1834.4 1855.0 84274.1 89737.6 90776.0 91230.0 92069.0 11751.7 11921.3 11949.9 11953.9 11971.9 14666.5 14688.6 14708.3 14715.9 14736.3 9009.1 9033.9 9041.0 9094.2 9131.9 7908.4 8769.2 9196.3 9258.5 9286.0 4071.8 4426.5 4547.1 4656.2 4701.3 1896.5 1932.3 1936.0 1937.7 1980.0 921.3 971.4 991.9 1018.0 1050.3 16843.0 19399.4 20204.0 20650.7 20739.5 1005.7 1016.8 1024.7 1075.7 1077.3 9680.3 11075.7 11203.4 11251.9 11330.2 660886.0 676128.0 680892.0 688863.0 702358.0 61584.0 84803.6 102150.0 118581.0 122527.0 841.7 1005.5 1023.4 1033.3 1037.6 17819.7 18069.9 18097.9 18205.7 18618.2 50709.0 51385.7 53432.2 53538.5 53683.4 72778.0 73283.0 75965.6 77400.6 77934.0 8160.2 8282.7 8381.5 8424.9 8544.7 8570.4 11357.8 13230.7 13576.0 13643.9 11397.5 11496.1 11505.3 11698.0 11818.6 11041.1 11219.8 11473.4 11653.9 11745.6 11603.7 11759.0 11853.8 11876.7 12020.9 8122.7 8227.4 8324.4 8337.2 8436.7 9680.7 10630.5 11647.2 11862.8 11887.5 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6100.57 Median:2969.77 stddev:3192.67 (107.5%) stddev-sans-first:3182.30 16:38:37 INFO - PROCESS | 1663 | Values: 1427.3 1620.2 1653.4 1978.9 2068.6 8132.8 8713.3 8867.2 8872.8 8880.9 8528.9 8769.6 8786.9 8797.1 8797.4 2248.3 2487.6 2531.8 2555.9 2568.8 2535.0 2572.6 2581.3 2582.5 2586.0 2554.1 2557.0 2557.8 2562.2 2565.7 2482.7 2557.5 2558.5 2560.0 2561.7 2509.5 2544.9 2552.5 2556.3 2561.8 8945.0 9023.6 9027.7 9033.0 9034.3 5291.3 5402.5 5404.2 5406.0 5408.5 3671.1 3703.4 3754.1 3831.9 3840.4 1093.0 1094.8 1095.5 1100.1 1108.2 12097.6 12138.0 12142.9 12171.5 12181.2 4969.9 5045.5 5084.5 5086.8 5122.2 8587.4 10250.5 10340.8 10344.4 10348.3 5000.4 5558.2 5662.3 5664.0 5668.6 4556.0 4912.2 5012.8 5025.4 5081.3 4034.6 4093.4 4099.9 4110.2 4124.5 1205.7 1336.7 1367.4 1370.4 1374.0 1244.2 1245.1 1273.1 1365.5 1465.7 8288.9 8305.2 8312.0 8338.0 8353.1 517.8 524.4 525.1 526.5 537.0 6178.0 6200.2 6256.4 6263.4 6268.7 8997.7 10498.8 10712.0 10859.0 11021.9 10048.6 10801.2 10822.7 10869.0 10877.7 8249.2 8364.0 8413.6 8437.0 8462.0 8106.1 8173.1 8176.3 8244.9 8272.7 9370.3 9448.5 9505.5 9547.1 9656.5 8233.8 9731.7 9742.9 9953.1 10239.1 6822.9 7020.3 7522.9 7685.8 7785.9 8278.7 8365.3 8368.7 8374.9 8375.4 7261.5 7387.4 7418.4 7507.9 7561.4 6740.6 7064.2 7087.5 7135.0 7185.3 7169.2 7601.8 7792.3 7813.9 7839.8 7144.9 7159.0 7200.1 7205.7 7206.9 7176.8 7249.1 7303.6 7319.5 7321.1 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5731.43 Median:6491.92 stddev:1803.91 (27.8%) stddev-sans-first:1762.99 16:38:37 INFO - PROCESS | 1663 | Values: 339.6 344.9 349.5 350.7 355.5 6470.6 6471.1 6493.7 6506.7 6599.0 6487.8 6490.2 6494.4 6501.7 6505.9 4568.0 4733.4 4739.3 4744.3 4839.4 3953.6 4073.6 4597.8 4787.9 4803.3 4792.2 4795.4 4833.2 4842.9 4848.0 4807.2 4813.4 4820.2 4831.9 4838.9 3948.4 4044.3 4114.8 4119.5 4134.1 6154.6 6156.2 6210.4 6222.8 6258.1 5723.7 5731.6 5736.2 5737.8 5740.1 6992.4 7077.6 7082.0 7094.6 7099.5 4550.7 4694.0 4697.7 4702.2 4706.9 7276.9 7297.6 7305.4 7324.0 7335.4 4764.2 4818.2 4820.2 4831.8 4833.9 4894.2 4906.8 4913.4 4914.6 4925.1 5691.6 5694.9 5705.6 5710.6 5716.3 6711.3 6937.7 6949.3 6956.3 6967.2 1674.4 1694.8 1709.6 1712.3 1716.1 957.8 1093.4 1110.0 1117.7 1123.5 6237.6 6371.0 6526.2 6539.8 6557.2 7112.4 7299.2 7316.5 7319.4 7329.2 6581.8 6585.6 6594.9 6595.4 6603.3 3775.8 3821.8 3824.0 3826.4 3828.6 6126.5 7391.7 7639.2 7667.4 7685.4 7094.3 7218.8 7436.5 7468.5 7512.0 7626.3 7627.3 7642.1 7644.3 7644.6 6074.8 7002.9 7230.3 7267.9 7268.2 6923.8 7114.7 7122.3 7135.4 7169.4 7621.4 7637.9 7659.8 7662.7 7667.5 4835.3 4837.0 4845.4 4856.2 4857.0 7222.1 7235.0 7241.4 7247.7 7265.4 6751.5 6986.1 7008.9 7013.3 7013.5 5695.7 5973.8 6659.0 6935.0 6980.4 6841.4 6852.7 6859.1 6870.8 6877.1 6981.3 6987.7 6994.7 6999.7 7006.0 5995.8 6157.7 6800.2 6836.2 6840.7 16:38:37 INFO - PROCESS | 1663 | 16:38:37 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18889.48 Median:3819.18 stddev:26752.81 (700.5%) stddev-sans-first:26793.11 16:38:37 INFO - PROCESS | 1663 | Values: 730.8 777.9 793.5 793.8 826.6 15144.7 15245.1 15430.5 15450.5 15458.0 14454.7 14554.0 14575.9 14579.5 14602.0 774.5 784.4 975.7 987.0 1011.3 1023.9 1027.9 1028.7 1029.4 1029.5 1075.7 1084.4 1085.3 1087.7 1090.6 792.1 931.6 1039.5 1064.5 1071.7 768.5 793.9 796.4 798.0 800.1 15286.3 15347.5 15368.4 15368.9 15382.8 13127.8 13220.3 13429.8 13699.6 13732.7 10254.8 10455.9 10459.1 10605.5 10733.6 3538.9 3568.3 3583.4 3616.4 3793.4 81831.0 81920.6 82084.6 84960.6 85358.6 9787.7 9918.4 10045.5 10062.6 10085.2 21948.0 22235.3 22247.2 22258.3 22289.3 7657.6 7790.4 7827.8 7897.1 7995.6 4230.2 4257.9 4259.9 4274.1 4353.2 3126.6 3816.6 3821.7 3824.8 3827.6 590.6 688.8 699.7 704.3 712.8 576.7 612.4 628.8 642.6 664.9 8106.9 8492.0 8526.6 8600.0 8606.2 536.5 549.4 609.2 614.9 632.9 3671.0 3783.7 4072.6 4112.9 4114.5 97949.5 98147.0 99232.0 100063.0 100169.5 83005.0 83185.6 83568.0 84705.0 85606.1 30563.0 38428.6 70743.6 71673.0 71875.6 8549.9 8640.7 8821.6 8863.0 8864.4 52899.0 53441.7 53882.2 54027.9 54999.9 73478.0 73557.6 73568.0 73941.0 74530.1 11268.0 11711.8 11742.5 11756.8 11887.6 12069.0 12117.5 12298.1 12304.3 12573.4 11639.6 11955.3 12183.9 12196.3 12322.4 11698.5 11794.7 11880.7 12160.9 12572.4 11432.7 11470.5 12024.9 12048.9 12105.3 9818.5 9898.9 10066.0 10111.4 10171.2 9989.5 10068.8 10074.9 10108.4 10115.0 16:38:37 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:38:37 INFO - PROCESS | 1663 | 16:38:38 INFO - TEST-INFO | 1663: exit 0 16:38:38 INFO - TEST-OK | dromaeo_css | took 1111986ms 16:38:38 INFO - TEST-START | kraken 16:38:38 INFO - operating with platform_type : mac_ 16:38:38 INFO - Initialising browser for kraken test... 16:38:38 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmprdY8da/profile http://localhost:49276/getInfo.html) 16:38:40 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 16:38:40 INFO - PROCESS | 1674 | colorDepth:24 16:38:40 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 16:38:40 INFO - PROCESS | 1674 | __metrics 16:38:40 INFO - PROCESS | 1674 | 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" 16:38:40 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:40 INFO - TEST-INFO | 1674: exit 0 16:38:40 INFO - Browser initialized. 16:38:40 INFO - Running cycle 1/1 for kraken test... 16:38:40 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmprdY8da/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:52 INFO - PROCESS | 1676 | RSS: Main: 210427904 16:38:52 INFO - PROCESS | 1676 | 16:38:55 INFO - PROCESS | 1676 | 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) 16:38:56 INFO - PROCESS | 1676 | RSS: Main: 265297920 16:38:56 INFO - PROCESS | 1676 | 16:38:58 INFO - PROCESS | 1676 | 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) 16:38:59 INFO - PROCESS | 1676 | RSS: Main: 274235392 16:38:59 INFO - PROCESS | 1676 | 16:39:02 INFO - PROCESS | 1676 | 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) 16:39:03 INFO - PROCESS | 1676 | RSS: Main: 264663040 16:39:03 INFO - PROCESS | 1676 | 16:39:05 INFO - PROCESS | 1676 | 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) 16:39:05 INFO - PROCESS | 1676 | RSS: Main: 266698752 16:39:05 INFO - PROCESS | 1676 | 16:39:07 INFO - PROCESS | 1676 | 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) 16:39:08 INFO - PROCESS | 1676 | RSS: Main: 266117120 16:39:08 INFO - PROCESS | 1676 | 16:39:11 INFO - PROCESS | 1676 | 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) 16:39:11 INFO - PROCESS | 1676 | RSS: Main: 266362880 16:39:11 INFO - PROCESS | 1676 | 16:39:14 INFO - PROCESS | 1676 | 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) 16:39:15 INFO - PROCESS | 1676 | RSS: Main: 265859072 16:39:15 INFO - PROCESS | 1676 | 16:39:17 INFO - PROCESS | 1676 | 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) 16:39:18 INFO - PROCESS | 1676 | RSS: Main: 266121216 16:39:18 INFO - PROCESS | 1676 | 16:39:19 INFO - PROCESS | 1676 | 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) 16:39:20 INFO - PROCESS | 1676 | RSS: Main: 300331008 16:39:20 INFO - PROCESS | 1676 | 16:39:22 INFO - PROCESS | 1676 | 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) 16:39:22 INFO - PROCESS | 1676 | RSS: Main: 299679744 16:39:22 INFO - PROCESS | 1676 | 16:39:25 INFO - PROCESS | 1676 | 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) 16:39:25 INFO - PROCESS | 1676 | RSS: Main: 307322880 16:39:25 INFO - PROCESS | 1676 | 16:39:28 INFO - PROCESS | 1676 | 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) 16:39:28 INFO - PROCESS | 1676 | RSS: Main: 308506624 16:39:28 INFO - PROCESS | 1676 | 16:39:31 INFO - PROCESS | 1676 | 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) 16:39:31 INFO - PROCESS | 1676 | RSS: Main: 309170176 16:39:31 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | 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) 16:39:33 INFO - PROCESS | 1676 | RSS: Main: 370081792 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | __start_tp_report 16:39:33 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 16:39:33 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 16:39:33 INFO - PROCESS | 1676 | |i|pagename|runs| 16:39:33 INFO - PROCESS | 1676 | |0;ai-astar;111;106;112;110;111;110;118;108;118;161 16:39:33 INFO - PROCESS | 1676 | |1;audio-beat-detection;155;119;161;149;118;136;119;149;146;117 16:39:33 INFO - PROCESS | 1676 | |2;audio-dft;182;187;258;186;184;186;183;185;185;183 16:39:33 INFO - PROCESS | 1676 | |3;audio-fft;72;75;74;118;57;56;59;57;117;54 16:39:33 INFO - PROCESS | 1676 | |4;audio-oscillator;90;94;127;79;77;87;116;76;79;112 16:39:33 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;87;85;88;84;87;84;134;85;86;84 16:39:33 INFO - PROCESS | 1676 | |6;imaging-darkroom;92;92;93;92;92;92;92;93;92;91 16:39:33 INFO - PROCESS | 1676 | |7;imaging-desaturate;86;84;85;84;85;84;87;85;85;85 16:39:33 INFO - PROCESS | 1676 | |8;json-parse-financial;54;58;58;58;57;57;58;66;49;51 16:39:33 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;62;61;68;85;108;104;84;64;65;66 16:39:33 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;81;80;80;78;80;79;79;81;82;84 16:39:33 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;119;127;129;116;125;106;131;129;131;130 16:39:33 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;131;117;130;131;130;119;132;132;130;132 16:39:33 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;63;68;65;67;66;67;65;65;64 16:39:33 INFO - PROCESS | 1676 | __end_tp_report 16:39:33 INFO - PROCESS | 1676 | __start_cc_report 16:39:33 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1182 16:39:33 INFO - PROCESS | 1676 | __end_cc_report 16:39:33 INFO - PROCESS | 1676 | __startTimestamp1459208373681__endTimestamp 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | ------- Summary: start ------- 16:39:33 INFO - PROCESS | 1676 | Number of tests: 14 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:116.50 Median:111.50 stddev:16.10 (14.4%) stddev-sans-first:16.95 16:39:33 INFO - PROCESS | 1676 | Values: 111.0 106.0 112.0 110.0 111.0 110.0 118.0 108.0 118.0 161.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:147.50 stddev:17.25 (11.7%) stddev-sans-first:17.01 16:39:33 INFO - PROCESS | 1676 | Values: 155.0 119.0 161.0 149.0 118.0 136.0 119.0 149.0 146.0 117.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:191.90 Median:185.50 stddev:23.28 (12.5%) stddev-sans-first:24.41 16:39:33 INFO - PROCESS | 1676 | Values: 182.0 187.0 258.0 186.0 184.0 186.0 183.0 185.0 185.0 183.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:73.90 Median:58.00 stddev:24.31 (41.9%) stddev-sans-first:25.77 16:39:33 INFO - PROCESS | 1676 | Values: 72.0 75.0 74.0 118.0 57.0 56.0 59.0 57.0 117.0 54.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:79.00 stddev:18.33 (23.2%) stddev-sans-first:19.39 16:39:33 INFO - PROCESS | 1676 | Values: 90.0 94.0 127.0 79.0 77.0 87.0 116.0 76.0 79.0 112.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:85.50 stddev:15.39 (18.0%) stddev-sans-first:16.27 16:39:33 INFO - PROCESS | 1676 | Values: 87.0 85.0 88.0 84.0 87.0 84.0 134.0 85.0 86.0 84.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:39:33 INFO - PROCESS | 1676 | Values: 92.0 92.0 93.0 92.0 92.0 92.0 92.0 93.0 92.0 91.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 16:39:33 INFO - PROCESS | 1676 | Values: 86.0 84.0 85.0 84.0 85.0 84.0 87.0 85.0 85.0 85.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:4.62 (8.0%) stddev-sans-first:4.81 16:39:33 INFO - PROCESS | 1676 | Values: 54.0 58.0 58.0 58.0 57.0 57.0 58.0 66.0 49.0 51.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:65.50 stddev:17.63 (26.9%) stddev-sans-first:17.88 16:39:33 INFO - PROCESS | 1676 | Values: 62.0 61.0 68.0 85.0 108.0 104.0 84.0 64.0 65.0 66.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.50 stddev:1.71 (2.1%) stddev-sans-first:1.80 16:39:33 INFO - PROCESS | 1676 | Values: 81.0 80.0 80.0 78.0 80.0 79.0 79.0 81.0 82.0 84.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:129.00 stddev:8.21 (6.4%) stddev-sans-first:8.48 16:39:33 INFO - PROCESS | 1676 | Values: 119.0 127.0 129.0 116.0 125.0 106.0 131.0 129.0 131.0 130.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:128.40 Median:131.00 stddev:5.56 (4.2%) stddev-sans-first:5.82 16:39:33 INFO - PROCESS | 1676 | Values: 131.0 117.0 130.0 131.0 130.0 119.0 132.0 132.0 130.0 132.0 16:39:33 INFO - PROCESS | 1676 | 16:39:33 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:1.59 16:39:33 INFO - PROCESS | 1676 | Values: 66.0 63.0 68.0 65.0 67.0 66.0 67.0 65.0 65.0 64.0 16:39:33 INFO - PROCESS | 1676 | -------- Summary: end -------- 16:39:33 INFO - PROCESS | 1676 | 16:39:34 INFO - TEST-INFO | 1676: exit 0 16:39:34 INFO - TEST-OK | kraken | took 56303ms 16:39:34 INFO - SUITE-END | took 1168s 16:39:34 INFO - Completed test suite (00:19:28) 16:39:34 INFO - javascript benchmark 16:39:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3464.3590935676903, 3537.363274610569, 3550.236699109691, 3578.713702903768, 3612.6026137124913, 5772.249607551023, 5805.535557155428, 5821.0, 5821.53427725782, 5868.50117739992, 5794.68129252892, 5847.0, 5852.590318677694, 5853.619514731539, 5855.0046492096335, 5152.845414637567, 5193.610479214055, 5206.088934436459, 5219.112750832349, 5266.0, 5271.4464981177, 5278.0, 5279.762410691528, 5282.049231138393, 5287.894242115155, 5204.167333226685, 5264.684118952856, 5285.445028272034, 5301.151815709487, 5302.973485132569, 4714.38712967312, 5298.23175639532, 5331.360236771593, 5341.786328546854, 5382.085045542267, 5136.666116702402, 5182.844514664566, 5201.479852014806, 5217.973910130425, 5227.163653815409, 5684.658920464744, 5700.201971723962, 5706.885862282773, 5736.713164341808, 5741.88516229673, 5171.793128274864, 6182.319944806068, 6243.687815609202, 6255.468285195764, 6313.084602732578, 6225.564210505267, 6248.562600617958, 6296.622202667854, 6297.307296197415, 6302.275238347557, 5905.995980683251, 5909.497692696169, 5925.822225333247, 5937.495312898365, 5954.4938680212235, 6219.875602487925, 6349.777757778455, 6371.362863713592, 6398.2641996170105, 6460.741570337228, 6246.500279977591, 6289.591176573508, 6291.02489114188, 6295.307516173218, 6300.1494798202575, 6244.1570387997035, 6270.905936410957, 6277.089821975788, 6279.843003924847, 6294.150289710922, 5220.321358223407, 6111.13596929516, 6199.907001394983, 6277.591956522811, 6290.308066112724, 6229.501639868799, 6248.781292654826, 6272.0, 6273.247210334698, 6282.277538083087, 4958.330625365602, 4984.177610694195, 4990.72551009698, 4991.351124353883, 5009.273655320031, 4406.537313582092, 4438.667099967515, 4487.887802804956, 4525.0, 4554.20301447252, 5868.471837534557, 5878.118282257696, 5879.559033072536, 5901.911471327933, 5915.40845915405, 5199.324087868553, 6226.719797609027, 6253.624782513064, 6266.404691554295, 6268.937310626927, 5593.216949627055, 5722.0, 5857.297124345106, 5880.117982302603, 5880.8235752927485, 5415.783368665209, 5431.8098866539485, 5437.891242175135, 5447.972760136174, 5449.972750136303, 6381.744730210925, 6471.7734879279, 6511.8697626047215, 6545.2800191979795, 6553.672316384257, 6202.627842329474, 6228.719707613259, 6265.216847894013, 6269.74921003173, 6272.0, 6513.316101809241, 6549.8690026200165, 6549.967250163719, 6553.344665533408, 6568.9014664781025, 6108.402780883668, 6210.068489726577, 6284.24589049317, 6295.433410993032, 6306.243250809932, 6203.4416902479, 6236.158118653923, 6259.718312675849, 6269.4984401246875, 6283.748650053946, 6211.596246243979, 6228.937710623017, 6239.875202495834, 6241.251049874044, 6245.594036387621, 5905.4685078343155, 6081.5742897996715, 6119.350229749377, 6223.813285601439, 6243.43809057187, 5105.744712764421, 5865.589408741518, 6145.170401995673, 6145.555794388226, 6167.660778657217, 6190.350013248724, 6201.81394558164, 6205.03821907605, 6209.782657606962, 6216.2540495140875, 5972.044472884491, 6034.21555197839, 6081.817545473643, 6104.236970378703, 6107.969460152671], "unit": "score", "name": "dojo.html", "value": 5761.727318674619}, {"lowerIsBetter": false, "replicates": [440.0319297545399, 551.3356405531335, 606.5056978562471, 628.9465395441388, 643.8776632439836, 29831.105066848002, 41645.79177104114, 41913.95215119624, 41986.16027679444, 42309.7884510577, 44567.554324456745, 45210.773946130306, 45214.09571808562, 45305.0, 45325.773371133095, 9683.515824208778, 9936.900630993707, 9940.751481212956, 9946.204303655726, 9952.701418957442, 9616.759581010461, 9743.951280243624, 9754.609815607368, 9756.707298781048, 9772.169365603932, 8541.572921353938, 9722.319437639368, 9935.254855885802, 9945.602175912954, 9952.303338766289, 9846.310758246926, 9895.554700038516, 9903.851442228372, 9907.108360247541, 9922.107010369065, 9844.01559844017, 10020.59917603295, 10023.097921187054, 10032.548535315927, 10034.448105354202, 43640.781796090814, 44047.33928991068, 44096.33855492138, 44133.33799993002, 44147.0, 3244.9837750811093, 3274.3942370661266, 3325.8503367348526, 3395.1172695099203, 3753.962460375416, 29930.802767889258, 29972.8501357494, 30098.849505752332, 30727.2318192047, 30915.690843091506, 2792.3577577157166, 2810.1007677543193, 2822.449622323648, 2844.9715502844915, 2882.20739296693, 499702.0, 500553.99999999633, 500765.98468030436, 502356.0, 503304.0, 70211.29788702048, 70604.29395705977, 70866.64566677134, 71077.0, 71122.0, 74780.0, 79634.60182699165, 80614.79077813837, 80851.0, 80911.0, 18326.63346733058, 18509.259629614935, 18512.537186570175, 18518.722219166724, 18562.44312670622, 13756.793648095287, 13782.862171378158, 13784.379702913393, 13843.723125537434, 13850.792238116437, 19962.600747984958, 21906.6855988638, 23105.53788924212, 23333.533329333317, 23343.88328058349, 9672.903270967341, 9895.505224738734, 9975.800483990279, 9978.151857092083, 10007.849882251772, 964.1756298364937, 1006.5571148694551, 1016.7458135466134, 1113.752597091263, 1124.4490199802037, 25935.351616209744, 30999.380012399626, 31087.0, 31177.0, 31890.535325054512, 1130.8134157864024, 1167.8832116788253, 1172.783035138502, 1185.466540056978, 1209.5343292832322, 13740.5572414897, 15414.537563873102, 15708.528744137695, 16016.599585010468, 16149.596260093356, 568968.0, 568974.0, 572411.0, 577873.0, 579557.0, 56162.15756763652, 56740.58148546237, 62984.0, 63336.68331658404, 63435.68282158652, 1299.7660421124099, 1344.515974249289, 1533.854283843033, 1557.509384543865, 1564.2022568490152, 30082.3983520324, 30858.382832342777, 30874.0, 30955.0, 31347.84326078355, 51433.48566514437, 51974.0, 52063.0, 52065.21902171395, 52117.47882521126, 362890.1855490706, 373832.13083935494, 373933.0, 374273.0, 374659.0, 29796.85101574478, 34723.30553388969, 35016.64983350134, 35451.29097418089, 35493.46759798553, 44232.0, 45192.644220673435, 45376.0, 45858.54141458676, 46658.533414666774, 36489.905302840954, 37190.0, 37596.0, 37784.0, 38392.0, 37171.7594739174, 38318.80840595779, 38495.615043849204, 38999.41500877546, 39106.02234944149, 37781.86654400372, 38384.808075959445, 38514.229715406094, 39503.60496395114, 39505.407418888164, 32883.34233315368, 34198.65801342054, 34263.972080837615, 34332.656673432946, 34345.96962091141, 26947.191584252505, 27199.728002720512, 27201.72798271992, 27207.59188612133, 27221.0], "unit": "score", "name": "ext.html", "value": 20762.80714452402}, {"lowerIsBetter": false, "replicates": [373.712241573988, 380.9409541521064, 391.19268977324765, 396.2906397548389, 398.6432143231809, 20180.39458816234, 21386.46533836655, 21508.56982860342, 21994.0, 21997.010134543943, 20865.895670521626, 21039.47401314968, 21195.258165964195, 21206.363809085753, 21725.782742172574, 5974.5220382369525, 6026.0960855871535, 6129.111278864562, 6199.0, 6229.314775374705, 6116.938830611703, 6160.6611636359985, 6171.938280617203, 6173.753049878022, 6180.165677633507, 6026.668533230692, 6045.758169673208, 6139.0, 6153.7846175383875, 6160.845978850542, 5985.5810093293485, 6058.273007239138, 6143.4470897618985, 6178.443940045418, 6183.9381606183815, 5269.209618557209, 5323.520883120537, 5331.253624492574, 5349.7592608332325, 5363.839084827461, 26671.73328266712, 26683.799229034546, 27128.59307110395, 27306.86346568274, 27375.0, 2053.260826102602, 2176.434127126958, 2311.8959646815933, 2878.675809127783, 2965.7034296570387, 10256.948715256376, 10338.638147664871, 10396.740081498023, 11236.0, 15634.9218253908, 1790.95229290865, 1817.391173956726, 1823.7264410338423, 1834.385480863912, 1854.9907250463662, 84274.05678258628, 89737.55131224367, 90776.0, 91230.0, 92069.01551399137, 11751.706207344714, 11921.34432606215, 11949.88050119505, 11953.864382883612, 11971.880281197251, 14666.486672966395, 14688.632784180267, 14708.264586770618, 14715.852841471662, 14736.263186840615, 9009.054049324726, 9033.864492032624, 9040.954795225982, 9094.226990705863, 9131.908680913106, 7908.367330613537, 8769.21077103051, 9196.264298856075, 9258.490783006999, 9286.024967378464, 4071.8395257351513, 4426.468823741172, 4547.113312904018, 4656.185167595657, 4701.318308845267, 1896.544829241, 1932.3236867096405, 1935.9709604355946, 1937.6609093408597, 1979.9505012374807, 921.3136213520836, 971.3734641156415, 991.8643153589101, 1017.97455063624, 1050.3172937590627, 16843.0, 19399.4180174595, 20203.989800509917, 20650.690239646417, 20739.481512961996, 1005.6775340427315, 1016.7661437869332, 1024.6874703215442, 1075.6504136155781, 1077.2620754783, 9680.27397945157, 11075.72310692239, 11203.43982800873, 11251.94374028141, 11330.206885518099, 660886.0, 676128.0, 680892.0, 688863.0, 702358.0, 61584.0, 84803.5759821197, 102150.0, 118581.0, 122527.0, 841.705403108907, 1005.4721271332463, 1023.3910823060268, 1033.3231733214757, 1037.6160820496314, 17819.732704009708, 18069.909650451664, 18097.909510452362, 18205.726914096034, 18618.16218270154, 50709.0, 51385.74307128441, 53432.198517023055, 53538.46461535335, 53683.44129212487, 72778.0, 73283.0, 75965.62017189879, 77400.6129969369, 77934.0, 8160.183981601793, 8282.71010514629, 8381.455205411628, 8424.915750842412, 8544.718292256211, 8570.4000719949, 11357.772844542898, 13230.669233269246, 13576.0, 13643.86356136426, 11397.461342718627, 11496.137789665641, 11505.252158609663, 11698.005669518187, 11818.645440636794, 11041.116710662967, 11219.775604488028, 11473.36896470702, 11653.883461165618, 11745.647630570755, 11603.6518904433, 11759.0, 11853.76292474163, 11876.703082423008, 12020.879791201976, 8122.7157049502985, 8227.382946278933, 8324.417290789586, 8337.166283371615, 8436.704715334934, 9680.661176858775, 10630.52162652698, 11647.242929209575, 11862.822057669315, 11887.465064071965], "unit": "score", "name": "jquery.html", "value": 9682.931313306188}, {"lowerIsBetter": false, "replicates": [1427.3291552970113, 1620.2303905644817, 1653.37998250656, 1978.8812671239718, 2068.5656012237437, 8132.837343253139, 8713.259372953298, 8867.246284065863, 8872.778180545489, 8880.91119088809, 8528.91471085289, 8769.56152192391, 8786.86819697705, 8797.1202879712, 8797.384183107186, 2248.336740661509, 2487.6019836826113, 2531.810114241435, 2555.8849851756718, 2568.8073394495395, 2534.9746502535017, 2572.62696908949, 2581.2514370832528, 2582.496413199427, 2585.9741402586014, 2554.118829004, 2557.0, 2557.8209525333236, 2562.192909233595, 2565.6536367590415, 2482.726900040994, 2557.462932784099, 2558.48830233953, 2559.987200064006, 2561.6669832921693, 2509.4855554611263, 2544.8854801533976, 2552.476742267849, 2556.309796354992, 2561.782248508879, 8945.01604823469, 9023.593938272794, 9027.684031058881, 9032.954835225848, 9034.277257819358, 5291.3121294231505, 5402.540784033362, 5404.189371594253, 5405.999890020319, 5408.513233808937, 3671.0822294426393, 3703.3889408247605, 3754.1177823211797, 3831.8658846940225, 3840.36633955397, 1093.0272057868503, 1094.7700982793542, 1095.45774841454, 1100.0539535999035, 1108.2353176308322, 12097.576584819577, 12138.028957683364, 12142.87857121435, 12171.513139474411, 12181.208221465577, 4969.850904472872, 5045.495450454925, 5084.516970887834, 5086.847394578169, 5122.231665250168, 8587.441816282048, 10250.538725757358, 10340.844887326695, 10344.37933723979, 10348.275620706478, 5000.374953130859, 5558.166275058774, 5662.348829884533, 5663.971680141655, 5668.631538950038, 4555.954440455619, 4912.189488734391, 5012.774425150877, 5025.39695236574, 5081.2632168335385, 4034.619574451088, 4093.3859921012086, 4099.85650502231, 4110.17796440713, 4124.505059392892, 1205.698575356161, 1336.7126067895256, 1367.3915107777143, 1370.4244217428704, 1373.9931300343635, 1244.2161438293817, 1245.1159676629695, 1273.1342686972948, 1365.481117175467, 1465.7361674898407, 8288.917110828936, 8305.211004954519, 8312.044114926739, 8338.0, 8353.122922093215, 517.7825313368394, 524.4152769661875, 525.1230445156598, 526.5471694342862, 536.9946300536944, 6177.96911015442, 6200.224971878515, 6256.405641464054, 6263.404976527223, 6268.655223962726, 8997.685081022133, 10498.790024199474, 10712.0, 10858.968398002176, 11021.944890275498, 10048.648297309559, 10801.189910756724, 10822.729431764268, 10869.0, 10877.67366978992, 8249.216324449168, 8363.95818020906, 8413.62138703772, 8436.957815210884, 8462.02686691026, 8106.148854370206, 8173.060098088558, 8176.305014073871, 8244.876326855221, 8272.669093236203, 9370.344075914893, 9448.48033358172, 9505.477198753859, 9547.093026162504, 9656.517174141125, 8233.83532329362, 9731.659391921248, 9742.90120837925, 9953.054459826304, 10239.129673977795, 6822.897656535057, 7020.262872398324, 7522.887156692764, 7685.807854803451, 7785.883211751715, 8278.71024514139, 8365.288950439037, 8368.665253389796, 8374.87437688423, 8375.41372103947, 7261.5280006799385, 7387.372073373824, 7418.36943859778, 7507.887381689388, 7561.432892533192, 6740.561863478858, 7064.222935476991, 7087.50387472872, 7134.964325178341, 7185.317394847481, 7169.247229041084, 7601.847963040597, 7792.337651299476, 7813.882791758015, 7839.843203135792, 7144.928550714426, 7159.0, 7200.099987501562, 7205.675744591401, 7206.855862882818, 7176.820579485555, 7249.130104387507, 7303.561786292839, 7319.5242309249725, 7321.121465424183], "unit": "score", "name": "mootools.html", "value": 4921.378104671711}, {"lowerIsBetter": false, "replicates": [339.6348924905726, 344.87584469590945, 349.4688074127326, 350.7439569114548, 355.4685744811509, 6470.611763294206, 6471.061696054069, 6493.675316234193, 6506.707198176087, 6599.010148477719, 6487.7729279475225, 6490.156279683646, 6494.44797192238, 6501.674916254192, 6505.90241146382, 4567.977160114195, 4733.431988161408, 4739.2654138608395, 4744.288356746481, 4839.395075615557, 3953.5651078381356, 4073.5926407359175, 4597.816087356502, 4787.880302992418, 4803.270822503896, 4792.209285467894, 4795.424549054118, 4833.226683730604, 4842.9031419371595, 4848.00615873745, 4807.230843065093, 4813.350197723297, 4820.156472617278, 4831.9275210871865, 4838.903221935541, 3948.4077388391684, 4044.312466880637, 4114.835406583733, 4119.464469618931, 4134.111166099273, 6154.63072215664, 6156.168162645188, 6210.441060304594, 6222.844428889269, 6258.092576576371, 5723.685197314146, 5731.627444216154, 5736.196932429463, 5737.82786516401, 5740.13897915316, 6992.440604751659, 7077.5753454792875, 7082.0, 7094.609796461193, 7099.538529995534, 4550.658700597469, 4693.95306046942, 4697.694649847749, 4702.200625893606, 4706.858794236178, 7276.8544629107655, 7297.562146271188, 7305.3790427813165, 7324.01125848009, 7335.4131669466315, 4764.190087685102, 4818.204996175662, 4820.228763397839, 4831.758412079382, 4833.9033219335415, 4894.216925291937, 4906.779194936236, 4913.410390753133, 4914.557689807934, 4925.1381008324115, 5691.630044047207, 5694.914576281359, 5705.5720820938595, 5710.600257981984, 5716.342620598602, 6711.3288671132495, 6937.653117344113, 6949.316862063115, 6956.269591692901, 6967.198772141167, 1674.380479222671, 1694.7712908141498, 1709.623882745794, 1712.2808420463434, 1716.064744714134, 957.8467445208872, 1093.4314156638504, 1109.9778004439866, 1117.6982214801958, 1123.5168877382803, 6237.594556353823, 6371.0, 6526.184226971629, 6539.757446085228, 6557.245916719638, 7112.395446387011, 7299.19708832028, 7316.5001174759045, 7319.41444684424, 7329.230430804795, 6581.769638062645, 6585.5719378240265, 6594.901076483857, 6595.373439523238, 6603.339666033455, 3775.8300876460626, 3821.770693758328, 3824.0, 3826.426036094608, 3828.6408325044763, 6126.479249263773, 7391.6673749681395, 7639.197884222188, 7667.424943129287, 7685.385169186452, 7094.290570942864, 7218.819529511699, 7436.516626419266, 7468.477206595595, 7511.962440187874, 7626.313631773167, 7627.275408836152, 7642.121156067013, 7644.312011919065, 7644.617769111634, 6074.754675291643, 7002.859942801014, 7230.276972302938, 7267.890981635385, 7268.236835132447, 6923.757668481579, 7114.679839407343, 7122.287771222836, 7135.357817796424, 7169.3906017986965, 7621.428392870446, 7637.923620763721, 7659.846803064019, 7662.655180517002, 7667.463277570517, 4835.29888166221, 4836.95163048365, 4845.370101886732, 4856.1987272099705, 4856.975715121402, 7222.133343998754, 7235.023271858232, 7241.384482319062, 7247.746328878675, 7265.382442492236, 6751.459883209233, 6986.126734158231, 7008.929910700827, 7013.333733295329, 7013.473989450709, 5695.658260504218, 5973.835102155038, 6659.0, 6935.029095926473, 6980.406665433495, 6841.350071743176, 6852.6916288768125, 6859.142607174103, 6870.793876183722, 6877.071595334766, 6981.301869812978, 6987.685554150177, 6994.6852391643515, 6999.650017499206, 7006.0, 5995.760169593342, 6157.692115394302, 6800.217974932946, 6836.248012718497, 6840.657967101525], "unit": "score", "name": "prototype.html", "value": 5138.040426032045}, {"lowerIsBetter": false, "replicates": [730.7734602273296, 777.9105402878668, 793.4564823096176, 793.765839077472, 826.5784449930534, 15144.697106057873, 15245.085294882301, 15430.537083887473, 15450.4592339268, 15458.0, 14454.710905781878, 14553.981221314485, 14575.854241457582, 14579.489717859877, 14602.0, 774.4772278711876, 784.419529548136, 975.7121649113528, 986.9506524673774, 1011.3072545306452, 1023.8617786598826, 1027.8972102789699, 1028.6913925822262, 1029.3926583315879, 1029.53156313877, 1075.7256899490658, 1084.4198353880674, 1085.2620218251625, 1087.7335052912008, 1090.5637744902024, 792.065362871811, 931.5994122527311, 1039.521819962818, 1064.4677661169414, 1071.7481391872905, 768.5388766739967, 793.8809178623195, 796.3828033274201, 797.9521228726295, 800.0799081056773, 15286.312115954697, 15347.462838800588, 15368.385264589402, 15368.924175307733, 15382.846171538253, 13127.79316070212, 13220.33898305081, 13429.798553021616, 13699.589012329647, 13732.65668358289, 10254.846177307347, 10455.94772026135, 10459.110975567086, 10605.469726513644, 10733.624323148651, 3538.9469157962653, 3568.2506673598577, 3583.4087375583, 3616.3671357512594, 3793.430985352192, 81831.0, 81920.59039704764, 82084.58957705233, 84960.57519712424, 85358.57320713357, 9787.657431989846, 9918.40489570628, 10045.547950342252, 10062.647807326855, 10085.193184545218, 21948.0, 22235.332940011827, 22247.22134725277, 22258.332250032527, 22289.331320060424, 7657.63292282959, 7790.376769858398, 7827.765167044998, 7897.131315555284, 7995.600219988977, 4230.238557059759, 4257.936130958038, 4259.936100958488, 4274.081072569413, 4353.172897149531, 3126.577911981899, 3816.637419445148, 3821.7324787264624, 3824.770513769183, 3827.61723827615, 590.5570821883588, 688.786476192382, 699.720111955222, 704.2886684448744, 712.8431745016088, 576.6684156609966, 612.3723183736705, 628.84593274648, 642.5983760149907, 664.8703502816904, 8106.878396824052, 8492.0, 8526.616302266413, 8600.0, 8606.182412670787, 536.4849744245568, 549.4148731600833, 609.186735707835, 614.9016157414792, 632.8576070384127, 3671.0, 3783.697304215656, 4072.552019277877, 4112.91774164515, 4114.526829414595, 97949.51025244828, 98147.0, 99232.0, 100062.99937000683, 100169.49915250378, 83005.0, 83185.58407207925, 83568.0, 84705.0, 85606.14393855982, 30563.0, 38428.615713843064, 70743.6462817693, 71673.0, 71875.64062179656, 8549.914500854911, 8640.654373824977, 8821.603027863634, 8863.0, 8864.42381245217, 52899.0, 53441.732791335795, 53882.191767124306, 54027.91944161173, 54999.90000199893, 73478.0, 73557.6322118386, 73568.0, 73941.0, 74530.06485654516, 11267.985881270724, 11711.824322634997, 11742.471588778355, 11756.823647645464, 11887.643370698894, 12069.0, 12117.454714538044, 12298.077644176901, 12304.323262220305, 12573.371331433575, 11639.59261425846, 11955.282683039046, 12183.939080304895, 12196.329201893626, 12322.445489952794, 11698.47356868926, 11794.705132371417, 11880.702982425508, 12160.939195303967, 12572.434240459384, 11432.657020289405, 11470.483828227583, 12024.939875300917, 12048.939755301168, 12105.33420661872, 9818.45998470091, 9898.851517227391, 10066.0, 10111.443870587189, 10171.23715721309, 9989.500524973868, 10068.798624027624, 10074.899251007397, 10108.39349639024, 10115.0], "unit": "score", "name": "yui.html", "value": 7227.578352396328}], "name": "dromaeo_css", "value": 7720.163974699868}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 110.0, 111.0, 110.0, 118.0, 108.0, 118.0, 161.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 161.0, 149.0, 118.0, 136.0, 119.0, 149.0, 146.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 136.9}, {"lowerIsBetter": true, "replicates": [182.0, 187.0, 258.0, 186.0, 184.0, 186.0, 183.0, 185.0, 185.0, 183.0], "unit": "score", "name": "audio-dft", "value": 191.9}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 74.0, 118.0, 57.0, 56.0, 59.0, 57.0, 117.0, 54.0], "unit": "score", "name": "audio-fft", "value": 73.9}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 127.0, 79.0, 77.0, 87.0, 116.0, 76.0, 79.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.7}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 84.0, 87.0, 84.0, 134.0, 85.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 92.0, 92.0, 93.0, 92.0, 91.0], "unit": "score", "name": "imaging-darkroom", "value": 92.1}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 84.0, 85.0, 84.0, 87.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0, 66.0, 49.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 68.0, 85.0, 108.0, 104.0, 84.0, 64.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.7}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 80.0, 78.0, 80.0, 79.0, 79.0, 81.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.4}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 129.0, 116.0, 125.0, 106.0, 131.0, 129.0, 131.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [131.0, 117.0, 130.0, 131.0, 130.0, 119.0, 132.0, 132.0, 130.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 128.4}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 68.0, 65.0, 67.0, 66.0, 67.0, 65.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1412.4}]} 16:39:34 INFO - Return code: 0 16:39:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:39:34 INFO - # TBPL SUCCESS # 16:39:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:35 INFO - 2016-03-28 16:39:35.009 screenresolution[1680:9707] starting screenresolution argv=screenresolution get 16:39:35 INFO - 2016-03-28 16:39:35.011 screenresolution[1680:9707] Display 0: 1600x1200x32@60 16:39:35 INFO - 2016-03-28 16:39:35.017 screenresolution[1681:9710] starting screenresolution argv=screenresolution list 16:39:35 INFO - Available Modes on Display 0 16:39:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:35 INFO - Intel Iris: 16:39:35 INFO - Chipset Model: Intel Iris 16:39:35 INFO - Type: GPU 16:39:35 INFO - Bus: Built-In 16:39:35 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:35 INFO - Vendor: Intel (0x8086) 16:39:35 INFO - Device ID: 0x0a2e 16:39:35 INFO - Revision ID: 0x0009 16:39:35 INFO - Displays: 16:39:35 INFO - Display: 16:39:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:35 INFO - Display Serial Number: 1600x1200 60 16:39:35 INFO - Main Display: Yes 16:39:35 INFO - Mirror: Off 16:39:35 INFO - Online: Yes 16:39:35 INFO - Rotation: Supported 16:39:35 INFO - Return code: 0 16:39:35 INFO - Running post-action listener: _resource_record_post_action 16:39:35 INFO - Running post-run listener: _resource_record_post_run 16:39:36 INFO - Total resource usage - Wall time: 1202s; CPU: 52.0%; Read bytes: 37725696; Write bytes: 664677376; Read time: 463; Write time: 1848 16:39:36 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360329728; Write bytes: 355153920; Read time: 28392; Write time: 702 16:39:36 INFO - run-tests - Wall time: 1171s; CPU: 52.0%; Read bytes: 35907072; Write bytes: 299398144; Read time: 377; Write time: 1112 16:39:36 INFO - Running post-run listener: _upload_blobber_files 16:39:36 INFO - Blob upload gear active. 16:39:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:36 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 16:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:39:36 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:39:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:37 INFO - (blobuploader) - INFO - Done attempting. 16:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:39:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:38 INFO - (blobuploader) - INFO - Done attempting. 16:39:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:38 INFO - Return code: 0 16:39:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e315f02a740ed70b685295c70aa1c527ea4aaf5a0d0f9d0d8a984d1d95671834ab7f0e5f6cccd32d73e4d0338756840280774b2dcbbe50d64d4c9574873fb49a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9910c92185964c57edb9194a8946873ca902c5c83f51b59fdc7d754f2411196ed0b83fd19d1a6667f769c29b6884d794bad66e576d2f3bee745d0998be58665"} 16:39:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:38 INFO - Contents: 16:39:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e315f02a740ed70b685295c70aa1c527ea4aaf5a0d0f9d0d8a984d1d95671834ab7f0e5f6cccd32d73e4d0338756840280774b2dcbbe50d64d4c9574873fb49a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9910c92185964c57edb9194a8946873ca902c5c83f51b59fdc7d754f2411196ed0b83fd19d1a6667f769c29b6884d794bad66e576d2f3bee745d0998be58665"} 16:39:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:38 INFO - Copying logs to upload dir... 16:39:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.073397 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-28 16:39:38.886006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 16:39:38.889222) ========= 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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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/Mozilla-Aurora/sha512/e315f02a740ed70b685295c70aa1c527ea4aaf5a0d0f9d0d8a984d1d95671834ab7f0e5f6cccd32d73e4d0338756840280774b2dcbbe50d64d4c9574873fb49a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9910c92185964c57edb9194a8946873ca902c5c83f51b59fdc7d754f2411196ed0b83fd19d1a6667f769c29b6884d794bad66e576d2f3bee745d0998be58665"} build_url:https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/Nz3T-Y98S-SuWXGYE3gV1g/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e315f02a740ed70b685295c70aa1c527ea4aaf5a0d0f9d0d8a984d1d95671834ab7f0e5f6cccd32d73e4d0338756840280774b2dcbbe50d64d4c9574873fb49a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a9910c92185964c57edb9194a8946873ca902c5c83f51b59fdc7d754f2411196ed0b83fd19d1a6667f769c29b6884d794bad66e576d2f3bee745d0998be58665"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-28 16:39:38.916526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:39:38.916821) ========= 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.TUZGEBi2XY/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.6GRPp5jtJm/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005108 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-28 16:39:38.968516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 16:39:38.968809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-28 16:39:38.969168) ========= ========= Total master_lag: 0.27 =========