builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0017 starttime: 1455826427.37 results: success (0) buildid: 20160218102627 builduid: 83e36cd8af9241a4ab1688179de92e93 revision: 30dbdd0de3332d5fac0619d8a8ff11da5836e949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.372511) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.372957) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.373243) ========= 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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005720 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.399259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.399596) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.415409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.415684) ========= 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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005457 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.463099) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.463390) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.463743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.464012) ========= 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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-18 12:13:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 36.4M=0s 2016-02-18 12:13:47 (36.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.658857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.659163) ========= 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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.025964 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.707191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:47.707538) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30dbdd0de3332d5fac0619d8a8ff11da5836e949 --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 30dbdd0de3332d5fac0619d8a8ff11da5836e949 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-18 12:13:47,748 truncating revision to first 12 chars 2016-02-18 12:13:47,748 Setting DEBUG logging. 2016-02-18 12:13:47,748 attempt 1/10 2016-02-18 12:13:47,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30dbdd0de333?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 12:13:48,008 unpacking tar archive at: fx-team-30dbdd0de333/testing/mozharness/ program finished with exit code 0 elapsedTime=0.504502 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:48.228061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:48.228768) ========= echo 30dbdd0de3332d5fac0619d8a8ff11da5836e949 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'30dbdd0de3332d5fac0619d8a8ff11da5836e949'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 30dbdd0de3332d5fac0619d8a8ff11da5836e949 program finished with exit code 0 elapsedTime=0.005383 script_repo_revision: '30dbdd0de3332d5fac0619d8a8ff11da5836e949' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:48.280194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:48.280639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 12:13:48.294415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-18 12:13:48.294778) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:13:48 INFO - MultiFileLogger online at 20160218 12:13:48 in /builds/slave/test 12:13:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:13:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:13:48 INFO - {'append_to_log': False, 12:13:48 INFO - 'base_work_dir': '/builds/slave/test', 12:13:48 INFO - 'blob_upload_branch': 'Fx-Team', 12:13:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:13:48 INFO - 'branch': 'Fx-Team', 12:13:48 INFO - 'buildbot_json_path': 'buildprops.json', 12:13:48 INFO - 'config_files': ('talos/mac_config.py',), 12:13:48 INFO - 'default_actions': ('clobber', 12:13:48 INFO - 'read-buildbot-config', 12:13:48 INFO - 'download-and-extract', 12:13:48 INFO - 'populate-webroot', 12:13:48 INFO - 'create-virtualenv', 12:13:48 INFO - 'install', 12:13:48 INFO - 'run-tests'), 12:13:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:13:48 INFO - 'download_minidump_stackwalk': True, 12:13:48 INFO - 'download_symbols': 'ondemand', 12:13:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:13:48 INFO - 'tooltool.py': '/tools/tooltool.py', 12:13:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:13:48 INFO - '/tools/misc-python/virtualenv.py')}, 12:13:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:13:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:13:48 INFO - 'installer_path': 'installer.exe', 12:13:48 INFO - 'log_level': 'info', 12:13:48 INFO - 'log_name': 'talos', 12:13:48 INFO - 'log_to_console': True, 12:13:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:13:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:13:48 INFO - 'opt_config_files': (), 12:13:48 INFO - 'pip_index': False, 12:13:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:13:48 INFO - 'cmd': ('bash', 12:13:48 INFO - '-c', 12:13:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:13:48 INFO - 'enabled': True, 12:13:48 INFO - 'halt_on_failure': False, 12:13:48 INFO - 'name': 'check_screen_resolution'},), 12:13:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:13:48 INFO - 'cmd': ('bash', 12:13:48 INFO - '-c', 12:13:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:13:48 INFO - 'enabled': True, 12:13:48 INFO - 'halt_on_failure': False, 12:13:48 INFO - 'name': 'check_screen_resolution'},), 12:13:48 INFO - 'run_cmd_checks_enabled': True, 12:13:48 INFO - 'sps_profile': False, 12:13:48 INFO - 'sps_profile_interval': 0, 12:13:48 INFO - 'suite': 'dromaeojs-e10s', 12:13:48 INFO - 'system_bits': '32', 12:13:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:13:48 INFO - 'title': 't-yosemite-r7-0017', 12:13:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:13:48 INFO - 'use_talos_json': True, 12:13:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:13:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:13:48 INFO - 'work_dir': 'build'} 12:13:48 INFO - ##### 12:13:48 INFO - ##### Running clobber step. 12:13:48 INFO - ##### 12:13:48 INFO - Running pre-action listener: _resource_record_pre_action 12:13:48 INFO - Running main action method: clobber 12:13:48 INFO - rmtree: /builds/slave/test/build 12:13:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:13:49 INFO - Running post-action listener: _resource_record_post_action 12:13:49 INFO - ##### 12:13:49 INFO - ##### Running read-buildbot-config step. 12:13:49 INFO - ##### 12:13:49 INFO - Running pre-action listener: _resource_record_pre_action 12:13:49 INFO - Running main action method: read_buildbot_config 12:13:49 INFO - Using buildbot properties: 12:13:49 INFO - { 12:13:49 INFO - "project": "", 12:13:49 INFO - "product": "firefox", 12:13:49 INFO - "script_repo_revision": "production", 12:13:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:13:49 INFO - "repository": "", 12:13:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:13:49 INFO - "buildid": "20160218102627", 12:13:49 INFO - "pgo_build": "False", 12:13:49 INFO - "basedir": "/builds/slave/test", 12:13:49 INFO - "buildnumber": 456, 12:13:49 INFO - "slavename": "t-yosemite-r7-0017", 12:13:49 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:13:49 INFO - "platform": "yosemite_r7", 12:13:49 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:13:49 INFO - "branch": "fx-team", 12:13:49 INFO - "repo_path": "integration/fx-team", 12:13:49 INFO - "revision": "30dbdd0de3332d5fac0619d8a8ff11da5836e949", 12:13:49 INFO - "stage_platform": "macosx64", 12:13:49 INFO - "builduid": "83e36cd8af9241a4ab1688179de92e93", 12:13:49 INFO - "slavebuilddir": "test" 12:13:49 INFO - } 12:13:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 12:13:49 INFO - Running post-action listener: _resource_record_post_action 12:13:49 INFO - ##### 12:13:49 INFO - ##### Running download-and-extract step. 12:13:49 INFO - ##### 12:13:49 INFO - Running pre-action listener: _resource_record_pre_action 12:13:49 INFO - Running main action method: download_and_extract 12:13:49 INFO - mkdir: /builds/slave/test/build/tests 12:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:49 INFO - https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/test_packages.json 12:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/test_packages.json 12:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:13:50 INFO - Downloaded 1277 bytes. 12:13:50 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:13:50 INFO - Using the following test package requirements: 12:13:50 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:13:50 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 12:13:50 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 12:13:50 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'jsshell-mac.zip'], 12:13:50 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 12:13:50 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:13:50 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 12:13:50 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 12:13:50 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 12:13:50 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:13:50 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:13:50 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 12:13:50 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:13:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:50 INFO - https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:13:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:13:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:13:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:13:51 INFO - Downloaded 17807378 bytes. 12:13:51 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'] 12:13:51 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 12:13:54 INFO - Return code: 0 12:13:54 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 12:13:54 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')]} 12:13:54 INFO - https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:13:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:13:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:13:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:13:55 INFO - Downloaded 17807378 bytes. 12:13:55 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'] 12:13:55 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 12:13:59 INFO - Return code: 0 12:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:59 INFO - https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:13:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:13:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:13:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:14:00 INFO - Downloaded 10707071 bytes. 12:14:00 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'] 12:14:00 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 12:14:00 INFO - Return code: 0 12:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:00 INFO - https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:14:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:14:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:14:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 12:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fdajydOBSISnlrsRf65KDQ/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 12:14:03 INFO - Downloaded 111338150 bytes. 12:14:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:14:03 INFO - mkdir: /builds/slave/test/properties 12:14:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:03 INFO - Contents: 12:14:03 INFO - build_url:https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:14:04 INFO - Running post-action listener: _resource_record_post_action 12:14:04 INFO - Running post-action listener: set_extra_try_arguments 12:14:04 INFO - ##### 12:14:04 INFO - ##### Running populate-webroot step. 12:14:04 INFO - ##### 12:14:04 INFO - Running pre-action listener: _resource_record_pre_action 12:14:04 INFO - Running main action method: populate_webroot 12:14:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:04 INFO - '--tppagecycles', 12:14:04 INFO - '7'], 12:14:04 INFO - 'tests': ['tsvgm']}}, 12:14:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:14:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:14:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'tests': ['damp', 'tps']}, 12:14:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['damp', 'tps']}, 12:14:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:14:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:04 INFO - 'other': {'tests': ['a11yr', 12:14:04 INFO - 'ts_paint', 12:14:04 INFO - 'tpaint', 12:14:04 INFO - 'sessionrestore', 12:14:04 INFO - 'sessionrestore_no_auto_restore']}, 12:14:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['a11yr', 12:14:04 INFO - 'ts_paint', 12:14:04 INFO - 'tpaint', 12:14:04 INFO - 'sessionrestore', 12:14:04 INFO - 'sessionrestore_no_auto_restore']}, 12:14:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['a11yr', 12:14:04 INFO - 'ts_paint', 12:14:04 INFO - 'tpaint', 12:14:04 INFO - 'sessionrestore', 12:14:04 INFO - 'sessionrestore_no_auto_restore']}, 12:14:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['a11yr', 12:14:04 INFO - 'ts_paint', 12:14:04 INFO - 'tpaint', 12:14:04 INFO - 'sessionrestore', 12:14:04 INFO - 'sessionrestore_no_auto_restore']}, 12:14:04 INFO - 'other_l64': {'tests': ['a11yr', 12:14:04 INFO - 'ts_paint', 12:14:04 INFO - 'tpaint', 12:14:04 INFO - 'sessionrestore', 12:14:04 INFO - 'sessionrestore_no_auto_restore']}, 12:14:04 INFO - 'other_nol64': {'tests': ['a11yr', 12:14:04 INFO - 'ts_paint', 12:14:04 INFO - 'tpaint', 12:14:04 INFO - 'sessionrestore', 12:14:04 INFO - 'sessionrestore_no_auto_restore']}, 12:14:04 INFO - 'svgr': {'tests': ['tsvgx', 12:14:04 INFO - 'tsvgr_opacity', 12:14:04 INFO - 'tart', 12:14:04 INFO - 'tscrollx', 12:14:04 INFO - 'cart']}, 12:14:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['tsvgx', 12:14:04 INFO - 'tsvgr_opacity', 12:14:04 INFO - 'tart', 12:14:04 INFO - 'tscrollx', 12:14:04 INFO - 'cart']}, 12:14:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'tests': ['tp5o']}, 12:14:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'talos_options': ['--e10s'], 12:14:04 INFO - 'tests': ['tp5o']}, 12:14:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'talos_options': ['--xperf_path', 12:14:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:04 INFO - 'tests': ['tp5n']}, 12:14:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:04 INFO - 'talos_options': ['--e10s', 12:14:04 INFO - '--xperf_path', 12:14:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:04 INFO - 'tests': ['tp5n']}}, 12:14:04 INFO - 'talos.zip': {'path': '', 12:14:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:04 INFO - Running post-action listener: _resource_record_post_action 12:14:04 INFO - ##### 12:14:04 INFO - ##### Running create-virtualenv step. 12:14:04 INFO - ##### 12:14:04 INFO - Running pre-action listener: _resource_record_pre_action 12:14:04 INFO - Running main action method: create_virtualenv 12:14:04 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:04 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 12:14:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:04 INFO - Using real prefix '/tools/python27' 12:14:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:05 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:07 INFO - Installing pip.................done. 12:14:07 INFO - Return code: 0 12:14:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:07 INFO - 'HOME': '/Users/cltbld', 12:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:07 INFO - 'LOGNAME': 'cltbld', 12:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:07 INFO - 'MOZ_NO_REMOTE': '1', 12:14:07 INFO - 'NO_EM_RESTART': '1', 12:14:07 INFO - 'PAGER': '/bin/cat', 12:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:07 INFO - 'PWD': '/builds/slave/test', 12:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:07 INFO - 'SHELL': '/bin/bash', 12:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:07 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:07 INFO - 'USER': 'cltbld', 12:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:07 INFO - 'XPC_FLAGS': '0x0', 12:14:07 INFO - 'XPC_SERVICE_NAME': '0', 12:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:08 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 12:14:08 INFO - Cleaning up... 12:14:08 INFO - Return code: 0 12:14:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:14:08 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')]} 12:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:08 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')]} 12:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:08 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:08 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 12:14:08 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 12:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:08 INFO - 'HOME': '/Users/cltbld', 12:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:08 INFO - 'LOGNAME': 'cltbld', 12:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:08 INFO - 'MOZ_NO_REMOTE': '1', 12:14:08 INFO - 'NO_EM_RESTART': '1', 12:14:08 INFO - 'PAGER': '/bin/cat', 12:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:08 INFO - 'PWD': '/builds/slave/test', 12:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:08 INFO - 'SHELL': '/bin/bash', 12:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:08 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:08 INFO - 'USER': 'cltbld', 12:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:08 INFO - 'XPC_FLAGS': '0x0', 12:14:08 INFO - 'XPC_SERVICE_NAME': '0', 12:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:08 INFO - Downloading/unpacking psutil>=0.7.1 12:14:08 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 12:14:08 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 12:14:08 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 12:14:08 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 12:14:08 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 12:14:08 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 12:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:10 INFO - Installing collected packages: psutil 12:14:10 INFO - Running setup.py install for psutil 12:14:11 INFO - building 'psutil._psutil_osx' extension 12:14:11 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 12:14:11 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 12:14:11 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 12:14:11 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 12:14:11 INFO - building 'psutil._psutil_posix' extension 12:14:11 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 12:14:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:14:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:14:11 INFO - ^ 12:14:12 INFO - 1 warning generated. 12:14:12 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 12:14:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:12 INFO - Successfully installed psutil 12:14:12 INFO - Cleaning up... 12:14:12 INFO - Return code: 0 12:14:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:12 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:12 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 12:14:12 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 12:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:12 INFO - 'HOME': '/Users/cltbld', 12:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:12 INFO - 'LOGNAME': 'cltbld', 12:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:12 INFO - 'MOZ_NO_REMOTE': '1', 12:14:12 INFO - 'NO_EM_RESTART': '1', 12:14:12 INFO - 'PAGER': '/bin/cat', 12:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:12 INFO - 'PWD': '/builds/slave/test', 12:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:12 INFO - 'SHELL': '/bin/bash', 12:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:12 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:12 INFO - 'USER': 'cltbld', 12:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:12 INFO - 'XPC_FLAGS': '0x0', 12:14:12 INFO - 'XPC_SERVICE_NAME': '0', 12:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:14:14 INFO - Installing collected packages: mozsystemmonitor 12:14:14 INFO - Running setup.py install for mozsystemmonitor 12:14:14 INFO - Successfully installed mozsystemmonitor 12:14:14 INFO - Cleaning up... 12:14:15 INFO - Return code: 0 12:14:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:15 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')]} 12:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:15 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')]} 12:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:15 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:15 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 12:14:15 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 12:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:15 INFO - 'HOME': '/Users/cltbld', 12:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:15 INFO - 'LOGNAME': 'cltbld', 12:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:15 INFO - 'MOZ_NO_REMOTE': '1', 12:14:15 INFO - 'NO_EM_RESTART': '1', 12:14:15 INFO - 'PAGER': '/bin/cat', 12:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:15 INFO - 'PWD': '/builds/slave/test', 12:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:15 INFO - 'SHELL': '/bin/bash', 12:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:15 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:15 INFO - 'USER': 'cltbld', 12:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:15 INFO - 'XPC_FLAGS': '0x0', 12:14:15 INFO - 'XPC_SERVICE_NAME': '0', 12:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:15 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 12:14:15 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 12:14:15 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 12:14:15 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 12:14:15 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 12:14:15 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 12:14:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:18 INFO - Downloading docopt-0.6.1.tar.gz 12:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:18 INFO - Running setup.py install for blobuploader 12:14:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:19 INFO - Running setup.py install for requests 12:14:19 INFO - Running setup.py install for docopt 12:14:19 INFO - Successfully installed blobuploader requests docopt 12:14:19 INFO - Cleaning up... 12:14:19 INFO - Return code: 0 12:14:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:19 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:19 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 12:14:19 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 12:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:19 INFO - 'HOME': '/Users/cltbld', 12:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:19 INFO - 'LOGNAME': 'cltbld', 12:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:19 INFO - 'MOZ_NO_REMOTE': '1', 12:14:19 INFO - 'NO_EM_RESTART': '1', 12:14:19 INFO - 'PAGER': '/bin/cat', 12:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:19 INFO - 'PWD': '/builds/slave/test', 12:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:19 INFO - 'SHELL': '/bin/bash', 12:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:19 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:19 INFO - 'USER': 'cltbld', 12:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:19 INFO - 'XPC_FLAGS': '0x0', 12:14:19 INFO - 'XPC_SERVICE_NAME': '0', 12:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:19 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-uGPcuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-6TM7o6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-u5Nmqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-22JdvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-5r5VAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-bePPO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-WxaaXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-uO9NNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ZIPmGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:20 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Y17Kd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ilX83F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Cm8qS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-pl4F05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-haTaw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-7YKuFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-SXBADZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:21 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-dn_E__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:21 INFO - Running setup.py install for manifestparser 12:14:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Running setup.py install for mozcrash 12:14:22 INFO - Running setup.py install for mozdebug 12:14:22 INFO - Running setup.py install for mozdevice 12:14:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Running setup.py install for mozfile 12:14:22 INFO - Running setup.py install for mozhttpd 12:14:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Running setup.py install for mozinfo 12:14:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Running setup.py install for mozInstall 12:14:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:22 INFO - Running setup.py install for mozleak 12:14:23 INFO - Running setup.py install for mozlog 12:14:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Running setup.py install for moznetwork 12:14:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Running setup.py install for mozprocess 12:14:23 INFO - Running setup.py install for mozprofile 12:14:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Running setup.py install for mozrunner 12:14:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:23 INFO - Running setup.py install for mozscreenshot 12:14:23 INFO - Running setup.py install for moztest 12:14:24 INFO - Running setup.py install for mozversion 12:14:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:24 INFO - Cleaning up... 12:14:24 INFO - Return code: 0 12:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:24 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:24 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 12:14:24 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 12:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:24 INFO - 'HOME': '/Users/cltbld', 12:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:24 INFO - 'LOGNAME': 'cltbld', 12:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:24 INFO - 'MOZ_NO_REMOTE': '1', 12:14:24 INFO - 'NO_EM_RESTART': '1', 12:14:24 INFO - 'PAGER': '/bin/cat', 12:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:24 INFO - 'PWD': '/builds/slave/test', 12:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:24 INFO - 'SHELL': '/bin/bash', 12:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:24 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:24 INFO - 'USER': 'cltbld', 12:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:24 INFO - 'XPC_FLAGS': '0x0', 12:14:24 INFO - 'XPC_SERVICE_NAME': '0', 12:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:24 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-jrfLb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:24 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)) 12:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:24 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-wRzKkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:24 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)) 12:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:24 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-lrt6kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:24 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)) 12:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:24 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-hC1J7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-eO7c6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-9zZF9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-be7TFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-wpWA1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-xVTpvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Oph2Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ohHYNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-eAvCoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-rGSqhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:25 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)) 12:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:25 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-MuVtpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:26 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)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:26 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-C1mOp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:26 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)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:26 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Yhug_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:26 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)) 12:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:26 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-n7TZas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:26 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)) 12:14:26 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)) 12:14:26 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)) 12:14:26 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)) 12:14:26 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)) 12:14:26 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)) 12:14:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:28 INFO - Downloading blessings-1.6.tar.gz 12:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:28 INFO - Installing collected packages: blessings 12:14:28 INFO - Running setup.py install for blessings 12:14:28 INFO - Successfully installed blessings 12:14:28 INFO - Cleaning up... 12:14:29 INFO - Return code: 0 12:14:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:29 INFO - Reading from file tmpfile_stdout 12:14:29 INFO - Current package versions: 12:14:29 INFO - blessings == 1.6 12:14:29 INFO - blobuploader == 1.2.4 12:14:29 INFO - docopt == 0.6.1 12:14:29 INFO - manifestparser == 1.1 12:14:29 INFO - mozInstall == 1.12 12:14:29 INFO - mozcrash == 0.16 12:14:29 INFO - mozdebug == 0.1 12:14:29 INFO - mozdevice == 0.48 12:14:29 INFO - mozfile == 1.2 12:14:29 INFO - mozhttpd == 0.7 12:14:29 INFO - mozinfo == 0.9 12:14:29 INFO - mozleak == 0.1 12:14:29 INFO - mozlog == 3.1 12:14:29 INFO - moznetwork == 0.27 12:14:29 INFO - mozprocess == 0.22 12:14:29 INFO - mozprofile == 0.28 12:14:29 INFO - mozrunner == 6.11 12:14:29 INFO - mozscreenshot == 0.1 12:14:29 INFO - mozsystemmonitor == 0.0 12:14:29 INFO - moztest == 0.7 12:14:29 INFO - mozversion == 1.4 12:14:29 INFO - psutil == 3.1.1 12:14:29 INFO - requests == 1.2.3 12:14:29 INFO - wsgiref == 0.1.2 12:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:29 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')]} 12:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 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')]} 12:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:29 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 12:14:29 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 12:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:29 INFO - 'HOME': '/Users/cltbld', 12:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:29 INFO - 'LOGNAME': 'cltbld', 12:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:29 INFO - 'MOZ_NO_REMOTE': '1', 12:14:29 INFO - 'NO_EM_RESTART': '1', 12:14:29 INFO - 'PAGER': '/bin/cat', 12:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:29 INFO - 'PWD': '/builds/slave/test', 12:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:29 INFO - 'SHELL': '/bin/bash', 12:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:29 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:29 INFO - 'USER': 'cltbld', 12:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:29 INFO - 'XPC_FLAGS': '0x0', 12:14:29 INFO - 'XPC_SERVICE_NAME': '0', 12:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 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)) 12:14:29 INFO - Cleaning up... 12:14:29 INFO - Return code: 0 12:14:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:29 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')]} 12:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 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')]} 12:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:29 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:29 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 12:14:29 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 12:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:29 INFO - 'HOME': '/Users/cltbld', 12:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:29 INFO - 'LOGNAME': 'cltbld', 12:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:29 INFO - 'MOZ_NO_REMOTE': '1', 12:14:29 INFO - 'NO_EM_RESTART': '1', 12:14:29 INFO - 'PAGER': '/bin/cat', 12:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:29 INFO - 'PWD': '/builds/slave/test', 12:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:29 INFO - 'SHELL': '/bin/bash', 12:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:29 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:29 INFO - 'USER': 'cltbld', 12:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:29 INFO - 'XPC_FLAGS': '0x0', 12:14:29 INFO - 'XPC_SERVICE_NAME': '0', 12:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:29 INFO - Downloading/unpacking jsonschema 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:32 INFO - Downloading/unpacking functools32 (from jsonschema) 12:14:32 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 12:14:32 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 12:14:32 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 12:14:32 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 12:14:32 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 12:14:32 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 12:14:32 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:32 INFO - warning: no files found matching '*.txt' 12:14:32 INFO - no previously-included directories found matching 'build' 12:14:32 INFO - no previously-included directories found matching 'dist' 12:14:32 INFO - no previously-included directories found matching '.git*' 12:14:32 INFO - Installing collected packages: jsonschema, functools32 12:14:32 INFO - Running setup.py install for functools32 12:14:32 INFO - warning: no files found matching '*.txt' 12:14:32 INFO - no previously-included directories found matching 'build' 12:14:32 INFO - no previously-included directories found matching 'dist' 12:14:32 INFO - no previously-included directories found matching '.git*' 12:14:32 INFO - Successfully installed jsonschema functools32 12:14:32 INFO - Cleaning up... 12:14:33 INFO - Return code: 0 12:14:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:14:33 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')]} 12:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:33 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')]} 12:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:33 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 0x10a85fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8664c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87f3ca3f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, '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.B38iTCYvVA/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.AWzPSvIaCn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 12:14:33 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 12:14:33 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 12:14:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:14:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:33 INFO - 'HOME': '/Users/cltbld', 12:14:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:33 INFO - 'LOGNAME': 'cltbld', 12:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:33 INFO - 'MOZ_NO_REMOTE': '1', 12:14:33 INFO - 'NO_EM_RESTART': '1', 12:14:33 INFO - 'PAGER': '/bin/cat', 12:14:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:33 INFO - 'PWD': '/builds/slave/test', 12:14:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:33 INFO - 'SHELL': '/bin/bash', 12:14:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:14:33 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:14:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:33 INFO - 'USER': 'cltbld', 12:14:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:33 INFO - 'XPC_FLAGS': '0x0', 12:14:33 INFO - 'XPC_SERVICE_NAME': '0', 12:14:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:33 INFO - Downloading/unpacking flake8 12:14:33 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 12:14:33 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 12:14:33 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 12:14:33 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 12:14:33 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 12:14:33 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 12:14:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:14:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:14:35 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 12:14:35 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 12:14:35 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 12:14:35 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 12:14:35 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 12:14:35 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 12:14:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:14:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 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 12:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:14:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:36 INFO - no previously-included directories found matching 'docs/_build' 12:14:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:14:37 INFO - Running setup.py install for pep8 12:14:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:37 INFO - no previously-included directories found matching 'docs/_build' 12:14:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:14:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:14:37 INFO - Cleaning up... 12:14:37 INFO - Return code: 0 12:14:37 INFO - Running post-action listener: _resource_record_post_action 12:14:37 INFO - Running post-action listener: _start_resource_monitoring 12:14:37 INFO - Starting resource monitoring. 12:14:37 INFO - ##### 12:14:37 INFO - ##### Running install step. 12:14:37 INFO - ##### 12:14:37 INFO - Running pre-action listener: _resource_record_pre_action 12:14:37 INFO - Running main action method: install 12:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:37 INFO - Reading from file tmpfile_stdout 12:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:37 INFO - Reading from file tmpfile_stdout 12:14:37 INFO - Output received: 12:14:37 INFO - Usage: mozinstall [options] installer 12:14:37 INFO - Options: 12:14:37 INFO - -h, --help show this help message and exit 12:14:37 INFO - -d DEST, --destination=DEST 12:14:37 INFO - Directory to install application into. [default: 12:14:37 INFO - "/builds/slave/test"] 12:14:37 INFO - --app=APP Application being installed. [default: firefox] 12:14:37 INFO - mkdir: /builds/slave/test/build/application 12:14:37 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'] 12:14:37 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 12:15:11 INFO - Reading from file tmpfile_stdout 12:15:11 INFO - Output received: 12:15:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:15:11 INFO - Running post-action listener: _resource_record_post_action 12:15:11 INFO - ##### 12:15:11 INFO - ##### Running run-tests step. 12:15:11 INFO - ##### 12:15:11 INFO - Running pre-action listener: _resource_record_pre_action 12:15:11 INFO - Running main action method: run_tests 12:15:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:11 INFO - 2016-02-18 12:15:11.796 screenresolution[1648:7628] starting screenresolution argv=screenresolution get 12:15:11 INFO - 2016-02-18 12:15:11.799 screenresolution[1648:7628] Display 0: 1600x1200x32@50 12:15:11 INFO - 2016-02-18 12:15:11.805 screenresolution[1649:7630] starting screenresolution argv=screenresolution list 12:15:11 INFO - Available Modes on Display 0 12:15:11 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 12:15:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:11 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 12:15:11 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 12:15:12 INFO - Graphics/Displays: 12:15:12 INFO - Intel Iris: 12:15:12 INFO - Chipset Model: Intel Iris 12:15:12 INFO - Type: GPU 12:15:12 INFO - Bus: Built-In 12:15:12 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:12 INFO - Vendor: Intel (0x8086) 12:15:12 INFO - Device ID: 0x0a2e 12:15:12 INFO - Revision ID: 0x0009 12:15:12 INFO - Displays: 12:15:12 INFO - Display: 12:15:12 INFO - Resolution: 1600 x 1200 @ 50 Hz 12:15:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:12 INFO - Display Serial Number: 1600x1200 50 12:15:12 INFO - Main Display: Yes 12:15:12 INFO - Mirror: Off 12:15:12 INFO - Online: Yes 12:15:12 INFO - Rotation: Supported 12:15:12 INFO - Return code: 0 12:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:12 INFO - Python 2.7.3 12:15:12 INFO - Return code: 0 12:15:12 INFO - grabbing minidump binary from tooltool 12:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:15:12 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 0x10a703d30>, '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 0x10a527db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a6fab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:12 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 12:15:12 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 12:15:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:12 INFO - Return code: 0 12:15:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:15:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:15:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:15:13 INFO - Return code: 0 12:15:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:15:13 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B38iTCYvVA/Render', 12:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:13 INFO - 'HOME': '/Users/cltbld', 12:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:13 INFO - 'LOGNAME': 'cltbld', 12:15:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:13 INFO - 'MOZ_NO_REMOTE': '1', 12:15:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:13 INFO - 'NO_EM_RESTART': '1', 12:15:13 INFO - 'PAGER': '/bin/cat', 12:15:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:13 INFO - 'PWD': '/builds/slave/test', 12:15:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:13 INFO - 'SHELL': '/bin/bash', 12:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWzPSvIaCn/Listeners', 12:15:13 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 12:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:13 INFO - 'USER': 'cltbld', 12:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:13 INFO - 'XPC_FLAGS': '0x0', 12:15:13 INFO - 'XPC_SERVICE_NAME': '0', 12:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:15:13 INFO - mozversion application_buildid: 20160218102627 12:15:13 INFO - mozversion application_changeset: 30dbdd0de3332d5fac0619d8a8ff11da5836e949 12:15:13 INFO - mozversion application_display_name: Nightly 12:15:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:13 INFO - mozversion application_name: Firefox 12:15:13 INFO - mozversion application_remotingname: firefox 12:15:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:15:13 INFO - mozversion application_vendor: Mozilla 12:15:13 INFO - mozversion application_version: 47.0a1 12:15:13 INFO - mozversion platform_buildid: 20160218102627 12:15:13 INFO - mozversion platform_changeset: 30dbdd0de3332d5fac0619d8a8ff11da5836e949 12:15:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:15:13 INFO - mozversion platform_version: 47.0a1 12:15:13 INFO - using testdate: 1455826513 12:15:13 INFO - actual date: 1455826513 12:15:14 INFO - starting webserver on 'localhost:49282' 12:15:14 INFO - SUITE-START | Running 2 tests 12:15:14 INFO - TEST-START | dromaeo_css 12:15:14 INFO - operating with platform_type : mac_ 12:15:14 INFO - Initialising browser for dromaeo_css test... 12:15:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpfhO9X3/profile http://localhost:49282/getInfo.html) 12:15:17 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 12:15:17 INFO - PROCESS | 1667 | colorDepth:24 12:15:17 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 12:15:17 INFO - PROCESS | 1667 | __metrics 12:15:17 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 12:15:17 INFO - TEST-INFO | 1667: exit 0 12:15:17 INFO - Browser initialized. 12:15:17 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:17 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpfhO9X3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:29 INFO - PROCESS | 1671 | RSS: Main: 255692800 12:15:29 INFO - PROCESS | 1671 | 12:16:19 INFO - PROCESS | 1671 | 1455826579328 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] 12:18:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 12:18:30 INFO - PROCESS | 1671 | RSS: Main: 270618624 12:18:30 INFO - PROCESS | 1671 | 12:21:32 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 12:21:33 INFO - PROCESS | 1671 | RSS: Main: 282705920 12:21:33 INFO - PROCESS | 1671 | 12:24:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 12:24:35 INFO - PROCESS | 1671 | RSS: Main: 284069888 12:24:35 INFO - PROCESS | 1671 | 12:27:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 12:27:37 INFO - PROCESS | 1671 | RSS: Main: 286699520 12:27:37 INFO - PROCESS | 1671 | 12:30:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 12:30:41 INFO - PROCESS | 1671 | RSS: Main: 289341440 12:30:41 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 12:33:43 INFO - PROCESS | 1671 | RSS: Main: 290082816 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | __start_tp_report 12:33:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 12:33:43 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 12:33:43 INFO - PROCESS | 1671 | |i|pagename|runs| 12:33:43 INFO - PROCESS | 1671 | |0;dojo.html;2973.4647763402586;3082.905568523173;3181.3796309719605;3532;3564.6613571710677;5773.913391299128;5800.44895734905;5808.1287806829;5826.883462330751;5839.445252700992;4813.37426134602;5732.48407643312;5880.441358070987;5882.941070607289;5967.134765459005;5259.158534634469;5264.447233040533;5275.630705850592;5395.919061214066;5464.890702185954;4735.905281894377;5126.5898728101665;5359.758810853521;5383.892322153554;5410.269613602172;4242.936355954663;5182.429932707418;5287.762050707727;5310.7610157543;5342.332208473941;4338.262495375794;4386.451693538308;5298.735063246822;5320.5211530962015;5343.492368225051;5187.714675692835;5191.948080519184;5266.894662106736;5277.762500687479;5279.762410691528;5671.801486947937;5712.657240565538;5778.075507918713;5802.419758024206;5841.240638716982;5551.750171242304;6217.471514921192;6230.5638605297645;6245.843853903643;6246.125542424064;6166.784162554289;6224.62652240867;6239.688015599202;6259.499240060784;6261.499080073583;4924.975375123101;5904.7342869570975;5984.7606095756555;6004.669743164168;6074.331823499411;6189.164462797465;6319.526035547352;6323.652199129092;6345.777897773556;6357.936420635827;6160.260768707783;6249.500039996789;6266.905996410058;6268.1851359323;6276.372362763687;6200.81397558074;6246.843828904313;6254.15568898202;6257.405546473078;6263.248410190807;6124.374210744355;6175.84560385985;6245.937540624535;6248.062790581449;6306.65313407767;5753.194552762617;6102.664353460514;6211.875762484725;6217.6891155442045;6233.3143354231;4958.256261560795;4960.70235785854;4965.205567109245;4971.37857767779;4981.601471882241;4376.190404775127;4415.050764085673;4453.22068637987;4471.977640111843;4489.685721999494;5828.329742079631;5855.092460668603;5866.677332746654;5889.823305300848;5891.941080589139;4708.623310135249;6183.165272688219;6224;6266.905996410058;6274.498040156776;4747.95252047482;4990.051890140861;5862.3653334932615;5871.588988770745;5874.559408044413;5448.9727551362785;5455.263539422127;5462.453754624506;5463.3717122530625;5510.1459273812625;6236.688165591793;6313.652749098844;6363.713632886439;6394.488440924715;6428.646424446607;6198.783042593487;6242.094896240111;6266.655333956493;6283.560150789401;6342.714577843916;6194;6416.101745755504;6423.582467139621;6426.710798014007;6431.517636177399;6154.938450615616;6255.624662520263;6268.404501572526;6268.811935641938;6288.276848162337;6224.1597384354345;6227.9377206227355;6246.843828904313;6275.74897004133;6276.968615156895;5123.524159142654;5658.943410565842;6100.328963814066;6133.693315334304;6208.596441231305;6108.938910610837;6205.5345849062405;6208.689565521796;6209.285932117684;6219;5971.462568368867;6100.389961003864;6105.542084343603;6117.908231376622;6129.2032035835055;6103.84740381494;6150.7539698411565;6230.50155987529;6238.095476156022;6269.49844012487;6070.392960704071;6106.145139680537;6111.908321375272;6138.969305153446;6148.538859585459 12:33:43 INFO - PROCESS | 1671 | |1;ext.html;459.9172149013176;500.7496251874063;510.77015343095616;552.7899398228673;569.001402538545;33583.16042098949;37012.25975480489;37377.439338409946;37391.62608373915;37448;38133;38634.61365386345;38671.03322416941;38764.030899227466;38814;9322.254219662427;9434.716958491223;9514.238860891111;9526.90473095267;9577;9389.76525586859;9498.620055197818;9503.714888553355;9504.287178461609;9532.80934381312;9480.24158067353;9563.80872382552;9593.95203023984;9602;9617.23062155026;8254.587270636444;9567.856482152738;9660.227181825438;9671.613135474572;9704.854427183633;9415.811683766286;9539.18916892065;9569.37799043067;9589.42463452195;9622.422654640744;30673.466326683578;37246.62753372486;37453.06367340811;37694;37735.24529509422;3002.076477041219;3214.5981752280964;3414.0270023043313;3570.9642903571153;3751.9624803751885;27049.323766905985;27600.309992250353;27800.58299125515;28531.36180291967;28980.130596082152;2747.093459158493;2778.19432364614;2809.606655068292;2821.619081424002;2926.3415731460464;441129;441668;441715;441817;442461.7876910627;52170.56550193276;56241.71879140578;58885;60866.391336086075;60921;57893;58016.41983580195;58030.129548056815;58242;58348;15701.685966280611;15906.204689765465;16093.517194484184;16110.67778644444;16113.113778742047;12332.013438924865;12365.938170309091;12391.318477483645;12394.442250098768;12652.683682908;18792.248310067716;18883.90558047201;18931;18967.43097707071;18984.525386865163;7762.844743105106;7881.763547093597;7919.247671471201;7981.600919953979;8044.913936618598;844.7845799321134;899.6941040046415;992.7518120469882;1050.207093644309;1069.1553672598716;24195.395115122265;27492.862535687193;29427.411451771273;29587.260318492208;30324.241893952385;960.1694534227843;1044.9268551201344;1045.6278501831532;1064.9520771565299;1141.7088642396302;13926.373313200931;15169.772453413208;15327.616809579627;15336.539903802905;15535.378584856478;448405;452848;453504;453834;455750;43948.56051439509;53993;53997.1900421494;54096.18855717168;54292;1179.8702142764462;1418.9432422703183;1423.096333828006;1425.4796999095463;1538.1002113763573;28793.56809647815;29017.12948611545;29022.984195553054;29491.705082948894;29510.704892950795;48155.27767083567;48396.75801620969;48539.5146048535;48723;49035;522937;525097.374513125;527655;528608;531668;31207.375852482368;31907.521387179677;32909.68361265522;33025.83487082645;33043;35070.94787156389;40971.79514102411;41805.37291940562;42568.57431425646;42640;33847.66152338544;33882.49176262407;34373.82813085918;34655;34680.65319346774;33159.336813263115;33485.665143348255;33533.66466335403;33583;33705.325893482484;33593;33872;33958.15104622404;33970.490442642884;34116.829415852764;25504.362390940376;26727.86636066885;27077.45845083048;28974.27564310909;31569.8421507891;20973.475663108544;24163.03347866136;24165.879170604036;24586.754132458445;24656.013759449423 12:33:43 INFO - PROCESS | 1671 | |2;jquery.html;357.24086316577274;359.1326945426796;361.8805794087951;363.68541211851755;373.41001218075445;15456.922715386407;19273.22907083715;19488.805111948877;19569.217231310748;20179.798202017977;10955.671329860097;11228.101751859853;11258.380789056599;11352.318860868354;19350.903245483754;5266.262723218762;5440.347158341005;6000.309964354112;6013;6017.217761690996;5389.191621256823;5495.258140151069;5819.7672093116435;5896.823095307126;5928.05151175812;3913.7847418391975;5349.893002139955;5360.865978350553;5380.300560927094;5752.424757524235;5883.08812134122;5935.554833387513;5937.287525496925;5967.433093856077;6002.849928751794;5321.4412486688725;5467.316585426822;5474.562035037187;5481.588880833953;5487.5884308677005;12843.678908027281;13303;13486.258255795927;13518.526851560147;13601.591952241448;2000.6398848207316;2119.109973811003;2149.8065174134404;2164.9242276520404;2206.293985924505;9788.312284272008;9818.9509052455;9838.508074596242;10305.690829275134;10333.896661033368;1685.5954570903018;1692.6022384739576;1715.305301352954;1727.8358555937166;1774.290283886443;93709.53145234298;99674;99709;100651.993480065;102702.48648756783;11478.368689721978;11510.827337589943;11543.595974141033;11621.88378116208;11652.592159274385;13649.385777640031;13749;13754.793678094837;13762.311884405739;13808.723825523433;7211.963940180265;8611.13888611134;8651.351148663874;8685.609147588373;8750.51872147038;8762.079981601968;8815.823683526294;8866.980297265896;8913.910860891308;8940.240079593308;4502.3921770560555;4557.475890272594;4585.9541404585525;4592.402987611589;4598.655100867449;1868.6916658751425;1922.3464022232508;1925.2876435718595;1933.661609218381;1979.059946525389;397.8090516552071;405.9695522835799;417.8391319342014;427.55320689879153;439.58020090813835;11482.311061336346;11947.641570752718;11978.46096925623;11983.700407489883;12140.635780926586;433.1423780913808;440.33729237497363;447.20174488537805;454.69989806727403;457.29348157097365;6152;6226.501879849601;6236.095766113888;6291.496680265568;6291.811245662638;645825;656008;664184;664552;667336;68682.96975545371;68700.41244844394;90807;111932;116712.41643791727;458.44070234314086;464.72348952373284;465.9347691323217;466.65001249063204;469.61960811742597;10483.895161048293;11039.227254092137;11355.829662554903;11627.244229125417;11745.530178793095;39221.803890980365;49134.77163070952;50819.491805081474;51764;52281.7385913068;70478;70984.64507677428;72286.63856680683;72550.18624534429;72774;6225.28409232944;7682.846343073219;7782.883256751266;8025.799355016171;8116.228958248957;11255.493502792231;12206.389680516117;12653.304068276333;12700;12858.292793896426;9257.768555786159;10520.631777887736;10827.729306767078;10934.890651093387;10986;10419.895801042196;10893.910608939043;10907.78184436291;11077.335359878432;11115.777684446104;11016.559337626726;11129.499172537093;11297.887021129683;11566.479508421973;11569.6529104127;7906.604669766603;8040.80857739549;8091.069527004234;8111.4321997461975;8132.227438393344;8522;9472;10579.682609521727;11086.667399978014;11218.326900386002 12:33:43 INFO - PROCESS | 1671 | |3;mootools.html;1386.8405133409658;1535.2707463954623;1756.7628370170032;1901.2204995951663;1922.8846269223839;7891.092524359686;8541.359398045155;8671.176238257363;8851.557422128892;8865.955670221656;8592.183742544465;8676.089010653885;8761;8788.736337909857;8789.165029322205;2465.1002384129797;2476.4304210031705;2485.9378515537164;2490.7260201377835;2491;2215.8892055397246;2437.171361737009;2494.07719143917;2496.5256601245705;2497.825152239344;2186.409669389272;2412.9155479558217;2447.167962892625;2460.188137914493;2476.0343466048257;1989.850761192909;2409.5180963807306;2459.594166962449;2479.764422379871;2484.627305904111;2006.4682859042366;2012.7886571909885;2443.1082654831034;2444;2449.497852940143;8804.119588041209;8832.11678832118;8865.335099867536;8882.511461869595;8908.752774611496;4770.427548694179;5415.025295446818;5531.778728850882;5588.050031494656;5649.350324712669;3571.589267234275;3585.8744943926836;3702.1670124222105;3710.9257814843822;3716.2381711749026;890.8218356328761;1042.9322094063862;1076.2036093290988;1078.9946050269778;1083.5286650307062;11850.3482308473;12112.970397516221;12154.088443366783;12171.33057681827;12192.51229950801;4196.223698615705;4792.185328494164;4824.782884770194;4866.683665561727;4927.728974906343;10319;10339.741506462247;10344.844827327595;10367.688969330782;10371.688849334532;5464.289642346549;5505.6696598204235;5507.228987941691;5508.55931525477;5537.280153580009;4957.578605818474;4983.6760610560195;4999.325091112726;5002.424721157041;5009.9729555441045;4053.43251944728;4065.7763822989427;4073.307537718595;4084.4281800547947;4090.9181816363507;1228.686684895364;1326.1380102933172;1340.2695530935664;1345.8317710286215;1355.356205802236;1113.4432783608195;1121.114319687454;1146.8451759012594;1278.8809791432498;1360.816289800884;8023.719169829144;8030.357571394275;8124.918750812534;8153.95923020393;8157.46976446541;1167;1178.4461303187488;1189.8750631183775;1194.5341316886422;1205.2587658589905;6115.266168059861;6186.907196392058;6238.719257633417;6244.12582238487;6253.249610046823;10300;10507.894921050845;10587.682369528926;10587.735306617242;10628.202884783517;8813.867791983126;10365.689029329133;10373.63692270782;10471;10505.789884202273;8209.384296177692;8244.917550824535;8255.174482551696;8273.669053237803;8355.749327520183;8013;8024.959875200587;8041.67833286662;8052.476589021695;8320.126386729306;8966.789483419916;9100.954495227747;9686.467244301632;9797.706068817946;9808.264380171373;8831.381803273965;9584.76038099053;10090.19278457707;10167.644132455329;10241.590336386462;7383;7589.924100758922;7700.383969282556;7706.653200606098;7724.961375193313;6637.800865973835;6848.554843935129;8265.586720664063;8302.460340077876;8403;6842.863142737217;7399.370835500773;7502.962485187539;7550.131734850563;7598;7252.492325537161;7319.670614822239;7347.044884165024;7377.446691498052;7381.667824947997;7819;7840.764777056697;7842.64708088126;7906.367490600853;7919.762407127795;6967.756128535477;7097.183823860322;7098.858022839618;7130.215676275502;7151.106111736033;7102.680379383043;7160;7186.029885965328;7233.31283528064;7247.782566523013 12:33:43 INFO - PROCESS | 1671 | |4;prototype.html;322.35207233460744;323.2323232323232;326.9950950735738;333.0890015806768;334.2829630442699;5638.492535671789;6717.3618506241955;6741.191057073158;6758.121444212258;6951.548149370294;6856.760013399532;6889.965550172242;6902.930970690291;6908.516403851732;6924.6883890224935;5130;5133.6919784813035;5138.22926561017;5143.177091665334;5143.639945203838;4791.2813078038225;5105.897882042357;5107.004134193834;5143.27994080829;5146.845594632148;4894.5594896459315;4924.089043526941;4950.207966725325;4961.875953101166;4971.875703107433;4920.237363208708;4937.432195297533;4947.1342515059905;4960.826371077013;4970.627202959757;3949.605039496056;4166.270902592034;4208.621224089816;4311.417958575584;4339.826406943718;6430.260520040209;6467.870642587169;6474.676266186719;6480.675966201671;6497.025446183063;4796.928046079312;5298.735063246861;5410.810621628263;5532.834014979517;5890.587658863881;7020.508564400494;7312.707491700326;7323.414126869838;7349.742759003409;7353.411727061823;4158.355454904495;4820.879478013043;4823.107725070838;4823.493533179036;4850.369451971256;7588.544687318778;7651.617419129021;7655.885161722523;7658.234176582298;7728.111267204287;4799.101092586467;4857.931255123867;4882;4885.926711099336;4901.828436004794;4985.102681517362;5013.047520971004;5024.472430394829;5031.4465408805;5043.621728370387;5881.941180588139;5892.793752218738;5896.086106653475;5906.940930590639;5928.081147422156;7261.346478816932;7273.854522909618;7298.2701729826595;7302.634868256566;7315.561066336037;1422.431027588952;1766.2493440287826;1768.7258474936405;1768.7612172356567;1778.48423957051;1137.0676045642658;1146.656003199037;1157.062779148892;1160.460385920551;1171.5957994491887;6934.965325173342;6942.305769423118;6943.652817359111;6951.826204344932;6993.580385176906;7811.945387372745;7833.843323133506;7834.0599128105;7841.960790196126;7854.6858125674335;6756.425703815133;6913.343232392915;6929.930700692928;6964.756233531802;6969.58182509051;3976.58245884178;4018.9397159042637;4021.235965166609;4041.8787436376956;4048.919021619551;8109.310708589718;8149.674013039412;8165.265126138676;8166.918330816735;8207.384446166441;6557.770478033246;8035.638396272182;8040.557769322626;8051.315638170821;8227.259546640831;8058.597070146469;8276.586170691562;8294.3779216559;8311.584420779058;8347.582620869054;7934.801629959297;7938.285554300141;7950.602469876599;7961.562114083781;7989.440739148204;6737.831554211184;7332.340089391767;7501.249875012673;7744.961275193588;7749.186335434698;8247.340212783083;8287;8288.046874609256;8312.584370781558;8331.250187483156;5037.848864534069;5079;5086.516780905808;5092.872678183075;5097.719625420637;7616.20029896875;7834.647440865061;7862.1351651319455;7874.72438464651;7877.842443151219;7558;7590.7722768317035;7591.734289299848;7597.962010189914;7604.581748003691;7344.192138864613;7547.660355284135;7575.24247575238;7579.848403031799;7580.128285247047;7342.045534080536;7349.412047036331;7361.521501102411;7367.300106489874;7390.2979216976455;7539;7539.585322807298;7545.7358992435;7547.207543207884;7570.432217583593;7197.604131772803;7325.926740732524;7367.594782286811;7375.631218439164;7391.6304184791625 12:33:43 INFO - PROCESS | 1671 | |5;yui.html;640.9423151916327;659.5811659596155;698.598305974065;721.0950257426929;734.8640501507222;14657.680808727213;14714.77927831082;15057.62355941102;15065.548033559011;15068.849311506881;14431.783523247159;15760.76358854618;15984.84015159851;15986.680266394666;15998.120103394309;713.0658836923647;865.2904618213067;870.8693695945595;887.6893087419417;891.425030855098;833.262562632072;880.7621942075635;891.5720454181997;891.9866202006975;894.5393122541897;926.0785518409159;931.417863835103;934.173256667847;935.3779736475236;936.8220038192721;778.910425301092;920.8618707193907;925.4077390470104;927.3647551427293;930.4417349590259;673.0610797936899;683.1426559667585;683.8666460040245;689.1144878830729;692.5463821197123;15220.543383698507;15300.387984480718;15390.846091539053;15415.460458883997;15479.767803482957;12680.365981700877;12800.61598152057;12825;13010.934945325307;13195.406206720721;10091.79816403675;10217.182625390025;10334.328268662588;10621.681349559449;10995.560177592886;3452.87914922979;3476.530668359764;3492.353914525821;3516.1736991806906;3577.678008979204;86890.56554717186;87515.12484875134;87531;87769;87843.56078219632;9170.493112397657;9288.164065234161;9327.97392286848;9629.807403852024;9742.561584728704;20700.58598828045;20898.955052247326;20959.8952005239;21033.15867365288;21054.15783368648;7277.963610181915;7358.484906056525;7410.777676669601;7438.59087750179;7563.168051514329;3619.9276014479565;4018.2967980603275;4044.6359827615065;4078.1639763848934;4080.9387859182134;3371.8482668279985;3400.948985765166;3401.3707464119216;3437.570303712036;3446.121239084068;572.4647454629934;636.1348565950304;647.9967600161968;652.9967350163218;672.8990651402231;593.1221791748237;595.6009473652576;614.2046050364788;619.9690015499207;624.0607885132937;8373.706920257762;8611.870821937677;8871.201591856763;9256.79661643982;9308.488033158106;477.12447658546955;498.0735831353679;552.8148070396462;557.5762420560322;613.3835495327256;3217.9678203218136;3740.9625903740616;3893.5911729268587;3926.54844692864;3935.252302062599;88438;93386.06613933909;96075.51962240144;96878;97975.53036704456;81841.59079204565;82148;82931.5853420741;83027.58486207652;83567.5821620888;64691.02963455552;72194.63902680454;74079.25920740831;75760.62119689367;78174.60912695514;7985.64064617082;7994.640241189277;8046.959765201371;8128.309093726863;8174.346052315682;52922.73538632282;53076.46923530715;53143.46856531385;54115.18827217516;54388.45611543834;71985;72096;72201.55596887927;72686;72804.63597681977;10622.20333475008;11008.339499630049;11375.146863985068;11378.601748938747;11822.408879555816;9727.319087664078;9951.502424878872;12360.75278494407;12470.5011799527;12839.229646221256;11278.266912650652;11326.886731132583;11891.601984416655;11917.986971107553;12094;11323.886761132613;11704.590339338083;11762.059035277329;11795.882041179822;12001.459934302802;11212.215144939775;11552.191346605992;11590.18868679218;11648.009919156966;11799.233049851731;9079.81962344891;9396.95301523488;9454.243660507005;9662.624493491447;9821.312508124363;8722.956385218033;9757.804843903225;9801.460919649488;9886.159676427584;9931.553080111267 12:33:43 INFO - PROCESS | 1671 | __end_tp_report 12:33:43 INFO - PROCESS | 1671 | __start_cc_report 12:33:43 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,362 12:33:43 INFO - PROCESS | 1671 | __end_cc_report 12:33:43 INFO - PROCESS | 1671 | __startTimestamp1455827623824__endTimestamp 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | ------- Summary: start ------- 12:33:43 INFO - PROCESS | 1671 | Number of tests: 6 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5744.70 Median:6100.33 stddev:699.74 (11.5%) stddev-sans-first:667.26 12:33:43 INFO - PROCESS | 1671 | Values: 2973.5 3082.9 3181.4 3532.0 3564.7 5773.9 5800.4 5808.1 5826.9 5839.4 4813.4 5732.5 5880.4 5882.9 5967.1 5259.2 5264.4 5275.6 5395.9 5464.9 4735.9 5126.6 5359.8 5383.9 5410.3 4242.9 5182.4 5287.8 5310.8 5342.3 4338.3 4386.5 5298.7 5320.5 5343.5 5187.7 5191.9 5266.9 5277.8 5279.8 5671.8 5712.7 5778.1 5802.4 5841.2 5551.8 6217.5 6230.6 6245.8 6246.1 6166.8 6224.6 6239.7 6259.5 6261.5 4925.0 5904.7 5984.8 6004.7 6074.3 6189.2 6319.5 6323.7 6345.8 6357.9 6160.3 6249.5 6266.9 6268.2 6276.4 6200.8 6246.8 6254.2 6257.4 6263.2 6124.4 6175.8 6245.9 6248.1 6306.7 5753.2 6102.7 6211.9 6217.7 6233.3 4958.3 4960.7 4965.2 4971.4 4981.6 4376.2 4415.1 4453.2 4472.0 4489.7 5828.3 5855.1 5866.7 5889.8 5891.9 4708.6 6183.2 6224.0 6266.9 6274.5 4748.0 4990.1 5862.4 5871.6 5874.6 5449.0 5455.3 5462.5 5463.4 5510.1 6236.7 6313.7 6363.7 6394.5 6428.6 6198.8 6242.1 6266.7 6283.6 6342.7 6194.0 6416.1 6423.6 6426.7 6431.5 6154.9 6255.6 6268.4 6268.8 6288.3 6224.2 6227.9 6246.8 6275.7 6277.0 5123.5 5658.9 6100.3 6133.7 6208.6 6108.9 6205.5 6208.7 6209.3 6219.0 5971.5 6100.4 6105.5 6117.9 6129.2 6103.8 6150.8 6230.5 6238.1 6269.5 6070.4 6106.1 6111.9 6139.0 6148.5 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:60815.57 Median:37384.53 stddev:126455.23 (338.3%) stddev-sans-first:126728.77 12:33:43 INFO - PROCESS | 1671 | Values: 459.9 500.7 510.8 552.8 569.0 33583.2 37012.3 37377.4 37391.6 37448.0 38133.0 38634.6 38671.0 38764.0 38814.0 9322.3 9434.7 9514.2 9526.9 9577.0 9389.8 9498.6 9503.7 9504.3 9532.8 9480.2 9563.8 9594.0 9602.0 9617.2 8254.6 9567.9 9660.2 9671.6 9704.9 9415.8 9539.2 9569.4 9589.4 9622.4 30673.5 37246.6 37453.1 37694.0 37735.2 3002.1 3214.6 3414.0 3571.0 3752.0 27049.3 27600.3 27800.6 28531.4 28980.1 2747.1 2778.2 2809.6 2821.6 2926.3 441129.0 441668.0 441715.0 441817.0 442461.8 52170.6 56241.7 58885.0 60866.4 60921.0 57893.0 58016.4 58030.1 58242.0 58348.0 15701.7 15906.2 16093.5 16110.7 16113.1 12332.0 12365.9 12391.3 12394.4 12652.7 18792.2 18883.9 18931.0 18967.4 18984.5 7762.8 7881.8 7919.2 7981.6 8044.9 844.8 899.7 992.8 1050.2 1069.2 24195.4 27492.9 29427.4 29587.3 30324.2 960.2 1044.9 1045.6 1065.0 1141.7 13926.4 15169.8 15327.6 15336.5 15535.4 448405.0 452848.0 453504.0 453834.0 455750.0 43948.6 53993.0 53997.2 54096.2 54292.0 1179.9 1418.9 1423.1 1425.5 1538.1 28793.6 29017.1 29023.0 29491.7 29510.7 48155.3 48396.8 48539.5 48723.0 49035.0 522937.0 525097.4 527655.0 528608.0 531668.0 31207.4 31907.5 32909.7 33025.8 33043.0 35070.9 40971.8 41805.4 42568.6 42640.0 33847.7 33882.5 34373.8 34655.0 34680.7 33159.3 33485.7 33533.7 33583.0 33705.3 33593.0 33872.0 33958.2 33970.5 34116.8 25504.4 26727.9 27077.5 28974.3 31569.8 20973.5 24163.0 24165.9 24586.8 24656.0 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:33569.41 Median:439.96 stddev:108730.47 (24713.8%) stddev-sans-first:109006.88 12:33:43 INFO - PROCESS | 1671 | Values: 357.2 359.1 361.9 363.7 373.4 15456.9 19273.2 19488.8 19569.2 20179.8 10955.7 11228.1 11258.4 11352.3 19350.9 5266.3 5440.3 6000.3 6013.0 6017.2 5389.2 5495.3 5819.8 5896.8 5928.1 3913.8 5349.9 5360.9 5380.3 5752.4 5883.1 5935.6 5937.3 5967.4 6002.8 5321.4 5467.3 5474.6 5481.6 5487.6 12843.7 13303.0 13486.3 13518.5 13601.6 2000.6 2119.1 2149.8 2164.9 2206.3 9788.3 9819.0 9838.5 10305.7 10333.9 1685.6 1692.6 1715.3 1727.8 1774.3 93709.5 99674.0 99709.0 100652.0 102702.5 11478.4 11510.8 11543.6 11621.9 11652.6 13649.4 13749.0 13754.8 13762.3 13808.7 7212.0 8611.1 8651.4 8685.6 8750.5 8762.1 8815.8 8867.0 8913.9 8940.2 4502.4 4557.5 4586.0 4592.4 4598.7 1868.7 1922.3 1925.3 1933.7 1979.1 397.8 406.0 417.8 427.6 439.6 11482.3 11947.6 11978.5 11983.7 12140.6 433.1 440.3 447.2 454.7 457.3 6152.0 6226.5 6236.1 6291.5 6291.8 645825.0 656008.0 664184.0 664552.0 667336.0 68683.0 68700.4 90807.0 111932.0 116712.4 458.4 464.7 465.9 466.7 469.6 10483.9 11039.2 11355.8 11627.2 11745.5 39221.8 49134.8 50819.5 51764.0 52281.7 70478.0 70984.6 72286.6 72550.2 72774.0 6225.3 7682.8 7782.9 8025.8 8116.2 11255.5 12206.4 12653.3 12700.0 12858.3 9257.8 10520.6 10827.7 10934.9 10986.0 10419.9 10893.9 10907.8 11077.3 11115.8 11016.6 11129.5 11297.9 11566.5 11569.7 7906.6 8040.8 8091.1 8111.4 8132.2 8522.0 9472.0 10579.7 11086.7 11218.3 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:6056.41 Median:5006.20 stddev:3179.85 (63.5%) stddev-sans-first:3169.39 12:33:43 INFO - PROCESS | 1671 | Values: 1386.8 1535.3 1756.8 1901.2 1922.9 7891.1 8541.4 8671.2 8851.6 8866.0 8592.2 8676.1 8761.0 8788.7 8789.2 2465.1 2476.4 2485.9 2490.7 2491.0 2215.9 2437.2 2494.1 2496.5 2497.8 2186.4 2412.9 2447.2 2460.2 2476.0 1989.9 2409.5 2459.6 2479.8 2484.6 2006.5 2012.8 2443.1 2444.0 2449.5 8804.1 8832.1 8865.3 8882.5 8908.8 4770.4 5415.0 5531.8 5588.1 5649.4 3571.6 3585.9 3702.2 3710.9 3716.2 890.8 1042.9 1076.2 1079.0 1083.5 11850.3 12113.0 12154.1 12171.3 12192.5 4196.2 4792.2 4824.8 4866.7 4927.7 10319.0 10339.7 10344.8 10367.7 10371.7 5464.3 5505.7 5507.2 5508.6 5537.3 4957.6 4983.7 4999.3 5002.4 5010.0 4053.4 4065.8 4073.3 4084.4 4090.9 1228.7 1326.1 1340.3 1345.8 1355.4 1113.4 1121.1 1146.8 1278.9 1360.8 8023.7 8030.4 8124.9 8154.0 8157.5 1167.0 1178.4 1189.9 1194.5 1205.3 6115.3 6186.9 6238.7 6244.1 6253.2 10300.0 10507.9 10587.7 10587.7 10628.2 8813.9 10365.7 10373.6 10471.0 10505.8 8209.4 8244.9 8255.2 8273.7 8355.7 8013.0 8025.0 8041.7 8052.5 8320.1 8966.8 9101.0 9686.5 9797.7 9808.3 8831.4 9584.8 10090.2 10167.6 10241.6 7383.0 7589.9 7700.4 7706.7 7725.0 6637.8 6848.6 8265.6 8302.5 8403.0 6842.9 7399.4 7503.0 7550.1 7598.0 7252.5 7319.7 7347.0 7377.4 7381.7 7819.0 7840.8 7842.6 7906.4 7919.8 6967.8 7097.2 7098.9 7130.2 7151.1 7102.7 7160.0 7186.0 7233.3 7247.8 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:6091.76 Median:6910.93 stddev:1989.88 (28.8%) stddev-sans-first:1947.78 12:33:43 INFO - PROCESS | 1671 | Values: 322.4 323.2 327.0 333.1 334.3 5638.5 6717.4 6741.2 6758.1 6951.5 6856.8 6890.0 6902.9 6908.5 6924.7 5130.0 5133.7 5138.2 5143.2 5143.6 4791.3 5105.9 5107.0 5143.3 5146.8 4894.6 4924.1 4950.2 4961.9 4971.9 4920.2 4937.4 4947.1 4960.8 4970.6 3949.6 4166.3 4208.6 4311.4 4339.8 6430.3 6467.9 6474.7 6480.7 6497.0 4796.9 5298.7 5410.8 5532.8 5890.6 7020.5 7312.7 7323.4 7349.7 7353.4 4158.4 4820.9 4823.1 4823.5 4850.4 7588.5 7651.6 7655.9 7658.2 7728.1 4799.1 4857.9 4882.0 4885.9 4901.8 4985.1 5013.0 5024.5 5031.4 5043.6 5881.9 5892.8 5896.1 5906.9 5928.1 7261.3 7273.9 7298.3 7302.6 7315.6 1422.4 1766.2 1768.7 1768.8 1778.5 1137.1 1146.7 1157.1 1160.5 1171.6 6935.0 6942.3 6943.7 6951.8 6993.6 7811.9 7833.8 7834.1 7842.0 7854.7 6756.4 6913.3 6929.9 6964.8 6969.6 3976.6 4018.9 4021.2 4041.9 4048.9 8109.3 8149.7 8165.3 8166.9 8207.4 6557.8 8035.6 8040.6 8051.3 8227.3 8058.6 8276.6 8294.4 8311.6 8347.6 7934.8 7938.3 7950.6 7961.6 7989.4 6737.8 7332.3 7501.2 7745.0 7749.2 8247.3 8287.0 8288.0 8312.6 8331.3 5037.8 5079.0 5086.5 5092.9 5097.7 7616.2 7834.6 7862.1 7874.7 7877.8 7558.0 7590.8 7591.7 7598.0 7604.6 7344.2 7547.7 7575.2 7579.8 7580.1 7342.0 7349.4 7361.5 7367.3 7390.3 7539.0 7539.6 7545.7 7547.2 7570.4 7197.6 7325.9 7367.6 7375.6 7391.6 12:33:43 INFO - PROCESS | 1671 | 12:33:43 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:19048.46 Median:32665.99 stddev:27181.54 (83.2%) stddev-sans-first:27222.65 12:33:43 INFO - PROCESS | 1671 | Values: 640.9 659.6 698.6 721.1 734.9 14657.7 14714.8 15057.6 15065.5 15068.8 14431.8 15760.8 15984.8 15986.7 15998.1 713.1 865.3 870.9 887.7 891.4 833.3 880.8 891.6 892.0 894.5 926.1 931.4 934.2 935.4 936.8 778.9 920.9 925.4 927.4 930.4 673.1 683.1 683.9 689.1 692.5 15220.5 15300.4 15390.8 15415.5 15479.8 12680.4 12800.6 12825.0 13010.9 13195.4 10091.8 10217.2 10334.3 10621.7 10995.6 3452.9 3476.5 3492.4 3516.2 3577.7 86890.6 87515.1 87531.0 87769.0 87843.6 9170.5 9288.2 9328.0 9629.8 9742.6 20700.6 20899.0 20959.9 21033.2 21054.2 7278.0 7358.5 7410.8 7438.6 7563.2 3619.9 4018.3 4044.6 4078.2 4080.9 3371.8 3400.9 3401.4 3437.6 3446.1 572.5 636.1 648.0 653.0 672.9 593.1 595.6 614.2 620.0 624.1 8373.7 8611.9 8871.2 9256.8 9308.5 477.1 498.1 552.8 557.6 613.4 3218.0 3741.0 3893.6 3926.5 3935.3 88438.0 93386.1 96075.5 96878.0 97975.5 81841.6 82148.0 82931.6 83027.6 83567.6 64691.0 72194.6 74079.3 75760.6 78174.6 7985.6 7994.6 8047.0 8128.3 8174.3 52922.7 53076.5 53143.5 54115.2 54388.5 71985.0 72096.0 72201.6 72686.0 72804.6 10622.2 11008.3 11375.1 11378.6 11822.4 9727.3 9951.5 12360.8 12470.5 12839.2 11278.3 11326.9 11891.6 11918.0 12094.0 11323.9 11704.6 11762.1 11795.9 12001.5 11212.2 11552.2 11590.2 11648.0 11799.2 9079.8 9397.0 9454.2 9662.6 9821.3 8723.0 9757.8 9801.5 9886.2 9931.6 12:33:43 INFO - PROCESS | 1671 | -------- Summary: end -------- 12:33:43 INFO - PROCESS | 1671 | 12:33:44 INFO - TEST-INFO | 1671: exit 0 12:33:44 INFO - TEST-OK | dromaeo_css | took 1110330ms 12:33:44 INFO - TEST-START | kraken 12:33:44 INFO - operating with platform_type : mac_ 12:33:44 INFO - Initialising browser for kraken test... 12:33:44 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp0Xtq1T/profile http://localhost:49282/getInfo.html) 12:33:46 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 12:33:46 INFO - PROCESS | 1683 | colorDepth:24 12:33:46 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 12:33:46 INFO - PROCESS | 1683 | __metrics 12:33:46 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 12:33:47 INFO - TEST-INFO | 1683: exit 0 12:33:47 INFO - Browser initialized. 12:33:47 INFO - Running cycle 1/1 for kraken test... 12:33:47 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp0Xtq1T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:59 INFO - PROCESS | 1686 | RSS: Main: 255442944 12:33:59 INFO - PROCESS | 1686 | 12:34:02 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:02 INFO - PROCESS | 1686 | RSS: Main: 268632064 12:34:02 INFO - PROCESS | 1686 | 12:34:05 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 12:34:06 INFO - PROCESS | 1686 | RSS: Main: 276271104 12:34:06 INFO - PROCESS | 1686 | 12:34:09 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 12:34:10 INFO - PROCESS | 1686 | RSS: Main: 280809472 12:34:10 INFO - PROCESS | 1686 | 12:34:12 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 12:34:12 INFO - PROCESS | 1686 | RSS: Main: 282865664 12:34:12 INFO - PROCESS | 1686 | 12:34:15 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:15 INFO - PROCESS | 1686 | RSS: Main: 283930624 12:34:15 INFO - PROCESS | 1686 | 12:34:18 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:18 INFO - PROCESS | 1686 | RSS: Main: 283385856 12:34:18 INFO - PROCESS | 1686 | 12:34:22 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:22 INFO - PROCESS | 1686 | RSS: Main: 283025408 12:34:22 INFO - PROCESS | 1686 | 12:34:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 12:34:25 INFO - PROCESS | 1686 | RSS: Main: 283553792 12:34:25 INFO - PROCESS | 1686 | 12:34:27 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:28 INFO - PROCESS | 1686 | RSS: Main: 285003776 12:34:28 INFO - PROCESS | 1686 | 12:34:29 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:30 INFO - PROCESS | 1686 | RSS: Main: 284221440 12:34:30 INFO - PROCESS | 1686 | 12:34:32 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:33 INFO - PROCESS | 1686 | RSS: Main: 284028928 12:34:33 INFO - PROCESS | 1686 | 12:34:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:36 INFO - PROCESS | 1686 | RSS: Main: 284270592 12:34:36 INFO - PROCESS | 1686 | 12:34:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:39 INFO - PROCESS | 1686 | RSS: Main: 283811840 12:34:39 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 12:34:41 INFO - PROCESS | 1686 | RSS: Main: 285687808 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | __start_tp_report 12:34:41 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 12:34:41 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 12:34:41 INFO - PROCESS | 1686 | |i|pagename|runs| 12:34:41 INFO - PROCESS | 1686 | |0;ai-astar;114;111;115;116;118;126;112;114;117;114 12:34:41 INFO - PROCESS | 1686 | |1;audio-beat-detection;154;141;165;186;158;169;139;120;156;127 12:34:41 INFO - PROCESS | 1686 | |2;audio-dft;195;198;194;209;258;269;275;257;195;192 12:34:41 INFO - PROCESS | 1686 | |3;audio-fft;73;68;72;110;59;67;87;91;138;57 12:34:41 INFO - PROCESS | 1686 | |4;audio-oscillator;111;71;138;119;120;122;104;119;122;149 12:34:41 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;87;95;86;94;88;94;87;92;87;94 12:34:41 INFO - PROCESS | 1686 | |6;imaging-darkroom;99;103;151;103;134;151;95;95;96;95 12:34:41 INFO - PROCESS | 1686 | |7;imaging-desaturate;90;90;92;91;94;91;91;94;92;115 12:34:41 INFO - PROCESS | 1686 | |8;json-parse-financial;56;58;55;54;55;56;56;64;54;54 12:34:41 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;63;70;101;75;74;72;67;66;66;67 12:34:41 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;86;82;84;84;86;85;84;88;86;84 12:34:41 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;145;124;125;127;124;125;126;123;129;140 12:34:41 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;157;184;147;144;184;182;182;142;140;132 12:34:41 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;69;67;69;68;70;66;69;67;67;72 12:34:41 INFO - PROCESS | 1686 | __end_tp_report 12:34:41 INFO - PROCESS | 1686 | __start_cc_report 12:34:41 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,874 12:34:41 INFO - PROCESS | 1686 | __end_cc_report 12:34:41 INFO - PROCESS | 1686 | __startTimestamp1455827681557__endTimestamp 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | ------- Summary: start ------- 12:34:41 INFO - PROCESS | 1686 | Number of tests: 14 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.50 stddev:4.19 (3.6%) stddev-sans-first:4.40 12:34:41 INFO - PROCESS | 1686 | Values: 114.0 111.0 115.0 116.0 118.0 126.0 112.0 114.0 117.0 114.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.00 stddev:20.02 (12.8%) stddev-sans-first:21.21 12:34:41 INFO - PROCESS | 1686 | Values: 154.0 141.0 165.0 186.0 158.0 169.0 139.0 120.0 156.0 127.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:224.20 Median:233.00 stddev:35.56 (15.3%) stddev-sans-first:36.11 12:34:41 INFO - PROCESS | 1686 | Values: 195.0 198.0 194.0 209.0 258.0 269.0 275.0 257.0 195.0 192.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:82.20 Median:70.00 stddev:25.35 (36.2%) stddev-sans-first:26.66 12:34:41 INFO - PROCESS | 1686 | Values: 73.0 68.0 72.0 110.0 59.0 67.0 87.0 91.0 138.0 57.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:117.50 Median:122.00 stddev:20.68 (17.0%) stddev-sans-first:21.80 12:34:41 INFO - PROCESS | 1686 | Values: 111.0 71.0 138.0 119.0 120.0 122.0 104.0 119.0 122.0 149.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:93.00 stddev:3.69 (4.0%) stddev-sans-first:3.70 12:34:41 INFO - PROCESS | 1686 | Values: 87.0 95.0 86.0 94.0 88.0 94.0 87.0 92.0 87.0 94.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:112.20 Median:95.00 stddev:23.52 (24.8%) stddev-sans-first:24.46 12:34:41 INFO - PROCESS | 1686 | Values: 99.0 103.0 151.0 103.0 134.0 151.0 95.0 95.0 96.0 95.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:91.50 stddev:7.51 (8.2%) stddev-sans-first:7.83 12:34:41 INFO - PROCESS | 1686 | Values: 90.0 90.0 92.0 91.0 94.0 91.0 91.0 94.0 92.0 115.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.01 (5.4%) stddev-sans-first:3.19 12:34:41 INFO - PROCESS | 1686 | Values: 56.0 58.0 55.0 54.0 55.0 56.0 56.0 64.0 54.0 54.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:68.50 stddev:10.86 (15.8%) stddev-sans-first:11.01 12:34:41 INFO - PROCESS | 1686 | Values: 63.0 70.0 101.0 75.0 74.0 72.0 67.0 66.0 66.0 67.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.50 stddev:1.66 (1.9%) stddev-sans-first:1.72 12:34:41 INFO - PROCESS | 1686 | Values: 86.0 82.0 84.0 84.0 86.0 85.0 84.0 88.0 86.0 84.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:126.50 stddev:7.51 (5.9%) stddev-sans-first:5.20 12:34:41 INFO - PROCESS | 1686 | Values: 145.0 124.0 125.0 127.0 124.0 125.0 126.0 123.0 129.0 140.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.40 Median:169.50 stddev:21.24 (12.5%) stddev-sans-first:22.51 12:34:41 INFO - PROCESS | 1686 | Values: 157.0 184.0 147.0 144.0 184.0 182.0 182.0 142.0 140.0 132.0 12:34:41 INFO - PROCESS | 1686 | 12:34:41 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.87 12:34:41 INFO - PROCESS | 1686 | Values: 69.0 67.0 69.0 68.0 70.0 66.0 69.0 67.0 67.0 72.0 12:34:41 INFO - PROCESS | 1686 | -------- Summary: end -------- 12:34:41 INFO - PROCESS | 1686 | 12:34:42 INFO - TEST-INFO | 1686: exit 0 12:34:42 INFO - TEST-OK | kraken | took 57956ms 12:34:42 INFO - SUITE-END | took 1168s 12:34:42 INFO - Completed test suite (00:19:28) 12:34:42 INFO - Working with test: dromaeo_css 12:34:42 INFO - Generating results file: dromaeo_css 12:34:42 INFO - Working with test: kraken 12:34:42 INFO - Generating results file: kraken 12:34:42 INFO - javascript benchmark 12:34:42 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:34:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 12:34:42 INFO - process_Request line: dromaeo_css 7373.96 graph.html#tests=[[72,64,61]] 12:34:42 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:34:42 INFO - process_Request line: kraken 1557.50 graph.html#tests=[[232,64,61]] 12:34:42 INFO - RETURN: dromaeo_css: 7373.96 12:34:42 INFO - RETURN: kraken: 1557.50 12:34:42 INFO - javascript benchmark 12:34:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2973.4647763402586, 3082.905568523173, 3181.3796309719605, 3532.0, 3564.6613571710677, 5773.913391299128, 5800.44895734905, 5808.1287806829, 5826.883462330751, 5839.445252700992, 4813.37426134602, 5732.48407643312, 5880.441358070987, 5882.941070607289, 5967.134765459005, 5259.158534634469, 5264.447233040533, 5275.630705850592, 5395.919061214066, 5464.890702185954, 4735.905281894377, 5126.5898728101665, 5359.758810853521, 5383.892322153554, 5410.269613602172, 4242.936355954663, 5182.429932707418, 5287.762050707727, 5310.7610157543, 5342.332208473941, 4338.262495375794, 4386.451693538308, 5298.735063246822, 5320.5211530962015, 5343.492368225051, 5187.714675692835, 5191.948080519184, 5266.894662106736, 5277.762500687479, 5279.762410691528, 5671.801486947937, 5712.657240565538, 5778.075507918713, 5802.419758024206, 5841.240638716982, 5551.750171242304, 6217.471514921192, 6230.5638605297645, 6245.843853903643, 6246.125542424064, 6166.784162554289, 6224.62652240867, 6239.688015599202, 6259.499240060784, 6261.499080073583, 4924.975375123101, 5904.7342869570975, 5984.7606095756555, 6004.669743164168, 6074.331823499411, 6189.164462797465, 6319.526035547352, 6323.652199129092, 6345.777897773556, 6357.936420635827, 6160.260768707783, 6249.500039996789, 6266.905996410058, 6268.1851359323, 6276.372362763687, 6200.81397558074, 6246.843828904313, 6254.15568898202, 6257.405546473078, 6263.248410190807, 6124.374210744355, 6175.84560385985, 6245.937540624535, 6248.062790581449, 6306.65313407767, 5753.194552762617, 6102.664353460514, 6211.875762484725, 6217.6891155442045, 6233.3143354231, 4958.256261560795, 4960.70235785854, 4965.205567109245, 4971.37857767779, 4981.601471882241, 4376.190404775127, 4415.050764085673, 4453.22068637987, 4471.977640111843, 4489.685721999494, 5828.329742079631, 5855.092460668603, 5866.677332746654, 5889.823305300848, 5891.941080589139, 4708.623310135249, 6183.165272688219, 6224.0, 6266.905996410058, 6274.498040156776, 4747.95252047482, 4990.051890140861, 5862.3653334932615, 5871.588988770745, 5874.559408044413, 5448.9727551362785, 5455.263539422127, 5462.453754624506, 5463.3717122530625, 5510.1459273812625, 6236.688165591793, 6313.652749098844, 6363.713632886439, 6394.488440924715, 6428.646424446607, 6198.783042593487, 6242.094896240111, 6266.655333956493, 6283.560150789401, 6342.714577843916, 6194.0, 6416.101745755504, 6423.582467139621, 6426.710798014007, 6431.517636177399, 6154.938450615616, 6255.624662520263, 6268.404501572526, 6268.811935641938, 6288.276848162337, 6224.1597384354345, 6227.9377206227355, 6246.843828904313, 6275.74897004133, 6276.968615156895, 5123.524159142654, 5658.943410565842, 6100.328963814066, 6133.693315334304, 6208.596441231305, 6108.938910610837, 6205.5345849062405, 6208.689565521796, 6209.285932117684, 6219.0, 5971.462568368867, 6100.389961003864, 6105.542084343603, 6117.908231376622, 6129.2032035835055, 6103.84740381494, 6150.7539698411565, 6230.50155987529, 6238.095476156022, 6269.49844012487, 6070.392960704071, 6106.145139680537, 6111.908321375272, 6138.969305153446, 6148.538859585459], "unit": "score", "name": "dojo.html", "value": 5699.549724988353}, {"lowerIsBetter": false, "replicates": [459.9172149013176, 500.7496251874063, 510.77015343095616, 552.7899398228673, 569.001402538545, 33583.16042098949, 37012.25975480489, 37377.439338409946, 37391.62608373915, 37448.0, 38133.0, 38634.61365386345, 38671.03322416941, 38764.030899227466, 38814.0, 9322.254219662427, 9434.716958491223, 9514.238860891111, 9526.90473095267, 9577.0, 9389.76525586859, 9498.620055197818, 9503.714888553355, 9504.287178461609, 9532.80934381312, 9480.24158067353, 9563.80872382552, 9593.95203023984, 9602.0, 9617.23062155026, 8254.587270636444, 9567.856482152738, 9660.227181825438, 9671.613135474572, 9704.854427183633, 9415.811683766286, 9539.18916892065, 9569.37799043067, 9589.42463452195, 9622.422654640744, 30673.466326683578, 37246.62753372486, 37453.06367340811, 37694.0, 37735.24529509422, 3002.076477041219, 3214.5981752280964, 3414.0270023043313, 3570.9642903571153, 3751.9624803751885, 27049.323766905985, 27600.309992250353, 27800.58299125515, 28531.36180291967, 28980.130596082152, 2747.093459158493, 2778.19432364614, 2809.606655068292, 2821.619081424002, 2926.3415731460464, 441129.0, 441668.0, 441715.0, 441817.0, 442461.7876910627, 52170.56550193276, 56241.71879140578, 58885.0, 60866.391336086075, 60921.0, 57893.0, 58016.41983580195, 58030.129548056815, 58242.0, 58348.0, 15701.685966280611, 15906.204689765465, 16093.517194484184, 16110.67778644444, 16113.113778742047, 12332.013438924865, 12365.938170309091, 12391.318477483645, 12394.442250098768, 12652.683682908, 18792.248310067716, 18883.90558047201, 18931.0, 18967.43097707071, 18984.525386865163, 7762.844743105106, 7881.763547093597, 7919.247671471201, 7981.600919953979, 8044.913936618598, 844.7845799321134, 899.6941040046415, 992.7518120469882, 1050.207093644309, 1069.1553672598716, 24195.395115122265, 27492.862535687193, 29427.411451771273, 29587.260318492208, 30324.241893952385, 960.1694534227843, 1044.9268551201344, 1045.6278501831532, 1064.9520771565299, 1141.7088642396302, 13926.373313200931, 15169.772453413208, 15327.616809579627, 15336.539903802905, 15535.378584856478, 448405.0, 452848.0, 453504.0, 453834.0, 455750.0, 43948.56051439509, 53993.0, 53997.1900421494, 54096.18855717168, 54292.0, 1179.8702142764462, 1418.9432422703183, 1423.096333828006, 1425.4796999095463, 1538.1002113763573, 28793.56809647815, 29017.12948611545, 29022.984195553054, 29491.705082948894, 29510.704892950795, 48155.27767083567, 48396.75801620969, 48539.5146048535, 48723.0, 49035.0, 522937.0, 525097.374513125, 527655.0, 528608.0, 531668.0, 31207.375852482368, 31907.521387179677, 32909.68361265522, 33025.83487082645, 33043.0, 35070.94787156389, 40971.79514102411, 41805.37291940562, 42568.57431425646, 42640.0, 33847.66152338544, 33882.49176262407, 34373.82813085918, 34655.0, 34680.65319346774, 33159.336813263115, 33485.665143348255, 33533.66466335403, 33583.0, 33705.325893482484, 33593.0, 33872.0, 33958.15104622404, 33970.490442642884, 34116.829415852764, 25504.362390940376, 26727.86636066885, 27077.45845083048, 28974.27564310909, 31569.8421507891, 20973.475663108544, 24163.03347866136, 24165.879170604036, 24586.754132458445, 24656.013759449423], "unit": "score", "name": "ext.html", "value": 18888.114923979647}, {"lowerIsBetter": false, "replicates": [357.24086316577274, 359.1326945426796, 361.8805794087951, 363.68541211851755, 373.41001218075445, 15456.922715386407, 19273.22907083715, 19488.805111948877, 19569.217231310748, 20179.798202017977, 10955.671329860097, 11228.101751859853, 11258.380789056599, 11352.318860868354, 19350.903245483754, 5266.262723218762, 5440.347158341005, 6000.309964354112, 6013.0, 6017.217761690996, 5389.191621256823, 5495.258140151069, 5819.7672093116435, 5896.823095307126, 5928.05151175812, 3913.7847418391975, 5349.893002139955, 5360.865978350553, 5380.300560927094, 5752.424757524235, 5883.08812134122, 5935.554833387513, 5937.287525496925, 5967.433093856077, 6002.849928751794, 5321.4412486688725, 5467.316585426822, 5474.562035037187, 5481.588880833953, 5487.5884308677005, 12843.678908027281, 13303.0, 13486.258255795927, 13518.526851560147, 13601.591952241448, 2000.6398848207316, 2119.109973811003, 2149.8065174134404, 2164.9242276520404, 2206.293985924505, 9788.312284272008, 9818.9509052455, 9838.508074596242, 10305.690829275134, 10333.896661033368, 1685.5954570903018, 1692.6022384739576, 1715.305301352954, 1727.8358555937166, 1774.290283886443, 93709.53145234298, 99674.0, 99709.0, 100651.993480065, 102702.48648756783, 11478.368689721978, 11510.827337589943, 11543.595974141033, 11621.88378116208, 11652.592159274385, 13649.385777640031, 13749.0, 13754.793678094837, 13762.311884405739, 13808.723825523433, 7211.963940180265, 8611.13888611134, 8651.351148663874, 8685.609147588373, 8750.51872147038, 8762.079981601968, 8815.823683526294, 8866.980297265896, 8913.910860891308, 8940.240079593308, 4502.3921770560555, 4557.475890272594, 4585.9541404585525, 4592.402987611589, 4598.655100867449, 1868.6916658751425, 1922.3464022232508, 1925.2876435718595, 1933.661609218381, 1979.059946525389, 397.8090516552071, 405.9695522835799, 417.8391319342014, 427.55320689879153, 439.58020090813835, 11482.311061336346, 11947.641570752718, 11978.46096925623, 11983.700407489883, 12140.635780926586, 433.1423780913808, 440.33729237497363, 447.20174488537805, 454.69989806727403, 457.29348157097365, 6152.0, 6226.501879849601, 6236.095766113888, 6291.496680265568, 6291.811245662638, 645825.0, 656008.0, 664184.0, 664552.0, 667336.0, 68682.96975545371, 68700.41244844394, 90807.0, 111932.0, 116712.41643791727, 458.44070234314086, 464.72348952373284, 465.9347691323217, 466.65001249063204, 469.61960811742597, 10483.895161048293, 11039.227254092137, 11355.829662554903, 11627.244229125417, 11745.530178793095, 39221.803890980365, 49134.77163070952, 50819.491805081474, 51764.0, 52281.7385913068, 70478.0, 70984.64507677428, 72286.63856680683, 72550.18624534429, 72774.0, 6225.28409232944, 7682.846343073219, 7782.883256751266, 8025.799355016171, 8116.228958248957, 11255.493502792231, 12206.389680516117, 12653.304068276333, 12700.0, 12858.292793896426, 9257.768555786159, 10520.631777887736, 10827.729306767078, 10934.890651093387, 10986.0, 10419.895801042196, 10893.910608939043, 10907.78184436291, 11077.335359878432, 11115.777684446104, 11016.559337626726, 11129.499172537093, 11297.887021129683, 11566.479508421973, 11569.6529104127, 7906.604669766603, 8040.80857739549, 8091.069527004234, 8111.4321997461975, 8132.227438393344, 8522.0, 9472.0, 10579.682609521727, 11086.667399978014, 11218.326900386002], "unit": "score", "name": "jquery.html", "value": 8028.224060307323}, {"lowerIsBetter": false, "replicates": [1386.8405133409658, 1535.2707463954623, 1756.7628370170032, 1901.2204995951663, 1922.8846269223839, 7891.092524359686, 8541.359398045155, 8671.176238257363, 8851.557422128892, 8865.955670221656, 8592.183742544465, 8676.089010653885, 8761.0, 8788.736337909857, 8789.165029322205, 2465.1002384129797, 2476.4304210031705, 2485.9378515537164, 2490.7260201377835, 2491.0, 2215.8892055397246, 2437.171361737009, 2494.07719143917, 2496.5256601245705, 2497.825152239344, 2186.409669389272, 2412.9155479558217, 2447.167962892625, 2460.188137914493, 2476.0343466048257, 1989.850761192909, 2409.5180963807306, 2459.594166962449, 2479.764422379871, 2484.627305904111, 2006.4682859042366, 2012.7886571909885, 2443.1082654831034, 2444.0, 2449.497852940143, 8804.119588041209, 8832.11678832118, 8865.335099867536, 8882.511461869595, 8908.752774611496, 4770.427548694179, 5415.025295446818, 5531.778728850882, 5588.050031494656, 5649.350324712669, 3571.589267234275, 3585.8744943926836, 3702.1670124222105, 3710.9257814843822, 3716.2381711749026, 890.8218356328761, 1042.9322094063862, 1076.2036093290988, 1078.9946050269778, 1083.5286650307062, 11850.3482308473, 12112.970397516221, 12154.088443366783, 12171.33057681827, 12192.51229950801, 4196.223698615705, 4792.185328494164, 4824.782884770194, 4866.683665561727, 4927.728974906343, 10319.0, 10339.741506462247, 10344.844827327595, 10367.688969330782, 10371.688849334532, 5464.289642346549, 5505.6696598204235, 5507.228987941691, 5508.55931525477, 5537.280153580009, 4957.578605818474, 4983.6760610560195, 4999.325091112726, 5002.424721157041, 5009.9729555441045, 4053.43251944728, 4065.7763822989427, 4073.307537718595, 4084.4281800547947, 4090.9181816363507, 1228.686684895364, 1326.1380102933172, 1340.2695530935664, 1345.8317710286215, 1355.356205802236, 1113.4432783608195, 1121.114319687454, 1146.8451759012594, 1278.8809791432498, 1360.816289800884, 8023.719169829144, 8030.357571394275, 8124.918750812534, 8153.95923020393, 8157.46976446541, 1167.0, 1178.4461303187488, 1189.8750631183775, 1194.5341316886422, 1205.2587658589905, 6115.266168059861, 6186.907196392058, 6238.719257633417, 6244.12582238487, 6253.249610046823, 10300.0, 10507.894921050845, 10587.682369528926, 10587.735306617242, 10628.202884783517, 8813.867791983126, 10365.689029329133, 10373.63692270782, 10471.0, 10505.789884202273, 8209.384296177692, 8244.917550824535, 8255.174482551696, 8273.669053237803, 8355.749327520183, 8013.0, 8024.959875200587, 8041.67833286662, 8052.476589021695, 8320.126386729306, 8966.789483419916, 9100.954495227747, 9686.467244301632, 9797.706068817946, 9808.264380171373, 8831.381803273965, 9584.76038099053, 10090.19278457707, 10167.644132455329, 10241.590336386462, 7383.0, 7589.924100758922, 7700.383969282556, 7706.653200606098, 7724.961375193313, 6637.800865973835, 6848.554843935129, 8265.586720664063, 8302.460340077876, 8403.0, 6842.863142737217, 7399.370835500773, 7502.962485187539, 7550.131734850563, 7598.0, 7252.492325537161, 7319.670614822239, 7347.044884165024, 7377.446691498052, 7381.667824947997, 7819.0, 7840.764777056697, 7842.64708088126, 7906.367490600853, 7919.762407127795, 6967.756128535477, 7097.183823860322, 7098.858022839618, 7130.215676275502, 7151.106111736033, 7102.680379383043, 7160.0, 7186.029885965328, 7233.31283528064, 7247.782566523013], "unit": "score", "name": "mootools.html", "value": 4939.330865294403}, {"lowerIsBetter": false, "replicates": [322.35207233460744, 323.2323232323232, 326.9950950735738, 333.0890015806768, 334.2829630442699, 5638.492535671789, 6717.3618506241955, 6741.191057073158, 6758.121444212258, 6951.548149370294, 6856.760013399532, 6889.965550172242, 6902.930970690291, 6908.516403851732, 6924.6883890224935, 5130.0, 5133.6919784813035, 5138.22926561017, 5143.177091665334, 5143.639945203838, 4791.2813078038225, 5105.897882042357, 5107.004134193834, 5143.27994080829, 5146.845594632148, 4894.5594896459315, 4924.089043526941, 4950.207966725325, 4961.875953101166, 4971.875703107433, 4920.237363208708, 4937.432195297533, 4947.1342515059905, 4960.826371077013, 4970.627202959757, 3949.605039496056, 4166.270902592034, 4208.621224089816, 4311.417958575584, 4339.826406943718, 6430.260520040209, 6467.870642587169, 6474.676266186719, 6480.675966201671, 6497.025446183063, 4796.928046079312, 5298.735063246861, 5410.810621628263, 5532.834014979517, 5890.587658863881, 7020.508564400494, 7312.707491700326, 7323.414126869838, 7349.742759003409, 7353.411727061823, 4158.355454904495, 4820.879478013043, 4823.107725070838, 4823.493533179036, 4850.369451971256, 7588.544687318778, 7651.617419129021, 7655.885161722523, 7658.234176582298, 7728.111267204287, 4799.101092586467, 4857.931255123867, 4882.0, 4885.926711099336, 4901.828436004794, 4985.102681517362, 5013.047520971004, 5024.472430394829, 5031.4465408805, 5043.621728370387, 5881.941180588139, 5892.793752218738, 5896.086106653475, 5906.940930590639, 5928.081147422156, 7261.346478816932, 7273.854522909618, 7298.2701729826595, 7302.634868256566, 7315.561066336037, 1422.431027588952, 1766.2493440287826, 1768.7258474936405, 1768.7612172356567, 1778.48423957051, 1137.0676045642658, 1146.656003199037, 1157.062779148892, 1160.460385920551, 1171.5957994491887, 6934.965325173342, 6942.305769423118, 6943.652817359111, 6951.826204344932, 6993.580385176906, 7811.945387372745, 7833.843323133506, 7834.0599128105, 7841.960790196126, 7854.6858125674335, 6756.425703815133, 6913.343232392915, 6929.930700692928, 6964.756233531802, 6969.58182509051, 3976.58245884178, 4018.9397159042637, 4021.235965166609, 4041.8787436376956, 4048.919021619551, 8109.310708589718, 8149.674013039412, 8165.265126138676, 8166.918330816735, 8207.384446166441, 6557.770478033246, 8035.638396272182, 8040.557769322626, 8051.315638170821, 8227.259546640831, 8058.597070146469, 8276.586170691562, 8294.3779216559, 8311.584420779058, 8347.582620869054, 7934.801629959297, 7938.285554300141, 7950.602469876599, 7961.562114083781, 7989.440739148204, 6737.831554211184, 7332.340089391767, 7501.249875012673, 7744.961275193588, 7749.186335434698, 8247.340212783083, 8287.0, 8288.046874609256, 8312.584370781558, 8331.250187483156, 5037.848864534069, 5079.0, 5086.516780905808, 5092.872678183075, 5097.719625420637, 7616.20029896875, 7834.647440865061, 7862.1351651319455, 7874.72438464651, 7877.842443151219, 7558.0, 7590.7722768317035, 7591.734289299848, 7597.962010189914, 7604.581748003691, 7344.192138864613, 7547.660355284135, 7575.24247575238, 7579.848403031799, 7580.128285247047, 7342.045534080536, 7349.412047036331, 7361.521501102411, 7367.300106489874, 7390.2979216976455, 7539.0, 7539.585322807298, 7545.7358992435, 7547.207543207884, 7570.432217583593, 7197.604131772803, 7325.926740732524, 7367.594782286811, 7375.631218439164, 7391.6304184791625], "unit": "score", "name": "prototype.html", "value": 5421.017338894232}, {"lowerIsBetter": false, "replicates": [640.9423151916327, 659.5811659596155, 698.598305974065, 721.0950257426929, 734.8640501507222, 14657.680808727213, 14714.77927831082, 15057.62355941102, 15065.548033559011, 15068.849311506881, 14431.783523247159, 15760.76358854618, 15984.84015159851, 15986.680266394666, 15998.120103394309, 713.0658836923647, 865.2904618213067, 870.8693695945595, 887.6893087419417, 891.425030855098, 833.262562632072, 880.7621942075635, 891.5720454181997, 891.9866202006975, 894.5393122541897, 926.0785518409159, 931.417863835103, 934.173256667847, 935.3779736475236, 936.8220038192721, 778.910425301092, 920.8618707193907, 925.4077390470104, 927.3647551427293, 930.4417349590259, 673.0610797936899, 683.1426559667585, 683.8666460040245, 689.1144878830729, 692.5463821197123, 15220.543383698507, 15300.387984480718, 15390.846091539053, 15415.460458883997, 15479.767803482957, 12680.365981700877, 12800.61598152057, 12825.0, 13010.934945325307, 13195.406206720721, 10091.79816403675, 10217.182625390025, 10334.328268662588, 10621.681349559449, 10995.560177592886, 3452.87914922979, 3476.530668359764, 3492.353914525821, 3516.1736991806906, 3577.678008979204, 86890.56554717186, 87515.12484875134, 87531.0, 87769.0, 87843.56078219632, 9170.493112397657, 9288.164065234161, 9327.97392286848, 9629.807403852024, 9742.561584728704, 20700.58598828045, 20898.955052247326, 20959.8952005239, 21033.15867365288, 21054.15783368648, 7277.963610181915, 7358.484906056525, 7410.777676669601, 7438.59087750179, 7563.168051514329, 3619.9276014479565, 4018.2967980603275, 4044.6359827615065, 4078.1639763848934, 4080.9387859182134, 3371.8482668279985, 3400.948985765166, 3401.3707464119216, 3437.570303712036, 3446.121239084068, 572.4647454629934, 636.1348565950304, 647.9967600161968, 652.9967350163218, 672.8990651402231, 593.1221791748237, 595.6009473652576, 614.2046050364788, 619.9690015499207, 624.0607885132937, 8373.706920257762, 8611.870821937677, 8871.201591856763, 9256.79661643982, 9308.488033158106, 477.12447658546955, 498.0735831353679, 552.8148070396462, 557.5762420560322, 613.3835495327256, 3217.9678203218136, 3740.9625903740616, 3893.5911729268587, 3926.54844692864, 3935.252302062599, 88438.0, 93386.06613933909, 96075.51962240144, 96878.0, 97975.53036704456, 81841.59079204565, 82148.0, 82931.5853420741, 83027.58486207652, 83567.5821620888, 64691.02963455552, 72194.63902680454, 74079.25920740831, 75760.62119689367, 78174.60912695514, 7985.64064617082, 7994.640241189277, 8046.959765201371, 8128.309093726863, 8174.346052315682, 52922.73538632282, 53076.46923530715, 53143.46856531385, 54115.18827217516, 54388.45611543834, 71985.0, 72096.0, 72201.55596887927, 72686.0, 72804.63597681977, 10622.20333475008, 11008.339499630049, 11375.146863985068, 11378.601748938747, 11822.408879555816, 9727.319087664078, 9951.502424878872, 12360.75278494407, 12470.5011799527, 12839.229646221256, 11278.266912650652, 11326.886731132583, 11891.601984416655, 11917.986971107553, 12094.0, 11323.886761132613, 11704.590339338083, 11762.059035277329, 11795.882041179822, 12001.459934302802, 11212.215144939775, 11552.191346605992, 11590.18868679218, 11648.009919156966, 11799.233049851731, 9079.81962344891, 9396.95301523488, 9454.243660507005, 9662.624493491447, 9821.312508124363, 8722.956385218033, 9757.804843903225, 9801.460919649488, 9886.159676427584, 9931.553080111267], "unit": "score", "name": "yui.html", "value": 6946.660713456447}], "name": "dromaeo_css", "value": 7373.958440548132}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 115.0, 116.0, 118.0, 126.0, 112.0, 114.0, 117.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [154.0, 141.0, 165.0, 186.0, 158.0, 169.0, 139.0, 120.0, 156.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 151.5}, {"lowerIsBetter": true, "replicates": [195.0, 198.0, 194.0, 209.0, 258.0, 269.0, 275.0, 257.0, 195.0, 192.0], "unit": "score", "name": "audio-dft", "value": 224.2}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 72.0, 110.0, 59.0, 67.0, 87.0, 91.0, 138.0, 57.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [111.0, 71.0, 138.0, 119.0, 120.0, 122.0, 104.0, 119.0, 122.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 117.5}, {"lowerIsBetter": true, "replicates": [87.0, 95.0, 86.0, 94.0, 88.0, 94.0, 87.0, 92.0, 87.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [99.0, 103.0, 151.0, 103.0, 134.0, 151.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 112.2}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 92.0, 91.0, 94.0, 91.0, 91.0, 94.0, 92.0, 115.0], "unit": "score", "name": "imaging-desaturate", "value": 94.0}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 55.0, 54.0, 55.0, 56.0, 56.0, 64.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 101.0, 75.0, 74.0, 72.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.1}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 84.0, 84.0, 86.0, 85.0, 84.0, 88.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [145.0, 124.0, 125.0, 127.0, 124.0, 125.0, 126.0, 123.0, 129.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.8}, {"lowerIsBetter": true, "replicates": [157.0, 184.0, 147.0, 144.0, 184.0, 182.0, 182.0, 142.0, 140.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.4}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 69.0, 68.0, 70.0, 66.0, 69.0, 67.0, 67.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1557.5000000000002}]} 12:34:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1557.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7373.96"}}} 12:34:42 INFO - Return code: 0 12:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:34:42 ERROR - # TBPL SUCCESS # 12:34:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:34:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:34:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:34:42 INFO - 2016-02-18 12:34:42.972 screenresolution[1691:10560] starting screenresolution argv=screenresolution get 12:34:42 INFO - 2016-02-18 12:34:42.974 screenresolution[1691:10560] Display 0: 1600x1200x32@50 12:34:42 INFO - 2016-02-18 12:34:42.980 screenresolution[1692:10563] starting screenresolution argv=screenresolution list 12:34:42 INFO - Available Modes on Display 0 12:34:42 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 12:34:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:34:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:34:42 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 12:34:42 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 12:34:43 INFO - Graphics/Displays: 12:34:43 INFO - Intel Iris: 12:34:43 INFO - Chipset Model: Intel Iris 12:34:43 INFO - Type: GPU 12:34:43 INFO - Bus: Built-In 12:34:43 INFO - VRAM (Dynamic, Max): 1536 MB 12:34:43 INFO - Vendor: Intel (0x8086) 12:34:43 INFO - Device ID: 0x0a2e 12:34:43 INFO - Revision ID: 0x0009 12:34:43 INFO - Displays: 12:34:43 INFO - Display: 12:34:43 INFO - Resolution: 1600 x 1200 @ 50 Hz 12:34:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:34:43 INFO - Display Serial Number: 1600x1200 50 12:34:43 INFO - Main Display: Yes 12:34:43 INFO - Mirror: Off 12:34:43 INFO - Online: Yes 12:34:43 INFO - Rotation: Supported 12:34:43 INFO - Return code: 0 12:34:43 INFO - Running post-action listener: _resource_record_post_action 12:34:43 INFO - Running post-run listener: _resource_record_post_run 12:34:44 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39400960; Write bytes: 710526464; Read time: 423; Write time: 1950 12:34:44 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 397957632; Write bytes: 391493120; Read time: 29848; Write time: 699 12:34:44 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 37467648; Write bytes: 303271936; Read time: 398; Write time: 1211 12:34:44 INFO - Running post-run listener: _upload_blobber_files 12:34:44 INFO - Blob upload gear active. 12:34:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:44 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 12:34:44 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'] 12:34:44 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 12:34:44 INFO - (blobuploader) - INFO - Open directory for files ... 12:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:45 INFO - (blobuploader) - INFO - Done attempting. 12:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:34:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:46 INFO - (blobuploader) - INFO - Done attempting. 12:34:46 INFO - (blobuploader) - INFO - Iteration through files over. 12:34:46 INFO - Return code: 0 12:34:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:34:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:34:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d20a31bdcc3b83c27d4504aefb5304301612eb44eb9561ee40f5dd4f6aff076b186cb704bbab7a24144183f4810ae7553b38f1734bfdd584c3752b40bed0bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3525a3ccdf87741916b67974b1c78359ef238d2e612e1d0af0525363e4eecb14ad07f1640c2c55387733597f58bf8f9b3e2edbfcd31ca86ae2bd5c9d8e3702d8"} 12:34:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:34:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:34:46 INFO - Contents: 12:34:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d20a31bdcc3b83c27d4504aefb5304301612eb44eb9561ee40f5dd4f6aff076b186cb704bbab7a24144183f4810ae7553b38f1734bfdd584c3752b40bed0bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3525a3ccdf87741916b67974b1c78359ef238d2e612e1d0af0525363e4eecb14ad07f1640c2c55387733597f58bf8f9b3e2edbfcd31ca86ae2bd5c9d8e3702d8"} 12:34:46 INFO - Running post-run listener: copy_logs_to_upload_dir 12:34:46 INFO - Copying logs to upload dir... 12:34:46 INFO - mkdir: /builds/slave/test/build/upload/logs 12:34:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.589657 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-18 12:34:46.962158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 12:34:46.965965) ========= 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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d20a31bdcc3b83c27d4504aefb5304301612eb44eb9561ee40f5dd4f6aff076b186cb704bbab7a24144183f4810ae7553b38f1734bfdd584c3752b40bed0bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3525a3ccdf87741916b67974b1c78359ef238d2e612e1d0af0525363e4eecb14ad07f1640c2c55387733597f58bf8f9b3e2edbfcd31ca86ae2bd5c9d8e3702d8"} build_url:https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010379 build_url: 'https://queue.taskcluster.net/v1/task/fdajydOBSISnlrsRf65KDQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d20a31bdcc3b83c27d4504aefb5304301612eb44eb9561ee40f5dd4f6aff076b186cb704bbab7a24144183f4810ae7553b38f1734bfdd584c3752b40bed0bbfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3525a3ccdf87741916b67974b1c78359ef238d2e612e1d0af0525363e4eecb14ad07f1640c2c55387733597f58bf8f9b3e2edbfcd31ca86ae2bd5c9d8e3702d8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 12:34:46.992275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:34:46.992630) ========= 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.B38iTCYvVA/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.AWzPSvIaCn/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005209 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 12:34:47.046612) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 12:34:47.046966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 12:34:47.047865) ========= ========= Total master_lag: 0.30 =========