builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1455041093.13 results: success (0) buildid: 20160209073407 builduid: e4df59b32670491db61968de5e687148 revision: 62437a8123876ca69e54c68a40659704139ce2d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.129019) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.129472) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.129795) ========= 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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005820 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.175976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.176252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.217314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.217900) ========= 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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005329 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.275653) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.275983) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.276334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.276605) ========= 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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-02-09 10:04:53-- 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% 8.31M=0.001s 2016-02-09 10:04:53 (8.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101895 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.395798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.396121) ========= 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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.019863 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:53.447005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 10:04:53.447360) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62437a8123876ca69e54c68a40659704139ce2d5 --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 62437a8123876ca69e54c68a40659704139ce2d5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-02-09 10:04:53,512 truncating revision to first 12 chars 2016-02-09 10:04:53,512 Setting DEBUG logging. 2016-02-09 10:04:53,512 attempt 1/10 2016-02-09 10:04:53,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62437a812387?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 10:04:54,746 unpacking tar archive at: fx-team-62437a812387/testing/mozharness/ program finished with exit code 0 elapsedTime=1.478026 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 10:04:54.992239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:54.992578) ========= echo 62437a8123876ca69e54c68a40659704139ce2d5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'62437a8123876ca69e54c68a40659704139ce2d5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 62437a8123876ca69e54c68a40659704139ce2d5 program finished with exit code 0 elapsedTime=0.004726 script_repo_revision: '62437a8123876ca69e54c68a40659704139ce2d5' ========= master_lag: 0.01 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:55.011855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:55.012178) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 10:04:55.023376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-09 10:04:55.023675) ========= /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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:04:55 INFO - MultiFileLogger online at 20160209 10:04:55 in /builds/slave/test 10:04:55 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 10:04:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:04:55 INFO - {'append_to_log': False, 10:04:55 INFO - 'base_work_dir': '/builds/slave/test', 10:04:55 INFO - 'blob_upload_branch': 'Fx-Team', 10:04:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:04:55 INFO - 'branch': 'Fx-Team', 10:04:55 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:55 INFO - 'config_files': ('talos/mac_config.py',), 10:04:55 INFO - 'default_actions': ('clobber', 10:04:55 INFO - 'read-buildbot-config', 10:04:55 INFO - 'download-and-extract', 10:04:55 INFO - 'populate-webroot', 10:04:55 INFO - 'create-virtualenv', 10:04:55 INFO - 'install', 10:04:55 INFO - 'run-tests'), 10:04:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:55 INFO - 'download_minidump_stackwalk': True, 10:04:55 INFO - 'download_symbols': 'ondemand', 10:04:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:55 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:55 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:55 INFO - 'installer_path': 'installer.exe', 10:04:55 INFO - 'log_level': 'info', 10:04:55 INFO - 'log_name': 'talos', 10:04:55 INFO - 'log_to_console': True, 10:04:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:04:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:04:55 INFO - 'opt_config_files': (), 10:04:55 INFO - 'pip_index': False, 10:04:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:04:55 INFO - 'cmd': ('bash', 10:04:55 INFO - '-c', 10:04:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:04:55 INFO - 'enabled': True, 10:04:55 INFO - 'halt_on_failure': False, 10:04:55 INFO - 'name': 'check_screen_resolution'},), 10:04:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:04:55 INFO - 'cmd': ('bash', 10:04:55 INFO - '-c', 10:04:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:04:55 INFO - 'enabled': True, 10:04:55 INFO - 'halt_on_failure': False, 10:04:55 INFO - 'name': 'check_screen_resolution'},), 10:04:55 INFO - 'run_cmd_checks_enabled': True, 10:04:55 INFO - 'sps_profile': False, 10:04:55 INFO - 'sps_profile_interval': 0, 10:04:55 INFO - 'suite': 'dromaeojs', 10:04:55 INFO - 'system_bits': '32', 10:04:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:55 INFO - 'title': 't-yosemite-r7-0032', 10:04:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:55 INFO - 'use_talos_json': True, 10:04:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:04:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:55 INFO - 'work_dir': 'build'} 10:04:55 INFO - ##### 10:04:55 INFO - ##### Running clobber step. 10:04:55 INFO - ##### 10:04:55 INFO - Running pre-action listener: _resource_record_pre_action 10:04:55 INFO - Running main action method: clobber 10:04:55 INFO - rmtree: /builds/slave/test/build 10:04:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:04:56 INFO - Running post-action listener: _resource_record_post_action 10:04:56 INFO - ##### 10:04:56 INFO - ##### Running read-buildbot-config step. 10:04:56 INFO - ##### 10:04:56 INFO - Running pre-action listener: _resource_record_pre_action 10:04:56 INFO - Running main action method: read_buildbot_config 10:04:56 INFO - Using buildbot properties: 10:04:56 INFO - { 10:04:56 INFO - "project": "", 10:04:56 INFO - "product": "firefox", 10:04:56 INFO - "script_repo_revision": "production", 10:04:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:04:56 INFO - "repository": "", 10:04:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:04:56 INFO - "buildid": "20160209073407", 10:04:56 INFO - "pgo_build": "False", 10:04:56 INFO - "basedir": "/builds/slave/test", 10:04:56 INFO - "buildnumber": 351, 10:04:56 INFO - "slavename": "t-yosemite-r7-0032", 10:04:56 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:04:56 INFO - "platform": "yosemite_r7", 10:04:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:04:56 INFO - "branch": "fx-team", 10:04:56 INFO - "repo_path": "integration/fx-team", 10:04:56 INFO - "revision": "62437a8123876ca69e54c68a40659704139ce2d5", 10:04:56 INFO - "stage_platform": "macosx64", 10:04:56 INFO - "builduid": "e4df59b32670491db61968de5e687148", 10:04:56 INFO - "slavebuilddir": "test" 10:04:56 INFO - } 10:04:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:04:56 INFO - Running post-action listener: _resource_record_post_action 10:04:56 INFO - ##### 10:04:56 INFO - ##### Running download-and-extract step. 10:04:56 INFO - ##### 10:04:56 INFO - Running pre-action listener: _resource_record_pre_action 10:04:56 INFO - Running main action method: download_and_extract 10:04:56 INFO - mkdir: /builds/slave/test/build/tests 10:04: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')]} 10:04:56 INFO - https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/test_packages.json 10:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/test_packages.json 10:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:04:57 INFO - Downloaded 1277 bytes. 10:04:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:04:57 INFO - Using the following test package requirements: 10:04:57 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:04:57 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:04:57 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:04:57 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'jsshell-mac.zip'], 10:04:57 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:04:57 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:04:57 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:04:57 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:04:57 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:04:57 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:04:57 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:04:57 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:04:57 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:04: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')]} 10:04:57 INFO - https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:04:58 INFO - Downloaded 17747107 bytes. 10:04:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:04:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:05:01 INFO - Return code: 0 10:05:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:01 INFO - https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:05:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:05:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:05:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:05:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:05:03 INFO - Downloaded 17747107 bytes. 10:05:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:05:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:05:06 INFO - Return code: 0 10:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:06 INFO - https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:05:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:05:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:05:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:05:07 INFO - Downloaded 10706547 bytes. 10:05:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:05:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:05:07 INFO - Return code: 0 10:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:07 INFO - https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 10:05:14 INFO - Downloaded 111246576 bytes. 10:05:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:05:14 INFO - mkdir: /builds/slave/test/properties 10:05:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:14 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:14 INFO - Contents: 10:05:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:05:15 INFO - Running post-action listener: _resource_record_post_action 10:05:15 INFO - Running post-action listener: set_extra_try_arguments 10:05:15 INFO - ##### 10:05:15 INFO - ##### Running populate-webroot step. 10:05:15 INFO - ##### 10:05:15 INFO - Running pre-action listener: _resource_record_pre_action 10:05:15 INFO - Running main action method: populate_webroot 10:05:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:15 INFO - '--tppagecycles', 10:05:15 INFO - '7'], 10:05:15 INFO - 'tests': ['tsvgm']}}, 10:05:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:05:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:05:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'tests': ['damp', 'tps']}, 10:05:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['damp', 'tps']}, 10:05:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:05:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:15 INFO - 'other': {'tests': ['a11yr', 10:05:15 INFO - 'ts_paint', 10:05:15 INFO - 'tpaint', 10:05:15 INFO - 'sessionrestore', 10:05:15 INFO - 'sessionrestore_no_auto_restore']}, 10:05:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['a11yr', 10:05:15 INFO - 'ts_paint', 10:05:15 INFO - 'tpaint', 10:05:15 INFO - 'sessionrestore', 10:05:15 INFO - 'sessionrestore_no_auto_restore']}, 10:05:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['a11yr', 10:05:15 INFO - 'ts_paint', 10:05:15 INFO - 'tpaint', 10:05:15 INFO - 'sessionrestore', 10:05:15 INFO - 'sessionrestore_no_auto_restore']}, 10:05:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['a11yr', 10:05:15 INFO - 'ts_paint', 10:05:15 INFO - 'tpaint', 10:05:15 INFO - 'sessionrestore', 10:05:15 INFO - 'sessionrestore_no_auto_restore']}, 10:05:15 INFO - 'other_l64': {'tests': ['a11yr', 10:05:15 INFO - 'ts_paint', 10:05:15 INFO - 'tpaint', 10:05:15 INFO - 'sessionrestore', 10:05:15 INFO - 'sessionrestore_no_auto_restore']}, 10:05:15 INFO - 'other_nol64': {'tests': ['a11yr', 10:05:15 INFO - 'ts_paint', 10:05:15 INFO - 'tpaint', 10:05:15 INFO - 'sessionrestore', 10:05:15 INFO - 'sessionrestore_no_auto_restore']}, 10:05:15 INFO - 'svgr': {'tests': ['tsvgx', 10:05:15 INFO - 'tsvgr_opacity', 10:05:15 INFO - 'tart', 10:05:15 INFO - 'tscrollx', 10:05:15 INFO - 'cart']}, 10:05:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['tsvgx', 10:05:15 INFO - 'tsvgr_opacity', 10:05:15 INFO - 'tart', 10:05:15 INFO - 'tscrollx', 10:05:15 INFO - 'cart']}, 10:05:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'tests': ['tp5o']}, 10:05:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'talos_options': ['--e10s'], 10:05:15 INFO - 'tests': ['tp5o']}, 10:05:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'talos_options': ['--xperf_path', 10:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:15 INFO - 'tests': ['tp5n']}, 10:05:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:15 INFO - 'talos_options': ['--e10s', 10:05:15 INFO - '--xperf_path', 10:05:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:15 INFO - 'tests': ['tp5n']}}, 10:05:15 INFO - 'talos.zip': {'path': '', 10:05:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:15 INFO - Running post-action listener: _resource_record_post_action 10:05:15 INFO - ##### 10:05:15 INFO - ##### Running create-virtualenv step. 10:05:15 INFO - ##### 10:05:15 INFO - Running pre-action listener: _resource_record_pre_action 10:05:15 INFO - Running main action method: create_virtualenv 10:05:15 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:15 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 10:05:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:15 INFO - Using real prefix '/tools/python27' 10:05:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:16 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:19 INFO - Installing pip.................done. 10:05:19 INFO - Return code: 0 10:05:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:19 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 10:05:19 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 10:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:19 INFO - 'HOME': '/Users/cltbld', 10:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:19 INFO - 'LOGNAME': 'cltbld', 10:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:19 INFO - 'MOZ_NO_REMOTE': '1', 10:05:19 INFO - 'NO_EM_RESTART': '1', 10:05:19 INFO - 'PAGER': '/bin/cat', 10:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:19 INFO - 'PWD': '/builds/slave/test', 10:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:19 INFO - 'SHELL': '/bin/bash', 10:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:19 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:19 INFO - 'USER': 'cltbld', 10:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:19 INFO - 'XPC_FLAGS': '0x0', 10:05:19 INFO - 'XPC_SERVICE_NAME': '0', 10:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:19 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 10:05:19 INFO - Cleaning up... 10:05:19 INFO - Return code: 0 10:05:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:19 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:19 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 10:05:19 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 10:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:19 INFO - 'HOME': '/Users/cltbld', 10:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:19 INFO - 'LOGNAME': 'cltbld', 10:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:19 INFO - 'MOZ_NO_REMOTE': '1', 10:05:19 INFO - 'NO_EM_RESTART': '1', 10:05:19 INFO - 'PAGER': '/bin/cat', 10:05:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:19 INFO - 'PWD': '/builds/slave/test', 10:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:19 INFO - 'SHELL': '/bin/bash', 10:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:19 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:19 INFO - 'USER': 'cltbld', 10:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:19 INFO - 'XPC_FLAGS': '0x0', 10:05:19 INFO - 'XPC_SERVICE_NAME': '0', 10:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:19 INFO - Downloading/unpacking psutil>=0.7.1 10:05:19 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 10:05:19 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 10:05:19 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 10:05:19 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 10:05:19 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 10:05:19 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 10:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:22 INFO - Installing collected packages: psutil 10:05:22 INFO - Running setup.py install for psutil 10:05:23 INFO - building 'psutil._psutil_osx' extension 10:05:23 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 10:05:23 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 10:05:23 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 10:05:23 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 10:05:23 INFO - building 'psutil._psutil_posix' extension 10:05:23 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 10:05:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:05:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:05:23 INFO - ^ 10:05:23 INFO - 1 warning generated. 10:05:23 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 10:05:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:23 INFO - Successfully installed psutil 10:05:23 INFO - Cleaning up... 10:05:23 INFO - Return code: 0 10:05:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:23 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:23 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 10:05:23 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 10:05:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:23 INFO - 'HOME': '/Users/cltbld', 10:05:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:23 INFO - 'LOGNAME': 'cltbld', 10:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:23 INFO - 'MOZ_NO_REMOTE': '1', 10:05:23 INFO - 'NO_EM_RESTART': '1', 10:05:23 INFO - 'PAGER': '/bin/cat', 10:05:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:23 INFO - 'PWD': '/builds/slave/test', 10:05:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:23 INFO - 'SHELL': '/bin/bash', 10:05:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:23 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:23 INFO - 'USER': 'cltbld', 10:05:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:23 INFO - 'XPC_FLAGS': '0x0', 10:05:23 INFO - 'XPC_SERVICE_NAME': '0', 10:05:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:05:26 INFO - Installing collected packages: mozsystemmonitor 10:05:26 INFO - Running setup.py install for mozsystemmonitor 10:05:26 INFO - Successfully installed mozsystemmonitor 10:05:26 INFO - Cleaning up... 10:05:26 INFO - Return code: 0 10:05:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05:26 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')]} 10:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:26 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')]} 10:05:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:26 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:26 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 10:05:26 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 10:05:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:26 INFO - 'HOME': '/Users/cltbld', 10:05:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:26 INFO - 'LOGNAME': 'cltbld', 10:05:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:26 INFO - 'MOZ_NO_REMOTE': '1', 10:05:26 INFO - 'NO_EM_RESTART': '1', 10:05:26 INFO - 'PAGER': '/bin/cat', 10:05:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:26 INFO - 'PWD': '/builds/slave/test', 10:05:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:26 INFO - 'SHELL': '/bin/bash', 10:05:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:26 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:26 INFO - 'USER': 'cltbld', 10:05:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:26 INFO - 'XPC_FLAGS': '0x0', 10:05:26 INFO - 'XPC_SERVICE_NAME': '0', 10:05:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:26 INFO - Downloading/unpacking blobuploader==1.2.4 10:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:30 INFO - Downloading docopt-0.6.1.tar.gz 10:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:30 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:30 INFO - Running setup.py install for blobuploader 10:05:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:30 INFO - Running setup.py install for requests 10:05:31 INFO - Running setup.py install for docopt 10:05:31 INFO - Successfully installed blobuploader requests docopt 10:05:31 INFO - Cleaning up... 10:05:31 INFO - Return code: 0 10:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:31 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')]} 10:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:31 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')]} 10:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:31 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:31 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 10:05:31 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 10:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:31 INFO - 'HOME': '/Users/cltbld', 10:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:31 INFO - 'LOGNAME': 'cltbld', 10:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:31 INFO - 'MOZ_NO_REMOTE': '1', 10:05:31 INFO - 'NO_EM_RESTART': '1', 10:05:31 INFO - 'PAGER': '/bin/cat', 10:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:31 INFO - 'PWD': '/builds/slave/test', 10:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:31 INFO - 'SHELL': '/bin/bash', 10:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:31 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:31 INFO - 'USER': 'cltbld', 10:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:31 INFO - 'XPC_FLAGS': '0x0', 10:05:31 INFO - 'XPC_SERVICE_NAME': '0', 10:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kWG8ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VD_CDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kRh89j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:31 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-um4kr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-D1uHTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-eFchEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yQYLaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-46LT89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gwJYE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gYHNPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SARmgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-W7eKKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yr7dwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:32 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-aanq2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:33 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-xiT9hT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:33 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6Kv0Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:33 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wgZ368-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:33 INFO - Running setup.py install for manifestparser 10:05:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Running setup.py install for mozcrash 10:05:33 INFO - Running setup.py install for mozdebug 10:05:33 INFO - Running setup.py install for mozdevice 10:05:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:33 INFO - Running setup.py install for mozfile 10:05:34 INFO - Running setup.py install for mozhttpd 10:05:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Running setup.py install for mozinfo 10:05:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Running setup.py install for mozInstall 10:05:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Running setup.py install for mozleak 10:05:34 INFO - Running setup.py install for mozlog 10:05:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:34 INFO - Running setup.py install for moznetwork 10:05:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:35 INFO - Running setup.py install for mozprocess 10:05:35 INFO - Running setup.py install for mozprofile 10:05:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:35 INFO - Running setup.py install for mozrunner 10:05:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:35 INFO - Running setup.py install for mozscreenshot 10:05:35 INFO - Running setup.py install for moztest 10:05:35 INFO - Running setup.py install for mozversion 10:05:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:35 INFO - Cleaning up... 10:05:35 INFO - Return code: 0 10:05:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:35 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')]} 10:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 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')]} 10:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:35 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:35 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 10:05:35 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 10:05:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:35 INFO - 'HOME': '/Users/cltbld', 10:05:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:35 INFO - 'LOGNAME': 'cltbld', 10:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:35 INFO - 'MOZ_NO_REMOTE': '1', 10:05:35 INFO - 'NO_EM_RESTART': '1', 10:05:35 INFO - 'PAGER': '/bin/cat', 10:05:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:35 INFO - 'PWD': '/builds/slave/test', 10:05:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:35 INFO - 'SHELL': '/bin/bash', 10:05:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:35 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:35 INFO - 'USER': 'cltbld', 10:05:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:36 INFO - 'XPC_FLAGS': '0x0', 10:05:36 INFO - 'XPC_SERVICE_NAME': '0', 10:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6VHqM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:36 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)) 10:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-skvVad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 10:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-jf7cez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:36 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)) 10:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sKqyZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:36 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)) 10:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-YM7gtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:36 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)) 10:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:36 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wyCf2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hJ2k4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Wdywfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-duKLLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-7PS6Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-AMXqjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-GiH51z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uSY6q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hQr_y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:37 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)) 10:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:37 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-i3FdAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:38 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)) 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-IYK9l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:38 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)) 10:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-F5U3Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:38 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)) 10:05:38 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:38 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:05:38 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)) 10:05:38 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)) 10:05:38 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)) 10:05:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:38 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 10:05:38 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 10:05:38 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 10:05:38 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 10:05:38 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 10:05:38 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 10:05:40 INFO - Downloading blessings-1.6.tar.gz 10:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:40 INFO - Installing collected packages: blessings 10:05:40 INFO - Running setup.py install for blessings 10:05:40 INFO - Successfully installed blessings 10:05:40 INFO - Cleaning up... 10:05:40 INFO - Return code: 0 10:05:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:41 INFO - Reading from file tmpfile_stdout 10:05:41 INFO - Current package versions: 10:05:41 INFO - blessings == 1.6 10:05:41 INFO - blobuploader == 1.2.4 10:05:41 INFO - docopt == 0.6.1 10:05:41 INFO - manifestparser == 1.1 10:05:41 INFO - mozInstall == 1.12 10:05:41 INFO - mozcrash == 0.16 10:05:41 INFO - mozdebug == 0.1 10:05:41 INFO - mozdevice == 0.48 10:05:41 INFO - mozfile == 1.2 10:05:41 INFO - mozhttpd == 0.7 10:05:41 INFO - mozinfo == 0.9 10:05:41 INFO - mozleak == 0.1 10:05:41 INFO - mozlog == 3.1 10:05:41 INFO - moznetwork == 0.27 10:05:41 INFO - mozprocess == 0.22 10:05:41 INFO - mozprofile == 0.28 10:05:41 INFO - mozrunner == 6.11 10:05:41 INFO - mozscreenshot == 0.1 10:05:41 INFO - mozsystemmonitor == 0.0 10:05:41 INFO - moztest == 0.7 10:05:41 INFO - mozversion == 1.4 10:05:41 INFO - psutil == 3.1.1 10:05:41 INFO - requests == 1.2.3 10:05:41 INFO - wsgiref == 0.1.2 10:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:41 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 10:05:41 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 10:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:41 INFO - 'HOME': '/Users/cltbld', 10:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:41 INFO - 'LOGNAME': 'cltbld', 10:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:41 INFO - 'MOZ_NO_REMOTE': '1', 10:05:41 INFO - 'NO_EM_RESTART': '1', 10:05:41 INFO - 'PAGER': '/bin/cat', 10:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:41 INFO - 'PWD': '/builds/slave/test', 10:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:41 INFO - 'SHELL': '/bin/bash', 10:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:41 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:41 INFO - 'USER': 'cltbld', 10:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:41 INFO - 'XPC_FLAGS': '0x0', 10:05:41 INFO - 'XPC_SERVICE_NAME': '0', 10:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 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)) 10:05:41 INFO - Cleaning up... 10:05:41 INFO - Return code: 0 10:05:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:41 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 10:05:41 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 10:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:41 INFO - 'HOME': '/Users/cltbld', 10:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:41 INFO - 'LOGNAME': 'cltbld', 10:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:41 INFO - 'MOZ_NO_REMOTE': '1', 10:05:41 INFO - 'NO_EM_RESTART': '1', 10:05:41 INFO - 'PAGER': '/bin/cat', 10:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:41 INFO - 'PWD': '/builds/slave/test', 10:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:41 INFO - 'SHELL': '/bin/bash', 10:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:41 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:41 INFO - 'USER': 'cltbld', 10:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:41 INFO - 'XPC_FLAGS': '0x0', 10:05:41 INFO - 'XPC_SERVICE_NAME': '0', 10:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 INFO - Downloading/unpacking jsonschema 10:05:41 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 10:05:41 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 10:05:41 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 10:05:41 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 10:05:41 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 10:05:41 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 10:05:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:43 INFO - Downloading/unpacking functools32 (from jsonschema) 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:43 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 10:05:44 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:44 INFO - warning: no files found matching '*.txt' 10:05:44 INFO - no previously-included directories found matching 'build' 10:05:44 INFO - no previously-included directories found matching 'dist' 10:05:44 INFO - no previously-included directories found matching '.git*' 10:05:44 INFO - Installing collected packages: jsonschema, functools32 10:05:44 INFO - Running setup.py install for functools32 10:05:44 INFO - warning: no files found matching '*.txt' 10:05:44 INFO - no previously-included directories found matching 'build' 10:05:44 INFO - no previously-included directories found matching 'dist' 10:05:44 INFO - no previously-included directories found matching '.git*' 10:05:44 INFO - Successfully installed jsonschema functools32 10:05:44 INFO - Cleaning up... 10:05:44 INFO - Return code: 0 10:05:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:45 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')]} 10:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:45 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 0x1068e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f962ad47730>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, '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.t9bslb78Fl/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.TB81qpCfwR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 10:05:45 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 10:05:45 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 10:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:45 INFO - 'HOME': '/Users/cltbld', 10:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:45 INFO - 'LOGNAME': 'cltbld', 10:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:45 INFO - 'MOZ_NO_REMOTE': '1', 10:05:45 INFO - 'NO_EM_RESTART': '1', 10:05:45 INFO - 'PAGER': '/bin/cat', 10:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:45 INFO - 'PWD': '/builds/slave/test', 10:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:45 INFO - 'SHELL': '/bin/bash', 10:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:05:45 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:45 INFO - 'USER': 'cltbld', 10:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:45 INFO - 'XPC_FLAGS': '0x0', 10:05:45 INFO - 'XPC_SERVICE_NAME': '0', 10:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:45 INFO - Downloading/unpacking flake8 10:05:45 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 10:05:45 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 10:05:45 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 10:05:45 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 10:05:45 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 10:05:45 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 10:05:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:48 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 10:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:49 INFO - no previously-included directories found matching 'docs/_build' 10:05:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:49 INFO - Running setup.py install for pep8 10:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:49 INFO - no previously-included directories found matching 'docs/_build' 10:05:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:05:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:49 INFO - Cleaning up... 10:05:49 INFO - Return code: 0 10:05:49 INFO - Running post-action listener: _resource_record_post_action 10:05:49 INFO - Running post-action listener: _start_resource_monitoring 10:05:49 INFO - Starting resource monitoring. 10:05:49 INFO - ##### 10:05:49 INFO - ##### Running install step. 10:05:49 INFO - ##### 10:05:49 INFO - Running pre-action listener: _resource_record_pre_action 10:05:49 INFO - Running main action method: install 10:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:05:49 INFO - Reading from file tmpfile_stdout 10:05:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:05:49 INFO - Reading from file tmpfile_stdout 10:05:49 INFO - Output received: 10:05:49 INFO - Usage: mozinstall [options] installer 10:05:49 INFO - Options: 10:05:49 INFO - -h, --help show this help message and exit 10:05:49 INFO - -d DEST, --destination=DEST 10:05:49 INFO - Directory to install application into. [default: 10:05:49 INFO - "/builds/slave/test"] 10:05:49 INFO - --app=APP Application being installed. [default: firefox] 10:05:49 INFO - mkdir: /builds/slave/test/build/application 10:05:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:05:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:06:24 INFO - Reading from file tmpfile_stdout 10:06:24 INFO - Output received: 10:06:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:06:24 INFO - Running post-action listener: _resource_record_post_action 10:06:24 INFO - ##### 10:06:24 INFO - ##### Running run-tests step. 10:06:24 INFO - ##### 10:06:24 INFO - Running pre-action listener: _resource_record_pre_action 10:06:24 INFO - Running main action method: run_tests 10:06:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:24 INFO - 2016-02-09 10:06:24.088 screenresolution[2291:17810] starting screenresolution argv=screenresolution get 10:06:24 INFO - 2016-02-09 10:06:24.091 screenresolution[2291:17810] Display 0: 1600x1200x32@60 10:06:24 INFO - 2016-02-09 10:06:24.097 screenresolution[2292:17812] starting screenresolution argv=screenresolution list 10:06:24 INFO - Available Modes on Display 0 10:06:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:24 INFO - Intel Iris: 10:06:24 INFO - Chipset Model: Intel Iris 10:06:24 INFO - Type: GPU 10:06:24 INFO - Bus: Built-In 10:06:24 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:24 INFO - Vendor: Intel (0x8086) 10:06:24 INFO - Device ID: 0x0a2e 10:06:24 INFO - Revision ID: 0x0009 10:06:24 INFO - Displays: 10:06:24 INFO - Display: 10:06:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:24 INFO - Display Serial Number: 1600x1200 60 10:06:24 INFO - Main Display: Yes 10:06:24 INFO - Mirror: Off 10:06:24 INFO - Online: Yes 10:06:24 INFO - Rotation: Supported 10:06:24 INFO - Return code: 0 10:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:24 INFO - Python 2.7.3 10:06:24 INFO - Return code: 0 10:06:24 INFO - grabbing minidump binary from tooltool 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:24 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 0x10678cd30>, '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 0x1065b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106783b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:24 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 10:06:24 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 10:06:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:24 INFO - Return code: 0 10:06:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:06:25 INFO - Return code: 0 10:06:25 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/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 10:06:25 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/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 10:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.t9bslb78Fl/Render', 10:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:25 INFO - 'HOME': '/Users/cltbld', 10:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:25 INFO - 'LOGNAME': 'cltbld', 10:06:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:25 INFO - 'MOZ_NO_REMOTE': '1', 10:06:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:25 INFO - 'NO_EM_RESTART': '1', 10:06:25 INFO - 'PAGER': '/bin/cat', 10:06:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:25 INFO - 'PWD': '/builds/slave/test', 10:06:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:25 INFO - 'SHELL': '/bin/bash', 10:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TB81qpCfwR/Listeners', 10:06:25 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 10:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:25 INFO - 'USER': 'cltbld', 10:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:25 INFO - 'XPC_FLAGS': '0x0', 10:06:25 INFO - 'XPC_SERVICE_NAME': '0', 10:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:25 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/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 10:06:25 INFO - mozversion application_buildid: 20160209073407 10:06:25 INFO - mozversion application_changeset: 62437a8123876ca69e54c68a40659704139ce2d5 10:06:25 INFO - mozversion application_display_name: Nightly 10:06:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:25 INFO - mozversion application_name: Firefox 10:06:25 INFO - mozversion application_remotingname: firefox 10:06:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:06:25 INFO - mozversion application_vendor: Mozilla 10:06:25 INFO - mozversion application_version: 47.0a1 10:06:25 INFO - mozversion platform_buildid: 20160209073407 10:06:25 INFO - mozversion platform_changeset: 62437a8123876ca69e54c68a40659704139ce2d5 10:06:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:06:25 INFO - mozversion platform_version: 47.0a1 10:06:25 INFO - using testdate: 1455041185 10:06:25 INFO - actual date: 1455041185 10:06:26 INFO - starting webserver on 'localhost:49881' 10:06:26 INFO - SUITE-START | Running 2 tests 10:06:26 INFO - TEST-START | dromaeo_css 10:06:26 INFO - operating with platform_type : mac_ 10:06:26 INFO - Initialising browser for dromaeo_css test... 10:06:26 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpFKGDoB/profile http://localhost:49881/getInfo.html) 10:06:28 INFO - PROCESS | 2310 | __metrics Screen width/height:1600/1200 10:06:28 INFO - PROCESS | 2310 | colorDepth:24 10:06:28 INFO - PROCESS | 2310 | Browser inner width/height: 1024/689 10:06:28 INFO - PROCESS | 2310 | __metrics 10:06:28 INFO - PROCESS | 2310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:06:28 INFO - PROCESS | 2310 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:06:29 INFO - TEST-INFO | 2310: exit 0 10:06:29 INFO - Browser initialized. 10:06:29 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:29 INFO - TEST-INFO | started process 2313 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpFKGDoB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:41 INFO - PROCESS | 2313 | RSS: Main: 245809152 10:06:41 INFO - PROCESS | 2313 | 10:07:33 INFO - PROCESS | 2313 | 1455041253030 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] 10:09:42 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49881/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49881/tests/dromaeo/cssquery-ext.html) 10:09:43 INFO - PROCESS | 2313 | RSS: Main: 360714240 10:09:43 INFO - PROCESS | 2313 | 10:12:46 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49881/tests/dromaeo/cssquery-ext.html (next: http://localhost:49881/tests/dromaeo/cssquery-jquery.html) 10:12:47 INFO - PROCESS | 2313 | RSS: Main: 378515456 10:12:47 INFO - PROCESS | 2313 | 10:15:49 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49881/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49881/tests/dromaeo/cssquery-mootools.html) 10:15:50 INFO - PROCESS | 2313 | RSS: Main: 379052032 10:15:50 INFO - PROCESS | 2313 | 10:18:52 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49881/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49881/tests/dromaeo/cssquery-prototype.html) 10:18:53 INFO - PROCESS | 2313 | RSS: Main: 344289280 10:18:53 INFO - PROCESS | 2313 | 10:21:56 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49881/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49881/tests/dromaeo/cssquery-yui.html) 10:21:56 INFO - PROCESS | 2313 | RSS: Main: 345669632 10:21:56 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | Cycle 1(1): loaded http://localhost:49881/tests/dromaeo/cssquery-yui.html (next: http://localhost:49881/tests/dromaeo/cssquery-dojo.html) 10:24:59 INFO - PROCESS | 2313 | RSS: Main: 432988160 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | __start_tp_report 10:24:59 INFO - PROCESS | 2313 | _x_x_mozilla_page_load 10:24:59 INFO - PROCESS | 2313 | _x_x_mozilla_page_load_details 10:24:59 INFO - PROCESS | 2313 | |i|pagename|runs| 10:24:59 INFO - PROCESS | 2313 | |0;dojo.html;2774.3896342804587;3435.1755578661127;3453.6201017888043;3462.7014869423965;3498.038039539126;5557.083081291582;5564;5577.525910297624;5585.664860108396;5650.26546548948;4555.863324100274;5653.462921022507;5745.052066409037;5766.0486019806785;5796.30444346679;5078.720670363128;5134.922976155361;5153.201253805666;5162.303089082963;5281.251705269848;5234.214867769827;5269.183276592115;5275.393329767068;5301.125314323132;5307.946920530803;5113.565346945514;5184.844454666366;5195.714235717034;5218.504242096995;5223.347081614798;5149.0731668299695;5189.299444574972;5196.064708352533;5263.421023687391;5265.736713164365;5118.181091025455;5144.43411224765;5147.510986456318;5153.6907785532985;5185.170372740344;5513.696746678931;5544.584156188302;5548.306461692288;5556.222128901957;5563.944360556424;6048.334683184846;6064.02975523914;6078.1317111663975;6135.2024236849375;6191.566590338678;6210.65841378724;6218.657973811439;6222.439980401786;6245.656488893109;6266.843328916768;4402.84590039347;5719.084946408555;5720.8283751487525;5741.88516229673;5750.309962804448;5566.666000040011;6079.554804254569;6105.8168254952425;6225.128482012522;6275.278342990615;6009.338972712998;6069.119977603223;6087.6956152192215;6093.177421048102;6097.8475538111015;6078.240219972504;6149.754009839646;6214.596051256744;6216.409441103088;6227.968860155761;6137.048757442603;6140.815775526741;6174.598651087665;6198.72105755233;6203.2245969253845;6152.8769424611255;6169.598976066542;6172.537059720449;6193;6209.534284928648;4753.928691069636;4802.8799280018275;4804.663673542818;4847.903041939141;4908.3619129513645;4319.308910574293;4341.630961368319;4345.869623911288;4369.3227549729845;4409.536998615164;5578.860528486739;5603.047481928082;5631.521320687787;5648.5763567731765;5656.943430565641;6107.908381374283;6140.995089002448;6176.8764624707255;6246.593971391936;6275.058741188858;5648.124540696199;5658.009848276535;5663.688497132697;5669.54643628517;5670.5747068969995;5322.148456246982;5329.760160792774;5354.812581559627;5356.839294821161;5384.1385378340065;6191.504679625619;6234.376562343729;6272.5922815016875;6275.964465863172;6283.340249273943;6167.444929956326;6260.123582698335;6269.279032911274;6271.686415679289;6291.119243306032;6270.968645156745;6291.685415729286;6306.684665766602;6309.49524038085;6311.715972781328;5894.263217097863;6079.604825686316;6100.328963814066;6155.415235552616;6170.167027451416;5239.790408383775;5859.00396932531;6127.953177891068;6226.875462490815;6256.217972753406;5486.177073439016;5820.941790582209;5996.610220335664;6020.096985452042;6046.697665116639;5777.537796976316;5923.289205295392;5984.072468767348;6002.129691194839;6010.9699451502465;4836.12949669063;5374.838754837361;5794.768209271582;5796.59423840344;5806.564507662027;5937.643741375531;5940.079287710412;5944.375840536682;5954.523638109027;5958.582899197015;5661.518770904519;5772.913406298993;5774.422557744192;5813.215215945793;5905.261842269716 10:24:59 INFO - PROCESS | 2313 | |1;ext.html;459.7218682696968;485.95626393624565;487.895102552951;508.06262445787553;576.0495182948137;28118;37411.438828417595;37786;37937.62062379379;37953.86138415845;39768.403473947845;40249.597504024954;40251.59748402515;40477.39283910744;40481.59518404815;9345.859812102806;9582;9589.568469418859;9590.328676992613;9595.712128636118;9396.906030939706;9562.952185239064;9578.664746733866;9583.137517623412;9680.757981050494;9629.951850240774;9683.12851843334;9686.128248457637;9691.98234185411;9699.224062075016;9454.716358509255;9462.337636365457;9572.234221262283;9646.035396460367;9661.275404344702;9487;9613;9615.134637882624;9631.3258071935;9642.084002019797;38840.61159388398;39257.60742392568;39279.8036009821;39377.40933885994;39428;2879;3197.2965947491516;3389.440742277521;3550.130218096557;3696.759710618828;23682.881585592135;27967.58048629272;28491;28735.28161795951;28786.687500622123;2721.550944094222;2798.38435544182;2824.5057115004793;2846.5303224967856;2852.5721141828685;385251;457150;457181;457997;458604;47732;52585;53032.93934121296;53114.734426327625;53378;64332.35667643357;65519;65668.67165664141;65689;65823;12692.984561235078;15836.841631583768;15893;15914.76127858083;16048.197590120448;10453.581856725797;12229.449674764657;12290.877091228973;12309.93845030769;12312.569060082855;16366.590835228977;19101;19266.32567860118;19273.22907083729;19324.03379831003;8507.361947853935;8789.428687135316;8796.164364385373;8850.690225842065;8922.910770892338;914.0402577293947;934.5187228577288;975.5319837976064;1068.7488440216543;1079.9676009719722;29093.272668183465;29519.704802951695;29604.55593166104;29787.40425191484;30261.394772104435;1043.8016776812533;1057.613970900631;1068.4070340960686;1070.218740319571;1074.333912973961;13387.330862879864;13388.732225355438;13390.129641573267;13521.729565408637;13649.522266720816;529391;538847;538922;539145;540101;54253.45746542563;54399.6400089993;54402.72798636061;54583.727081365134;54618.726906366006;1262.9115961882765;1441.0561082490985;1448.7464693678776;1450.0429716387134;1517.5750789778879;27610;28110.221262385036;28413.147605571867;28963.420731585673;29525.852370738008;44863.32705009362;45112.77443612761;45328.77335613301;45344.09311813811;45769.855753606425;324288;635753;636911.8154409198;637263;638017;30050.445712114713;30136.794528218627;30306.545401819432;30339.69660303457;30411.695883040888;41936.1612767749;42498.78750606227;42531.36202956896;42827;43663.781681091394;34408.48387274143;35497.645023549434;35700.46449303314;36317.81841090778;36552.634473655984;34829.12927176841;35361.11597209988;35729.64270357367;35826.28347433089;36681.816590916875;28292.85853570719;34236;36132.27735445329;36934.261314773015;37151.62848371482;28498.715012849607;30809.386472202605;30863.13162819713;30881.354578490842;30919.11306213019;19304.32434864773;23120.075196991933;23381.649275260545;23390.064397423914;23720.932558035274 10:24:59 INFO - PROCESS | 2313 | |2;jquery.html;360.6916086745832;360.9422492401216;363.1810267846009;364.5224755570203;366.7139631087749;14170.574882753508;14812.925935370335;15999.920000399996;18616.720749188757;18928.90535547322;18091.366802161927;18184.54538636535;18780.812191878078;19627;19680.409587712355;5501.724913754307;5697.401772813857;5716.028275193206;5735.397783232763;5744.79893203738;4113.71204015719;4315.158544083889;5651.463111004448;6022.728977196037;6293.370662933693;6082.178905847721;6170.0436432352835;6217.191765070557;6244.875102497947;6256.499480041586;6229.159063526411;6239.65681887496;6243.875122497548;6262.3111457739615;6263.123162757218;5270.235815806686;5516.806911758069;5528.143137813645;5529.364123125812;5541.251930989345;12339.259644421363;12699.492020319176;16772.496825095146;23721.88139059311;23759.7624023761;1763.6649036683118;2030.9390718278476;2265.3883451468178;2367.9462639125595;2726.5364887969095;7985.560794156319;9741.902580974242;9915.553800079013;9923.007699230091;13301.600951971457;1619.8380161983825;1722.2938595175917;1750.518607382967;1757.7011907975675;1798.1368942907347;87705.68441473383;94701;99731.50134249282;100449.4977525115;102943.48528257386;10916.454177291262;11045.33727976324;11062.004419602274;11079.667609971713;11168.274062185932;13168.341582920815;13236.470541178245;13282;13308;13325.866741332657;8206;8228.753137405887;8287.254147126787;8352.665893364197;8356.247937685515;8205.01539815226;8222.547759873265;8237.752867413867;8296.336293096538;8311.503929292785;3275.623303320101;4130.070734084867;4282.978585107055;4383.802728877208;4410.1400226956075;1727.2400143936627;1755.4645833020795;1755.490907636771;1762.8237176282526;1764.197290232941;813.9755807325789;909.6270529083044;930.7806773127224;990.0544979544518;1026.2098184397971;19835.008249587463;20251;20525;21111.894440528005;21364.893175534024;780.5316809914119;900.257287737606;949.368669834566;959.0936564946198;1014.5535964175739;10252.846207306897;10382.896171038345;10384.32501887375;10397.480125993821;10401.895981040092;557152;562822;567748;700204.498977512;722316;114015.42992285152;116662.25006624908;118774;119120;119755;1031.9329243599143;1130.2540323386525;1179.5281887245171;1189.3815216087587;1197.5449329254827;17904.641907162044;18203.180856861738;18279.451616451526;18315.908420457814;18674.159662814935;35411;47159.528404715515;48041.75979120082;48331.275030875266;48567;65444.691106178565;68980;69659.65170174117;70638.64680676769;71582.64208679131;7344.192138864827;7499.850003000019;7565.848683026419;7567.394608431202;7596.354309883722;10474.266801324138;11731.354775487089;11811.405460262755;11830.52677892909;12048.879511204776;6857.799885020002;8523.701670441505;8556.401051926305;9898.703038908845;10197.847032294374;10110.342827716175;10446;10579;10736;10882.945585272022;10098.29311948186;10554.736131596464;10592.735181620521;10644.627438039632;10777.13782897382;7436.330730234305;7527.929819299737;7573.621318933921;7603.391728661804;7604.859271109378;8245.505269683837;10435.94782026085;10555.783285509822;10650.307729997525;10813.891861081289 10:24:59 INFO - PROCESS | 2313 | |3;mootools.html;1365.644932317597;1470.9852901470986;1505.3978408636544;1724.5085150732043;1933.7099435084726;6655.833604159892;8591.871121933169;8745.737627871174;8747.693830715927;8765.956170219157;7273.12722473304;8493.278071363926;8631.482111073325;8736.039035706068;8745.169208925157;2145.6996020557135;2208.0836452872118;2380.9642855357183;2449.2897059852667;2469.950600987979;2457.7173625033083;2462.926112216627;2464.864432456214;2467.198160597804;2468.2841975826987;2365.9408514787183;2429.720582133051;2430.0644251962945;2433.3551608823677;2438.5854404751235;2131.6909048188004;2202.0751284460484;2392.3660230039054;2451.8651474168914;2453.0555736041574;2414.9758502414925;2421.3462365161486;2465.260421873431;2469.296250568579;2487.3781554611346;8667.21995020445;8742.781430464225;8743.825123497558;8746.212840844291;8750.431221970552;5244.527992480657;5359.946400535984;5390.164524498709;5396.514313711746;5396.757145928443;3232.095013396229;3552.182997910469;3554.573451185848;3578.6063533011347;3608.963910360915;1039.5062345385957;1052.8052310322614;1057.1701214546545;1065.0999905080196;1085.7285678580356;11783.941080294544;11847.466863991142;11848.763024739543;11858.881411185865;11879.406029698566;4399.582039706287;4503.301988191835;4734.55021772931;4756.6908150970075;4811.879703007383;9817.803643927082;9826.557804898797;9829.262805289633;9833;9835.409875407355;5381.461853814587;5388.245645609618;5427.674339539641;5440.700761458158;5452.427495112956;4928.728919909439;4931.16170251051;4945.184044632667;4952.950470495321;4956.504349565014;3936.8976686527817;3999.6400323970984;4043;4068.3083875740604;4088.3049881520215;1297.8896793772446;1329.6210579984659;1330.9068365214341;1334.1594795279107;1342.127617048926;980.5293459139652;1084.3710647824244;1110.0841805510486;1115.2360632966281;1118.9664310070712;7961.323287520626;8027.1972802719265;8131.105578386373;8157.673693052211;8185.590720463953;1109.7059279290995;1160.3733983648904;1195.4022988505747;1209.1113031921532;1234.1361047266948;6236.251649801962;6263.937360626426;6275.937240627627;6290.339514351019;6306.684665766785;10196.745081373025;10452.477376131163;10558.366498010144;10564;10572.995565421274;10073.647422340184;10339.793204135874;10592.470376481146;10634.936506349302;10637.095846853104;8086.474379165335;8188.754337369888;8225.465344752572;8305.169483051646;8324.583770811436;7947.364210863001;7999;8047.396445266511;8085.029796424466;8096.39277054235;7760.573168475788;9381.624735010797;9527.428354298765;9589;9598.376105553116;9692.41845489273;9692.563834627317;9848.70453886356;10104.747381315232;10120.645777398051;7417.36952359034;7448.143463501767;7530.058742657168;7547.773566793005;7555.9244407555225;8080.676772929017;8142.51144931306;8145;8168.509889406417;8174.918250817415;7516.586587737727;7572.204918483701;7670.27132422419;7782.455228133977;7846.921530784619;5954.917680334063;7372.447066469929;7542.698292068475;7599.696012159673;7627.54234745917;7569.243075692387;7694.730684426018;7712.9614351927885;7721.691132354643;7726.459147859596;6999.265077166824;7011.754588589375;7021.508494405342;7036.542624729376;7045.964770176116;6854.931450685429;7039.225685174524;7040.753573624898;7045.11936007999;7061.470389720689 10:24:59 INFO - PROCESS | 2313 | |4;prototype.html;316.90017644441997;322.13667371444535;326.23660634116163;328.5662924939081;331.40843594184383;6694.564853284539;6738;6744.69648865801;6768.3908448239645;6771.932280677204;6658.966705166479;6659.167604049494;6671.332866713326;6672.7664531741275;6682.298358672342;4819.325294458778;4926.162552366089;4941.752912354368;4968.50314968503;4968.87577810554;4891.608671306305;4950.183219768734;4963.900721985558;4966.503349665023;4981.676191047571;4380.57631269837;4873.6832105913;4893.143699852511;4899.314096026559;4902.485239049902;3947.3289540778137;4515.548445155491;4691.859244222679;4797.56821886032;4799.952000480021;4159.147374788161;4176.749395036277;4183.4979802423595;4208.579142085798;4210.536840947493;6322.936770632281;6420.93579064208;6430.067640192193;6442.387973142544;6448.774292899773;5467.863303417406;5613.607047506676;5627.324721033502;5771.8557036074435;5844.1818145459665;6997.335253150943;7069.116360454943;7070.5050646454765;7076.115485564304;7103.680334384965;4669.299605059235;4675.345451636774;4676.812927482896;4678.251479763256;4681.180793361183;7276.599787011713;7467.290607392289;7492.512986655905;7500.437467189982;7527.887081693724;4791.832285870048;4800.73595952226;4802.399700037496;4811.254255590389;4820.469748327681;4879.512048795092;4887.413510378707;4898.951010489849;4899.534544218293;4901.240307752304;4451;5508.91736623951;5568.220449137124;5741.62679425836;5763.0202865512965;7093.787186384417;7104.964475177694;7131.857362852714;7134.108236470442;7147.392471639969;1566.6709990902038;1681.3190657783616;1683.7979442466738;1688.5272123805355;1690.5689049292598;1078.185969592968;1088.0697004061572;1100.0539535999035;1104.3429159649995;1116.564539829451;6633.800985970429;6671.966640166768;6684.097646817715;6688.130543029375;6691.330866913269;6028.251806975928;6044.516438684895;7423.4061275097865;7431.405487560982;7437.962810185914;6396.1045453636525;6644.900326495106;6651.368120028589;6659.700313485905;6669.533132680665;3883.456316115746;3939.2515422069714;3945.388464787905;3949.822257998397;3951.3677811550015;7728.420368472387;7742;7747.883781743279;7748.147703752583;7753.10839253493;7084.787456376317;7148.17795953472;7521.849563008709;7577.355924746348;7614.543127412373;6257.4681152102585;7779.29986301213;7799.415043871732;7822.983012208377;7832.686692532235;7474.065741782278;7477.14012888503;7479.551226926402;7488.925110748823;7495.550266983998;7135.964320178366;7343.045404097433;7375.446841486802;7384.37232835215;7400.259974002557;7835.960820195863;7869.095054068626;7873.37013038967;7874.3306818918745;7885.2114788520685;4627.560381763862;4681.64887633422;4686.156491831503;4708.576228139347;4708.741019243975;7159.248278930637;7475.36459400957;7481.7755467336065;7482.513636613603;7507.286807753255;7211.4230861532005;7213.098362704662;7214.927850721426;7217.6030318330895;7217.6030318333;6961.686724097529;7202.243764404662;7202.783916482514;7207.675654595451;7211.67547460355;7041.5422997505;7054.858902821812;7056;7059.5764254144915;7064.505484616027;7189.856202876018;7197.352238298578;7197.928020719726;7213;7219.2780721929485;6748.325167483213;6975.9302406975285;7023.262557431601;7028.50800443964;7062.858742825012 10:24:59 INFO - PROCESS | 2313 | |5;yui.html;682.8122266376746;728.300831202046;735.7020406735271;752.1876373516602;772.0010346405624;14690;15055.698886022301;15079.773803392944;15093.773593396108;15094.396224151034;11948.701282467942;13089.476420943174;13657.907367410608;13679.179249245028;13727.107737997023;678.4030053552866;686.0909295183876;835.5863847395548;838.6477679374663;856.1652388920814;838.0906716212886;846.318713435684;849.7960489482541;850.8978922529274;851.2083762101244;843.4011851585351;899.1817446124029;899.6626265150569;899.9100089990982;902.7607683963755;710.8649356622251;719.8020544350293;880.2034159086037;896.753392816974;897.9371443998923;664.1565212180552;665.5673812022176;666.183924692253;666.2305037681485;666.5067849791168;14403.71192576153;14452.421903123863;14458.783118253235;14463.20452375119;14478.203698796562;12352.814707779391;12504.937475312565;12593.244405335618;12725.681857953532;12761.808572871414;9874.901250987541;9970.252231082697;9985.500724963722;10004.249681273934;10660.20048496366;3470.4967779671806;3517.296540691872;3529.9647003529894;3577.838997245104;3605.1167463971233;79159.60420197863;79590;80100.59949700272;80972.19027809706;81242.78135828026;9523.809523809563;9581.425114493153;9707.378123882465;9744;9862.852057219148;21818.236361727264;21851.562968740534;21856.23503177413;21899.562008759734;21899.562008760055;7284.854302914018;7310.378617817545;7448.553086814808;7455.25447455261;7479.588622625808;3852.788096654711;4015.959840401617;4074.572169922175;4120.62914337705;4147.04617937876;3372.865085396557;3481.408160612702;3545.6808887200277;3583.8924832255075;3584.426491761306;633.1294470103608;643.1092936283281;646.0696596900449;649.818050945736;654.3652656922777;506.7770181120295;567.4552429667483;593.4154857465479;597.1550256387251;612.6844674992383;8034.959825200954;8153.836923261501;8362.12197719243;8375.162483751697;8505.362097842686;455.94528656561425;477.84947741462025;488.7995921672169;509.5770510476296;512.9740518962076;3755.586885442599;3770.9057273567832;3796.677282431024;3872.845086196577;4319.870403887889;86441.56779216064;87974.56012720024;93768.593471098;94114;94141;65557.68884622281;68663;75843;76301.61849190718;79800.60099699465;62435;65560.67219663871;72383.6380818103;72812;75628.62185689036;8929.73210803677;8931.285497160081;8989.55052247398;9013.18881300686;9132.876356441986;48147.74167157171;51596.48403515917;51773.48226517686;51803.24263809134;51961.7401912988;67438.31404214934;67532.66233668801;68591.31408685849;68819.65590172017;70348.29651703621;9027.684031059143;10821.917808219116;10848.620298289838;10908.072813810597;11308.095352371625;11775.116866234895;12046.277223366626;12199.451024703732;12637.17858339205;12784.232946023269;10946.069584085442;11347.659570212907;11392.373419461677;11575.421228938689;12367.752644946871;11242.494087765906;11277.379744113825;11315.996690820804;11363.602273920373;12253.75492490163;10957.83563246568;11209.159313051718;11381.54473821071;11423.314601123959;11441.256318339281;9188.540572971458;9226.769330766785;9446.244300456085;9520.571574279036;9656.71029869105;8959.865602016105;9058.909410905806;9308.767280818034;9583.90416095858;9807 10:24:59 INFO - PROCESS | 2313 | __end_tp_report 10:24:59 INFO - PROCESS | 2313 | __start_cc_report 10:24:59 INFO - PROCESS | 2313 | _x_x_mozilla_cycle_collect,1057 10:24:59 INFO - PROCESS | 2313 | __end_cc_report 10:24:59 INFO - PROCESS | 2313 | __startTimestamp1455042299859__endTimestamp 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | ------- Summary: start ------- 10:24:59 INFO - PROCESS | 2313 | Number of tests: 6 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | [#0] dojo.html Cycles:165 Average:5645.45 Median:5777.54 stddev:645.48 (11.2%) stddev-sans-first:606.89 10:24:59 INFO - PROCESS | 2313 | Values: 2774.4 3435.2 3453.6 3462.7 3498.0 5557.1 5564.0 5577.5 5585.7 5650.3 4555.9 5653.5 5745.1 5766.0 5796.3 5078.7 5134.9 5153.2 5162.3 5281.3 5234.2 5269.2 5275.4 5301.1 5307.9 5113.6 5184.8 5195.7 5218.5 5223.3 5149.1 5189.3 5196.1 5263.4 5265.7 5118.2 5144.4 5147.5 5153.7 5185.2 5513.7 5544.6 5548.3 5556.2 5563.9 6048.3 6064.0 6078.1 6135.2 6191.6 6210.7 6218.7 6222.4 6245.7 6266.8 4402.8 5719.1 5720.8 5741.9 5750.3 5566.7 6079.6 6105.8 6225.1 6275.3 6009.3 6069.1 6087.7 6093.2 6097.8 6078.2 6149.8 6214.6 6216.4 6228.0 6137.0 6140.8 6174.6 6198.7 6203.2 6152.9 6169.6 6172.5 6193.0 6209.5 4753.9 4802.9 4804.7 4847.9 4908.4 4319.3 4341.6 4345.9 4369.3 4409.5 5578.9 5603.0 5631.5 5648.6 5656.9 6107.9 6141.0 6176.9 6246.6 6275.1 5648.1 5658.0 5663.7 5669.5 5670.6 5322.1 5329.8 5354.8 5356.8 5384.1 6191.5 6234.4 6272.6 6276.0 6283.3 6167.4 6260.1 6269.3 6271.7 6291.1 6271.0 6291.7 6306.7 6309.5 6311.7 5894.3 6079.6 6100.3 6155.4 6170.2 5239.8 5859.0 6128.0 6226.9 6256.2 5486.2 5820.9 5996.6 6020.1 6046.7 5777.5 5923.3 5984.1 6002.1 6011.0 4836.1 5374.8 5794.8 5796.6 5806.6 5937.6 5940.1 5944.4 5954.5 5958.6 5661.5 5772.9 5774.4 5813.2 5905.3 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | [#1] ext.html Cycles:180 Average:64753.71 Median:37861.81 stddev:140726.57 (371.7%) stddev-sans-first:141038.55 10:24:59 INFO - PROCESS | 2313 | Values: 459.7 486.0 487.9 508.1 576.0 28118.0 37411.4 37786.0 37937.6 37953.9 39768.4 40249.6 40251.6 40477.4 40481.6 9345.9 9582.0 9589.6 9590.3 9595.7 9396.9 9563.0 9578.7 9583.1 9680.8 9630.0 9683.1 9686.1 9692.0 9699.2 9454.7 9462.3 9572.2 9646.0 9661.3 9487.0 9613.0 9615.1 9631.3 9642.1 38840.6 39257.6 39279.8 39377.4 39428.0 2879.0 3197.3 3389.4 3550.1 3696.8 23682.9 27967.6 28491.0 28735.3 28786.7 2721.6 2798.4 2824.5 2846.5 2852.6 385251.0 457150.0 457181.0 457997.0 458604.0 47732.0 52585.0 53032.9 53114.7 53378.0 64332.4 65519.0 65668.7 65689.0 65823.0 12693.0 15836.8 15893.0 15914.8 16048.2 10453.6 12229.4 12290.9 12309.9 12312.6 16366.6 19101.0 19266.3 19273.2 19324.0 8507.4 8789.4 8796.2 8850.7 8922.9 914.0 934.5 975.5 1068.7 1080.0 29093.3 29519.7 29604.6 29787.4 30261.4 1043.8 1057.6 1068.4 1070.2 1074.3 13387.3 13388.7 13390.1 13521.7 13649.5 529391.0 538847.0 538922.0 539145.0 540101.0 54253.5 54399.6 54402.7 54583.7 54618.7 1262.9 1441.1 1448.7 1450.0 1517.6 27610.0 28110.2 28413.1 28963.4 29525.9 44863.3 45112.8 45328.8 45344.1 45769.9 324288.0 635753.0 636911.8 637263.0 638017.0 30050.4 30136.8 30306.5 30339.7 30411.7 41936.2 42498.8 42531.4 42827.0 43663.8 34408.5 35497.6 35700.5 36317.8 36552.6 34829.1 35361.1 35729.6 35826.3 36681.8 28292.9 34236.0 36132.3 36934.3 37151.6 28498.7 30809.4 30863.1 30881.4 30919.1 19304.3 23120.1 23381.6 23390.1 23720.9 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | [#2] jquery.html Cycles:180 Average:33717.68 Median:19343.31 stddev:103679.09 (536.0%) stddev-sans-first:103939.68 10:24:59 INFO - PROCESS | 2313 | Values: 360.7 360.9 363.2 364.5 366.7 14170.6 14812.9 15999.9 18616.7 18928.9 18091.4 18184.5 18780.8 19627.0 19680.4 5501.7 5697.4 5716.0 5735.4 5744.8 4113.7 4315.2 5651.5 6022.7 6293.4 6082.2 6170.0 6217.2 6244.9 6256.5 6229.2 6239.7 6243.9 6262.3 6263.1 5270.2 5516.8 5528.1 5529.4 5541.3 12339.3 12699.5 16772.5 23721.9 23759.8 1763.7 2030.9 2265.4 2367.9 2726.5 7985.6 9741.9 9915.6 9923.0 13301.6 1619.8 1722.3 1750.5 1757.7 1798.1 87705.7 94701.0 99731.5 100449.5 102943.5 10916.5 11045.3 11062.0 11079.7 11168.3 13168.3 13236.5 13282.0 13308.0 13325.9 8206.0 8228.8 8287.3 8352.7 8356.2 8205.0 8222.5 8237.8 8296.3 8311.5 3275.6 4130.1 4283.0 4383.8 4410.1 1727.2 1755.5 1755.5 1762.8 1764.2 814.0 909.6 930.8 990.1 1026.2 19835.0 20251.0 20525.0 21111.9 21364.9 780.5 900.3 949.4 959.1 1014.6 10252.8 10382.9 10384.3 10397.5 10401.9 557152.0 562822.0 567748.0 700204.5 722316.0 114015.4 116662.3 118774.0 119120.0 119755.0 1031.9 1130.3 1179.5 1189.4 1197.5 17904.6 18203.2 18279.5 18315.9 18674.2 35411.0 47159.5 48041.8 48331.3 48567.0 65444.7 68980.0 69659.7 70638.6 71582.6 7344.2 7499.9 7565.8 7567.4 7596.4 10474.3 11731.4 11811.4 11830.5 12048.9 6857.8 8523.7 8556.4 9898.7 10197.8 10110.3 10446.0 10579.0 10736.0 10882.9 10098.3 10554.7 10592.7 10644.6 10777.1 7436.3 7527.9 7573.6 7603.4 7604.9 8245.5 10435.9 10555.8 10650.3 10813.9 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | [#3] mootools.html Cycles:180 Average:6002.40 Median:5393.34 stddev:3152.20 (58.4%) stddev-sans-first:3141.77 10:24:59 INFO - PROCESS | 2313 | Values: 1365.6 1471.0 1505.4 1724.5 1933.7 6655.8 8591.9 8745.7 8747.7 8766.0 7273.1 8493.3 8631.5 8736.0 8745.2 2145.7 2208.1 2381.0 2449.3 2470.0 2457.7 2462.9 2464.9 2467.2 2468.3 2365.9 2429.7 2430.1 2433.4 2438.6 2131.7 2202.1 2392.4 2451.9 2453.1 2415.0 2421.3 2465.3 2469.3 2487.4 8667.2 8742.8 8743.8 8746.2 8750.4 5244.5 5359.9 5390.2 5396.5 5396.8 3232.1 3552.2 3554.6 3578.6 3609.0 1039.5 1052.8 1057.2 1065.1 1085.7 11783.9 11847.5 11848.8 11858.9 11879.4 4399.6 4503.3 4734.6 4756.7 4811.9 9817.8 9826.6 9829.3 9833.0 9835.4 5381.5 5388.2 5427.7 5440.7 5452.4 4928.7 4931.2 4945.2 4953.0 4956.5 3936.9 3999.6 4043.0 4068.3 4088.3 1297.9 1329.6 1330.9 1334.2 1342.1 980.5 1084.4 1110.1 1115.2 1119.0 7961.3 8027.2 8131.1 8157.7 8185.6 1109.7 1160.4 1195.4 1209.1 1234.1 6236.3 6263.9 6275.9 6290.3 6306.7 10196.7 10452.5 10558.4 10564.0 10573.0 10073.6 10339.8 10592.5 10634.9 10637.1 8086.5 8188.8 8225.5 8305.2 8324.6 7947.4 7999.0 8047.4 8085.0 8096.4 7760.6 9381.6 9527.4 9589.0 9598.4 9692.4 9692.6 9848.7 10104.7 10120.6 7417.4 7448.1 7530.1 7547.8 7555.9 8080.7 8142.5 8145.0 8168.5 8174.9 7516.6 7572.2 7670.3 7782.5 7846.9 5954.9 7372.4 7542.7 7599.7 7627.5 7569.2 7694.7 7713.0 7721.7 7726.5 6999.3 7011.8 7021.5 7036.5 7046.0 6854.9 7039.2 7040.8 7045.1 7061.5 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | [#4] prototype.html Cycles:180 Average:5847.13 Median:6670.43 stddev:1874.82 (28.1%) stddev-sans-first:1833.55 10:24:59 INFO - PROCESS | 2313 | Values: 316.9 322.1 326.2 328.6 331.4 6694.6 6738.0 6744.7 6768.4 6771.9 6659.0 6659.2 6671.3 6672.8 6682.3 4819.3 4926.2 4941.8 4968.5 4968.9 4891.6 4950.2 4963.9 4966.5 4981.7 4380.6 4873.7 4893.1 4899.3 4902.5 3947.3 4515.5 4691.9 4797.6 4800.0 4159.1 4176.7 4183.5 4208.6 4210.5 6322.9 6420.9 6430.1 6442.4 6448.8 5467.9 5613.6 5627.3 5771.9 5844.2 6997.3 7069.1 7070.5 7076.1 7103.7 4669.3 4675.3 4676.8 4678.3 4681.2 7276.6 7467.3 7492.5 7500.4 7527.9 4791.8 4800.7 4802.4 4811.3 4820.5 4879.5 4887.4 4899.0 4899.5 4901.2 4451.0 5508.9 5568.2 5741.6 5763.0 7093.8 7105.0 7131.9 7134.1 7147.4 1566.7 1681.3 1683.8 1688.5 1690.6 1078.2 1088.1 1100.1 1104.3 1116.6 6633.8 6672.0 6684.1 6688.1 6691.3 6028.3 6044.5 7423.4 7431.4 7438.0 6396.1 6644.9 6651.4 6659.7 6669.5 3883.5 3939.3 3945.4 3949.8 3951.4 7728.4 7742.0 7747.9 7748.1 7753.1 7084.8 7148.2 7521.8 7577.4 7614.5 6257.5 7779.3 7799.4 7823.0 7832.7 7474.1 7477.1 7479.6 7488.9 7495.6 7136.0 7343.0 7375.4 7384.4 7400.3 7836.0 7869.1 7873.4 7874.3 7885.2 4627.6 4681.6 4686.2 4708.6 4708.7 7159.2 7475.4 7481.8 7482.5 7507.3 7211.4 7213.1 7214.9 7217.6 7217.6 6961.7 7202.2 7202.8 7207.7 7211.7 7041.5 7054.9 7056.0 7059.6 7064.5 7189.9 7197.4 7197.9 7213.0 7219.3 6748.3 6975.9 7023.3 7028.5 7062.9 10:24:59 INFO - PROCESS | 2313 | 10:24:59 INFO - PROCESS | 2313 | [#5] yui.html Cycles:180 Average:18140.54 Median:652.09 stddev:25381.58 (3892.3%) stddev-sans-first:25418.93 10:24:59 INFO - PROCESS | 2313 | Values: 682.8 728.3 735.7 752.2 772.0 14690.0 15055.7 15079.8 15093.8 15094.4 11948.7 13089.5 13657.9 13679.2 13727.1 678.4 686.1 835.6 838.6 856.2 838.1 846.3 849.8 850.9 851.2 843.4 899.2 899.7 899.9 902.8 710.9 719.8 880.2 896.8 897.9 664.2 665.6 666.2 666.2 666.5 14403.7 14452.4 14458.8 14463.2 14478.2 12352.8 12504.9 12593.2 12725.7 12761.8 9874.9 9970.3 9985.5 10004.2 10660.2 3470.5 3517.3 3530.0 3577.8 3605.1 79159.6 79590.0 80100.6 80972.2 81242.8 9523.8 9581.4 9707.4 9744.0 9862.9 21818.2 21851.6 21856.2 21899.6 21899.6 7284.9 7310.4 7448.6 7455.3 7479.6 3852.8 4016.0 4074.6 4120.6 4147.0 3372.9 3481.4 3545.7 3583.9 3584.4 633.1 643.1 646.1 649.8 654.4 506.8 567.5 593.4 597.2 612.7 8035.0 8153.8 8362.1 8375.2 8505.4 455.9 477.8 488.8 509.6 513.0 3755.6 3770.9 3796.7 3872.8 4319.9 86441.6 87974.6 93768.6 94114.0 94141.0 65557.7 68663.0 75843.0 76301.6 79800.6 62435.0 65560.7 72383.6 72812.0 75628.6 8929.7 8931.3 8989.6 9013.2 9132.9 48147.7 51596.5 51773.5 51803.2 51961.7 67438.3 67532.7 68591.3 68819.7 70348.3 9027.7 10821.9 10848.6 10908.1 11308.1 11775.1 12046.3 12199.5 12637.2 12784.2 10946.1 11347.7 11392.4 11575.4 12367.8 11242.5 11277.4 11316.0 11363.6 12253.8 10957.8 11209.2 11381.5 11423.3 11441.3 9188.5 9226.8 9446.2 9520.6 9656.7 8959.9 9058.9 9308.8 9583.9 9807.0 10:24:59 INFO - PROCESS | 2313 | -------- Summary: end -------- 10:24:59 INFO - PROCESS | 2313 | 10:25:00 INFO - TEST-INFO | 2313: exit 0 10:25:00 INFO - TEST-OK | dromaeo_css | took 1114051ms 10:25:00 INFO - TEST-START | kraken 10:25:00 INFO - operating with platform_type : mac_ 10:25:00 INFO - Initialising browser for kraken test... 10:25:00 INFO - TEST-INFO | started process 2316 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpGCkGej/profile http://localhost:49881/getInfo.html) 10:25:02 INFO - PROCESS | 2316 | __metrics Screen width/height:1600/1200 10:25:02 INFO - PROCESS | 2316 | colorDepth:24 10:25:02 INFO - PROCESS | 2316 | Browser inner width/height: 1024/689 10:25:02 INFO - PROCESS | 2316 | __metrics 10:25:02 INFO - PROCESS | 2316 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:25:02 INFO - PROCESS | 2316 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:25:03 INFO - TEST-INFO | 2316: exit 0 10:25:03 INFO - Browser initialized. 10:25:03 INFO - Running cycle 1/1 for kraken test... 10:25:03 INFO - TEST-INFO | started process 2318 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpGCkGej/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:15 INFO - PROCESS | 2318 | RSS: Main: 245821440 10:25:15 INFO - PROCESS | 2318 | 10:25:17 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49881/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:18 INFO - PROCESS | 2318 | RSS: Main: 292569088 10:25:18 INFO - PROCESS | 2318 | 10:25:21 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49881/tests/kraken/driver.html?testName=audio-dft) 10:25:21 INFO - PROCESS | 2318 | RSS: Main: 303116288 10:25:21 INFO - PROCESS | 2318 | 10:25:25 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49881/tests/kraken/driver.html?testName=audio-fft) 10:25:25 INFO - PROCESS | 2318 | RSS: Main: 286998528 10:25:25 INFO - PROCESS | 2318 | 10:25:27 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49881/tests/kraken/driver.html?testName=audio-oscillator) 10:25:28 INFO - PROCESS | 2318 | RSS: Main: 289067008 10:25:28 INFO - PROCESS | 2318 | 10:25:30 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49881/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:30 INFO - PROCESS | 2318 | RSS: Main: 291643392 10:25:30 INFO - PROCESS | 2318 | 10:25:33 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49881/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:34 INFO - PROCESS | 2318 | RSS: Main: 292102144 10:25:34 INFO - PROCESS | 2318 | 10:25:37 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49881/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:37 INFO - PROCESS | 2318 | RSS: Main: 291536896 10:25:37 INFO - PROCESS | 2318 | 10:25:40 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49881/tests/kraken/driver.html?testName=json-parse-financial) 10:25:41 INFO - PROCESS | 2318 | RSS: Main: 291598336 10:25:41 INFO - PROCESS | 2318 | 10:25:42 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49881/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:43 INFO - PROCESS | 2318 | RSS: Main: 324878336 10:25:43 INFO - PROCESS | 2318 | 10:25:45 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:45 INFO - PROCESS | 2318 | RSS: Main: 326578176 10:25:45 INFO - PROCESS | 2318 | 10:25:47 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:48 INFO - PROCESS | 2318 | RSS: Main: 334446592 10:25:48 INFO - PROCESS | 2318 | 10:25:50 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:51 INFO - PROCESS | 2318 | RSS: Main: 334802944 10:25:51 INFO - PROCESS | 2318 | 10:25:54 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:54 INFO - PROCESS | 2318 | RSS: Main: 335200256 10:25:54 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | Cycle 1(1): loaded http://localhost:49881/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49881/tests/kraken/driver.html?testName=ai-astar) 10:25:56 INFO - PROCESS | 2318 | RSS: Main: 395206656 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | __start_tp_report 10:25:56 INFO - PROCESS | 2318 | _x_x_mozilla_page_load 10:25:56 INFO - PROCESS | 2318 | _x_x_mozilla_page_load_details 10:25:56 INFO - PROCESS | 2318 | |i|pagename|runs| 10:25:56 INFO - PROCESS | 2318 | |0;ai-astar;109;107;111;110;109;115;163;163;110;110 10:25:56 INFO - PROCESS | 2318 | |1;audio-beat-detection;158;118;146;158;122;144;140;118;168;129 10:25:56 INFO - PROCESS | 2318 | |2;audio-dft;186;184;197;263;204;185;185;179;183;182 10:25:56 INFO - PROCESS | 2318 | |3;audio-fft;79;74;86;78;57;60;58;82;75;56 10:25:56 INFO - PROCESS | 2318 | |4;audio-oscillator;96;93;127;79;81;83;113;85;114;148 10:25:56 INFO - PROCESS | 2318 | |5;imaging-gaussian-blur;87;98;87;78;124;139;129;93;87;92 10:25:56 INFO - PROCESS | 2318 | |6;imaging-darkroom;95;94;95;94;95;94;95;94;94;95 10:25:56 INFO - PROCESS | 2318 | |7;imaging-desaturate;87;85;87;88;86;86;86;85;85;88 10:25:56 INFO - PROCESS | 2318 | |8;json-parse-financial;55;54;54;54;54;53;55;64;54;53 10:25:56 INFO - PROCESS | 2318 | |9;json-stringify-tinderbox;61;68;69;72;70;66;65;66;67;67 10:25:56 INFO - PROCESS | 2318 | |10;stanford-crypto-aes;84;84;82;82;82;84;82;82;85;84 10:25:56 INFO - PROCESS | 2318 | |11;stanford-crypto-ccm;127;124;119;125;122;129;119;120;123;124 10:25:56 INFO - PROCESS | 2318 | |12;stanford-crypto-pbkdf2;140;135;136;137;139;128;137;139;138;140 10:25:56 INFO - PROCESS | 2318 | |13;stanford-crypto-sha256-iterative;69;67;67;67;67;67;67;69;66;67 10:25:56 INFO - PROCESS | 2318 | __end_tp_report 10:25:56 INFO - PROCESS | 2318 | __start_cc_report 10:25:56 INFO - PROCESS | 2318 | _x_x_mozilla_cycle_collect,1188 10:25:56 INFO - PROCESS | 2318 | __end_cc_report 10:25:56 INFO - PROCESS | 2318 | __startTimestamp1455042356577__endTimestamp 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | ------- Summary: start ------- 10:25:56 INFO - PROCESS | 2318 | Number of tests: 14 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#0] ai-astar Cycles:10 Average:120.70 Median:110.50 stddev:22.39 (20.3%) stddev-sans-first:23.34 10:25:56 INFO - PROCESS | 2318 | Values: 109.0 107.0 111.0 110.0 109.0 115.0 163.0 163.0 110.0 110.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:17.94 (12.4%) stddev-sans-first:17.82 10:25:56 INFO - PROCESS | 2318 | Values: 158.0 118.0 146.0 158.0 122.0 144.0 140.0 118.0 168.0 129.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#2] audio-dft Cycles:10 Average:194.80 Median:185.50 stddev:25.12 (13.5%) stddev-sans-first:26.44 10:25:56 INFO - PROCESS | 2318 | Values: 186.0 184.0 197.0 263.0 204.0 185.0 185.0 179.0 183.0 182.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#3] audio-fft Cycles:10 Average:70.50 Median:76.50 stddev:11.51 (15.0%) stddev-sans-first:11.79 10:25:56 INFO - PROCESS | 2318 | Values: 79.0 74.0 86.0 78.0 57.0 60.0 58.0 82.0 75.0 56.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:82.00 stddev:22.96 (28.0%) stddev-sans-first:24.25 10:25:56 INFO - PROCESS | 2318 | Values: 96.0 93.0 127.0 79.0 81.0 83.0 113.0 85.0 114.0 148.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:87.00 stddev:21.15 (24.3%) stddev-sans-first:21.78 10:25:56 INFO - PROCESS | 2318 | Values: 87.0 98.0 87.0 78.0 124.0 139.0 129.0 93.0 87.0 92.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 10:25:56 INFO - PROCESS | 2318 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.16 (1.3%) stddev-sans-first:1.20 10:25:56 INFO - PROCESS | 2318 | Values: 87.0 85.0 87.0 88.0 86.0 86.0 86.0 85.0 85.0 88.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.23 (6.0%) stddev-sans-first:3.43 10:25:56 INFO - PROCESS | 2318 | Values: 55.0 54.0 54.0 54.0 54.0 53.0 55.0 64.0 54.0 53.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:3.00 (4.4%) stddev-sans-first:2.22 10:25:56 INFO - PROCESS | 2318 | Values: 61.0 68.0 69.0 72.0 70.0 66.0 65.0 66.0 67.0 67.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.22 10:25:56 INFO - PROCESS | 2318 | Values: 84.0 84.0 82.0 82.0 82.0 84.0 82.0 82.0 85.0 84.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:3.33 (2.7%) stddev-sans-first:3.23 10:25:56 INFO - PROCESS | 2318 | Values: 127.0 124.0 119.0 125.0 122.0 129.0 119.0 120.0 123.0 124.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.90 Median:138.50 stddev:3.54 (2.6%) stddev-sans-first:3.57 10:25:56 INFO - PROCESS | 2318 | Values: 140.0 135.0 136.0 137.0 139.0 128.0 137.0 139.0 138.0 140.0 10:25:56 INFO - PROCESS | 2318 | 10:25:56 INFO - PROCESS | 2318 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.78 10:25:56 INFO - PROCESS | 2318 | Values: 69.0 67.0 67.0 67.0 67.0 67.0 67.0 69.0 66.0 67.0 10:25:56 INFO - PROCESS | 2318 | -------- Summary: end -------- 10:25:56 INFO - PROCESS | 2318 | 10:25:57 INFO - TEST-INFO | 2318: exit 0 10:25:57 INFO - TEST-OK | kraken | took 56975ms 10:25:57 INFO - SUITE-END | took 1171s 10:25:57 INFO - Completed test suite (00:19:31) 10:25:57 INFO - Working with test: dromaeo_css 10:25:57 INFO - Generating results file: dromaeo_css 10:25:57 INFO - Working with test: kraken 10:25:57 INFO - Generating results file: kraken 10:25:57 INFO - javascript benchmark 10:25:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:25:58 INFO - process_Request line: dromaeo_css 7415.36 graph.html#tests=[[72,64,59]] 10:25:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:58 INFO - process_Request line: kraken 1442.80 graph.html#tests=[[232,64,59]] 10:25:58 INFO - RETURN: dromaeo_css: 7415.36 10:25:58 INFO - RETURN: kraken: 1442.80 10:25:58 INFO - javascript benchmark 10:25:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2774.3896342804587, 3435.1755578661127, 3453.6201017888043, 3462.7014869423965, 3498.038039539126, 5557.083081291582, 5564.0, 5577.525910297624, 5585.664860108396, 5650.26546548948, 4555.863324100274, 5653.462921022507, 5745.052066409037, 5766.0486019806785, 5796.30444346679, 5078.720670363128, 5134.922976155361, 5153.201253805666, 5162.303089082963, 5281.251705269848, 5234.214867769827, 5269.183276592115, 5275.393329767068, 5301.125314323132, 5307.946920530803, 5113.565346945514, 5184.844454666366, 5195.714235717034, 5218.504242096995, 5223.347081614798, 5149.0731668299695, 5189.299444574972, 5196.064708352533, 5263.421023687391, 5265.736713164365, 5118.181091025455, 5144.43411224765, 5147.510986456318, 5153.6907785532985, 5185.170372740344, 5513.696746678931, 5544.584156188302, 5548.306461692288, 5556.222128901957, 5563.944360556424, 6048.334683184846, 6064.02975523914, 6078.1317111663975, 6135.2024236849375, 6191.566590338678, 6210.65841378724, 6218.657973811439, 6222.439980401786, 6245.656488893109, 6266.843328916768, 4402.84590039347, 5719.084946408555, 5720.8283751487525, 5741.88516229673, 5750.309962804448, 5566.666000040011, 6079.554804254569, 6105.8168254952425, 6225.128482012522, 6275.278342990615, 6009.338972712998, 6069.119977603223, 6087.6956152192215, 6093.177421048102, 6097.8475538111015, 6078.240219972504, 6149.754009839646, 6214.596051256744, 6216.409441103088, 6227.968860155761, 6137.048757442603, 6140.815775526741, 6174.598651087665, 6198.72105755233, 6203.2245969253845, 6152.8769424611255, 6169.598976066542, 6172.537059720449, 6193.0, 6209.534284928648, 4753.928691069636, 4802.8799280018275, 4804.663673542818, 4847.903041939141, 4908.3619129513645, 4319.308910574293, 4341.630961368319, 4345.869623911288, 4369.3227549729845, 4409.536998615164, 5578.860528486739, 5603.047481928082, 5631.521320687787, 5648.5763567731765, 5656.943430565641, 6107.908381374283, 6140.995089002448, 6176.8764624707255, 6246.593971391936, 6275.058741188858, 5648.124540696199, 5658.009848276535, 5663.688497132697, 5669.54643628517, 5670.5747068969995, 5322.148456246982, 5329.760160792774, 5354.812581559627, 5356.839294821161, 5384.1385378340065, 6191.504679625619, 6234.376562343729, 6272.5922815016875, 6275.964465863172, 6283.340249273943, 6167.444929956326, 6260.123582698335, 6269.279032911274, 6271.686415679289, 6291.119243306032, 6270.968645156745, 6291.685415729286, 6306.684665766602, 6309.49524038085, 6311.715972781328, 5894.263217097863, 6079.604825686316, 6100.328963814066, 6155.415235552616, 6170.167027451416, 5239.790408383775, 5859.00396932531, 6127.953177891068, 6226.875462490815, 6256.217972753406, 5486.177073439016, 5820.941790582209, 5996.610220335664, 6020.096985452042, 6046.697665116639, 5777.537796976316, 5923.289205295392, 5984.072468767348, 6002.129691194839, 6010.9699451502465, 4836.12949669063, 5374.838754837361, 5794.768209271582, 5796.59423840344, 5806.564507662027, 5937.643741375531, 5940.079287710412, 5944.375840536682, 5954.523638109027, 5958.582899197015, 5661.518770904519, 5772.913406298993, 5774.422557744192, 5813.215215945793, 5905.261842269716], "unit": "score", "name": "dojo.html", "value": 5605.297244233955}, {"lowerIsBetter": false, "replicates": [459.7218682696968, 485.95626393624565, 487.895102552951, 508.06262445787553, 576.0495182948137, 28118.0, 37411.438828417595, 37786.0, 37937.62062379379, 37953.86138415845, 39768.403473947845, 40249.597504024954, 40251.59748402515, 40477.39283910744, 40481.59518404815, 9345.859812102806, 9582.0, 9589.568469418859, 9590.328676992613, 9595.712128636118, 9396.906030939706, 9562.952185239064, 9578.664746733866, 9583.137517623412, 9680.757981050494, 9629.951850240774, 9683.12851843334, 9686.128248457637, 9691.98234185411, 9699.224062075016, 9454.716358509255, 9462.337636365457, 9572.234221262283, 9646.035396460367, 9661.275404344702, 9487.0, 9613.0, 9615.134637882624, 9631.3258071935, 9642.084002019797, 38840.61159388398, 39257.60742392568, 39279.8036009821, 39377.40933885994, 39428.0, 2879.0, 3197.2965947491516, 3389.440742277521, 3550.130218096557, 3696.759710618828, 23682.881585592135, 27967.58048629272, 28491.0, 28735.28161795951, 28786.687500622123, 2721.550944094222, 2798.38435544182, 2824.5057115004793, 2846.5303224967856, 2852.5721141828685, 385251.0, 457150.0, 457181.0, 457997.0, 458604.0, 47732.0, 52585.0, 53032.93934121296, 53114.734426327625, 53378.0, 64332.35667643357, 65519.0, 65668.67165664141, 65689.0, 65823.0, 12692.984561235078, 15836.841631583768, 15893.0, 15914.76127858083, 16048.197590120448, 10453.581856725797, 12229.449674764657, 12290.877091228973, 12309.93845030769, 12312.569060082855, 16366.590835228977, 19101.0, 19266.32567860118, 19273.22907083729, 19324.03379831003, 8507.361947853935, 8789.428687135316, 8796.164364385373, 8850.690225842065, 8922.910770892338, 914.0402577293947, 934.5187228577288, 975.5319837976064, 1068.7488440216543, 1079.9676009719722, 29093.272668183465, 29519.704802951695, 29604.55593166104, 29787.40425191484, 30261.394772104435, 1043.8016776812533, 1057.613970900631, 1068.4070340960686, 1070.218740319571, 1074.333912973961, 13387.330862879864, 13388.732225355438, 13390.129641573267, 13521.729565408637, 13649.522266720816, 529391.0, 538847.0, 538922.0, 539145.0, 540101.0, 54253.45746542563, 54399.6400089993, 54402.72798636061, 54583.727081365134, 54618.726906366006, 1262.9115961882765, 1441.0561082490985, 1448.7464693678776, 1450.0429716387134, 1517.5750789778879, 27610.0, 28110.221262385036, 28413.147605571867, 28963.420731585673, 29525.852370738008, 44863.32705009362, 45112.77443612761, 45328.77335613301, 45344.09311813811, 45769.855753606425, 324288.0, 635753.0, 636911.8154409198, 637263.0, 638017.0, 30050.445712114713, 30136.794528218627, 30306.545401819432, 30339.69660303457, 30411.695883040888, 41936.1612767749, 42498.78750606227, 42531.36202956896, 42827.0, 43663.781681091394, 34408.48387274143, 35497.645023549434, 35700.46449303314, 36317.81841090778, 36552.634473655984, 34829.12927176841, 35361.11597209988, 35729.64270357367, 35826.28347433089, 36681.816590916875, 28292.85853570719, 34236.0, 36132.27735445329, 36934.261314773015, 37151.62848371482, 28498.715012849607, 30809.386472202605, 30863.13162819713, 30881.354578490842, 30919.11306213019, 19304.32434864773, 23120.075196991933, 23381.649275260545, 23390.064397423914, 23720.932558035274], "unit": "score", "name": "ext.html", "value": 19124.327984912044}, {"lowerIsBetter": false, "replicates": [360.6916086745832, 360.9422492401216, 363.1810267846009, 364.5224755570203, 366.7139631087749, 14170.574882753508, 14812.925935370335, 15999.920000399996, 18616.720749188757, 18928.90535547322, 18091.366802161927, 18184.54538636535, 18780.812191878078, 19627.0, 19680.409587712355, 5501.724913754307, 5697.401772813857, 5716.028275193206, 5735.397783232763, 5744.79893203738, 4113.71204015719, 4315.158544083889, 5651.463111004448, 6022.728977196037, 6293.370662933693, 6082.178905847721, 6170.0436432352835, 6217.191765070557, 6244.875102497947, 6256.499480041586, 6229.159063526411, 6239.65681887496, 6243.875122497548, 6262.3111457739615, 6263.123162757218, 5270.235815806686, 5516.806911758069, 5528.143137813645, 5529.364123125812, 5541.251930989345, 12339.259644421363, 12699.492020319176, 16772.496825095146, 23721.88139059311, 23759.7624023761, 1763.6649036683118, 2030.9390718278476, 2265.3883451468178, 2367.9462639125595, 2726.5364887969095, 7985.560794156319, 9741.902580974242, 9915.553800079013, 9923.007699230091, 13301.600951971457, 1619.8380161983825, 1722.2938595175917, 1750.518607382967, 1757.7011907975675, 1798.1368942907347, 87705.68441473383, 94701.0, 99731.50134249282, 100449.4977525115, 102943.48528257386, 10916.454177291262, 11045.33727976324, 11062.004419602274, 11079.667609971713, 11168.274062185932, 13168.341582920815, 13236.470541178245, 13282.0, 13308.0, 13325.866741332657, 8206.0, 8228.753137405887, 8287.254147126787, 8352.665893364197, 8356.247937685515, 8205.01539815226, 8222.547759873265, 8237.752867413867, 8296.336293096538, 8311.503929292785, 3275.623303320101, 4130.070734084867, 4282.978585107055, 4383.802728877208, 4410.1400226956075, 1727.2400143936627, 1755.4645833020795, 1755.490907636771, 1762.8237176282526, 1764.197290232941, 813.9755807325789, 909.6270529083044, 930.7806773127224, 990.0544979544518, 1026.2098184397971, 19835.008249587463, 20251.0, 20525.0, 21111.894440528005, 21364.893175534024, 780.5316809914119, 900.257287737606, 949.368669834566, 959.0936564946198, 1014.5535964175739, 10252.846207306897, 10382.896171038345, 10384.32501887375, 10397.480125993821, 10401.895981040092, 557152.0, 562822.0, 567748.0, 700204.498977512, 722316.0, 114015.42992285152, 116662.25006624908, 118774.0, 119120.0, 119755.0, 1031.9329243599143, 1130.2540323386525, 1179.5281887245171, 1189.3815216087587, 1197.5449329254827, 17904.641907162044, 18203.180856861738, 18279.451616451526, 18315.908420457814, 18674.159662814935, 35411.0, 47159.528404715515, 48041.75979120082, 48331.275030875266, 48567.0, 65444.691106178565, 68980.0, 69659.65170174117, 70638.64680676769, 71582.64208679131, 7344.192138864827, 7499.850003000019, 7565.848683026419, 7567.394608431202, 7596.354309883722, 10474.266801324138, 11731.354775487089, 11811.405460262755, 11830.52677892909, 12048.879511204776, 6857.799885020002, 8523.701670441505, 8556.401051926305, 9898.703038908845, 10197.847032294374, 10110.342827716175, 10446.0, 10579.0, 10736.0, 10882.945585272022, 10098.29311948186, 10554.736131596464, 10592.735181620521, 10644.627438039632, 10777.13782897382, 7436.330730234305, 7527.929819299737, 7573.621318933921, 7603.391728661804, 7604.859271109378, 8245.505269683837, 10435.94782026085, 10555.783285509822, 10650.307729997525, 10813.891861081289], "unit": "score", "name": "jquery.html", "value": 8976.808123171284}, {"lowerIsBetter": false, "replicates": [1365.644932317597, 1470.9852901470986, 1505.3978408636544, 1724.5085150732043, 1933.7099435084726, 6655.833604159892, 8591.871121933169, 8745.737627871174, 8747.693830715927, 8765.956170219157, 7273.12722473304, 8493.278071363926, 8631.482111073325, 8736.039035706068, 8745.169208925157, 2145.6996020557135, 2208.0836452872118, 2380.9642855357183, 2449.2897059852667, 2469.950600987979, 2457.7173625033083, 2462.926112216627, 2464.864432456214, 2467.198160597804, 2468.2841975826987, 2365.9408514787183, 2429.720582133051, 2430.0644251962945, 2433.3551608823677, 2438.5854404751235, 2131.6909048188004, 2202.0751284460484, 2392.3660230039054, 2451.8651474168914, 2453.0555736041574, 2414.9758502414925, 2421.3462365161486, 2465.260421873431, 2469.296250568579, 2487.3781554611346, 8667.21995020445, 8742.781430464225, 8743.825123497558, 8746.212840844291, 8750.431221970552, 5244.527992480657, 5359.946400535984, 5390.164524498709, 5396.514313711746, 5396.757145928443, 3232.095013396229, 3552.182997910469, 3554.573451185848, 3578.6063533011347, 3608.963910360915, 1039.5062345385957, 1052.8052310322614, 1057.1701214546545, 1065.0999905080196, 1085.7285678580356, 11783.941080294544, 11847.466863991142, 11848.763024739543, 11858.881411185865, 11879.406029698566, 4399.582039706287, 4503.301988191835, 4734.55021772931, 4756.6908150970075, 4811.879703007383, 9817.803643927082, 9826.557804898797, 9829.262805289633, 9833.0, 9835.409875407355, 5381.461853814587, 5388.245645609618, 5427.674339539641, 5440.700761458158, 5452.427495112956, 4928.728919909439, 4931.16170251051, 4945.184044632667, 4952.950470495321, 4956.504349565014, 3936.8976686527817, 3999.6400323970984, 4043.0, 4068.3083875740604, 4088.3049881520215, 1297.8896793772446, 1329.6210579984659, 1330.9068365214341, 1334.1594795279107, 1342.127617048926, 980.5293459139652, 1084.3710647824244, 1110.0841805510486, 1115.2360632966281, 1118.9664310070712, 7961.323287520626, 8027.1972802719265, 8131.105578386373, 8157.673693052211, 8185.590720463953, 1109.7059279290995, 1160.3733983648904, 1195.4022988505747, 1209.1113031921532, 1234.1361047266948, 6236.251649801962, 6263.937360626426, 6275.937240627627, 6290.339514351019, 6306.684665766785, 10196.745081373025, 10452.477376131163, 10558.366498010144, 10564.0, 10572.995565421274, 10073.647422340184, 10339.793204135874, 10592.470376481146, 10634.936506349302, 10637.095846853104, 8086.474379165335, 8188.754337369888, 8225.465344752572, 8305.169483051646, 8324.583770811436, 7947.364210863001, 7999.0, 8047.396445266511, 8085.029796424466, 8096.39277054235, 7760.573168475788, 9381.624735010797, 9527.428354298765, 9589.0, 9598.376105553116, 9692.41845489273, 9692.563834627317, 9848.70453886356, 10104.747381315232, 10120.645777398051, 7417.36952359034, 7448.143463501767, 7530.058742657168, 7547.773566793005, 7555.9244407555225, 8080.676772929017, 8142.51144931306, 8145.0, 8168.509889406417, 8174.918250817415, 7516.586587737727, 7572.204918483701, 7670.27132422419, 7782.455228133977, 7846.921530784619, 5954.917680334063, 7372.447066469929, 7542.698292068475, 7599.696012159673, 7627.54234745917, 7569.243075692387, 7694.730684426018, 7712.9614351927885, 7721.691132354643, 7726.459147859596, 6999.265077166824, 7011.754588589375, 7021.508494405342, 7036.542624729376, 7045.964770176116, 6854.931450685429, 7039.225685174524, 7040.753573624898, 7045.11936007999, 7061.470389720689], "unit": "score", "name": "mootools.html", "value": 4888.896448854906}, {"lowerIsBetter": false, "replicates": [316.90017644441997, 322.13667371444535, 326.23660634116163, 328.5662924939081, 331.40843594184383, 6694.564853284539, 6738.0, 6744.69648865801, 6768.3908448239645, 6771.932280677204, 6658.966705166479, 6659.167604049494, 6671.332866713326, 6672.7664531741275, 6682.298358672342, 4819.325294458778, 4926.162552366089, 4941.752912354368, 4968.50314968503, 4968.87577810554, 4891.608671306305, 4950.183219768734, 4963.900721985558, 4966.503349665023, 4981.676191047571, 4380.57631269837, 4873.6832105913, 4893.143699852511, 4899.314096026559, 4902.485239049902, 3947.3289540778137, 4515.548445155491, 4691.859244222679, 4797.56821886032, 4799.952000480021, 4159.147374788161, 4176.749395036277, 4183.4979802423595, 4208.579142085798, 4210.536840947493, 6322.936770632281, 6420.93579064208, 6430.067640192193, 6442.387973142544, 6448.774292899773, 5467.863303417406, 5613.607047506676, 5627.324721033502, 5771.8557036074435, 5844.1818145459665, 6997.335253150943, 7069.116360454943, 7070.5050646454765, 7076.115485564304, 7103.680334384965, 4669.299605059235, 4675.345451636774, 4676.812927482896, 4678.251479763256, 4681.180793361183, 7276.599787011713, 7467.290607392289, 7492.512986655905, 7500.437467189982, 7527.887081693724, 4791.832285870048, 4800.73595952226, 4802.399700037496, 4811.254255590389, 4820.469748327681, 4879.512048795092, 4887.413510378707, 4898.951010489849, 4899.534544218293, 4901.240307752304, 4451.0, 5508.91736623951, 5568.220449137124, 5741.62679425836, 5763.0202865512965, 7093.787186384417, 7104.964475177694, 7131.857362852714, 7134.108236470442, 7147.392471639969, 1566.6709990902038, 1681.3190657783616, 1683.7979442466738, 1688.5272123805355, 1690.5689049292598, 1078.185969592968, 1088.0697004061572, 1100.0539535999035, 1104.3429159649995, 1116.564539829451, 6633.800985970429, 6671.966640166768, 6684.097646817715, 6688.130543029375, 6691.330866913269, 6028.251806975928, 6044.516438684895, 7423.4061275097865, 7431.405487560982, 7437.962810185914, 6396.1045453636525, 6644.900326495106, 6651.368120028589, 6659.700313485905, 6669.533132680665, 3883.456316115746, 3939.2515422069714, 3945.388464787905, 3949.822257998397, 3951.3677811550015, 7728.420368472387, 7742.0, 7747.883781743279, 7748.147703752583, 7753.10839253493, 7084.787456376317, 7148.17795953472, 7521.849563008709, 7577.355924746348, 7614.543127412373, 6257.4681152102585, 7779.29986301213, 7799.415043871732, 7822.983012208377, 7832.686692532235, 7474.065741782278, 7477.14012888503, 7479.551226926402, 7488.925110748823, 7495.550266983998, 7135.964320178366, 7343.045404097433, 7375.446841486802, 7384.37232835215, 7400.259974002557, 7835.960820195863, 7869.095054068626, 7873.37013038967, 7874.3306818918745, 7885.2114788520685, 4627.560381763862, 4681.64887633422, 4686.156491831503, 4708.576228139347, 4708.741019243975, 7159.248278930637, 7475.36459400957, 7481.7755467336065, 7482.513636613603, 7507.286807753255, 7211.4230861532005, 7213.098362704662, 7214.927850721426, 7217.6030318330895, 7217.6030318333, 6961.686724097529, 7202.243764404662, 7202.783916482514, 7207.675654595451, 7211.67547460355, 7041.5422997505, 7054.858902821812, 7056.0, 7059.5764254144915, 7064.505484616027, 7189.856202876018, 7197.352238298578, 7197.928020719726, 7213.0, 7219.2780721929485, 6748.325167483213, 6975.9302406975285, 7023.262557431601, 7028.50800443964, 7062.858742825012], "unit": "score", "name": "prototype.html", "value": 5217.886073372812}, {"lowerIsBetter": false, "replicates": [682.8122266376746, 728.300831202046, 735.7020406735271, 752.1876373516602, 772.0010346405624, 14690.0, 15055.698886022301, 15079.773803392944, 15093.773593396108, 15094.396224151034, 11948.701282467942, 13089.476420943174, 13657.907367410608, 13679.179249245028, 13727.107737997023, 678.4030053552866, 686.0909295183876, 835.5863847395548, 838.6477679374663, 856.1652388920814, 838.0906716212886, 846.318713435684, 849.7960489482541, 850.8978922529274, 851.2083762101244, 843.4011851585351, 899.1817446124029, 899.6626265150569, 899.9100089990982, 902.7607683963755, 710.8649356622251, 719.8020544350293, 880.2034159086037, 896.753392816974, 897.9371443998923, 664.1565212180552, 665.5673812022176, 666.183924692253, 666.2305037681485, 666.5067849791168, 14403.71192576153, 14452.421903123863, 14458.783118253235, 14463.20452375119, 14478.203698796562, 12352.814707779391, 12504.937475312565, 12593.244405335618, 12725.681857953532, 12761.808572871414, 9874.901250987541, 9970.252231082697, 9985.500724963722, 10004.249681273934, 10660.20048496366, 3470.4967779671806, 3517.296540691872, 3529.9647003529894, 3577.838997245104, 3605.1167463971233, 79159.60420197863, 79590.0, 80100.59949700272, 80972.19027809706, 81242.78135828026, 9523.809523809563, 9581.425114493153, 9707.378123882465, 9744.0, 9862.852057219148, 21818.236361727264, 21851.562968740534, 21856.23503177413, 21899.562008759734, 21899.562008760055, 7284.854302914018, 7310.378617817545, 7448.553086814808, 7455.25447455261, 7479.588622625808, 3852.788096654711, 4015.959840401617, 4074.572169922175, 4120.62914337705, 4147.04617937876, 3372.865085396557, 3481.408160612702, 3545.6808887200277, 3583.8924832255075, 3584.426491761306, 633.1294470103608, 643.1092936283281, 646.0696596900449, 649.818050945736, 654.3652656922777, 506.7770181120295, 567.4552429667483, 593.4154857465479, 597.1550256387251, 612.6844674992383, 8034.959825200954, 8153.836923261501, 8362.12197719243, 8375.162483751697, 8505.362097842686, 455.94528656561425, 477.84947741462025, 488.7995921672169, 509.5770510476296, 512.9740518962076, 3755.586885442599, 3770.9057273567832, 3796.677282431024, 3872.845086196577, 4319.870403887889, 86441.56779216064, 87974.56012720024, 93768.593471098, 94114.0, 94141.0, 65557.68884622281, 68663.0, 75843.0, 76301.61849190718, 79800.60099699465, 62435.0, 65560.67219663871, 72383.6380818103, 72812.0, 75628.62185689036, 8929.73210803677, 8931.285497160081, 8989.55052247398, 9013.18881300686, 9132.876356441986, 48147.74167157171, 51596.48403515917, 51773.48226517686, 51803.24263809134, 51961.7401912988, 67438.31404214934, 67532.66233668801, 68591.31408685849, 68819.65590172017, 70348.29651703621, 9027.684031059143, 10821.917808219116, 10848.620298289838, 10908.072813810597, 11308.095352371625, 11775.116866234895, 12046.277223366626, 12199.451024703732, 12637.17858339205, 12784.232946023269, 10946.069584085442, 11347.659570212907, 11392.373419461677, 11575.421228938689, 12367.752644946871, 11242.494087765906, 11277.379744113825, 11315.996690820804, 11363.602273920373, 12253.75492490163, 10957.83563246568, 11209.159313051718, 11381.54473821071, 11423.314601123959, 11441.256318339281, 9188.540572971458, 9226.769330766785, 9446.244300456085, 9520.571574279036, 9656.71029869105, 8959.865602016105, 9058.909410905806, 9308.767280818034, 9583.90416095858, 9807.0], "unit": "score", "name": "yui.html", "value": 6772.465105210531}], "name": "dromaeo_css", "value": 7415.35684222558}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 111.0, 110.0, 109.0, 115.0, 163.0, 163.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 120.7}, {"lowerIsBetter": true, "replicates": [158.0, 118.0, 146.0, 158.0, 122.0, 144.0, 140.0, 118.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 140.1}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 197.0, 263.0, 204.0, 185.0, 185.0, 179.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 194.8}, {"lowerIsBetter": true, "replicates": [79.0, 74.0, 86.0, 78.0, 57.0, 60.0, 58.0, 82.0, 75.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.5}, {"lowerIsBetter": true, "replicates": [96.0, 93.0, 127.0, 79.0, 81.0, 83.0, 113.0, 85.0, 114.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [87.0, 98.0, 87.0, 78.0, 124.0, 139.0, 129.0, 93.0, 87.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 101.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 88.0, 86.0, 86.0, 86.0, 85.0, 85.0, 88.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [61.0, 68.0, 69.0, 72.0, 70.0, 66.0, 65.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 82.0, 82.0, 82.0, 84.0, 82.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 119.0, 125.0, 122.0, 129.0, 119.0, 120.0, 123.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [140.0, 135.0, 136.0, 137.0, 139.0, 128.0, 137.0, 139.0, 138.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1442.8}]} 10:25:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1442.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7415.36"}}} 10:25:58 INFO - Return code: 0 10:25:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:25:58 INFO - # TBPL SUCCESS # 10:25:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:25:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:25:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:25:58 INFO - 2016-02-09 10:25:58.328 screenresolution[2322:19864] starting screenresolution argv=screenresolution get 10:25:58 INFO - 2016-02-09 10:25:58.330 screenresolution[2322:19864] Display 0: 1600x1200x32@60 10:25:58 INFO - 2016-02-09 10:25:58.336 screenresolution[2323:19867] starting screenresolution argv=screenresolution list 10:25:58 INFO - Available Modes on Display 0 10:25:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:25:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:25:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:25:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:25:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:25:58 INFO - Intel Iris: 10:25:58 INFO - Chipset Model: Intel Iris 10:25:58 INFO - Type: GPU 10:25:58 INFO - Bus: Built-In 10:25:58 INFO - VRAM (Dynamic, Max): 1536 MB 10:25:58 INFO - Vendor: Intel (0x8086) 10:25:58 INFO - Device ID: 0x0a2e 10:25:58 INFO - Revision ID: 0x0009 10:25:58 INFO - Displays: 10:25:58 INFO - Display: 10:25:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:25:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:25:58 INFO - Display Serial Number: 1600x1200 60 10:25:58 INFO - Main Display: Yes 10:25:58 INFO - Mirror: Off 10:25:58 INFO - Online: Yes 10:25:58 INFO - Rotation: Supported 10:25:58 INFO - Return code: 0 10:25:58 INFO - Running post-action listener: _resource_record_post_action 10:25:58 INFO - Running post-run listener: _resource_record_post_run 10:25:59 INFO - Total resource usage - Wall time: 1208s; CPU: 52.0%; Read bytes: 2408448; Write bytes: 710381568; Read time: 34; Write time: 2920 10:25:59 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397337088; Write bytes: 395410944; Read time: 29677; Write time: 755 10:25:59 INFO - run-tests - Wall time: 1175s; CPU: 52.0%; Read bytes: 2408448; Write bytes: 299209216; Read time: 34; Write time: 2126 10:25:59 INFO - Running post-run listener: _upload_blobber_files 10:25:59 INFO - Blob upload gear active. 10:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:59 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 10:25:59 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'] 10:25:59 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 10:26:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:00 INFO - (blobuploader) - INFO - Done attempting. 10:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:01 INFO - (blobuploader) - INFO - Done attempting. 10:26:01 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:01 INFO - Return code: 0 10:26:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddded35976d5b6757ce82685e62cbbdc351c409ce2ce4ae19cc1b3cdf1db38124d27161b321ede411f99c8d5a98df32d7423f6bbf2b93d2021a657e1f1baf15e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bc06ff24e57181e45da017aa87bfe32e2f200aaa631ddf69af72b2b464c1171ab33ad2d7ca1dac11653ca2fbb67bde3e2f19912aecf23f1073cd9feea429363"} 10:26:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:01 INFO - Contents: 10:26:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddded35976d5b6757ce82685e62cbbdc351c409ce2ce4ae19cc1b3cdf1db38124d27161b321ede411f99c8d5a98df32d7423f6bbf2b93d2021a657e1f1baf15e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bc06ff24e57181e45da017aa87bfe32e2f200aaa631ddf69af72b2b464c1171ab33ad2d7ca1dac11653ca2fbb67bde3e2f19912aecf23f1073cd9feea429363"} 10:26:01 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:01 INFO - Copying logs to upload dir... 10:26:01 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.856792 ========= master_lag: 2.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-09 10:26:04.200842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 10:26:04.201933) ========= 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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/ddded35976d5b6757ce82685e62cbbdc351c409ce2ce4ae19cc1b3cdf1db38124d27161b321ede411f99c8d5a98df32d7423f6bbf2b93d2021a657e1f1baf15e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bc06ff24e57181e45da017aa87bfe32e2f200aaa631ddf69af72b2b464c1171ab33ad2d7ca1dac11653ca2fbb67bde3e2f19912aecf23f1073cd9feea429363"} build_url:https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/HetQlhsxQG6rEA-i3D9zFw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ddded35976d5b6757ce82685e62cbbdc351c409ce2ce4ae19cc1b3cdf1db38124d27161b321ede411f99c8d5a98df32d7423f6bbf2b93d2021a657e1f1baf15e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7bc06ff24e57181e45da017aa87bfe32e2f200aaa631ddf69af72b2b464c1171ab33ad2d7ca1dac11653ca2fbb67bde3e2f19912aecf23f1073cd9feea429363"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 10:26:04.599710) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-02-09 10:26:04.600060) ========= 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.t9bslb78Fl/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.TB81qpCfwR/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.004556 ========= master_lag: 3.68 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-02-09 10:26:08.283874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 10:26:08.284249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 10:26:08.439083) ========= ========= Total master_lag: 6.61 =========