builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0124 starttime: 1458349888.62 results: success (0) buildid: 20160318161539 builduid: f63d1f09720a4136baeb1df373b6a7cf revision: 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.622616) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.623079) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.623374) ========= 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.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005541 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.648291) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.649010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.666688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.666992) ========= 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.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005370 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.715288) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.715593) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.715944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.716218) ========= 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.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-18 18:11:28-- 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% 28.6M=0s 2016-03-18 18:11:28 (28.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162736 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.897637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.899833) ========= 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.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.025791 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:28.948255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 18:11:28.950636) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-18 18:11:29,027 truncating revision to first 12 chars 2016-03-18 18:11:29,027 Setting DEBUG logging. 2016-03-18 18:11:29,027 attempt 1/10 2016-03-18 18:11:29,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7bfa7db399f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-18 18:11:30,116 unpacking tar archive at: fx-team-7bfa7db399f6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-18 18:11:30.299614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:30.300008) ========= echo 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7bfa7db399f60e99e9e4e35d6e9d9194819816e1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 program finished with exit code 0 elapsedTime=0.005517 script_repo_revision: '7bfa7db399f60e99e9e4e35d6e9d9194819816e1' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:30.350276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:30.350737) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-18 18:11:30.365202) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-18 18:11:30.365777) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:11:30 INFO - MultiFileLogger online at 20160318 18:11:30 in /builds/slave/test 18:11:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:11:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:30 INFO - {'append_to_log': False, 18:11:30 INFO - 'base_work_dir': '/builds/slave/test', 18:11:30 INFO - 'blob_upload_branch': 'Fx-Team', 18:11:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:30 INFO - 'branch': 'Fx-Team', 18:11:30 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:30 INFO - 'config_files': ('talos/mac_config.py',), 18:11:30 INFO - 'default_actions': ('clobber', 18:11:30 INFO - 'read-buildbot-config', 18:11:30 INFO - 'download-and-extract', 18:11:30 INFO - 'populate-webroot', 18:11:30 INFO - 'create-virtualenv', 18:11:30 INFO - 'install', 18:11:30 INFO - 'run-tests'), 18:11:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:30 INFO - 'download_minidump_stackwalk': True, 18:11:30 INFO - 'download_symbols': 'ondemand', 18:11:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:30 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:30 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:30 INFO - 'installer_path': 'installer.exe', 18:11:30 INFO - 'log_level': 'info', 18:11:30 INFO - 'log_name': 'talos', 18:11:30 INFO - 'log_to_console': True, 18:11:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:11:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:11:30 INFO - 'opt_config_files': (), 18:11:30 INFO - 'pip_index': False, 18:11:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:30 INFO - 'cmd': ('bash', 18:11:30 INFO - '-c', 18:11:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:30 INFO - 'enabled': True, 18:11:30 INFO - 'halt_on_failure': False, 18:11:30 INFO - 'name': 'check_screen_resolution'},), 18:11:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:30 INFO - 'cmd': ('bash', 18:11:30 INFO - '-c', 18:11:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:30 INFO - 'enabled': True, 18:11:30 INFO - 'halt_on_failure': False, 18:11:30 INFO - 'name': 'check_screen_resolution'},), 18:11:30 INFO - 'run_cmd_checks_enabled': True, 18:11:30 INFO - 'sps_profile': False, 18:11:30 INFO - 'sps_profile_interval': 0, 18:11:30 INFO - 'suite': 'dromaeojs', 18:11:30 INFO - 'system_bits': '32', 18:11:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:30 INFO - 'title': 't-yosemite-r7-0124', 18:11:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:30 INFO - 'use_talos_json': True, 18:11:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:30 INFO - 'work_dir': 'build'} 18:11:30 INFO - ##### 18:11:30 INFO - ##### Running clobber step. 18:11:30 INFO - ##### 18:11:30 INFO - Running pre-action listener: _resource_record_pre_action 18:11:30 INFO - Running main action method: clobber 18:11:30 INFO - rmtree: /builds/slave/test/build 18:11:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:32 INFO - Running post-action listener: _resource_record_post_action 18:11:32 INFO - ##### 18:11:32 INFO - ##### Running read-buildbot-config step. 18:11:32 INFO - ##### 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: read_buildbot_config 18:11:32 INFO - Using buildbot properties: 18:11:32 INFO - { 18:11:32 INFO - "project": "", 18:11:32 INFO - "product": "firefox", 18:11:32 INFO - "script_repo_revision": "production", 18:11:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:11:32 INFO - "repository": "", 18:11:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:11:32 INFO - "buildid": "20160318161539", 18:11:32 INFO - "pgo_build": "False", 18:11:32 INFO - "basedir": "/builds/slave/test", 18:11:32 INFO - "buildnumber": 552, 18:11:32 INFO - "slavename": "t-yosemite-r7-0124", 18:11:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:11:32 INFO - "platform": "yosemite_r7", 18:11:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:11:32 INFO - "branch": "fx-team", 18:11:32 INFO - "repo_path": "integration/fx-team", 18:11:32 INFO - "revision": "7bfa7db399f60e99e9e4e35d6e9d9194819816e1", 18:11:32 INFO - "stage_platform": "macosx64", 18:11:32 INFO - "builduid": "f63d1f09720a4136baeb1df373b6a7cf", 18:11:32 INFO - "slavebuilddir": "test" 18:11:32 INFO - } 18:11:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:11:32 INFO - Running post-action listener: _resource_record_post_action 18:11:32 INFO - ##### 18:11:32 INFO - ##### Running download-and-extract step. 18:11:32 INFO - ##### 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: download_and_extract 18:11:32 INFO - mkdir: /builds/slave/test/build/tests 18:11:32 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')]} 18:11:32 INFO - https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:11:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:11:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:11:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:11:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 18:11:34 INFO - Downloaded 1199 bytes. 18:11:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:11:34 INFO - Using the following test package requirements: 18:11:34 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:11:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:11:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:11:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'jsshell-mac.zip'], 18:11:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:11:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:11:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:11:34 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:11:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:11:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:11:34 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:11:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:34 INFO - https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:11:35 INFO - Downloaded 17871366 bytes. 18:11:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:11:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:11:39 INFO - Return code: 0 18:11:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:39 INFO - https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:11:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:11:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:11:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:11:40 INFO - Downloaded 17871366 bytes. 18:11:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:11:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:11:43 INFO - Return code: 0 18:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:43 INFO - https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:11:44 INFO - Downloaded 10846565 bytes. 18:11:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:11:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 18:11:44 INFO - Return code: 0 18:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:44 INFO - https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 18:11:47 INFO - Downloaded 111187797 bytes. 18:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:11:47 INFO - mkdir: /builds/slave/test/properties 18:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 18:11:47 INFO - Contents: 18:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:11:49 INFO - Running post-action listener: _resource_record_post_action 18:11:49 INFO - Running post-action listener: set_extra_try_arguments 18:11:49 INFO - ##### 18:11:49 INFO - ##### Running populate-webroot step. 18:11:49 INFO - ##### 18:11:49 INFO - Running pre-action listener: _resource_record_pre_action 18:11:49 INFO - Running main action method: populate_webroot 18:11:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:11:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:11:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:11:49 INFO - '--tppagecycles', 18:11:49 INFO - '7'], 18:11:49 INFO - 'tests': ['tsvgm']}}, 18:11:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:11:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:11:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:11:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:11:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'tests': ['damp', 'tps']}, 18:11:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['damp', 'tps']}, 18:11:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:11:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:11:49 INFO - 'other': {'tests': ['a11yr', 18:11:49 INFO - 'ts_paint', 18:11:49 INFO - 'tpaint', 18:11:49 INFO - 'sessionrestore', 18:11:49 INFO - 'sessionrestore_no_auto_restore', 18:11:49 INFO - 'tabpaint']}, 18:11:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['a11yr', 18:11:49 INFO - 'ts_paint', 18:11:49 INFO - 'tpaint', 18:11:49 INFO - 'sessionrestore', 18:11:49 INFO - 'sessionrestore_no_auto_restore', 18:11:49 INFO - 'tabpaint']}, 18:11:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['a11yr', 18:11:49 INFO - 'ts_paint', 18:11:49 INFO - 'tpaint', 18:11:49 INFO - 'sessionrestore', 18:11:49 INFO - 'sessionrestore_no_auto_restore', 18:11:49 INFO - 'tabpaint']}, 18:11:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['a11yr', 18:11:49 INFO - 'ts_paint', 18:11:49 INFO - 'tpaint', 18:11:49 INFO - 'sessionrestore', 18:11:49 INFO - 'sessionrestore_no_auto_restore', 18:11:49 INFO - 'tabpaint']}, 18:11:49 INFO - 'other_l64': {'tests': ['a11yr', 18:11:49 INFO - 'ts_paint', 18:11:49 INFO - 'tpaint', 18:11:49 INFO - 'sessionrestore', 18:11:49 INFO - 'sessionrestore_no_auto_restore', 18:11:49 INFO - 'tabpaint']}, 18:11:49 INFO - 'other_nol64': {'tests': ['a11yr', 18:11:49 INFO - 'ts_paint', 18:11:49 INFO - 'tpaint', 18:11:49 INFO - 'sessionrestore', 18:11:49 INFO - 'sessionrestore_no_auto_restore', 18:11:49 INFO - 'tabpaint']}, 18:11:49 INFO - 'svgr': {'tests': ['tsvgx', 18:11:49 INFO - 'tsvgr_opacity', 18:11:49 INFO - 'tart', 18:11:49 INFO - 'tscrollx', 18:11:49 INFO - 'cart']}, 18:11:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['tsvgx', 18:11:49 INFO - 'tsvgr_opacity', 18:11:49 INFO - 'tart', 18:11:49 INFO - 'tscrollx', 18:11:49 INFO - 'cart']}, 18:11:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'tests': ['tp5o']}, 18:11:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'talos_options': ['--e10s'], 18:11:49 INFO - 'tests': ['tp5o']}, 18:11:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'talos_options': ['--xperf_path', 18:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:49 INFO - 'tests': ['tp5n']}, 18:11:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:11:49 INFO - 'talos_options': ['--e10s', 18:11:49 INFO - '--xperf_path', 18:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:49 INFO - 'tests': ['tp5n']}}, 18:11:49 INFO - 'talos.zip': {'path': '', 18:11:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:11:49 INFO - Running post-action listener: _resource_record_post_action 18:11:49 INFO - ##### 18:11:49 INFO - ##### Running create-virtualenv step. 18:11:49 INFO - ##### 18:11:49 INFO - Running pre-action listener: _resource_record_pre_action 18:11:49 INFO - Running main action method: create_virtualenv 18:11:49 INFO - Creating virtualenv /builds/slave/test/build/venv 18:11:49 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 18:11:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:11:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:11:49 INFO - Using real prefix '/tools/python27' 18:11:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:52 INFO - Installing pip.................done. 18:11:52 INFO - Return code: 0 18:11:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11: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')]} 18:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11: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')]} 18:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:52 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:11:52 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 18:11:52 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 18:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:52 INFO - 'HOME': '/Users/cltbld', 18:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:52 INFO - 'LOGNAME': 'cltbld', 18:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:52 INFO - 'MOZ_NO_REMOTE': '1', 18:11:52 INFO - 'NO_EM_RESTART': '1', 18:11:52 INFO - 'PAGER': '/bin/cat', 18:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:52 INFO - 'PWD': '/builds/slave/test', 18:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:52 INFO - 'SHELL': '/bin/bash', 18:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:11:52 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:52 INFO - 'USER': 'cltbld', 18:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:52 INFO - 'XPC_FLAGS': '0x0', 18:11:52 INFO - 'XPC_SERVICE_NAME': '0', 18:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:53 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 18:11:53 INFO - Cleaning up... 18:11:53 INFO - Return code: 0 18:11:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:53 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:11:53 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 18:11:53 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 18:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:53 INFO - 'HOME': '/Users/cltbld', 18:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:53 INFO - 'LOGNAME': 'cltbld', 18:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:53 INFO - 'MOZ_NO_REMOTE': '1', 18:11:53 INFO - 'NO_EM_RESTART': '1', 18:11:53 INFO - 'PAGER': '/bin/cat', 18:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:53 INFO - 'PWD': '/builds/slave/test', 18:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:53 INFO - 'SHELL': '/bin/bash', 18:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:11:53 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:53 INFO - 'USER': 'cltbld', 18:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:53 INFO - 'XPC_FLAGS': '0x0', 18:11:53 INFO - 'XPC_SERVICE_NAME': '0', 18:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:53 INFO - Downloading/unpacking psutil>=0.7.1 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 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 18:11:53 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 18:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:55 INFO - Installing collected packages: psutil 18:11:55 INFO - Running setup.py install for psutil 18:11:55 INFO - building 'psutil._psutil_osx' extension 18:11:55 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 18:11:56 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 18:11:56 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 18:11:56 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 18:11:56 INFO - building 'psutil._psutil_posix' extension 18:11:56 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 18:11:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:11:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:11:56 INFO - ^ 18:11:56 INFO - 1 warning generated. 18:11:56 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 18:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:56 INFO - Successfully installed psutil 18:11:56 INFO - Cleaning up... 18:11:57 INFO - Return code: 0 18:11:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:57 INFO - 'HOME': '/Users/cltbld', 18:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:57 INFO - 'LOGNAME': 'cltbld', 18:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:57 INFO - 'MOZ_NO_REMOTE': '1', 18:11:57 INFO - 'NO_EM_RESTART': '1', 18:11:57 INFO - 'PAGER': '/bin/cat', 18:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:57 INFO - 'PWD': '/builds/slave/test', 18:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:57 INFO - 'SHELL': '/bin/bash', 18:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:11:57 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:57 INFO - 'USER': 'cltbld', 18:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:57 INFO - 'XPC_FLAGS': '0x0', 18:11:57 INFO - 'XPC_SERVICE_NAME': '0', 18:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:11:57 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 18:11:57 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 18:11:57 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 18:11:57 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 18:11:57 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 18:11:57 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 18:11:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:11:59 INFO - Installing collected packages: mozsystemmonitor 18:11:59 INFO - Running setup.py install for mozsystemmonitor 18:11:59 INFO - Successfully installed mozsystemmonitor 18:11:59 INFO - Cleaning up... 18:11:59 INFO - Return code: 0 18:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:11:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:00 INFO - 'HOME': '/Users/cltbld', 18:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:00 INFO - 'LOGNAME': 'cltbld', 18:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:00 INFO - 'MOZ_NO_REMOTE': '1', 18:12:00 INFO - 'NO_EM_RESTART': '1', 18:12:00 INFO - 'PAGER': '/bin/cat', 18:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:00 INFO - 'PWD': '/builds/slave/test', 18:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:00 INFO - 'SHELL': '/bin/bash', 18:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:00 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:00 INFO - 'USER': 'cltbld', 18:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:00 INFO - 'XPC_FLAGS': '0x0', 18:12:00 INFO - 'XPC_SERVICE_NAME': '0', 18:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:03 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 18:12:03 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 18:12:03 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 18:12:03 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 18:12:03 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 18:12:03 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 18:12:03 INFO - Downloading docopt-0.6.1.tar.gz 18:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:03 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:03 INFO - Running setup.py install for blobuploader 18:12:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:03 INFO - Running setup.py install for requests 18:12:04 INFO - Running setup.py install for docopt 18:12:04 INFO - Successfully installed blobuploader requests docopt 18:12:04 INFO - Cleaning up... 18:12:04 INFO - Return code: 0 18:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:04 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:12:04 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 18:12:04 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 18:12:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:04 INFO - 'HOME': '/Users/cltbld', 18:12:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:04 INFO - 'LOGNAME': 'cltbld', 18:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:04 INFO - 'MOZ_NO_REMOTE': '1', 18:12:04 INFO - 'NO_EM_RESTART': '1', 18:12:04 INFO - 'PAGER': '/bin/cat', 18:12:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:04 INFO - 'PWD': '/builds/slave/test', 18:12:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:04 INFO - 'SHELL': '/bin/bash', 18:12:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:04 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:04 INFO - 'USER': 'cltbld', 18:12:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:04 INFO - 'XPC_FLAGS': '0x0', 18:12:04 INFO - 'XPC_SERVICE_NAME': '0', 18:12:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:04 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-j9JEm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-I18WYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-pRoHDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-KTvf9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-1660XR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-4DUyqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-48Ut4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-fiJ2d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-g6fjQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-JzDbvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:05 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qgHsrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:06 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-HrWWYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:06 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-TaemOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:06 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-5w29Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:06 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-AJOlxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:06 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ITpOjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:06 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jDy19k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:06 INFO - Running setup.py install for manifestparser 18:12:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:06 INFO - Running setup.py install for mozcrash 18:12:07 INFO - Running setup.py install for mozdebug 18:12:07 INFO - Running setup.py install for mozdevice 18:12:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozfile 18:12:07 INFO - Running setup.py install for mozhttpd 18:12:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozinfo 18:12:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozInstall 18:12:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:07 INFO - Running setup.py install for mozleak 18:12:08 INFO - Running setup.py install for mozlog 18:12:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:08 INFO - Running setup.py install for moznetwork 18:12:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:08 INFO - Running setup.py install for mozprocess 18:12:08 INFO - Running setup.py install for mozprofile 18:12:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:08 INFO - Running setup.py install for mozrunner 18:12:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:08 INFO - Running setup.py install for mozscreenshot 18:12:08 INFO - Running setup.py install for moztest 18:12:09 INFO - Running setup.py install for mozversion 18:12:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:09 INFO - Cleaning up... 18:12:09 INFO - Return code: 0 18:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:12:09 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 18:12:09 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 18:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:09 INFO - 'HOME': '/Users/cltbld', 18:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:09 INFO - 'LOGNAME': 'cltbld', 18:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:09 INFO - 'MOZ_NO_REMOTE': '1', 18:12:09 INFO - 'NO_EM_RESTART': '1', 18:12:09 INFO - 'PAGER': '/bin/cat', 18:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:09 INFO - 'PWD': '/builds/slave/test', 18:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:09 INFO - 'SHELL': '/bin/bash', 18:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:09 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:09 INFO - 'USER': 'cltbld', 18:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:09 INFO - 'XPC_FLAGS': '0x0', 18:12:09 INFO - 'XPC_SERVICE_NAME': '0', 18:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-TXbYpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Y0D39P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-6xSAik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:09 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)) 18:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:09 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ixSlSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-LHCA9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Z3b_gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-akN6cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qoYFpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-6f81am-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-P3DwI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-kHcOlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wtfxWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-dA8j4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:10 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)) 18:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:10 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zFN_GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:11 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)) 18:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-dzqNKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:11 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)) 18:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-NBij7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:11 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)) 18:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:11 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-8WWfF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:11 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)) 18:12:11 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)) 18:12:11 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)) 18:12:11 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)) 18:12:11 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)) 18:12:11 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)) 18:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:11 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 18:12:11 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 18:12:11 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 18:12:11 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 18:12:11 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 18:12:11 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 18:12:13 INFO - Downloading blessings-1.6.tar.gz 18:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:13 INFO - Installing collected packages: blessings 18:12:13 INFO - Running setup.py install for blessings 18:12:13 INFO - Successfully installed blessings 18:12:13 INFO - Cleaning up... 18:12:14 INFO - Return code: 0 18:12:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:14 INFO - Reading from file tmpfile_stdout 18:12:14 INFO - Current package versions: 18:12:14 INFO - blessings == 1.6 18:12:14 INFO - blobuploader == 1.2.4 18:12:14 INFO - docopt == 0.6.1 18:12:14 INFO - manifestparser == 1.1 18:12:14 INFO - mozInstall == 1.12 18:12:14 INFO - mozcrash == 0.17 18:12:14 INFO - mozdebug == 0.1 18:12:14 INFO - mozdevice == 0.48 18:12:14 INFO - mozfile == 1.2 18:12:14 INFO - mozhttpd == 0.7 18:12:14 INFO - mozinfo == 0.9 18:12:14 INFO - mozleak == 0.1 18:12:14 INFO - mozlog == 3.1 18:12:14 INFO - moznetwork == 0.27 18:12:14 INFO - mozprocess == 0.22 18:12:14 INFO - mozprofile == 0.28 18:12:14 INFO - mozrunner == 6.11 18:12:14 INFO - mozscreenshot == 0.1 18:12:14 INFO - mozsystemmonitor == 0.0 18:12:14 INFO - moztest == 0.7 18:12:14 INFO - mozversion == 1.4 18:12:14 INFO - psutil == 3.1.1 18:12:14 INFO - requests == 1.2.3 18:12:14 INFO - wsgiref == 0.1.2 18:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:14 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:12:14 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 18:12:14 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 18:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:14 INFO - 'HOME': '/Users/cltbld', 18:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:14 INFO - 'LOGNAME': 'cltbld', 18:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:14 INFO - 'MOZ_NO_REMOTE': '1', 18:12:14 INFO - 'NO_EM_RESTART': '1', 18:12:14 INFO - 'PAGER': '/bin/cat', 18:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:14 INFO - 'PWD': '/builds/slave/test', 18:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:14 INFO - 'SHELL': '/bin/bash', 18:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:14 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:14 INFO - 'USER': 'cltbld', 18:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:14 INFO - 'XPC_FLAGS': '0x0', 18:12:14 INFO - 'XPC_SERVICE_NAME': '0', 18:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 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)) 18:12:14 INFO - Cleaning up... 18:12:14 INFO - Return code: 0 18:12:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:14 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:12:14 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 18:12:14 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 18:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:14 INFO - 'HOME': '/Users/cltbld', 18:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:14 INFO - 'LOGNAME': 'cltbld', 18:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:14 INFO - 'MOZ_NO_REMOTE': '1', 18:12:14 INFO - 'NO_EM_RESTART': '1', 18:12:14 INFO - 'PAGER': '/bin/cat', 18:12:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:14 INFO - 'PWD': '/builds/slave/test', 18:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:14 INFO - 'SHELL': '/bin/bash', 18:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:14 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:14 INFO - 'USER': 'cltbld', 18:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:14 INFO - 'XPC_FLAGS': '0x0', 18:12:14 INFO - 'XPC_SERVICE_NAME': '0', 18:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:14 INFO - Downloading/unpacking jsonschema 18:12:14 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 18:12:14 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 18:12:14 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 18:12:14 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 18:12:14 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 18:12:14 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 18:12:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:17 INFO - Downloading/unpacking functools32 (from jsonschema) 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:17 INFO - warning: no files found matching '*.txt' 18:12:17 INFO - no previously-included directories found matching 'build' 18:12:17 INFO - no previously-included directories found matching 'dist' 18:12:17 INFO - no previously-included directories found matching '.git*' 18:12:17 INFO - Installing collected packages: jsonschema, functools32 18:12:17 INFO - Running setup.py install for functools32 18:12:17 INFO - warning: no files found matching '*.txt' 18:12:17 INFO - no previously-included directories found matching 'build' 18:12:17 INFO - no previously-included directories found matching 'dist' 18:12:17 INFO - no previously-included directories found matching '.git*' 18:12:17 INFO - Successfully installed jsonschema functools32 18:12:17 INFO - Cleaning up... 18:12:18 INFO - Return code: 0 18:12:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:18 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 0x10ea7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8184635d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, '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.a4baeHAhlt/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.rv42r4TUpO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 18:12:18 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 18:12:18 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 18:12:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:18 INFO - 'HOME': '/Users/cltbld', 18:12:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:18 INFO - 'LOGNAME': 'cltbld', 18:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:18 INFO - 'MOZ_NO_REMOTE': '1', 18:12:18 INFO - 'NO_EM_RESTART': '1', 18:12:18 INFO - 'PAGER': '/bin/cat', 18:12:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:18 INFO - 'PWD': '/builds/slave/test', 18:12:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:18 INFO - 'SHELL': '/bin/bash', 18:12:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:18 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:18 INFO - 'USER': 'cltbld', 18:12:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:18 INFO - 'XPC_FLAGS': '0x0', 18:12:18 INFO - 'XPC_SERVICE_NAME': '0', 18:12:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:18 INFO - Downloading/unpacking flake8 18:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:12:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12: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 18:12:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:12:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 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 18:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:12:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:12:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:12:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:12:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:12:21 INFO - no previously-included directories found matching 'docs/_build' 18:12:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:12:22 INFO - Running setup.py install for pep8 18:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:12:22 INFO - no previously-included directories found matching 'docs/_build' 18:12:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:12:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:12:22 INFO - Cleaning up... 18:12:22 INFO - Return code: 0 18:12:22 INFO - Running post-action listener: _resource_record_post_action 18:12:22 INFO - Running post-action listener: _start_resource_monitoring 18:12:22 INFO - Starting resource monitoring. 18:12:22 INFO - ##### 18:12:22 INFO - ##### Running install step. 18:12:22 INFO - ##### 18:12:22 INFO - Running pre-action listener: _resource_record_pre_action 18:12:22 INFO - Running main action method: install 18:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:22 INFO - Reading from file tmpfile_stdout 18:12:22 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:22 INFO - Reading from file tmpfile_stdout 18:12:22 INFO - Output received: 18:12:22 INFO - Usage: mozinstall [options] installer 18:12:22 INFO - Options: 18:12:22 INFO - -h, --help show this help message and exit 18:12:22 INFO - -d DEST, --destination=DEST 18:12:22 INFO - Directory to install application into. [default: 18:12:22 INFO - "/builds/slave/test"] 18:12:22 INFO - --app=APP Application being installed. [default: firefox] 18:12:22 INFO - mkdir: /builds/slave/test/build/application 18:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:12:56 INFO - Reading from file tmpfile_stdout 18:12:56 INFO - Output received: 18:12:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:12:56 INFO - Running post-action listener: _resource_record_post_action 18:12:56 INFO - ##### 18:12:56 INFO - ##### Running run-tests step. 18:12:56 INFO - ##### 18:12:56 INFO - Running pre-action listener: _resource_record_pre_action 18:12:56 INFO - Running main action method: run_tests 18:12:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:12:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:12:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:12:56 INFO - 2016-03-18 18:12:56.104 screenresolution[1649:7526] starting screenresolution argv=screenresolution get 18:12:56 INFO - 2016-03-18 18:12:56.107 screenresolution[1649:7526] Display 0: 1600x1200x32@60 18:12:56 INFO - 2016-03-18 18:12:56.113 screenresolution[1650:7528] starting screenresolution argv=screenresolution list 18:12:56 INFO - Available Modes on Display 0 18:12:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:12:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:12:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:12:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:12:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:12:56 INFO - Intel Iris: 18:12:56 INFO - Chipset Model: Intel Iris 18:12:56 INFO - Type: GPU 18:12:56 INFO - Bus: Built-In 18:12:56 INFO - VRAM (Dynamic, Max): 1536 MB 18:12:56 INFO - Vendor: Intel (0x8086) 18:12:56 INFO - Device ID: 0x0a2e 18:12:56 INFO - Revision ID: 0x0009 18:12:56 INFO - Displays: 18:12:56 INFO - Display: 18:12:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:12:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:12:56 INFO - Display Serial Number: 1600x1200 60 18:12:56 INFO - Main Display: Yes 18:12:56 INFO - Mirror: Off 18:12:56 INFO - Online: Yes 18:12:56 INFO - Rotation: Supported 18:12:56 INFO - Return code: 0 18:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:56 INFO - Python 2.7.3 18:12:56 INFO - Return code: 0 18:12:56 INFO - grabbing minidump binary from tooltool 18:12:56 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')]} 18:12:56 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 0x10e91ee00>, '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 0x10e747db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e919b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:56 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 18:12:56 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 18:12:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:56 INFO - Return code: 0 18:12:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:12:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:12:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:12:57 INFO - Return code: 0 18:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 18:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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 18:12:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4baeHAhlt/Render', 18:12:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:57 INFO - 'HOME': '/Users/cltbld', 18:12:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:57 INFO - 'LOGNAME': 'cltbld', 18:12:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:57 INFO - 'MOZ_NO_REMOTE': '1', 18:12:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:57 INFO - 'NO_EM_RESTART': '1', 18:12:57 INFO - 'PAGER': '/bin/cat', 18:12:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:57 INFO - 'PWD': '/builds/slave/test', 18:12:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:57 INFO - 'SHELL': '/bin/bash', 18:12:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rv42r4TUpO/Listeners', 18:12:57 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 18:12:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:57 INFO - 'USER': 'cltbld', 18:12:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:57 INFO - 'XPC_FLAGS': '0x0', 18:12:57 INFO - 'XPC_SERVICE_NAME': '0', 18:12:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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 18:12:57 INFO - mozversion application_buildid: 20160318161539 18:12:57 INFO - mozversion application_changeset: 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 18:12:57 INFO - mozversion application_display_name: Nightly 18:12:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:57 INFO - mozversion application_name: Firefox 18:12:57 INFO - mozversion application_remotingname: firefox 18:12:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:12:57 INFO - mozversion application_vendor: Mozilla 18:12:57 INFO - mozversion application_version: 48.0a1 18:12:57 INFO - mozversion platform_buildid: 20160318161539 18:12:57 INFO - mozversion platform_changeset: 7bfa7db399f60e99e9e4e35d6e9d9194819816e1 18:12:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:12:57 INFO - mozversion platform_version: 48.0a1 18:12:57 INFO - using testdate: 1458349977 18:12:57 INFO - actual date: 1458349977 18:12:57 INFO - starting webserver on 'localhost:49270' 18:12:57 INFO - SUITE-START | Running 2 tests 18:12:57 INFO - TEST-START | dromaeo_css 18:12:57 INFO - operating with platform_type : mac_ 18:12:57 INFO - Initialising browser for dromaeo_css test... 18:12:57 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpUfi4Lh/profile http://localhost:49270/getInfo.html) 18:13:00 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 18:13:00 INFO - PROCESS | 1668 | colorDepth:24 18:13:00 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 18:13:00 INFO - PROCESS | 1668 | __metrics 18:13:00 INFO - PROCESS | 1668 | 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" 18:13:00 ERROR - PROCESS | 1668 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:13:01 INFO - TEST-INFO | 1668: exit 0 18:13:01 INFO - Browser initialized. 18:13:01 INFO - Running cycle 1/1 for dromaeo_css test... 18:13:01 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpUfi4Lh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:13 INFO - PROCESS | 1671 | RSS: Main: 245460992 18:13:13 INFO - PROCESS | 1671 | 18:14:04 INFO - PROCESS | 1671 | 1458350044138 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] 18:16:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 18:16:16 INFO - PROCESS | 1671 | RSS: Main: 433442816 18:16:16 INFO - PROCESS | 1671 | 18:19:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 18:19:19 INFO - PROCESS | 1671 | RSS: Main: 386580480 18:19:19 INFO - PROCESS | 1671 | 18:22:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 18:22:22 INFO - PROCESS | 1671 | RSS: Main: 380899328 18:22:22 INFO - PROCESS | 1671 | 18:25:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 18:25:25 INFO - PROCESS | 1671 | RSS: Main: 343810048 18:25:25 INFO - PROCESS | 1671 | 18:28:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 18:28:28 INFO - PROCESS | 1671 | RSS: Main: 343814144 18:28:28 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 18:31:31 INFO - PROCESS | 1671 | RSS: Main: 383651840 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | __start_tp_report 18:31:31 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 18:31:31 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 18:31:31 INFO - PROCESS | 1671 | |i|pagename|runs| 18:31:31 INFO - PROCESS | 1671 | |0;dojo.html;3373.628900820909;3422.8801991930272;3446.1212390840333;3462.948055779162;3493.8427770750313;4951.3810773653295;5459.918101228484;5563.749631266593;5585.1063829787245;5590.776368945238;5555.916661250085;5582.413846546115;5606.467385598372;5728;5739.741711622976;5020.974895125538;5065.3668291463655;5071.264666623338;5092.79628814847;5233.188855727369;5127.051495473349;5129.871753206163;5180.1452760294505;5180.989707007135;5210.921836172461;4110.219058378899;4511;5026.698398096108;5087.287779710843;5093.236014597803;4535.7732113394195;5116.411612664517;5128.153854613985;5152.510511501401;5167.974160129213;5044.39467263927;5073.974630126862;5108.386993560796;5114.977004599095;5138.74306284688;5379.085555455582;5479.123340265578;5479.726013699299;5498.367687715924;5503.9174412383845;6078.513718902477;6086.239220097488;6102.633841969496;6103.6948152592195;6110.480609148228;6117.969410152965;6177.166082578839;6188.938110618881;6199.783007594758;6209.472194863397;5531.225628412026;5654.29321334829;5655.4344565543115;5694.316681998145;5765.423457654201;5728.484436400744;5800.810833779065;6220.595661282002;6231.563790534619;6248.343923888017;5915.911261331084;5944.167816505693;5994.1608174855555;5997.100434934795;6018.247719035121;6019.909701354483;6093.866968087961;6121.632702037892;6134.4172303631085;6156.8768624627255;6023.69881505923;6057.939420605826;6058.394160583995;6064.636121832704;6070.180525628984;6085.57400981927;6097.939020609826;6099.146119543268;6100.816975490742;6102.962496375627;4715;4814.325994360793;4814.855554333376;4819.903601928012;4937.975310123498;4241.766702831313;4251.681123915719;4338.501072376717;4348.565143485689;4439.134368798053;5554.555635549146;5569.275994120739;5571.916421253684;5584.5811564132855;5593.3847276799515;6088.8782224356155;6125.724342404603;6154.169187159766;6157.922363586444;6168.722407491674;5564.527015203672;5580.748866301026;5589.8323050307745;5594.1608758686525;5622.746976386073;5268.051750684837;5274.393444753826;5278.947210527922;5280.287161233261;5356.705381203993;5084.872878178076;6185.165002724574;6232.781852635136;6252.937470625327;6315.5579109462815;6132.509399247961;6178.1659475971965;6187.907181392193;6188.412100850412;6211.223597050369;6237.75048998035;6247.375262473898;6258.249010118815;6266.811995640138;6270.905936410866;5878.088896221093;5973.940260597338;5975.820725378246;6056.66688332146;6097.176881120992;6020.608660437058;6081.239845019372;6115.021596544531;6116.877662446637;6123.2958209804665;5900.085486749561;5928.199693041384;5947.078202878561;5953.255843019622;5957.523398128053;5972.58191926561;5973.850653733692;5975.40245975399;6010.579259451796;6047.881141988746;4973.751312434291;5428.37573679032;5806.535477161901;5815.738291776795;5828.271466066742;5654.915176272277;5789.768409263583;5934.347221805684;5951.642901425928;6011.428914253139;5807.477327040587;5830.912536312044;5839.240898683144;5840;5897.734601942837 18:31:31 INFO - PROCESS | 1671 | |1;ext.html;451.1720991979717;483.8918875774479;584.9208210850978;643.5334382572636;649.6816559885656;30139.643716032777;30653.693463065363;30725.84637076817;39824.004399890015;40278.59721402785;44889;45330;45351.09297814042;45473.54526454743;45564.0887182257;9562.521873906295;9765.462899540522;9779.511024448784;9788.510574471284;9800.460974646392;8855.937287525507;9362.906370936305;9614.519274036305;9799.118079372854;9817.705468835946;8662;9707.805843883118;9731.902680973171;9823.36148150368;9831;9699.466529340883;9807.950960245189;9815.852762208573;9823.656172033945;9855.55649995752;9564.521773911276;9721.222302215805;9733.90266097337;9737.659181928599;9751.609935602568;41991.7900410496;42258.36612450816;42285.78857105726;42363;42422.36366454505;2589.7539733725266;3123.9219019524467;3299.472084466498;3344.899653010389;3475.461303497962;26110.477790444274;28768;28880.566791498146;29627.555586666218;29932.700672993426;2739.411026629264;2788.6374771279807;2811.9156425307274;2872.942541149186;2934.9559756603667;493086;494409.9999999964;497648.9999999964;499661;500123;47158.76420617875;69048;69064;69734.65132674406;69896;45962;46125;46186.538134618895;46282.84292892705;46310;13441.46234150623;15618.76571851423;15950.361985520682;15953.361865525249;15986.440474583334;12646.177998430072;12747.235165890077;12747.553835615709;12764.425600847984;12765.68085797844;14735.778963315559;14743.926280368529;15015.849841501664;15032;15192.696146077016;6122.418370254819;6243.719032643542;6296.496280297565;6363.7726795621165;6370.872582548323;972.9513524323755;974.2546951582045;974.3715303629119;1002.4436437776958;1138.3056335635256;28415.289617759307;29235.707642923724;29277.682504287357;29358.97243596464;29778.702212978027;1106.833974903771;1126.5662719852917;1159.7390587117832;1162.3200427749691;1210.334316126127;15066.322015509328;15080.472183473745;15185.772213416807;15274.007189532645;15279.694406112038;534104;537620;539674;540018;543322;61109.38890611126;61692.69153654203;61823.072653910225;61937.38062619406;62103;1332.486992507872;1450.6735984403635;1455.5560554030699;1466.2741942738412;1490.880729541634;23590;23645.81770911413;24317.756822432257;28828.567571486026;29578.260543485725;47410.52589474061;47835.043299133125;47887.521124788305;47972.520274798204;48403;292940.53529732215;378521;379014;379033;379033;28923.855380723802;33646.831765841016;33774.49338259977;34523;34639.30721385508;42648.78675606602;43348.783256083516;43988.34017489804;44066.33900491559;44238;34133.31733365269;34200.65799342074;34863.65136348604;35065.824670877504;35169.41737621762;34790.82604586961;34916.47625285674;34969.77605783887;35775.82112089527;35900;36012;36079.098022549646;36588;36852.262954741294;36875.63124368722;30264.55238057171;32183.51724724084;32285.35429291448;32405.837970809996;32414.027579172664;20972;23980.52038959246;24288.757112428648;24616.6307505384;24663.38341541476 18:31:31 INFO - PROCESS | 1671 | |2;jquery.html;316.7671761255477;362.20676717987607;369.7467234944063;373.21252157946725;373.48832100022975;19541.902290488546;20023;21099.945002749857;21617.67573486395;21659;16769.91615041923;20680.505541202412;20924.790752092475;21259;21282.57434851302;5727.684977326256;5877.118432235156;5947.970260148715;5948.583599148062;5951.166836642852;4212.178625168093;4513.458384993805;5942.465178133967;6552.508561857856;6591.472682185437;5249.527542521172;6328.778492752755;6341.492680585542;6361.586496877711;6525.184351956005;6155.692215389257;6257.186565746447;6324.588901721373;6326.65203413812;6326.84182895429;5475.151351540518;5499.862503437406;5504.724763761796;5511.200875873016;5515.696636684981;25501.724913754424;25797.48405031889;25993.610095848577;26027;26243;2055.3011975928107;2069.4929742213103;2156.6010288096754;2158.2554018863466;2243.7980581747556;9243.953780231122;9704.078112579293;13076.803847942288;14543.709125817424;15171.165585892772;1677.2117104960648;1685.1237356574636;1704.795424549062;1734.904580248086;1833.0193346559527;97314.51342743241;97527.7399260272;98640;100323.49838250762;102751;10772.353658780497;11054.502547385388;11159.721006974729;11255.212135150625;11315.603953861575;13464.394102265422;13555.661108472366;13569.118007329493;13571.1857288563;13576.77808997195;8414.15858414166;8478.194571515696;8482.236598706022;8487.745367638981;8574.485530868167;8757.868631970525;8777.69278075277;8790.912090879137;8791.604377803014;8886.777830554287;4463.375127482155;4484.990877052637;4485.887852803706;4526.230540808005;4589.472210695746;1832.2121487760126;1870.4014715291248;1881.3509339277928;1897.2885168061978;1905.4759941016332;755.6675062972274;764.8049747314399;851.4082712514743;902.801383695586;958.4488918871538;16609.83390166107;19004.809951900304;20120.59758804845;20205.49486262855;20292;999.5502024089044;1022.3865680591585;1027.5786927359895;1051.5951358726945;1069.6309773128257;10836.349819010884;11269.66191014271;11272.605458808903;11295.830562541569;11365.261258018203;595952;604291;639734;645614;647462;119683.20475192879;119887;124044;126217.10674339892;126285;993.0913214408735;1018.3686114608842;1034.182995433614;1034.5603118674533;1036.1555332404066;17931.193096310435;18080.81919180844;18171.909140454212;18738.344157954405;18963.715544267125;49163.508364917325;50096.74951625364;50226.74433139201;50334.244986324506;50933.490665092875;69223.65388173026;72508.63745681237;72664;72989.90515142384;74368.62815686103;7526.548407095592;7742.148363680103;7749.070111586646;7844.725434609762;8088.919110809052;8668;11217.66347009591;11899.940500297444;12376;12514.374281286082;10614.681559553226;10796.190285728444;10808.729781755519;10968.23222374426;10997.61508347204;9825.312228143961;10224.693259202237;10622.681319560426;10690;10850.240483166419;10780.676579702622;10969.122470202525;10990;11083.390413527333;11214.831777523506;7702.114256860533;7783.688652453839;7850.685972561262;7901.130875603794;8127.634256458356;9666.323357364918;9890.802183956424;10452.320599161334;10745.355278683304;11008.39453830015 18:31:31 INFO - PROCESS | 1671 | |3;mootools.html;1456.9873937613363;1589.5787616281684;1613.096665867114;1894.8389386902113;2025.058347868241;7937.5237485750895;8471.237588617023;8652.091530389305;8675.305975521958;8676.95661521693;8337.16628337166;8565.785855353604;8578.099299573549;8584.613692383859;8596.183362580561;2156.1914282144194;2202.3282898715884;2209.5801797658473;2426.817988650849;2477.7893879020303;2219.345293138528;2432.221689059502;2490.987545062272;2495.263897150345;2496.10140349474;2040.3776848061336;2421.83047186697;2456.8403053801535;2462.22439931421;2467.0748469324003;2443.364725171459;2443.841150325241;2447.2291228263216;2451.521953219123;2451.558719430493;2401;2450.718167410753;2454.202384225116;2460.963085553718;2466.050570530341;8645.351598630064;8742.388032837704;8742.562871856382;8747.387682862201;8754.474731516066;5328.946710532922;5437.918431223535;5484.725763711838;5495.422980587021;5496.4503549645115;3537.7523573349877;3539.6460353964653;3717.8141092945243;3725.403935370328;3741.5323084614424;1045.1273186888957;1049.5644307612408;1055.5724931402794;1073.420353009374;1073.8335557988523;11441.427928603536;11532.36571988532;11555.248908820984;11620.6513804586;11688.357140357277;4807.471178170398;4908.901821963541;4960.206366981266;4971.37857767779;4978.65149439543;9974.45140517264;10054.34646747959;10063.748406289902;10067.848982265272;10110.191184705205;5471.863203419866;5478.068728316196;5479.369872464637;5480.780768769284;5482.424345443751;4421.358902959053;4570.542945705402;4893.290472881412;4960.181570040975;4961.627877909171;3883.184531248413;3904.316744569689;3973.940390894139;3978.264021156095;3981.343078392033;1299.811527328532;1311.6392991927105;1324.0599174586152;1328.0570794735652;1337.518493342396;1351.5607427585878;1351.9526816561372;1376.0436496634743;1413.7313910357;1420.112429731418;7904.20957904205;8039.15588863161;8048.114707382183;8054.436189466681;8060.919390806017;1201.567435723139;1212.7695737809963;1230.913836031487;1231.2550906701497;1255.121415009497;6259.2488901332135;6289;6358.268799088164;6359.459445947146;6367.777127800598;10181.440020798927;10548.578056877639;10603.098736607475;10670;10679;10114.089731924016;10481.423521706227;10481.423521706227;10530.210234232463;10556.47217639115;8012.759617211493;8126.024877014796;8151.5109093454585;8202.58987050645;8222.876656850032;7559.811004724926;7740.458167928191;7811;7821.843563128819;7824.530528168328;9174.26605871542;9331.72004839856;9444.291678124306;9508.524573771145;9552.713418597454;8221.876671850046;9571.425714457155;9722.513874306398;9800.11798938099;9985.101340879355;6667.966660166862;7062.505624606229;7449.4412919032375;7492.550446973199;7524.887126693214;6656.467482601283;8140.87788683182;8146.389020823343;8147.307478864126;8164.387670924823;7031.718731250693;7141.642917853983;7164.247753985756;7271;7299.197088320174;7029.683664235019;7041;7081.681324340314;7178.676959536729;7201.783946481614;6034.7284372202475;7514.211007844317;7565.773026809205;7617.200193979553;7626.504277221963;6912.516123871281;6922.238553758982;6970.302969702989;6973.232944376216;6985.336393042653;6909.136357955255;7022.894656580053;7023.157221133497;7067.081279433641;7102.147742270754 18:31:31 INFO - PROCESS | 1671 | |4;prototype.html;298.2097441779285;316.87483444039606;327.13146595788174;327.28324968319384;336.54230246864273;6389.0735843302755;6448.193975753031;6451.935480645192;6476.773312934049;6559.212894452672;6423.550351475398;6452.51606129541;6455.128557644716;6471.773487927923;6484.22189337279;4616.44602647681;4767.5709186173235;4770.8750768246855;4827.493113223122;4858.854234372974;3856.9807150964207;4073.61497090989;4641.605463535587;4655.930161047587;4757.690750101249;4778.450478195;4801.663883528155;4815.398075240595;4815.759212039402;4817.759112044401;4775.594074503671;4795.424549054101;4825.155597770411;4827.155247831633;4835.806567737286;3897.259520691088;3971.702122340836;4059.3707975263883;4063.553009168989;4135.338345864648;6142.907856382158;6167.383261673842;6186.319504854462;6186.9381306186815;6193.566450348478;5654.575906807006;5657.660540367591;5666.376698563155;5668.348139963916;5672.092465205547;6864.897026544606;6878.621675807829;6879.58722476648;6887.483438742114;6888.827779305508;4588;4592.862214133581;4594.494605593382;4597;4617.353570500132;5568.610197286192;7201.675924583354;7254.637268136625;7284.417246620258;7304.634768261619;4653.906921861544;4691.859244222679;4704.03567268716;4715.905681886343;4716.151092803259;4291.03451723366;4497.9325310120375;4783.617310615143;4787.329773831666;4792.616590672737;5593.8321850344555;5596.412376700469;5600.859978500489;5608.69152196625;5615.101583746663;6888.345607167311;6889.517733758589;6901.033855260268;6908.3437073477935;6920.826979325557;1397.82527184102;1570.1452933049336;1642.5565097423628;1663.4261179892917;1665.53365057784;1077.4343469678324;1077.5097330714507;1086.9402182880017;1090.0625462102585;1101.6639924823005;6432.9678351607945;6439.871202575922;6441.742330306735;6452.870942581122;6466.838329041811;6923.6192009438955;7006.614636195059;7153.3919616833155;7173.748918787817;7195.964020179866;5086.287919691246;6373.458256048195;6439.613623182624;6500.707468163944;6522.15212022434;3176.348848486055;3767.4348847672522;3769.0577355661085;3808.6953043756434;3827.5789663137034;7604.429667774939;7605.391568674493;7608.467407281437;7628.580428076398;7629.122650895218;7225.385842203366;7443.925560744432;7452.441066920002;7458.664360103809;7484.176740558534;7514.586697731677;7548.320651141424;7569.1295501018085;7569.886451703229;7583.7724868254045;7214;7222.674979625825;7228.530145540523;7234.02340684022;7241.5293005954445;6453.741850325934;7096.503244772816;7132.607706576188;7138.072050633385;7146.392556632536;7430.331270185709;7585.924140758521;7595.734149304748;7605.847883042419;7606.163322034682;4657.951960808791;4754.738489383117;4761.476237613929;4763.857084287477;4776.522347765195;7108.537945033763;7125.501214914906;7147.85704285901;7148.0350152728715;7167.139943206848;5912.822615321547;6629.07192992991;6659.667016649245;6880.65596720172;6888.276730943179;6798.354156355138;6899.482538809509;6920.9307906920285;6921.653917304216;6930.61881596517;6697.196336439659;6764.289749576224;6769.93230067693;6774.525783195129;6791.830204244933;6910.654467276516;6911.274316196727;6917.27368626287;6918.688659010256;6933.237343892269;5515;6493.577917435352;6759.594424334556;6768.052472653931;6769.729210831511 18:31:31 INFO - PROCESS | 1671 | |5;yui.html;712.7434123715461;765.4718244411356;768.2240936653977;770.506875599616;821.4085858182109;15003.849961500382;15173.39306427743;15250.161241131733;15305.540833774976;15314.310856011492;13958.651033724162;13968.161910285364;13973.161610303363;13992.930035349835;14014.019018668672;922.9861552076708;937.634322614181;942.6370847223834;944.8110377924409;945.347710080046;752.9585872776995;760.2587477209704;879.885614870066;917.6008436330185;937.1565590968115;986.8322385194498;994.368575954267;998.2562990572034;998.3859926145441;1003.0571263012781;991.3754334769085;993.538004827755;994.6369575105107;996.4170959988415;998.9051040151174;594.2067340100971;598.335847209597;601.4526780629606;731.8024133483983;757.1708978668349;14866.959312848105;14941.02883312592;14954.850451495564;14964.925175374163;14987;12322.507099716;12372.505099795997;12406.193597416139;12417.379131043412;12648.241105533698;9775.853362199572;9825.164860986824;9886.456244906527;10110.49447527628;10221.131203847683;3431.1936694876686;3470.5908646181415;3527.9823600882087;3712.201876596545;3723.255348930225;83549.58225208896;83557;83668.16331836664;83690;83926;9340.299477539213;9468;9494.715158545254;9547.093026162504;9793.510324483746;21754;21780.89109554474;21795.891020544797;21839.563208735737;21895.562088758456;7298.197198308182;7420.183779784219;7474.925250747532;7502.664581486362;7540.472166948261;4100.91798164035;4143.0678097428445;4147.00471886745;4158.272302347077;4169.770662613585;3144;3636.7272454565486;3667.3032123896373;3681.5029970954115;3681.5214022176947;630.8612105336819;646.9967650161719;653.1998302080009;656.8095252376758;668.3416834418094;584.8391692284571;601.4136217188294;624.5128799536369;640.6604499615212;644.4200219802121;7610.847783044308;7649.694012239448;8099.878501822477;8150.388720845842;8215.383846211558;557.6431084106175;567.8126218347935;576.7001159397174;599.9520038396918;627.4760574919993;3713.8514459421863;3742.925141497155;3751.4185301278344;3818;3818.8090595470117;94807;95612.52193739126;97425;97454;97772;79239;79760;80336;80586.19413805786;81433;69597;70440.64779676069;71707;71747;72976;7519.699212031676;7523.473356864967;7564.130125035691;7642.617869106633;7769.339606133316;49749.253761192886;50034.49965500444;50093.24860127028;50540;51164.97670046653;61978.38021619726;64833.67583162054;64853;66098;71827.92258116028;11196.38419886914;11395.829062564235;11428;11510.53957841677;11531.654050378502;11944.76110477803;12124.75750485003;12282.201656892274;12287.75424491523;12405.813912791134;11440.94279528597;11450.427478625868;11851.407429628312;11964.700882478008;11973.76052478963;11598.362090085126;11629.24409913353;11650.825237621611;11712.70718232051;11928.880711193124;11165.553377864795;11175.72060698489;11223.494942727433;11497.367644779617;11740.060795136198;9456.905430945602;9508.667196648084;9623.518824058909;9999.500024998866;10052.246081543768;9410.95294523523;9438.95280523593;9470.052994700474;9485.905140948502;9639.325247232908 18:31:31 INFO - PROCESS | 1671 | __end_tp_report 18:31:31 INFO - PROCESS | 1671 | __start_cc_report 18:31:31 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2095 18:31:31 INFO - PROCESS | 1671 | __end_cc_report 18:31:31 INFO - PROCESS | 1671 | __startTimestamp1458351091905__endTimestamp 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | ------- Summary: start ------- 18:31:31 INFO - PROCESS | 1671 | Number of tests: 6 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5600.94 Median:5806.54 stddev:633.43 (10.9%) stddev-sans-first:610.80 18:31:31 INFO - PROCESS | 1671 | Values: 3373.6 3422.9 3446.1 3462.9 3493.8 4951.4 5459.9 5563.7 5585.1 5590.8 5555.9 5582.4 5606.5 5728.0 5739.7 5021.0 5065.4 5071.3 5092.8 5233.2 5127.1 5129.9 5180.1 5181.0 5210.9 4110.2 4511.0 5026.7 5087.3 5093.2 4535.8 5116.4 5128.2 5152.5 5168.0 5044.4 5074.0 5108.4 5115.0 5138.7 5379.1 5479.1 5479.7 5498.4 5503.9 6078.5 6086.2 6102.6 6103.7 6110.5 6118.0 6177.2 6188.9 6199.8 6209.5 5531.2 5654.3 5655.4 5694.3 5765.4 5728.5 5800.8 6220.6 6231.6 6248.3 5915.9 5944.2 5994.2 5997.1 6018.2 6019.9 6093.9 6121.6 6134.4 6156.9 6023.7 6057.9 6058.4 6064.6 6070.2 6085.6 6097.9 6099.1 6100.8 6103.0 4715.0 4814.3 4814.9 4819.9 4938.0 4241.8 4251.7 4338.5 4348.6 4439.1 5554.6 5569.3 5571.9 5584.6 5593.4 6088.9 6125.7 6154.2 6157.9 6168.7 5564.5 5580.7 5589.8 5594.2 5622.7 5268.1 5274.4 5278.9 5280.3 5356.7 5084.9 6185.2 6232.8 6252.9 6315.6 6132.5 6178.2 6187.9 6188.4 6211.2 6237.8 6247.4 6258.2 6266.8 6270.9 5878.1 5973.9 5975.8 6056.7 6097.2 6020.6 6081.2 6115.0 6116.9 6123.3 5900.1 5928.2 5947.1 5953.3 5957.5 5972.6 5973.9 5975.4 6010.6 6047.9 4973.8 5428.4 5806.5 5815.7 5828.3 5654.9 5789.8 5934.3 5951.6 6011.4 5807.5 5830.9 5839.2 5840.0 5897.7 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:60722.06 Median:207698.32 stddev:125787.36 (60.6%) stddev-sans-first:126058.83 18:31:31 INFO - PROCESS | 1671 | Values: 451.2 483.9 584.9 643.5 649.7 30139.6 30653.7 30725.8 39824.0 40278.6 44889.0 45330.0 45351.1 45473.5 45564.1 9562.5 9765.5 9779.5 9788.5 9800.5 8855.9 9362.9 9614.5 9799.1 9817.7 8662.0 9707.8 9731.9 9823.4 9831.0 9699.5 9808.0 9815.9 9823.7 9855.6 9564.5 9721.2 9733.9 9737.7 9751.6 41991.8 42258.4 42285.8 42363.0 42422.4 2589.8 3123.9 3299.5 3344.9 3475.5 26110.5 28768.0 28880.6 29627.6 29932.7 2739.4 2788.6 2811.9 2872.9 2935.0 493086.0 494410.0 497649.0 499661.0 500123.0 47158.8 69048.0 69064.0 69734.7 69896.0 45962.0 46125.0 46186.5 46282.8 46310.0 13441.5 15618.8 15950.4 15953.4 15986.4 12646.2 12747.2 12747.6 12764.4 12765.7 14735.8 14743.9 15015.8 15032.0 15192.7 6122.4 6243.7 6296.5 6363.8 6370.9 973.0 974.3 974.4 1002.4 1138.3 28415.3 29235.7 29277.7 29359.0 29778.7 1106.8 1126.6 1159.7 1162.3 1210.3 15066.3 15080.5 15185.8 15274.0 15279.7 534104.0 537620.0 539674.0 540018.0 543322.0 61109.4 61692.7 61823.1 61937.4 62103.0 1332.5 1450.7 1455.6 1466.3 1490.9 23590.0 23645.8 24317.8 28828.6 29578.3 47410.5 47835.0 47887.5 47972.5 48403.0 292940.5 378521.0 379014.0 379033.0 379033.0 28923.9 33646.8 33774.5 34523.0 34639.3 42648.8 43348.8 43988.3 44066.3 44238.0 34133.3 34200.7 34863.7 35065.8 35169.4 34790.8 34916.5 34969.8 35775.8 35900.0 36012.0 36079.1 36588.0 36852.3 36875.6 30264.6 32183.5 32285.4 32405.8 32414.0 20972.0 23980.5 24288.8 24616.6 24663.4 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34839.02 Median:25895.55 stddev:103853.44 (401.0%) stddev-sans-first:104112.42 18:31:31 INFO - PROCESS | 1671 | Values: 316.8 362.2 369.7 373.2 373.5 19541.9 20023.0 21099.9 21617.7 21659.0 16769.9 20680.5 20924.8 21259.0 21282.6 5727.7 5877.1 5948.0 5948.6 5951.2 4212.2 4513.5 5942.5 6552.5 6591.5 5249.5 6328.8 6341.5 6361.6 6525.2 6155.7 6257.2 6324.6 6326.7 6326.8 5475.2 5499.9 5504.7 5511.2 5515.7 25501.7 25797.5 25993.6 26027.0 26243.0 2055.3 2069.5 2156.6 2158.3 2243.8 9244.0 9704.1 13076.8 14543.7 15171.2 1677.2 1685.1 1704.8 1734.9 1833.0 97314.5 97527.7 98640.0 100323.5 102751.0 10772.4 11054.5 11159.7 11255.2 11315.6 13464.4 13555.7 13569.1 13571.2 13576.8 8414.2 8478.2 8482.2 8487.7 8574.5 8757.9 8777.7 8790.9 8791.6 8886.8 4463.4 4485.0 4485.9 4526.2 4589.5 1832.2 1870.4 1881.4 1897.3 1905.5 755.7 764.8 851.4 902.8 958.4 16609.8 19004.8 20120.6 20205.5 20292.0 999.6 1022.4 1027.6 1051.6 1069.6 10836.3 11269.7 11272.6 11295.8 11365.3 595952.0 604291.0 639734.0 645614.0 647462.0 119683.2 119887.0 124044.0 126217.1 126285.0 993.1 1018.4 1034.2 1034.6 1036.2 17931.2 18080.8 18171.9 18738.3 18963.7 49163.5 50096.7 50226.7 50334.2 50933.5 69223.7 72508.6 72664.0 72989.9 74368.6 7526.5 7742.1 7749.1 7844.7 8088.9 8668.0 11217.7 11899.9 12376.0 12514.4 10614.7 10796.2 10808.7 10968.2 10997.6 9825.3 10224.7 10622.7 10690.0 10850.2 10780.7 10969.1 10990.0 11083.4 11214.8 7702.1 7783.7 7850.7 7901.1 8127.6 9666.3 9890.8 10452.3 10745.4 11008.4 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5971.27 Median:5454.89 stddev:3093.25 (56.7%) stddev-sans-first:3083.31 18:31:31 INFO - PROCESS | 1671 | Values: 1457.0 1589.6 1613.1 1894.8 2025.1 7937.5 8471.2 8652.1 8675.3 8677.0 8337.2 8565.8 8578.1 8584.6 8596.2 2156.2 2202.3 2209.6 2426.8 2477.8 2219.3 2432.2 2491.0 2495.3 2496.1 2040.4 2421.8 2456.8 2462.2 2467.1 2443.4 2443.8 2447.2 2451.5 2451.6 2401.0 2450.7 2454.2 2461.0 2466.1 8645.4 8742.4 8742.6 8747.4 8754.5 5328.9 5437.9 5484.7 5495.4 5496.5 3537.8 3539.6 3717.8 3725.4 3741.5 1045.1 1049.6 1055.6 1073.4 1073.8 11441.4 11532.4 11555.2 11620.7 11688.4 4807.5 4908.9 4960.2 4971.4 4978.7 9974.5 10054.3 10063.7 10067.8 10110.2 5471.9 5478.1 5479.4 5480.8 5482.4 4421.4 4570.5 4893.3 4960.2 4961.6 3883.2 3904.3 3973.9 3978.3 3981.3 1299.8 1311.6 1324.1 1328.1 1337.5 1351.6 1352.0 1376.0 1413.7 1420.1 7904.2 8039.2 8048.1 8054.4 8060.9 1201.6 1212.8 1230.9 1231.3 1255.1 6259.2 6289.0 6358.3 6359.5 6367.8 10181.4 10548.6 10603.1 10670.0 10679.0 10114.1 10481.4 10481.4 10530.2 10556.5 8012.8 8126.0 8151.5 8202.6 8222.9 7559.8 7740.5 7811.0 7821.8 7824.5 9174.3 9331.7 9444.3 9508.5 9552.7 8221.9 9571.4 9722.5 9800.1 9985.1 6668.0 7062.5 7449.4 7492.6 7524.9 6656.5 8140.9 8146.4 8147.3 8164.4 7031.7 7141.6 7164.2 7271.0 7299.2 7029.7 7041.0 7081.7 7178.7 7201.8 6034.7 7514.2 7565.8 7617.2 7626.5 6912.5 6922.2 6970.3 6973.2 6985.3 6909.1 7022.9 7023.2 7067.1 7102.1 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5668.64 Median:6444.97 stddev:1811.03 (28.1%) stddev-sans-first:1770.68 18:31:31 INFO - PROCESS | 1671 | Values: 298.2 316.9 327.1 327.3 336.5 6389.1 6448.2 6451.9 6476.8 6559.2 6423.6 6452.5 6455.1 6471.8 6484.2 4616.4 4767.6 4770.9 4827.5 4858.9 3857.0 4073.6 4641.6 4655.9 4757.7 4778.5 4801.7 4815.4 4815.8 4817.8 4775.6 4795.4 4825.2 4827.2 4835.8 3897.3 3971.7 4059.4 4063.6 4135.3 6142.9 6167.4 6186.3 6186.9 6193.6 5654.6 5657.7 5666.4 5668.3 5672.1 6864.9 6878.6 6879.6 6887.5 6888.8 4588.0 4592.9 4594.5 4597.0 4617.4 5568.6 7201.7 7254.6 7284.4 7304.6 4653.9 4691.9 4704.0 4715.9 4716.2 4291.0 4497.9 4783.6 4787.3 4792.6 5593.8 5596.4 5600.9 5608.7 5615.1 6888.3 6889.5 6901.0 6908.3 6920.8 1397.8 1570.1 1642.6 1663.4 1665.5 1077.4 1077.5 1086.9 1090.1 1101.7 6433.0 6439.9 6441.7 6452.9 6466.8 6923.6 7006.6 7153.4 7173.7 7196.0 5086.3 6373.5 6439.6 6500.7 6522.2 3176.3 3767.4 3769.1 3808.7 3827.6 7604.4 7605.4 7608.5 7628.6 7629.1 7225.4 7443.9 7452.4 7458.7 7484.2 7514.6 7548.3 7569.1 7569.9 7583.8 7214.0 7222.7 7228.5 7234.0 7241.5 6453.7 7096.5 7132.6 7138.1 7146.4 7430.3 7585.9 7595.7 7605.8 7606.2 4658.0 4754.7 4761.5 4763.9 4776.5 7108.5 7125.5 7147.9 7148.0 7167.1 5912.8 6629.1 6659.7 6880.7 6888.3 6798.4 6899.5 6920.9 6921.7 6930.6 6697.2 6764.3 6769.9 6774.5 6791.8 6910.7 6911.3 6917.3 6918.7 6933.2 5515.0 6493.6 6759.6 6768.1 6769.7 18:31:31 INFO - PROCESS | 1671 | 18:31:31 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18575.22 Median:629.17 stddev:26378.21 (4192.5%) stddev-sans-first:26418.10 18:31:31 INFO - PROCESS | 1671 | Values: 712.7 765.5 768.2 770.5 821.4 15003.8 15173.4 15250.2 15305.5 15314.3 13958.7 13968.2 13973.2 13992.9 14014.0 923.0 937.6 942.6 944.8 945.3 753.0 760.3 879.9 917.6 937.2 986.8 994.4 998.3 998.4 1003.1 991.4 993.5 994.6 996.4 998.9 594.2 598.3 601.5 731.8 757.2 14867.0 14941.0 14954.9 14964.9 14987.0 12322.5 12372.5 12406.2 12417.4 12648.2 9775.9 9825.2 9886.5 10110.5 10221.1 3431.2 3470.6 3528.0 3712.2 3723.3 83549.6 83557.0 83668.2 83690.0 83926.0 9340.3 9468.0 9494.7 9547.1 9793.5 21754.0 21780.9 21795.9 21839.6 21895.6 7298.2 7420.2 7474.9 7502.7 7540.5 4100.9 4143.1 4147.0 4158.3 4169.8 3144.0 3636.7 3667.3 3681.5 3681.5 630.9 647.0 653.2 656.8 668.3 584.8 601.4 624.5 640.7 644.4 7610.8 7649.7 8099.9 8150.4 8215.4 557.6 567.8 576.7 600.0 627.5 3713.9 3742.9 3751.4 3818.0 3818.8 94807.0 95612.5 97425.0 97454.0 97772.0 79239.0 79760.0 80336.0 80586.2 81433.0 69597.0 70440.6 71707.0 71747.0 72976.0 7519.7 7523.5 7564.1 7642.6 7769.3 49749.3 50034.5 50093.2 50540.0 51165.0 61978.4 64833.7 64853.0 66098.0 71827.9 11196.4 11395.8 11428.0 11510.5 11531.7 11944.8 12124.8 12282.2 12287.8 12405.8 11440.9 11450.4 11851.4 11964.7 11973.8 11598.4 11629.2 11650.8 11712.7 11928.9 11165.6 11175.7 11223.5 11497.4 11740.1 9456.9 9508.7 9623.5 9999.5 10052.2 9411.0 9439.0 9470.1 9485.9 9639.3 18:31:31 INFO - PROCESS | 1671 | -------- Summary: end -------- 18:31:31 INFO - PROCESS | 1671 | 18:31:32 INFO - TEST-INFO | 1671: exit 0 18:31:32 INFO - TEST-OK | dromaeo_css | took 1114616ms 18:31:32 INFO - TEST-START | kraken 18:31:32 INFO - operating with platform_type : mac_ 18:31:32 INFO - Initialising browser for kraken test... 18:31:32 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpVFVLVG/profile http://localhost:49270/getInfo.html) 18:31:34 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 18:31:34 INFO - PROCESS | 1681 | colorDepth:24 18:31:34 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 18:31:34 INFO - PROCESS | 1681 | __metrics 18:31:34 INFO - PROCESS | 1681 | 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" 18:31:34 ERROR - PROCESS | 1681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:31:35 INFO - TEST-INFO | 1681: exit 0 18:31:35 INFO - Browser initialized. 18:31:35 INFO - Running cycle 1/1 for kraken test... 18:31:35 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpVFVLVG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:47 INFO - PROCESS | 1683 | RSS: Main: 244637696 18:31:47 INFO - PROCESS | 1683 | 18:31:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:50 INFO - PROCESS | 1683 | RSS: Main: 290533376 18:31:50 INFO - PROCESS | 1683 | 18:31:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 18:31:53 INFO - PROCESS | 1683 | RSS: Main: 300670976 18:31:53 INFO - PROCESS | 1683 | 18:31:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 18:31:57 INFO - PROCESS | 1683 | RSS: Main: 288202752 18:31:57 INFO - PROCESS | 1683 | 18:31:59 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 18:32:00 INFO - PROCESS | 1683 | RSS: Main: 289456128 18:32:00 INFO - PROCESS | 1683 | 18:32:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:32:02 INFO - PROCESS | 1683 | RSS: Main: 291409920 18:32:02 INFO - PROCESS | 1683 | 18:32:05 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:06 INFO - PROCESS | 1683 | RSS: Main: 291565568 18:32:06 INFO - PROCESS | 1683 | 18:32:09 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:09 INFO - PROCESS | 1683 | RSS: Main: 290091008 18:32:09 INFO - PROCESS | 1683 | 18:32:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 18:32:13 INFO - PROCESS | 1683 | RSS: Main: 290045952 18:32:13 INFO - PROCESS | 1683 | 18:32:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:15 INFO - PROCESS | 1683 | RSS: Main: 324542464 18:32:15 INFO - PROCESS | 1683 | 18:32:16 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:17 INFO - PROCESS | 1683 | RSS: Main: 323551232 18:32:17 INFO - PROCESS | 1683 | 18:32:19 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:20 INFO - PROCESS | 1683 | RSS: Main: 333910016 18:32:20 INFO - PROCESS | 1683 | 18:32:22 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:23 INFO - PROCESS | 1683 | RSS: Main: 333787136 18:32:23 INFO - PROCESS | 1683 | 18:32:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:26 INFO - PROCESS | 1683 | RSS: Main: 335302656 18:32:26 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 18:32:28 INFO - PROCESS | 1683 | RSS: Main: 395264000 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | __start_tp_report 18:32:28 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 18:32:28 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 18:32:28 INFO - PROCESS | 1683 | |i|pagename|runs| 18:32:28 INFO - PROCESS | 1683 | |0;ai-astar;150;157;164;125;113;111;119;114;110;111 18:32:28 INFO - PROCESS | 1683 | |1;audio-beat-detection;158;121;142;158;119;139;145;142;166;118 18:32:28 INFO - PROCESS | 1683 | |2;audio-dft;186;185;186;189;185;185;186;180;182;186 18:32:28 INFO - PROCESS | 1683 | |3;audio-fft;80;75;86;80;81;84;83;101;77;81 18:32:28 INFO - PROCESS | 1683 | |4;audio-oscillator;97;93;129;78;81;80;115;78;82;115 18:32:28 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;86;85;87;85;87;83;89;85;87;84 18:32:28 INFO - PROCESS | 1683 | |6;imaging-darkroom;92;92;93;92;92;93;96;97;118;144 18:32:28 INFO - PROCESS | 1683 | |7;imaging-desaturate;85;87;86;86;87;85;84;87;83;86 18:32:28 INFO - PROCESS | 1683 | |8;json-parse-financial;55;56;54;53;54;54;53;64;56;53 18:32:28 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;65;72;66;72;72;67;66;67;69;67 18:32:28 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;83;83;83;79;84;82;82;83;84;84 18:32:28 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;132;128;109;133;132;128;126;119;119;125 18:32:28 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;140;126;138;139;137;127;138;139;139;138 18:32:28 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;68;67;66;66;67;67;67;69;69;76 18:32:28 INFO - PROCESS | 1683 | __end_tp_report 18:32:28 INFO - PROCESS | 1683 | __start_cc_report 18:32:28 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1231 18:32:28 INFO - PROCESS | 1683 | __end_cc_report 18:32:28 INFO - PROCESS | 1683 | __startTimestamp1458351148404__endTimestamp 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | ------- Summary: start ------- 18:32:28 INFO - PROCESS | 1683 | Number of tests: 14 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:127.40 Median:122.00 stddev:21.16 (17.3%) stddev-sans-first:20.81 18:32:28 INFO - PROCESS | 1683 | Values: 150.0 157.0 164.0 125.0 113.0 111.0 119.0 114.0 110.0 111.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:143.50 stddev:17.12 (11.9%) stddev-sans-first:16.99 18:32:28 INFO - PROCESS | 1683 | Values: 158.0 121.0 142.0 158.0 119.0 139.0 145.0 142.0 166.0 118.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:2.45 (1.3%) stddev-sans-first:2.57 18:32:28 INFO - PROCESS | 1683 | Values: 186.0 185.0 186.0 189.0 185.0 185.0 186.0 180.0 182.0 186.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:82.80 Median:81.00 stddev:7.15 (8.8%) stddev-sans-first:7.51 18:32:28 INFO - PROCESS | 1683 | Values: 80.0 75.0 86.0 80.0 81.0 84.0 83.0 101.0 77.0 81.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:80.50 stddev:18.65 (23.2%) stddev-sans-first:19.77 18:32:28 INFO - PROCESS | 1683 | Values: 97.0 93.0 129.0 78.0 81.0 80.0 115.0 78.0 82.0 115.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.50 stddev:1.75 (2.0%) stddev-sans-first:1.86 18:32:28 INFO - PROCESS | 1683 | Values: 86.0 85.0 87.0 85.0 87.0 83.0 89.0 85.0 87.0 84.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:100.90 Median:92.50 stddev:17.10 (18.5%) stddev-sans-first:17.83 18:32:28 INFO - PROCESS | 1683 | Values: 92.0 92.0 93.0 92.0 92.0 93.0 96.0 97.0 118.0 144.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.41 18:32:28 INFO - PROCESS | 1683 | Values: 85.0 87.0 86.0 86.0 87.0 85.0 84.0 87.0 83.0 86.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.29 (6.0%) stddev-sans-first:3.49 18:32:28 INFO - PROCESS | 1683 | Values: 55.0 56.0 54.0 53.0 54.0 54.0 53.0 64.0 56.0 53.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:2.75 (4.0%) stddev-sans-first:2.65 18:32:28 INFO - PROCESS | 1683 | Values: 65.0 72.0 66.0 72.0 72.0 67.0 66.0 67.0 69.0 67.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.49 (1.8%) stddev-sans-first:1.58 18:32:28 INFO - PROCESS | 1683 | Values: 83.0 83.0 83.0 79.0 84.0 82.0 82.0 83.0 84.0 84.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:128.00 stddev:7.52 (5.9%) stddev-sans-first:7.55 18:32:28 INFO - PROCESS | 1683 | Values: 132.0 128.0 109.0 133.0 132.0 128.0 126.0 119.0 119.0 125.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:138.50 stddev:5.13 (3.7%) stddev-sans-first:5.24 18:32:28 INFO - PROCESS | 1683 | Values: 140.0 126.0 138.0 139.0 137.0 127.0 138.0 139.0 139.0 138.0 18:32:28 INFO - PROCESS | 1683 | 18:32:28 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.50 stddev:2.94 (4.4%) stddev-sans-first:3.11 18:32:28 INFO - PROCESS | 1683 | Values: 68.0 67.0 66.0 66.0 67.0 67.0 67.0 69.0 69.0 76.0 18:32:28 INFO - PROCESS | 1683 | -------- Summary: end -------- 18:32:28 INFO - PROCESS | 1683 | 18:32:29 INFO - TEST-INFO | 1683: exit 0 18:32:29 INFO - TEST-OK | kraken | took 56749ms 18:32:29 INFO - SUITE-END | took 1171s 18:32:29 INFO - Completed test suite (00:19:31) 18:32:29 INFO - javascript benchmark 18:32:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3373.628900820909, 3422.8801991930272, 3446.1212390840333, 3462.948055779162, 3493.8427770750313, 4951.3810773653295, 5459.918101228484, 5563.749631266593, 5585.1063829787245, 5590.776368945238, 5555.916661250085, 5582.413846546115, 5606.467385598372, 5728.0, 5739.741711622976, 5020.974895125538, 5065.3668291463655, 5071.264666623338, 5092.79628814847, 5233.188855727369, 5127.051495473349, 5129.871753206163, 5180.1452760294505, 5180.989707007135, 5210.921836172461, 4110.219058378899, 4511.0, 5026.698398096108, 5087.287779710843, 5093.236014597803, 4535.7732113394195, 5116.411612664517, 5128.153854613985, 5152.510511501401, 5167.974160129213, 5044.39467263927, 5073.974630126862, 5108.386993560796, 5114.977004599095, 5138.74306284688, 5379.085555455582, 5479.123340265578, 5479.726013699299, 5498.367687715924, 5503.9174412383845, 6078.513718902477, 6086.239220097488, 6102.633841969496, 6103.6948152592195, 6110.480609148228, 6117.969410152965, 6177.166082578839, 6188.938110618881, 6199.783007594758, 6209.472194863397, 5531.225628412026, 5654.29321334829, 5655.4344565543115, 5694.316681998145, 5765.423457654201, 5728.484436400744, 5800.810833779065, 6220.595661282002, 6231.563790534619, 6248.343923888017, 5915.911261331084, 5944.167816505693, 5994.1608174855555, 5997.100434934795, 6018.247719035121, 6019.909701354483, 6093.866968087961, 6121.632702037892, 6134.4172303631085, 6156.8768624627255, 6023.69881505923, 6057.939420605826, 6058.394160583995, 6064.636121832704, 6070.180525628984, 6085.57400981927, 6097.939020609826, 6099.146119543268, 6100.816975490742, 6102.962496375627, 4715.0, 4814.325994360793, 4814.855554333376, 4819.903601928012, 4937.975310123498, 4241.766702831313, 4251.681123915719, 4338.501072376717, 4348.565143485689, 4439.134368798053, 5554.555635549146, 5569.275994120739, 5571.916421253684, 5584.5811564132855, 5593.3847276799515, 6088.8782224356155, 6125.724342404603, 6154.169187159766, 6157.922363586444, 6168.722407491674, 5564.527015203672, 5580.748866301026, 5589.8323050307745, 5594.1608758686525, 5622.746976386073, 5268.051750684837, 5274.393444753826, 5278.947210527922, 5280.287161233261, 5356.705381203993, 5084.872878178076, 6185.165002724574, 6232.781852635136, 6252.937470625327, 6315.5579109462815, 6132.509399247961, 6178.1659475971965, 6187.907181392193, 6188.412100850412, 6211.223597050369, 6237.75048998035, 6247.375262473898, 6258.249010118815, 6266.811995640138, 6270.905936410866, 5878.088896221093, 5973.940260597338, 5975.820725378246, 6056.66688332146, 6097.176881120992, 6020.608660437058, 6081.239845019372, 6115.021596544531, 6116.877662446637, 6123.2958209804665, 5900.085486749561, 5928.199693041384, 5947.078202878561, 5953.255843019622, 5957.523398128053, 5972.58191926561, 5973.850653733692, 5975.40245975399, 6010.579259451796, 6047.881141988746, 4973.751312434291, 5428.37573679032, 5806.535477161901, 5815.738291776795, 5828.271466066742, 5654.915176272277, 5789.768409263583, 5934.347221805684, 5951.642901425928, 6011.428914253139, 5807.477327040587, 5830.912536312044, 5839.240898683144, 5840.0, 5897.734601942837], "unit": "score", "name": "dojo.html", "value": 5561.977100514826}, {"lowerIsBetter": false, "replicates": [451.1720991979717, 483.8918875774479, 584.9208210850978, 643.5334382572636, 649.6816559885656, 30139.643716032777, 30653.693463065363, 30725.84637076817, 39824.004399890015, 40278.59721402785, 44889.0, 45330.0, 45351.09297814042, 45473.54526454743, 45564.0887182257, 9562.521873906295, 9765.462899540522, 9779.511024448784, 9788.510574471284, 9800.460974646392, 8855.937287525507, 9362.906370936305, 9614.519274036305, 9799.118079372854, 9817.705468835946, 8662.0, 9707.805843883118, 9731.902680973171, 9823.36148150368, 9831.0, 9699.466529340883, 9807.950960245189, 9815.852762208573, 9823.656172033945, 9855.55649995752, 9564.521773911276, 9721.222302215805, 9733.90266097337, 9737.659181928599, 9751.609935602568, 41991.7900410496, 42258.36612450816, 42285.78857105726, 42363.0, 42422.36366454505, 2589.7539733725266, 3123.9219019524467, 3299.472084466498, 3344.899653010389, 3475.461303497962, 26110.477790444274, 28768.0, 28880.566791498146, 29627.555586666218, 29932.700672993426, 2739.411026629264, 2788.6374771279807, 2811.9156425307274, 2872.942541149186, 2934.9559756603667, 493086.0, 494409.9999999964, 497648.9999999964, 499661.0, 500123.0, 47158.76420617875, 69048.0, 69064.0, 69734.65132674406, 69896.0, 45962.0, 46125.0, 46186.538134618895, 46282.84292892705, 46310.0, 13441.46234150623, 15618.76571851423, 15950.361985520682, 15953.361865525249, 15986.440474583334, 12646.177998430072, 12747.235165890077, 12747.553835615709, 12764.425600847984, 12765.68085797844, 14735.778963315559, 14743.926280368529, 15015.849841501664, 15032.0, 15192.696146077016, 6122.418370254819, 6243.719032643542, 6296.496280297565, 6363.7726795621165, 6370.872582548323, 972.9513524323755, 974.2546951582045, 974.3715303629119, 1002.4436437776958, 1138.3056335635256, 28415.289617759307, 29235.707642923724, 29277.682504287357, 29358.97243596464, 29778.702212978027, 1106.833974903771, 1126.5662719852917, 1159.7390587117832, 1162.3200427749691, 1210.334316126127, 15066.322015509328, 15080.472183473745, 15185.772213416807, 15274.007189532645, 15279.694406112038, 534104.0, 537620.0, 539674.0, 540018.0, 543322.0, 61109.38890611126, 61692.69153654203, 61823.072653910225, 61937.38062619406, 62103.0, 1332.486992507872, 1450.6735984403635, 1455.5560554030699, 1466.2741942738412, 1490.880729541634, 23590.0, 23645.81770911413, 24317.756822432257, 28828.567571486026, 29578.260543485725, 47410.52589474061, 47835.043299133125, 47887.521124788305, 47972.520274798204, 48403.0, 292940.53529732215, 378521.0, 379014.0, 379033.0, 379033.0, 28923.855380723802, 33646.831765841016, 33774.49338259977, 34523.0, 34639.30721385508, 42648.78675606602, 43348.783256083516, 43988.34017489804, 44066.33900491559, 44238.0, 34133.31733365269, 34200.65799342074, 34863.65136348604, 35065.824670877504, 35169.41737621762, 34790.82604586961, 34916.47625285674, 34969.77605783887, 35775.82112089527, 35900.0, 36012.0, 36079.098022549646, 36588.0, 36852.262954741294, 36875.63124368722, 30264.55238057171, 32183.51724724084, 32285.35429291448, 32405.837970809996, 32414.027579172664, 20972.0, 23980.52038959246, 24288.757112428648, 24616.6307505384, 24663.38341541476], "unit": "score", "name": "ext.html", "value": 19052.055216070858}, {"lowerIsBetter": false, "replicates": [316.7671761255477, 362.20676717987607, 369.7467234944063, 373.21252157946725, 373.48832100022975, 19541.902290488546, 20023.0, 21099.945002749857, 21617.67573486395, 21659.0, 16769.91615041923, 20680.505541202412, 20924.790752092475, 21259.0, 21282.57434851302, 5727.684977326256, 5877.118432235156, 5947.970260148715, 5948.583599148062, 5951.166836642852, 4212.178625168093, 4513.458384993805, 5942.465178133967, 6552.508561857856, 6591.472682185437, 5249.527542521172, 6328.778492752755, 6341.492680585542, 6361.586496877711, 6525.184351956005, 6155.692215389257, 6257.186565746447, 6324.588901721373, 6326.65203413812, 6326.84182895429, 5475.151351540518, 5499.862503437406, 5504.724763761796, 5511.200875873016, 5515.696636684981, 25501.724913754424, 25797.48405031889, 25993.610095848577, 26027.0, 26243.0, 2055.3011975928107, 2069.4929742213103, 2156.6010288096754, 2158.2554018863466, 2243.7980581747556, 9243.953780231122, 9704.078112579293, 13076.803847942288, 14543.709125817424, 15171.165585892772, 1677.2117104960648, 1685.1237356574636, 1704.795424549062, 1734.904580248086, 1833.0193346559527, 97314.51342743241, 97527.7399260272, 98640.0, 100323.49838250762, 102751.0, 10772.353658780497, 11054.502547385388, 11159.721006974729, 11255.212135150625, 11315.603953861575, 13464.394102265422, 13555.661108472366, 13569.118007329493, 13571.1857288563, 13576.77808997195, 8414.15858414166, 8478.194571515696, 8482.236598706022, 8487.745367638981, 8574.485530868167, 8757.868631970525, 8777.69278075277, 8790.912090879137, 8791.604377803014, 8886.777830554287, 4463.375127482155, 4484.990877052637, 4485.887852803706, 4526.230540808005, 4589.472210695746, 1832.2121487760126, 1870.4014715291248, 1881.3509339277928, 1897.2885168061978, 1905.4759941016332, 755.6675062972274, 764.8049747314399, 851.4082712514743, 902.801383695586, 958.4488918871538, 16609.83390166107, 19004.809951900304, 20120.59758804845, 20205.49486262855, 20292.0, 999.5502024089044, 1022.3865680591585, 1027.5786927359895, 1051.5951358726945, 1069.6309773128257, 10836.349819010884, 11269.66191014271, 11272.605458808903, 11295.830562541569, 11365.261258018203, 595952.0, 604291.0, 639734.0, 645614.0, 647462.0, 119683.20475192879, 119887.0, 124044.0, 126217.10674339892, 126285.0, 993.0913214408735, 1018.3686114608842, 1034.182995433614, 1034.5603118674533, 1036.1555332404066, 17931.193096310435, 18080.81919180844, 18171.909140454212, 18738.344157954405, 18963.715544267125, 49163.508364917325, 50096.74951625364, 50226.74433139201, 50334.244986324506, 50933.490665092875, 69223.65388173026, 72508.63745681237, 72664.0, 72989.90515142384, 74368.62815686103, 7526.548407095592, 7742.148363680103, 7749.070111586646, 7844.725434609762, 8088.919110809052, 8668.0, 11217.66347009591, 11899.940500297444, 12376.0, 12514.374281286082, 10614.681559553226, 10796.190285728444, 10808.729781755519, 10968.23222374426, 10997.61508347204, 9825.312228143961, 10224.693259202237, 10622.681319560426, 10690.0, 10850.240483166419, 10780.676579702622, 10969.122470202525, 10990.0, 11083.390413527333, 11214.831777523506, 7702.114256860533, 7783.688652453839, 7850.685972561262, 7901.130875603794, 8127.634256458356, 9666.323357364918, 9890.802183956424, 10452.320599161334, 10745.355278683304, 11008.39453830015], "unit": "score", "name": "jquery.html", "value": 9393.843338132794}, {"lowerIsBetter": false, "replicates": [1456.9873937613363, 1589.5787616281684, 1613.096665867114, 1894.8389386902113, 2025.058347868241, 7937.5237485750895, 8471.237588617023, 8652.091530389305, 8675.305975521958, 8676.95661521693, 8337.16628337166, 8565.785855353604, 8578.099299573549, 8584.613692383859, 8596.183362580561, 2156.1914282144194, 2202.3282898715884, 2209.5801797658473, 2426.817988650849, 2477.7893879020303, 2219.345293138528, 2432.221689059502, 2490.987545062272, 2495.263897150345, 2496.10140349474, 2040.3776848061336, 2421.83047186697, 2456.8403053801535, 2462.22439931421, 2467.0748469324003, 2443.364725171459, 2443.841150325241, 2447.2291228263216, 2451.521953219123, 2451.558719430493, 2401.0, 2450.718167410753, 2454.202384225116, 2460.963085553718, 2466.050570530341, 8645.351598630064, 8742.388032837704, 8742.562871856382, 8747.387682862201, 8754.474731516066, 5328.946710532922, 5437.918431223535, 5484.725763711838, 5495.422980587021, 5496.4503549645115, 3537.7523573349877, 3539.6460353964653, 3717.8141092945243, 3725.403935370328, 3741.5323084614424, 1045.1273186888957, 1049.5644307612408, 1055.5724931402794, 1073.420353009374, 1073.8335557988523, 11441.427928603536, 11532.36571988532, 11555.248908820984, 11620.6513804586, 11688.357140357277, 4807.471178170398, 4908.901821963541, 4960.206366981266, 4971.37857767779, 4978.65149439543, 9974.45140517264, 10054.34646747959, 10063.748406289902, 10067.848982265272, 10110.191184705205, 5471.863203419866, 5478.068728316196, 5479.369872464637, 5480.780768769284, 5482.424345443751, 4421.358902959053, 4570.542945705402, 4893.290472881412, 4960.181570040975, 4961.627877909171, 3883.184531248413, 3904.316744569689, 3973.940390894139, 3978.264021156095, 3981.343078392033, 1299.811527328532, 1311.6392991927105, 1324.0599174586152, 1328.0570794735652, 1337.518493342396, 1351.5607427585878, 1351.9526816561372, 1376.0436496634743, 1413.7313910357, 1420.112429731418, 7904.20957904205, 8039.15588863161, 8048.114707382183, 8054.436189466681, 8060.919390806017, 1201.567435723139, 1212.7695737809963, 1230.913836031487, 1231.2550906701497, 1255.121415009497, 6259.2488901332135, 6289.0, 6358.268799088164, 6359.459445947146, 6367.777127800598, 10181.440020798927, 10548.578056877639, 10603.098736607475, 10670.0, 10679.0, 10114.089731924016, 10481.423521706227, 10481.423521706227, 10530.210234232463, 10556.47217639115, 8012.759617211493, 8126.024877014796, 8151.5109093454585, 8202.58987050645, 8222.876656850032, 7559.811004724926, 7740.458167928191, 7811.0, 7821.843563128819, 7824.530528168328, 9174.26605871542, 9331.72004839856, 9444.291678124306, 9508.524573771145, 9552.713418597454, 8221.876671850046, 9571.425714457155, 9722.513874306398, 9800.11798938099, 9985.101340879355, 6667.966660166862, 7062.505624606229, 7449.4412919032375, 7492.550446973199, 7524.887126693214, 6656.467482601283, 8140.87788683182, 8146.389020823343, 8147.307478864126, 8164.387670924823, 7031.718731250693, 7141.642917853983, 7164.247753985756, 7271.0, 7299.197088320174, 7029.683664235019, 7041.0, 7081.681324340314, 7178.676959536729, 7201.783946481614, 6034.7284372202475, 7514.211007844317, 7565.773026809205, 7617.200193979553, 7626.504277221963, 6912.516123871281, 6922.238553758982, 6970.302969702989, 6973.232944376216, 6985.336393042653, 6909.136357955255, 7022.894656580053, 7023.157221133497, 7067.081279433641, 7102.147742270754], "unit": "score", "name": "mootools.html", "value": 4912.45499469365}, {"lowerIsBetter": false, "replicates": [298.2097441779285, 316.87483444039606, 327.13146595788174, 327.28324968319384, 336.54230246864273, 6389.0735843302755, 6448.193975753031, 6451.935480645192, 6476.773312934049, 6559.212894452672, 6423.550351475398, 6452.51606129541, 6455.128557644716, 6471.773487927923, 6484.22189337279, 4616.44602647681, 4767.5709186173235, 4770.8750768246855, 4827.493113223122, 4858.854234372974, 3856.9807150964207, 4073.61497090989, 4641.605463535587, 4655.930161047587, 4757.690750101249, 4778.450478195, 4801.663883528155, 4815.398075240595, 4815.759212039402, 4817.759112044401, 4775.594074503671, 4795.424549054101, 4825.155597770411, 4827.155247831633, 4835.806567737286, 3897.259520691088, 3971.702122340836, 4059.3707975263883, 4063.553009168989, 4135.338345864648, 6142.907856382158, 6167.383261673842, 6186.319504854462, 6186.9381306186815, 6193.566450348478, 5654.575906807006, 5657.660540367591, 5666.376698563155, 5668.348139963916, 5672.092465205547, 6864.897026544606, 6878.621675807829, 6879.58722476648, 6887.483438742114, 6888.827779305508, 4588.0, 4592.862214133581, 4594.494605593382, 4597.0, 4617.353570500132, 5568.610197286192, 7201.675924583354, 7254.637268136625, 7284.417246620258, 7304.634768261619, 4653.906921861544, 4691.859244222679, 4704.03567268716, 4715.905681886343, 4716.151092803259, 4291.03451723366, 4497.9325310120375, 4783.617310615143, 4787.329773831666, 4792.616590672737, 5593.8321850344555, 5596.412376700469, 5600.859978500489, 5608.69152196625, 5615.101583746663, 6888.345607167311, 6889.517733758589, 6901.033855260268, 6908.3437073477935, 6920.826979325557, 1397.82527184102, 1570.1452933049336, 1642.5565097423628, 1663.4261179892917, 1665.53365057784, 1077.4343469678324, 1077.5097330714507, 1086.9402182880017, 1090.0625462102585, 1101.6639924823005, 6432.9678351607945, 6439.871202575922, 6441.742330306735, 6452.870942581122, 6466.838329041811, 6923.6192009438955, 7006.614636195059, 7153.3919616833155, 7173.748918787817, 7195.964020179866, 5086.287919691246, 6373.458256048195, 6439.613623182624, 6500.707468163944, 6522.15212022434, 3176.348848486055, 3767.4348847672522, 3769.0577355661085, 3808.6953043756434, 3827.5789663137034, 7604.429667774939, 7605.391568674493, 7608.467407281437, 7628.580428076398, 7629.122650895218, 7225.385842203366, 7443.925560744432, 7452.441066920002, 7458.664360103809, 7484.176740558534, 7514.586697731677, 7548.320651141424, 7569.1295501018085, 7569.886451703229, 7583.7724868254045, 7214.0, 7222.674979625825, 7228.530145540523, 7234.02340684022, 7241.5293005954445, 6453.741850325934, 7096.503244772816, 7132.607706576188, 7138.072050633385, 7146.392556632536, 7430.331270185709, 7585.924140758521, 7595.734149304748, 7605.847883042419, 7606.163322034682, 4657.951960808791, 4754.738489383117, 4761.476237613929, 4763.857084287477, 4776.522347765195, 7108.537945033763, 7125.501214914906, 7147.85704285901, 7148.0350152728715, 7167.139943206848, 5912.822615321547, 6629.07192992991, 6659.667016649245, 6880.65596720172, 6888.276730943179, 6798.354156355138, 6899.482538809509, 6920.9307906920285, 6921.653917304216, 6930.61881596517, 6697.196336439659, 6764.289749576224, 6769.93230067693, 6774.525783195129, 6791.830204244933, 6910.654467276516, 6911.274316196727, 6917.27368626287, 6918.688659010256, 6933.237343892269, 5515.0, 6493.577917435352, 6759.594424334556, 6768.052472653931, 6769.729210831511], "unit": "score", "name": "prototype.html", "value": 5063.823762679027}, {"lowerIsBetter": false, "replicates": [712.7434123715461, 765.4718244411356, 768.2240936653977, 770.506875599616, 821.4085858182109, 15003.849961500382, 15173.39306427743, 15250.161241131733, 15305.540833774976, 15314.310856011492, 13958.651033724162, 13968.161910285364, 13973.161610303363, 13992.930035349835, 14014.019018668672, 922.9861552076708, 937.634322614181, 942.6370847223834, 944.8110377924409, 945.347710080046, 752.9585872776995, 760.2587477209704, 879.885614870066, 917.6008436330185, 937.1565590968115, 986.8322385194498, 994.368575954267, 998.2562990572034, 998.3859926145441, 1003.0571263012781, 991.3754334769085, 993.538004827755, 994.6369575105107, 996.4170959988415, 998.9051040151174, 594.2067340100971, 598.335847209597, 601.4526780629606, 731.8024133483983, 757.1708978668349, 14866.959312848105, 14941.02883312592, 14954.850451495564, 14964.925175374163, 14987.0, 12322.507099716, 12372.505099795997, 12406.193597416139, 12417.379131043412, 12648.241105533698, 9775.853362199572, 9825.164860986824, 9886.456244906527, 10110.49447527628, 10221.131203847683, 3431.1936694876686, 3470.5908646181415, 3527.9823600882087, 3712.201876596545, 3723.255348930225, 83549.58225208896, 83557.0, 83668.16331836664, 83690.0, 83926.0, 9340.299477539213, 9468.0, 9494.715158545254, 9547.093026162504, 9793.510324483746, 21754.0, 21780.89109554474, 21795.891020544797, 21839.563208735737, 21895.562088758456, 7298.197198308182, 7420.183779784219, 7474.925250747532, 7502.664581486362, 7540.472166948261, 4100.91798164035, 4143.0678097428445, 4147.00471886745, 4158.272302347077, 4169.770662613585, 3144.0, 3636.7272454565486, 3667.3032123896373, 3681.5029970954115, 3681.5214022176947, 630.8612105336819, 646.9967650161719, 653.1998302080009, 656.8095252376758, 668.3416834418094, 584.8391692284571, 601.4136217188294, 624.5128799536369, 640.6604499615212, 644.4200219802121, 7610.847783044308, 7649.694012239448, 8099.878501822477, 8150.388720845842, 8215.383846211558, 557.6431084106175, 567.8126218347935, 576.7001159397174, 599.9520038396918, 627.4760574919993, 3713.8514459421863, 3742.925141497155, 3751.4185301278344, 3818.0, 3818.8090595470117, 94807.0, 95612.52193739126, 97425.0, 97454.0, 97772.0, 79239.0, 79760.0, 80336.0, 80586.19413805786, 81433.0, 69597.0, 70440.64779676069, 71707.0, 71747.0, 72976.0, 7519.699212031676, 7523.473356864967, 7564.130125035691, 7642.617869106633, 7769.339606133316, 49749.253761192886, 50034.49965500444, 50093.24860127028, 50540.0, 51164.97670046653, 61978.38021619726, 64833.67583162054, 64853.0, 66098.0, 71827.92258116028, 11196.38419886914, 11395.829062564235, 11428.0, 11510.53957841677, 11531.654050378502, 11944.76110477803, 12124.75750485003, 12282.201656892274, 12287.75424491523, 12405.813912791134, 11440.94279528597, 11450.427478625868, 11851.407429628312, 11964.700882478008, 11973.76052478963, 11598.362090085126, 11629.24409913353, 11650.825237621611, 11712.70718232051, 11928.880711193124, 11165.553377864795, 11175.72060698489, 11223.494942727433, 11497.367644779617, 11740.060795136198, 9456.905430945602, 9508.667196648084, 9623.518824058909, 9999.500024998866, 10052.246081543768, 9410.95294523523, 9438.95280523593, 9470.052994700474, 9485.905140948502, 9639.325247232908], "unit": "score", "name": "yui.html", "value": 6958.597123919936}], "name": "dromaeo_css", "value": 7459.75554231211}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [150.0, 157.0, 164.0, 125.0, 113.0, 111.0, 119.0, 114.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 127.4}, {"lowerIsBetter": true, "replicates": [158.0, 121.0, 142.0, 158.0, 119.0, 139.0, 145.0, 142.0, 166.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 186.0, 189.0, 185.0, 185.0, 186.0, 180.0, 182.0, 186.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [80.0, 75.0, 86.0, 80.0, 81.0, 84.0, 83.0, 101.0, 77.0, 81.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [97.0, 93.0, 129.0, 78.0, 81.0, 80.0, 115.0, 78.0, 82.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.8}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 85.0, 87.0, 83.0, 89.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 93.0, 96.0, 97.0, 118.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 100.9}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 86.0, 87.0, 85.0, 84.0, 87.0, 83.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 54.0, 53.0, 54.0, 54.0, 53.0, 64.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 66.0, 72.0, 72.0, 67.0, 66.0, 67.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 79.0, 84.0, 82.0, 82.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [132.0, 128.0, 109.0, 133.0, 132.0, 128.0, 126.0, 119.0, 119.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [140.0, 126.0, 138.0, 139.0, 137.0, 127.0, 138.0, 139.0, 139.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 69.0, 69.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1438.6999999999998}]} 18:32:29 INFO - Return code: 0 18:32:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:32:29 ERROR - # TBPL SUCCESS # 18:32:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:29 INFO - 2016-03-18 18:32:29.710 screenresolution[1687:9918] starting screenresolution argv=screenresolution get 18:32:29 INFO - 2016-03-18 18:32:29.713 screenresolution[1687:9918] Display 0: 1600x1200x32@60 18:32:29 INFO - 2016-03-18 18:32:29.718 screenresolution[1688:9921] starting screenresolution argv=screenresolution list 18:32:29 INFO - Available Modes on Display 0 18:32:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:29 INFO - Intel Iris: 18:32:29 INFO - Chipset Model: Intel Iris 18:32:29 INFO - Type: GPU 18:32:29 INFO - Bus: Built-In 18:32:29 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:29 INFO - Vendor: Intel (0x8086) 18:32:29 INFO - Device ID: 0x0a2e 18:32:29 INFO - Revision ID: 0x0009 18:32:29 INFO - Displays: 18:32:29 INFO - Display: 18:32:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:29 INFO - Display Serial Number: 1600x1200 60 18:32:29 INFO - Main Display: Yes 18:32:29 INFO - Mirror: Off 18:32:29 INFO - Online: Yes 18:32:29 INFO - Rotation: Supported 18:32:29 INFO - Return code: 0 18:32:29 INFO - Running post-action listener: _resource_record_post_action 18:32:29 INFO - Running post-run listener: _resource_record_post_run 18:32:31 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39466496; Write bytes: 707906048; Read time: 434; Write time: 1924 18:32:31 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 385235456; Write bytes: 378435584; Read time: 28682; Write time: 663 18:32:31 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38508032; Write bytes: 300059136; Read time: 420; Write time: 1119 18:32:31 INFO - Running post-run listener: _upload_blobber_files 18:32:31 INFO - Blob upload gear active. 18:32:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:31 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 18:32:31 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:31 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:31 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:32:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:32:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:32 INFO - (blobuploader) - INFO - Done attempting. 18:32:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:32:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:33 INFO - (blobuploader) - INFO - Done attempting. 18:32:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:33 INFO - Return code: 0 18:32:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/936a23db9c923257f8704ba7f656c8002e9919f854ac89d554576a47793389a73bcdb3a219164ff3fd98efbd0c39014e911e5d5375e906e43598231b20c97891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f16c1c7a6a8ee1249039af6eda430bddd6ae258a659938d3ee4bf622cdac62e3e716b85fbb48887d18a1123872667c199c488ff80950392829e89b6ae7c6b386"} 18:32:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:33 INFO - Contents: 18:32:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/936a23db9c923257f8704ba7f656c8002e9919f854ac89d554576a47793389a73bcdb3a219164ff3fd98efbd0c39014e911e5d5375e906e43598231b20c97891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f16c1c7a6a8ee1249039af6eda430bddd6ae258a659938d3ee4bf622cdac62e3e716b85fbb48887d18a1123872667c199c488ff80950392829e89b6ae7c6b386"} 18:32:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:33 INFO - Copying logs to upload dir... 18:32:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.087343 ========= master_lag: 0.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-18 18:32:34.048593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 18:32:34.052152) ========= 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.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/Fx-Team/sha512/936a23db9c923257f8704ba7f656c8002e9919f854ac89d554576a47793389a73bcdb3a219164ff3fd98efbd0c39014e911e5d5375e906e43598231b20c97891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f16c1c7a6a8ee1249039af6eda430bddd6ae258a659938d3ee4bf622cdac62e3e716b85fbb48887d18a1123872667c199c488ff80950392829e89b6ae7c6b386"} build_url:https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/EaRlHOZhTeWzfzN8bnwyyQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/936a23db9c923257f8704ba7f656c8002e9919f854ac89d554576a47793389a73bcdb3a219164ff3fd98efbd0c39014e911e5d5375e906e43598231b20c97891", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f16c1c7a6a8ee1249039af6eda430bddd6ae258a659938d3ee4bf622cdac62e3e716b85fbb48887d18a1123872667c199c488ff80950392829e89b6ae7c6b386"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-18 18:32:34.143860) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:32:34.144185) ========= 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.a4baeHAhlt/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.rv42r4TUpO/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005180 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-18 18:32:34.349572) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 18:32:34.349879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-18 18:32:34.354467) ========= ========= Total master_lag: 1.04 =========