builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0171 starttime: 1455160440.2 results: success (0) buildid: 20160210173431 builduid: 963db82065f3463fa56103b5c1481557 revision: 9ea6b7becbd398de4563a02bbad832200dca1453 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.204311) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.204778) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.205220) ========= 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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005789 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.257498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.257800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.322470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.322727) ========= 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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005571 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.397323) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.397683) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.398184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:00.398473) ========= 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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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-10 19:14:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.9M=0.001s 2016-02-10 19:14:01 (15.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.622179 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:01.068277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:01.068563) ========= 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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.026724 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:01.158388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 19:14:01.158737) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9ea6b7becbd398de4563a02bbad832200dca1453 --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 9ea6b7becbd398de4563a02bbad832200dca1453 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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-10 19:14:01,236 truncating revision to first 12 chars 2016-02-10 19:14:01,236 Setting DEBUG logging. 2016-02-10 19:14:01,236 attempt 1/10 2016-02-10 19:14:01,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9ea6b7becbd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-10 19:14:02,358 unpacking tar archive at: fx-team-9ea6b7becbd3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367268 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-10 19:14:02.799087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:02.799391) ========= echo 9ea6b7becbd398de4563a02bbad832200dca1453 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9ea6b7becbd398de4563a02bbad832200dca1453'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 9ea6b7becbd398de4563a02bbad832200dca1453 program finished with exit code 0 elapsedTime=0.005948 script_repo_revision: '9ea6b7becbd398de4563a02bbad832200dca1453' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:02.837364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:02.837648) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-10 19:14:02.860783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-02-10 19:14:02.861042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:14:03 INFO - MultiFileLogger online at 20160210 19:14:03 in /builds/slave/test 19:14:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:14:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:14:03 INFO - {'append_to_log': False, 19:14:03 INFO - 'base_work_dir': '/builds/slave/test', 19:14:03 INFO - 'blob_upload_branch': 'Fx-Team', 19:14:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:14:03 INFO - 'branch': 'Fx-Team', 19:14:03 INFO - 'buildbot_json_path': 'buildprops.json', 19:14:03 INFO - 'config_files': ('talos/mac_config.py',), 19:14:03 INFO - 'default_actions': ('clobber', 19:14:03 INFO - 'read-buildbot-config', 19:14:03 INFO - 'download-and-extract', 19:14:03 INFO - 'populate-webroot', 19:14:03 INFO - 'create-virtualenv', 19:14:03 INFO - 'install', 19:14:03 INFO - 'run-tests'), 19:14:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:14:03 INFO - 'download_minidump_stackwalk': True, 19:14:03 INFO - 'download_symbols': 'ondemand', 19:14:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:14:03 INFO - 'tooltool.py': '/tools/tooltool.py', 19:14:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:14:03 INFO - '/tools/misc-python/virtualenv.py')}, 19:14:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:14:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:14:03 INFO - 'installer_path': 'installer.exe', 19:14:03 INFO - 'log_level': 'info', 19:14:03 INFO - 'log_name': 'talos', 19:14:03 INFO - 'log_to_console': True, 19:14:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:14:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:14:03 INFO - 'opt_config_files': (), 19:14:03 INFO - 'pip_index': False, 19:14:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:14:03 INFO - 'cmd': ('bash', 19:14:03 INFO - '-c', 19:14:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:14:03 INFO - 'enabled': True, 19:14:03 INFO - 'halt_on_failure': False, 19:14:03 INFO - 'name': 'check_screen_resolution'},), 19:14:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:14:03 INFO - 'cmd': ('bash', 19:14:03 INFO - '-c', 19:14:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:14:03 INFO - 'enabled': True, 19:14:03 INFO - 'halt_on_failure': False, 19:14:03 INFO - 'name': 'check_screen_resolution'},), 19:14:03 INFO - 'run_cmd_checks_enabled': True, 19:14:03 INFO - 'sps_profile': False, 19:14:03 INFO - 'sps_profile_interval': 0, 19:14:03 INFO - 'suite': 'dromaeojs', 19:14:03 INFO - 'system_bits': '32', 19:14:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:14:03 INFO - 'title': 't-yosemite-r7-0171', 19:14:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:14:03 INFO - 'use_talos_json': True, 19:14:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:14:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:14:03 INFO - 'work_dir': 'build'} 19:14:03 INFO - ##### 19:14:03 INFO - ##### Running clobber step. 19:14:03 INFO - ##### 19:14:03 INFO - Running pre-action listener: _resource_record_pre_action 19:14:03 INFO - Running main action method: clobber 19:14:03 INFO - rmtree: /builds/slave/test/build 19:14:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:14:04 INFO - Running post-action listener: _resource_record_post_action 19:14:04 INFO - ##### 19:14:04 INFO - ##### Running read-buildbot-config step. 19:14:04 INFO - ##### 19:14:04 INFO - Running pre-action listener: _resource_record_pre_action 19:14:04 INFO - Running main action method: read_buildbot_config 19:14:04 INFO - Using buildbot properties: 19:14:04 INFO - { 19:14:04 INFO - "project": "", 19:14:04 INFO - "product": "firefox", 19:14:04 INFO - "script_repo_revision": "production", 19:14:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:14:04 INFO - "repository": "", 19:14:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:14:04 INFO - "buildid": "20160210173431", 19:14:04 INFO - "pgo_build": "False", 19:14:04 INFO - "basedir": "/builds/slave/test", 19:14:04 INFO - "buildnumber": 328, 19:14:04 INFO - "slavename": "t-yosemite-r7-0171", 19:14:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:14:04 INFO - "platform": "yosemite_r7", 19:14:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:14:04 INFO - "branch": "fx-team", 19:14:04 INFO - "repo_path": "integration/fx-team", 19:14:04 INFO - "revision": "9ea6b7becbd398de4563a02bbad832200dca1453", 19:14:04 INFO - "stage_platform": "macosx64", 19:14:04 INFO - "builduid": "963db82065f3463fa56103b5c1481557", 19:14:04 INFO - "slavebuilddir": "test" 19:14:04 INFO - } 19:14:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 19:14:04 INFO - Running post-action listener: _resource_record_post_action 19:14:04 INFO - ##### 19:14:04 INFO - ##### Running download-and-extract step. 19:14:04 INFO - ##### 19:14:04 INFO - Running pre-action listener: _resource_record_pre_action 19:14:04 INFO - Running main action method: download_and_extract 19:14:04 INFO - mkdir: /builds/slave/test/build/tests 19:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:04 INFO - https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:14:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/test_packages.json 19:14:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/test_packages.json 19:14:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:14:14 INFO - Downloaded 1277 bytes. 19:14:14 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:14:14 INFO - Using the following test package requirements: 19:14:14 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:14:14 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 19:14:14 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 19:14:14 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'jsshell-mac.zip'], 19:14:14 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 19:14:14 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:14:14 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 19:14:14 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 19:14:14 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 19:14:14 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:14:14 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:14:14 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 19:14:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:14 INFO - https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:28 INFO - Downloaded 17750533 bytes. 19:14:28 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'] 19:14:28 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 19:14:31 INFO - Return code: 0 19:14:31 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 19:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:31 INFO - https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:14:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:14:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:14:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:34 INFO - Downloaded 17750533 bytes. 19:14:34 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'] 19:14:34 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 19:14:38 INFO - Return code: 0 19:14:38 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')]} 19:14:38 INFO - https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:14:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:14:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:14:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:39 INFO - Downloaded 10706547 bytes. 19:14:39 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'] 19:14:39 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 19:14:40 INFO - Return code: 0 19:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:40 INFO - https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 19:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZH4wYy-Tra9It1B2RkNbg/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 19:14:44 INFO - Downloaded 111182674 bytes. 19:14:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:14:44 INFO - mkdir: /builds/slave/test/properties 19:14:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:14:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:14:44 INFO - Contents: 19:14:44 INFO - build_url:https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:14:45 INFO - Running post-action listener: _resource_record_post_action 19:14:45 INFO - Running post-action listener: set_extra_try_arguments 19:14:45 INFO - ##### 19:14:45 INFO - ##### Running populate-webroot step. 19:14:45 INFO - ##### 19:14:45 INFO - Running pre-action listener: _resource_record_pre_action 19:14:45 INFO - Running main action method: populate_webroot 19:14:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:14:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:14:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:14:45 INFO - '--tppagecycles', 19:14:45 INFO - '7'], 19:14:45 INFO - 'tests': ['tsvgm']}}, 19:14:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:14:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:14:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:14:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:14:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'tests': ['damp', 'tps']}, 19:14:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['damp', 'tps']}, 19:14:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:14:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:14:45 INFO - 'other': {'tests': ['a11yr', 19:14:45 INFO - 'ts_paint', 19:14:45 INFO - 'tpaint', 19:14:45 INFO - 'sessionrestore', 19:14:45 INFO - 'sessionrestore_no_auto_restore']}, 19:14:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['a11yr', 19:14:45 INFO - 'ts_paint', 19:14:45 INFO - 'tpaint', 19:14:45 INFO - 'sessionrestore', 19:14:45 INFO - 'sessionrestore_no_auto_restore']}, 19:14:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['a11yr', 19:14:45 INFO - 'ts_paint', 19:14:45 INFO - 'tpaint', 19:14:45 INFO - 'sessionrestore', 19:14:45 INFO - 'sessionrestore_no_auto_restore']}, 19:14:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['a11yr', 19:14:45 INFO - 'ts_paint', 19:14:45 INFO - 'tpaint', 19:14:45 INFO - 'sessionrestore', 19:14:45 INFO - 'sessionrestore_no_auto_restore']}, 19:14:45 INFO - 'other_l64': {'tests': ['a11yr', 19:14:45 INFO - 'ts_paint', 19:14:45 INFO - 'tpaint', 19:14:45 INFO - 'sessionrestore', 19:14:45 INFO - 'sessionrestore_no_auto_restore']}, 19:14:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:14:45 INFO - 'ts_paint', 19:14:45 INFO - 'tpaint', 19:14:45 INFO - 'sessionrestore', 19:14:45 INFO - 'sessionrestore_no_auto_restore']}, 19:14:45 INFO - 'svgr': {'tests': ['tsvgx', 19:14:45 INFO - 'tsvgr_opacity', 19:14:45 INFO - 'tart', 19:14:45 INFO - 'tscrollx', 19:14:45 INFO - 'cart']}, 19:14:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['tsvgx', 19:14:45 INFO - 'tsvgr_opacity', 19:14:45 INFO - 'tart', 19:14:45 INFO - 'tscrollx', 19:14:45 INFO - 'cart']}, 19:14:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'tests': ['tp5o']}, 19:14:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'talos_options': ['--e10s'], 19:14:45 INFO - 'tests': ['tp5o']}, 19:14:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'talos_options': ['--xperf_path', 19:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:45 INFO - 'tests': ['tp5n']}, 19:14:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:45 INFO - 'talos_options': ['--e10s', 19:14:45 INFO - '--xperf_path', 19:14:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:45 INFO - 'tests': ['tp5n']}}, 19:14:45 INFO - 'talos.zip': {'path': '', 19:14:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:14:45 INFO - Running post-action listener: _resource_record_post_action 19:14:45 INFO - ##### 19:14:45 INFO - ##### Running create-virtualenv step. 19:14:45 INFO - ##### 19:14:45 INFO - Running pre-action listener: _resource_record_pre_action 19:14:45 INFO - Running main action method: create_virtualenv 19:14:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:14:45 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 19:14:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:14:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:14:45 INFO - Using real prefix '/tools/python27' 19:14:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:14:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:14:49 INFO - Installing pip.................done. 19:14:49 INFO - Return code: 0 19:14:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:49 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:14:49 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 19:14:49 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 19:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:49 INFO - 'HOME': '/Users/cltbld', 19:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:49 INFO - 'LOGNAME': 'cltbld', 19:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:49 INFO - 'MOZ_NO_REMOTE': '1', 19:14:49 INFO - 'NO_EM_RESTART': '1', 19:14:49 INFO - 'PAGER': '/bin/cat', 19:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:49 INFO - 'PWD': '/builds/slave/test', 19:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:49 INFO - 'SHELL': '/bin/bash', 19:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:14:49 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:49 INFO - 'USER': 'cltbld', 19:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:49 INFO - 'XPC_FLAGS': '0x0', 19:14:49 INFO - 'XPC_SERVICE_NAME': '0', 19:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:49 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 19:14:49 INFO - Cleaning up... 19:14:49 INFO - Return code: 0 19:14:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:49 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:14:49 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 19:14:49 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 19:14:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:14:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:49 INFO - 'HOME': '/Users/cltbld', 19:14:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:49 INFO - 'LOGNAME': 'cltbld', 19:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:49 INFO - 'MOZ_NO_REMOTE': '1', 19:14:49 INFO - 'NO_EM_RESTART': '1', 19:14:49 INFO - 'PAGER': '/bin/cat', 19:14:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:49 INFO - 'PWD': '/builds/slave/test', 19:14:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:49 INFO - 'SHELL': '/bin/bash', 19:14:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:14:49 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:14:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:49 INFO - 'USER': 'cltbld', 19:14:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:49 INFO - 'XPC_FLAGS': '0x0', 19:14:49 INFO - 'XPC_SERVICE_NAME': '0', 19:14:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:49 INFO - Downloading/unpacking psutil>=0.7.1 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:49 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 19:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:52 INFO - Installing collected packages: psutil 19:14:52 INFO - Running setup.py install for psutil 19:14:52 INFO - building 'psutil._psutil_osx' extension 19:14:52 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 19:14:53 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 19:14:53 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 19:14:53 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 19:14:53 INFO - building 'psutil._psutil_posix' extension 19:14:53 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 19:14:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:14:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:14:53 INFO - ^ 19:14:53 INFO - 1 warning generated. 19:14:53 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 19:14:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:53 INFO - Successfully installed psutil 19:14:53 INFO - Cleaning up... 19:14:53 INFO - Return code: 0 19:14:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:14:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:14:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:53 INFO - 'HOME': '/Users/cltbld', 19:14:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:53 INFO - 'LOGNAME': 'cltbld', 19:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:53 INFO - 'MOZ_NO_REMOTE': '1', 19:14:53 INFO - 'NO_EM_RESTART': '1', 19:14:53 INFO - 'PAGER': '/bin/cat', 19:14:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:53 INFO - 'PWD': '/builds/slave/test', 19:14:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:53 INFO - 'SHELL': '/bin/bash', 19:14:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:14:53 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:14:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:53 INFO - 'USER': 'cltbld', 19:14:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:53 INFO - 'XPC_FLAGS': '0x0', 19:14:53 INFO - 'XPC_SERVICE_NAME': '0', 19:14:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:14:56 INFO - Installing collected packages: mozsystemmonitor 19:14:56 INFO - Running setup.py install for mozsystemmonitor 19:14:56 INFO - Successfully installed mozsystemmonitor 19:14:56 INFO - Cleaning up... 19:14:56 INFO - Return code: 0 19:14:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:56 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:14:56 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 19:14:56 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 19:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:56 INFO - 'HOME': '/Users/cltbld', 19:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:56 INFO - 'LOGNAME': 'cltbld', 19:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:56 INFO - 'MOZ_NO_REMOTE': '1', 19:14:56 INFO - 'NO_EM_RESTART': '1', 19:14:56 INFO - 'PAGER': '/bin/cat', 19:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:56 INFO - 'PWD': '/builds/slave/test', 19:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:56 INFO - 'SHELL': '/bin/bash', 19:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:14:56 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:56 INFO - 'USER': 'cltbld', 19:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:56 INFO - 'XPC_FLAGS': '0x0', 19:14:56 INFO - 'XPC_SERVICE_NAME': '0', 19:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:56 INFO - Downloading/unpacking blobuploader==1.2.4 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 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 19:14:56 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 19:14:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:14:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:14:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 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 19:14:59 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 19:15:00 INFO - Downloading docopt-0.6.1.tar.gz 19:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:15:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:15:00 INFO - Running setup.py install for blobuploader 19:15:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:15:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:15:00 INFO - Running setup.py install for requests 19:15:00 INFO - Running setup.py install for docopt 19:15:01 INFO - Successfully installed blobuploader requests docopt 19:15:01 INFO - Cleaning up... 19:15:01 INFO - Return code: 0 19:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:01 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:15:01 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 19:15:01 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 19:15:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:15:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:01 INFO - 'HOME': '/Users/cltbld', 19:15:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:01 INFO - 'LOGNAME': 'cltbld', 19:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:01 INFO - 'MOZ_NO_REMOTE': '1', 19:15:01 INFO - 'NO_EM_RESTART': '1', 19:15:01 INFO - 'PAGER': '/bin/cat', 19:15:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:01 INFO - 'PWD': '/builds/slave/test', 19:15:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:01 INFO - 'SHELL': '/bin/bash', 19:15:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:15:01 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:15:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:01 INFO - 'USER': 'cltbld', 19:15:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:01 INFO - 'XPC_FLAGS': '0x0', 19:15:01 INFO - 'XPC_SERVICE_NAME': '0', 19:15:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:15:01 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-6dw4Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:15:01 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-vK7dFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:15:01 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-5KxGqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:15:01 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Zs495f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:15:01 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-HW0_4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:15:01 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-tHglmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-sIyEBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-2x7z01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BJwczy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-T9AGnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-bZXcDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-PCNyiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-TN2sCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-z7JHah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7M0Mv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:15:02 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-cm89Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:15:03 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-p37xoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:15:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:15:03 INFO - Running setup.py install for manifestparser 19:15:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Running setup.py install for mozcrash 19:15:03 INFO - Running setup.py install for mozdebug 19:15:03 INFO - Running setup.py install for mozdevice 19:15:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:15:03 INFO - Running setup.py install for mozfile 19:15:03 INFO - Running setup.py install for mozhttpd 19:15:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Running setup.py install for mozinfo 19:15:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Running setup.py install for mozInstall 19:15:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Running setup.py install for mozleak 19:15:04 INFO - Running setup.py install for mozlog 19:15:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Running setup.py install for moznetwork 19:15:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:15:04 INFO - Running setup.py install for mozprocess 19:15:04 INFO - Running setup.py install for mozprofile 19:15:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:15:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:15:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:15:05 INFO - Running setup.py install for mozrunner 19:15:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:15:05 INFO - Running setup.py install for mozscreenshot 19:15:05 INFO - Running setup.py install for moztest 19:15:05 INFO - Running setup.py install for mozversion 19:15:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:15:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:15:05 INFO - Cleaning up... 19:15:05 INFO - Return code: 0 19:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:05 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:15:05 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 19:15:05 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 19:15:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:15:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:05 INFO - 'HOME': '/Users/cltbld', 19:15:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:05 INFO - 'LOGNAME': 'cltbld', 19:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:05 INFO - 'MOZ_NO_REMOTE': '1', 19:15:05 INFO - 'NO_EM_RESTART': '1', 19:15:05 INFO - 'PAGER': '/bin/cat', 19:15:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:05 INFO - 'PWD': '/builds/slave/test', 19:15:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:05 INFO - 'SHELL': '/bin/bash', 19:15:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:15:05 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:15:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:05 INFO - 'USER': 'cltbld', 19:15:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:05 INFO - 'XPC_FLAGS': '0x0', 19:15:05 INFO - 'XPC_SERVICE_NAME': '0', 19:15:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-WHfePZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-hBOtop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-bIETsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ZgmDlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-CG8Lkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1zG_mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Gtkzkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-sLMXmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-6LCmZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:15:06 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)) 19:15:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:15:06 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-XNPKXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-oO1wWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-jzh0xF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-S66Rco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-F0vnQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BdiWgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-g2MExy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:15:07 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)) 19:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:15:07 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-4eR3Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 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)) 19:15:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:10 INFO - Downloading blessings-1.6.tar.gz 19:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:15:10 INFO - Installing collected packages: blessings 19:15:10 INFO - Running setup.py install for blessings 19:15:10 INFO - Successfully installed blessings 19:15:10 INFO - Cleaning up... 19:15:10 INFO - Return code: 0 19:15:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:11 INFO - Reading from file tmpfile_stdout 19:15:11 INFO - Current package versions: 19:15:11 INFO - blessings == 1.6 19:15:11 INFO - blobuploader == 1.2.4 19:15:11 INFO - docopt == 0.6.1 19:15:11 INFO - manifestparser == 1.1 19:15:11 INFO - mozInstall == 1.12 19:15:11 INFO - mozcrash == 0.16 19:15:11 INFO - mozdebug == 0.1 19:15:11 INFO - mozdevice == 0.48 19:15:11 INFO - mozfile == 1.2 19:15:11 INFO - mozhttpd == 0.7 19:15:11 INFO - mozinfo == 0.9 19:15:11 INFO - mozleak == 0.1 19:15:11 INFO - mozlog == 3.1 19:15:11 INFO - moznetwork == 0.27 19:15:11 INFO - mozprocess == 0.22 19:15:11 INFO - mozprofile == 0.28 19:15:11 INFO - mozrunner == 6.11 19:15:11 INFO - mozscreenshot == 0.1 19:15:11 INFO - mozsystemmonitor == 0.0 19:15:11 INFO - moztest == 0.7 19:15:11 INFO - mozversion == 1.4 19:15:11 INFO - psutil == 3.1.1 19:15:11 INFO - requests == 1.2.3 19:15:11 INFO - wsgiref == 0.1.2 19:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:15:11 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')]} 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:11 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')]} 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:11 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:15:11 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 19:15:11 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 19:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:11 INFO - 'HOME': '/Users/cltbld', 19:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:11 INFO - 'LOGNAME': 'cltbld', 19:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:11 INFO - 'MOZ_NO_REMOTE': '1', 19:15:11 INFO - 'NO_EM_RESTART': '1', 19:15:11 INFO - 'PAGER': '/bin/cat', 19:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:11 INFO - 'PWD': '/builds/slave/test', 19:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:11 INFO - 'SHELL': '/bin/bash', 19:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:15:11 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:11 INFO - 'USER': 'cltbld', 19:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:11 INFO - 'XPC_FLAGS': '0x0', 19:15:11 INFO - 'XPC_SERVICE_NAME': '0', 19:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 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)) 19:15:11 INFO - Cleaning up... 19:15:11 INFO - Return code: 0 19:15:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:15:11 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')]} 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:11 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')]} 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:11 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 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:15:11 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 19:15:11 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 19:15:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:15:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:11 INFO - 'HOME': '/Users/cltbld', 19:15:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:11 INFO - 'LOGNAME': 'cltbld', 19:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:11 INFO - 'MOZ_NO_REMOTE': '1', 19:15:11 INFO - 'NO_EM_RESTART': '1', 19:15:11 INFO - 'PAGER': '/bin/cat', 19:15:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:11 INFO - 'PWD': '/builds/slave/test', 19:15:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:11 INFO - 'SHELL': '/bin/bash', 19:15:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:15:11 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:15:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:11 INFO - 'USER': 'cltbld', 19:15:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:11 INFO - 'XPC_FLAGS': '0x0', 19:15:11 INFO - 'XPC_SERVICE_NAME': '0', 19:15:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:11 INFO - Downloading/unpacking jsonschema 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:15:14 INFO - Downloading/unpacking functools32 (from jsonschema) 19:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:15:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:15:14 INFO - warning: no files found matching '*.txt' 19:15:14 INFO - no previously-included directories found matching 'build' 19:15:14 INFO - no previously-included directories found matching 'dist' 19:15:14 INFO - no previously-included directories found matching '.git*' 19:15:14 INFO - Installing collected packages: jsonschema, functools32 19:15:14 INFO - Running setup.py install for functools32 19:15:14 INFO - warning: no files found matching '*.txt' 19:15:14 INFO - no previously-included directories found matching 'build' 19:15:14 INFO - no previously-included directories found matching 'dist' 19:15:14 INFO - no previously-included directories found matching '.git*' 19:15:14 INFO - Successfully installed jsonschema functools32 19:15:14 INFO - Cleaning up... 19:15:14 INFO - Return code: 0 19:15:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108f79a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f814c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2ebca1960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, '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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 19:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:15:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:15:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:14 INFO - 'HOME': '/Users/cltbld', 19:15:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:14 INFO - 'LOGNAME': 'cltbld', 19:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:14 INFO - 'MOZ_NO_REMOTE': '1', 19:15:14 INFO - 'NO_EM_RESTART': '1', 19:15:14 INFO - 'PAGER': '/bin/cat', 19:15:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:14 INFO - 'PWD': '/builds/slave/test', 19:15:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:14 INFO - 'SHELL': '/bin/bash', 19:15:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:15:14 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:15:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:14 INFO - 'USER': 'cltbld', 19:15:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:14 INFO - 'XPC_FLAGS': '0x0', 19:15:14 INFO - 'XPC_SERVICE_NAME': '0', 19:15:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:15:15 INFO - Downloading/unpacking flake8 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:15:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:15:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15: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 19:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:15:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:15:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:15:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:15:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:15:18 INFO - no previously-included directories found matching 'docs/_build' 19:15:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:15:18 INFO - Running setup.py install for pep8 19:15:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:15:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:15:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:15:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:15:18 INFO - no previously-included directories found matching 'docs/_build' 19:15:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:15:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:15:18 INFO - Cleaning up... 19:15:18 INFO - Return code: 0 19:15:18 INFO - Running post-action listener: _resource_record_post_action 19:15:18 INFO - Running post-action listener: _start_resource_monitoring 19:15:18 INFO - Starting resource monitoring. 19:15:18 INFO - ##### 19:15:18 INFO - ##### Running install step. 19:15:18 INFO - ##### 19:15:18 INFO - Running pre-action listener: _resource_record_pre_action 19:15:18 INFO - Running main action method: install 19:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:15:19 INFO - Reading from file tmpfile_stdout 19:15:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:15:19 INFO - Reading from file tmpfile_stdout 19:15:19 INFO - Output received: 19:15:19 INFO - Usage: mozinstall [options] installer 19:15:19 INFO - Options: 19:15:19 INFO - -h, --help show this help message and exit 19:15:19 INFO - -d DEST, --destination=DEST 19:15:19 INFO - Directory to install application into. [default: 19:15:19 INFO - "/builds/slave/test"] 19:15:19 INFO - --app=APP Application being installed. [default: firefox] 19:15:19 INFO - mkdir: /builds/slave/test/build/application 19:15:19 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'] 19:15:19 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 19:15:53 INFO - Reading from file tmpfile_stdout 19:15:53 INFO - Output received: 19:15:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:15:53 INFO - Running post-action listener: _resource_record_post_action 19:15:53 INFO - ##### 19:15:53 INFO - ##### Running run-tests step. 19:15:53 INFO - ##### 19:15:53 INFO - Running pre-action listener: _resource_record_pre_action 19:15:53 INFO - Running main action method: run_tests 19:15:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:15:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:15:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:15:53 INFO - 2016-02-10 19:15:53.053 screenresolution[1659:8169] starting screenresolution argv=screenresolution get 19:15:53 INFO - 2016-02-10 19:15:53.056 screenresolution[1659:8169] Display 0: 1600x1200x32@60 19:15:53 INFO - 2016-02-10 19:15:53.062 screenresolution[1660:8171] starting screenresolution argv=screenresolution list 19:15:53 INFO - Available Modes on Display 0 19:15:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:15:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:15:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:15:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:15:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:15:53 INFO - Intel Iris: 19:15:53 INFO - Chipset Model: Intel Iris 19:15:53 INFO - Type: GPU 19:15:53 INFO - Bus: Built-In 19:15:53 INFO - VRAM (Dynamic, Max): 1536 MB 19:15:53 INFO - Vendor: Intel (0x8086) 19:15:53 INFO - Device ID: 0x0a2e 19:15:53 INFO - Revision ID: 0x0009 19:15:53 INFO - Displays: 19:15:53 INFO - Display: 19:15:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:15:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:15:53 INFO - Display Serial Number: 1600x1200 60 19:15:53 INFO - Main Display: Yes 19:15:53 INFO - Mirror: Off 19:15:53 INFO - Online: Yes 19:15:53 INFO - Rotation: Supported 19:15:53 INFO - Return code: 0 19:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:15:53 INFO - Python 2.7.3 19:15:53 INFO - Return code: 0 19:15:53 INFO - grabbing minidump binary from tooltool 19:15:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:15:53 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 0x108e1dd30>, '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 0x108c41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108e14b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:15:53 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 19:15:53 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 19:15:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:15:53 INFO - Return code: 0 19:15:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:15:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:15:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:15:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:15:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:15:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:15:54 INFO - Return code: 0 19:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GtqzHJDZ0y/Render', 19:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:54 INFO - 'HOME': '/Users/cltbld', 19:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:54 INFO - 'LOGNAME': 'cltbld', 19:15:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:15:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:54 INFO - 'MOZ_NO_REMOTE': '1', 19:15:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:15:54 INFO - 'NO_EM_RESTART': '1', 19:15:54 INFO - 'PAGER': '/bin/cat', 19:15:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:54 INFO - 'PWD': '/builds/slave/test', 19:15:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:54 INFO - 'SHELL': '/bin/bash', 19:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXHbkmrPOE/Listeners', 19:15:54 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 19:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:54 INFO - 'USER': 'cltbld', 19:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:54 INFO - 'XPC_FLAGS': '0x0', 19:15:54 INFO - 'XPC_SERVICE_NAME': '0', 19:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:15:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:15:54 INFO - mozversion application_buildid: 20160210173431 19:15:54 INFO - mozversion application_changeset: 9ea6b7becbd398de4563a02bbad832200dca1453 19:15:54 INFO - mozversion application_display_name: Nightly 19:15:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:15:54 INFO - mozversion application_name: Firefox 19:15:54 INFO - mozversion application_remotingname: firefox 19:15:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:15:54 INFO - mozversion application_vendor: Mozilla 19:15:54 INFO - mozversion application_version: 47.0a1 19:15:54 INFO - mozversion platform_buildid: 20160210173431 19:15:54 INFO - mozversion platform_changeset: 9ea6b7becbd398de4563a02bbad832200dca1453 19:15:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:15:54 INFO - mozversion platform_version: 47.0a1 19:15:54 INFO - using testdate: 1455160554 19:15:54 INFO - actual date: 1455160554 19:15:54 INFO - starting webserver on 'localhost:49278' 19:15:54 INFO - SUITE-START | Running 2 tests 19:15:54 INFO - TEST-START | dromaeo_css 19:15:54 INFO - operating with platform_type : mac_ 19:15:54 INFO - Initialising browser for dromaeo_css test... 19:15:54 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmp0JoM3T/profile http://localhost:49278/getInfo.html) 19:15:57 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 19:15:57 INFO - PROCESS | 1678 | colorDepth:24 19:15:57 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 19:15:57 INFO - PROCESS | 1678 | __metrics 19:15:57 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:15:57 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:15:57 INFO - TEST-INFO | 1678: exit 0 19:15:57 INFO - Browser initialized. 19:15:57 INFO - Running cycle 1/1 for dromaeo_css test... 19:15:57 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmp0JoM3T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:16:10 INFO - PROCESS | 1682 | RSS: Main: 246923264 19:16:10 INFO - PROCESS | 1682 | 19:17:01 INFO - PROCESS | 1682 | 1455160621001 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] 19:19:11 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 19:19:13 INFO - PROCESS | 1682 | RSS: Main: 382697472 19:19:13 INFO - PROCESS | 1682 | 19:22:15 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 19:22:16 INFO - PROCESS | 1682 | RSS: Main: 373936128 19:22:16 INFO - PROCESS | 1682 | 19:25:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 19:25:19 INFO - PROCESS | 1682 | RSS: Main: 388534272 19:25:19 INFO - PROCESS | 1682 | 19:28:21 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 19:28:22 INFO - PROCESS | 1682 | RSS: Main: 347529216 19:28:22 INFO - PROCESS | 1682 | 19:31:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 19:31:26 INFO - PROCESS | 1682 | RSS: Main: 348725248 19:31:26 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 19:34:29 INFO - PROCESS | 1682 | RSS: Main: 409362432 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | __start_tp_report 19:34:29 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 19:34:29 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 19:34:29 INFO - PROCESS | 1682 | |i|pagename|runs| 19:34:29 INFO - PROCESS | 1682 | |0;dojo.html;3463.8960831175064;3500.6849383555473;3517.7863637045225;3538.999999999999;3600.657937495937;4164.729292595983;5665.036943719567;5668.943310566893;5720.856978575538;5728.971355143219;4764.047190561884;5658.151277308396;5776.451237132465;5785.710714464281;5786.855328616787;5118.257852611369;5142.434332223453;5178.6892786432745;5187.221916712486;5299.311089558371;5264.8157314494;5309.469053094698;5326.840194794143;5336.4129945705945;5340.839774806743;5113.590912726973;5163.14808056674;5231.738413079331;5235.921461178085;5266.947330526684;5182.53357197854;5209.869753256161;5249.921251181236;5265.86835329116;5286.127788914824;5137.434882162959;5162.974185129088;5200.063988482072;5209.2446595243855;5246.265522826808;5572.916406253868;5703.5437165027115;5707.942920570783;5716.228309178291;5731.398203188689;5322.787088516455;6125.662799505643;6294.087357333161;6301.842453938688;6303.369663033705;6243.594166379171;6270.153529273535;6288.119663247149;6301.59039662425;6311.147995020705;5663.773449062074;5712.714364281769;5837.591368604157;5846.064629659234;5864.237649105632;6222.222222222223;6234.438900498977;6271.7804876830005;6297.685115744194;6307.306196318401;6153.353897840662;6173.783917562953;6174.228221472316;6180.227471566054;6212.161358216673;6147.678249176449;6292.024736165901;6294.087357333253;6303.558750887486;6310.495160387158;6149.477294429934;6182;6268.592541484789;6271.7804876830005;6285.717142728588;6241.313455519889;6247.406496382836;6273.905891411632;6288;6312.147860038928;4844.636652251095;4917.139500587383;4937.382827146606;4939.2838038484215;4972.303877457159;3703.5555733312176;4439.64482841372;4442.222611043055;4461.24158892989;4486.955130448654;5656.208130861683;5681.971590142106;5683;5707.6290041147195;5738.368779434342;6085.695715214221;6153.384661533811;6156.015037593964;6266.843328916813;6297.716602752887;5687.260656114761;5692.288463942007;5708;5720.942790572124;5730.77076916927;5414.106672399089;5416.729163541807;5424.484673955968;5440.319960004999;5447.455254474521;6332.430081292706;6335;6375.521835862329;6393.296737358887;6414.262359828493;6246.625202487865;6289.465395441439;6291.02489114188;6303.4642055423965;6305.306416294296;6337.176167098432;6353.5870168438905;6357.459615932513;6364.268109167505;6381.8085457436355;6085.57400981927;6176.629402235881;6203;6285.779997700059;6292.1505596743855;6300.684965751786;6303.275123360689;6304.148939893239;6306.337834527309;6316.305206427382;6019.127226552037;6149.569530132848;6154.353792851686;6172.938270617236;6182.69086545662;6108.938910610837;6127.877442451215;6152.876942461216;6178.598391104564;6188.9788184948975;5997.16039754426;6002.849928751816;6004.939950600438;6008;6043.969780151071;5197.0905091608065;6019.277686677451;6096.556923351527;6135.655508508514;6138.07928810682;5848.941510584839;5908.438698323653;5938.168656388023;6002.909956350571;6020.277566692025 19:34:29 INFO - PROCESS | 1682 | |1;ext.html;521.2702216896342;521.3066621393547;569.5329829539778;587.9441453061958;625.9217597800275;27367.863160684192;37505.81247093764;37517.81241093794;37551;37659.43510847339;39848.60151398485;40222.99442513938;40241.99395015126;40260.79869600648;40404.59595404045;9413.058694130601;9651.276154288422;9653.90346096537;9654.324197306192;9665.275104367165;9490.335676502647;9596.712098637052;9622.326437149402;9625.518724063804;9733.56198971048;9724.951375243114;9768;9777.804443911118;9779.364341317827;9787.902120978806;9676.612935482608;9748.561314740818;9752.707418777378;9752.90247097527;9758.756031099208;9581.520923953844;9703.12671859529;9703.12671859536;9718.805623887554;9727.221822254203;37782.81108594467;38099.857004289915;38111.42832857509;38226;38234;2768.709285525011;3315.4529502632035;3358;3438.9312213755834;3526.1713497328105;28008.719912801018;28117.57823632647;28738.281542961384;28791.712082879112;29680.851595741882;2770.986145069282;2772.7643150332246;2834.5606431003225;2869.9856500717365;2968.9163455338644;406477;410705;411042;411194;411462;55602.721986389806;56814.715926420104;60877.39122608717;61259.6937015321;61426;66417.66791166013;67700.6614966922;68504.6574767123;68539.65730171416;68566.65716671385;15912.92043539775;16170.75743863843;16176.676466470604;16178.676426471404;16192.514224573282;10338.638147664946;11373.090152787758;11591.536338546532;11985.041196704242;12333.753324933452;19522.219111235674;20493.38519844407;20502.077406516444;20507.38477845667;20639.58720825575;7625.513024960191;8987;9187.2190863776;9292.024337444605;9307.3019523536;923.1599244687302;998.9250806189565;999.7000899730052;1000.1448761309122;1088.896554827306;28887.56668649972;29351.85324073366;29483.262918427212;29626.703732962393;30280.394392112034;1078.2829418436809;1084.1944773843866;1099.6261271167682;1129.3280498103616;1153.2042890405594;14423.855761442252;14424.927875360556;14454.710905782036;14816.259187040605;14848.554543363716;647202;647537;648935;649800;654414;47005.05989880183;54361.45638543564;55020;55825.44174558284;56489.43510564924;1438.7769895666188;1443.6318738721768;1456.6722487440454;1460.3355473259853;1462.8317743459424;27770.028049018187;28039.859800700866;28049.158525244275;28608.998685045925;28636.284092897844;45113.77443112763;46119;50625.74687126541;51873;51911;368193;370001.2999869967;374113;374136;374630;30652.693473064985;30964.0710778677;31016.22459438532;31027.534586981667;31032.68967310298;39525.60474395334;40088;40174.79912600418;40657.18685626212;41251.38122928098;34403.79586714453;35670.92987210388;35960;36008.459873102445;37058.44412333871;33140.50289245615;33719.81980630666;33843.830780845936;34002;34311.31377372389;34649.48025779565;34865.82567087148;35126.94619161429;35127.47308790421;36214;31400.05799826009;32520.512192316663;32556.02331930046;32581.511277330384;32617.836910815295;23573.17493887706;24037.639435408833;24085.638715418932;24312.756872431048;24497 19:34:29 INFO - PROCESS | 1682 | |2;jquery.html;364.72463290215893;367.82160652083735;368.4933216826862;369.34625712488895;372.3725522494595;14782.704345913075;15120;18809.529761755944;19221.51946201344;20028.399148025565;11677.824832627517;11941.223820451687;11948.701282467942;13027.28349940753;19760.604787904234;4522.4346956630425;5207.323048003764;5398.325209348832;5400.729963501829;5404.162354834987;3826.2730081284467;4038.0712436139706;5731.742071606767;5993.28080630325;5993.640381577119;5959.284885813709;5982.371850955652;6025.789097381593;6224.253089629251;6422.100905873158;6281.120643109968;6370.5222108341595;6382.20222472191;6385.201849768779;6394.6482943438095;5537.556995440355;5741.942580574183;5742.966266072105;5750.02249617566;5751.568632352549;23114.191003314972;23362.64956025661;23920.7607923922;24028.911471116062;24373.903174357198;2098.842586805996;2219.6448568229007;2286.531261091472;2336.2874323331375;2367.9526409471887;9721.97919218479;10117.797644047152;10140.492975351202;12186.146969712123;13349.998750093684;1640.9343626254936;1729.3687803951593;1800.486861244552;1808.52074200337;1836.917338719761;99668.50165749124;101699.96600067957;101935.47096793554;102636.48681756544;103694;8910.910890891138;10787.83818242727;11102.666919992413;11119.332840029625;11191.832122518168;13328.733425331438;13464.528741494001;13483.865161348262;13496.178015967718;13509.459621615026;8301.128381519853;8354.749357519284;8369.163083691583;8427.429633961578;8461.873071903927;8455.281301089353;8471.838639241443;8489.235968762841;8570.957145214234;8600.956995215109;3959.5644479107277;4157.542670306264;4319.654427645781;4405.867823965286;4457.866264012085;1732.4581122800716;1784.7679801625707;1788.3472532525534;1791.113398867569;1796.9460916172536;692.8129405060706;873.7378786364065;953.4708236928433;977.9119879210905;981.9214462842956;19425.708614370797;19549.218031278873;19803.40589782309;20211.393658190278;20282.985850707406;892.4377642085444;915.2403505090758;926.6988228825659;946.5976959792199;949.5964215208509;9911.355761875455;10614.89385106139;10902;10902.236843421044;10920.542877852578;705880;710657;718297.2255416173;725332;729459;106100;106352;106566;107325;109197;987.5605355616682;1117.932924024561;1118.5861231344454;1138.6754774889116;1144.765323108744;17585.64828703393;17721.468355949342;17728.734068988717;17916.820831791516;18159.001254931107;46691.53308466872;47555.811104722656;47649.52350476589;48033.5196648029;49101.263481048525;69780.30219697738;70289.64855175691;70491.88524344073;71051.64474177596;71801.6409917947;5780.393058728773;7357.153927298215;7429.5542267464125;7565.167831538416;7726.613669316399;11094;11917.404129793302;12041.03671706244;12094.455749491119;12281.078919080926;6884.449244060564;8145.307648849915;8451.45065570736;10298.794024119326;10320.741981450525;9917.702468925943;9961.40231586107;10261.897381026392;10305.749202816201;10352.809426916001;4213.894652633586;8894.599743011451;10592.981000414844;10651.627193048205;10778.514966826355;5820.388859169726;7728.149903510722;7729.729459468892;7774.144844067261;7775.650095745592;9674.75813104678;10462.372257664565;10681.46592670379;10866.239363244496;10872.967068128515 19:34:29 INFO - PROCESS | 1682 | |3;mootools.html;1402.7825687018515;1540.753479443289;1560.469440390267;1807.8372946434827;1959.9314024009154;7882.724104656339;8574.099719529453;8763.211310982011;8775.912240877606;8777.429467084636;8470.66117355305;8658.87011694825;8663.220310172082;8682.175193356621;8698.695545655903;1778.6353797471488;2196.593630178414;2197.7802219778055;2440.6461063145834;2472.6661900643453;2215.29110684581;2221.7889300516426;2450.82844200906;2509.77412032917;2510.3724068982756;2423.7697418745192;2454.521368333176;2458.6557881896547;2465.568525508038;2479.2686157583557;2133.7866213378693;2206.051397898903;2457.508498300338;2466.075221791828;2475.517274131545;2096.9056392462376;2422.4549476367674;2483.317087800869;2484.776370126697;2487.3657217409627;8586.613602387908;8658.960924689014;8672.349573781992;8674.56627168639;8675.696350627697;4463.218936686099;5378.1663842104535;5409.837704868821;5410.404855465896;5411.756470958816;3454.671806178434;3606.134527713356;3606.9098272543397;3616.6021737608844;3619.7828130312;1032.3496197395593;1036.6268143468346;1054.936703797767;1071.1377341240297;1071.44284971815;11830.940845295805;11852.88147118535;11860.52557897683;11898.92909638128;11899.524019039229;4800.975995120072;4905.558499735041;4937.5556199942175;4966.726830024311;5007.624428167902;10179.389236645826;10206.540705668263;10221.284510084222;10222;10224.488775561193;5507.944920550824;5534.225208470817;5535.916961245584;5546.55627549795;5547.611667183339;4972.90054198914;5017.949820501748;5022.84931452057;5023.271625614266;5035;3959.6832253419657;4008.959910400917;4026.7583944963394;4056.3915412688334;4065.8576949806616;1302.908796384244;1321.6960099177052;1329.2689021038584;1334.5195729537359;1337.404854839587;1296.1121631682329;1323.0275747325709;1323.2391374959245;1326.4163767942075;1343.0128855291352;8103.554304513308;8232.382571307176;8319.8336033279;8320.542370169578;8333.000039995239;511.40166005773335;523.2151772341488;527.3566249175999;528.8624957510998;529.2933933199222;6042.577019608673;6189.907151392733;6246.968765156236;6424.807255782334;6545.181852268466;10202.38785672862;10553.208509361828;10611.628592999208;10747.140228781678;10840.186985976083;10440.269181157399;10442.060214580724;10474.266801323834;10556.049955504042;10563.313384629975;7047.577145371294;8016.358691304682;8136.267735903797;8280.8343833123;8299.709510167115;8127.512349259064;8201.79495512617;8237.382196335418;8241.587920603826;8251.463654862415;9275.39709918853;9574;9633.08485693858;9720.708378748648;9747;8463.53450560225;9875.703728888146;9995.200383969119;10023.949880250551;10029.943861508227;7412.332890039922;7558.508696934681;7568.583727894798;7574.697012119454;7577.431692622965;8087.797805054921;8087.959560202161;8154.673813047411;8174.264316211569;8251.174882511701;7699.345555627834;7722.26638469367;7794.2985131338455;7798.532088074507;7798.610069496389;7666.731664391719;7674.155842857393;7742;7845.921540784748;7866.252705992922;7706.537607743553;7862.842743145219;7909.24862138096;7910.9604451977375;7913.971183746076;7095.467839911924;7147.785566433015;7153.034340364193;7157.749478768218;7175.964120179366;6006.279246490449;6507.837304067436;7229.63851807397;7265.782026539212;7271.563706177646 19:34:29 INFO - PROCESS | 1682 | |4;prototype.html;323.70057696630613;326.80555069733515;333.3965522404448;338.3351713882221;341.53039570590437;5507.008738427082;6606.174228221473;6677.131972843529;6690.531662783607;6711.8657626847435;6292.779752708656;6444.420002199801;6531.444827189683;6545.476361891049;6597.505187110962;4318.661215023345;4575.908481830362;4874.439439464454;4892.241702536095;5026.472220416858;4916.729579873106;4925.08885856116;4934.5443094287275;4944.233643785219;4968.254761785743;4574.773700471572;4623.838165664202;4715.834945776898;4728.787204575785;4742.075295317414;4096.221717873595;4131.194417088669;4483.50681425043;4739.834105806281;4881.365422495089;4158.251514727348;4180.28935081037;4206.957930420687;4213.2837417639075;4213.431186789775;6396.456301214403;6412.166418365629;6422.454091402236;6444.709988050549;6473.28793832678;5656.4060773619;5824.155497452888;5844.386339434383;5845;5851.561132915006;7061.1526616805795;7064.858702825966;7069.787906362817;7070.858582828366;7082.104842336746;4713.976430117862;4716.95283047172;4718.905621887578;4730.834420795256;4733.526647335273;7163.140423149203;7474.663640136207;7478.663460144307;7481.8877716834295;7494.75157452762;4802.255650374198;4804.615630749532;4819.445763737145;4820.469748327681;4823.493533178966;4888.242322439956;4894.412670479565;4902.730349830794;4902.950970490249;4903.313536104948;5814.912776308359;5821.446962538552;5830.5044071254415;5835.795747148914;5843.766249349978;5766.971165144148;6878.243393226741;7172.784816455514;7175.31834475724;7197.352238298578;1670.2734310574938;1699.762033315312;1700.3623641134575;1703.897766134036;1704.207543492282;994.7314225159166;1029.8815636201932;1037.4501514197486;1064.9733756656146;1082.377632861108;5369.301990741179;6501.47988160946;6520.673966301666;6522.119513865662;6542.672866356758;7312.1956584775635;7313.341799238094;7313.597752123685;7317.634118294171;7323.963380183065;6182.350853160443;6473.320301368382;6479.157709497829;6482.546221764525;6525.738970441129;3851.614838516126;3891.96108038916;3898.1229223424502;3902.2780785554764;3905.6094390561284;7584.317411432998;7590.127135379392;7591.924080759232;7602;7607.125180604191;7275.236100209508;7529.058867641545;7540.396768258526;7552.093748750185;7561.243875612395;6137.7851775187655;7564.697412103455;7585.279398457138;7588.203238659971;7604.961975190088;7290.380317673057;7295.562266263829;7296.671649775667;7298.160711518243;7308.8903666443985;5961.761529538943;7054.894176587252;7199.964000179965;7305.379042781423;7379.667914943733;7793.337566306701;7794.376449884109;7794.805129871798;7796.688132474637;7798.298153166243;4624;4669.883252918568;4675.6727029109;4677.824811462686;4691.929621055755;6723.621657560287;7363.631818408951;7412.444066694911;7424.480286379901;7443.739469118555;7155.3202445767565;7191.244919283609;7195.964020179866;7208.4593655475;7212.963935180501;6180.918339290516;7012.544184627983;7185.568865868065;7196.992421060951;7217.350438460564;6695.363940425652;6849.520533562602;6974.4769142315545;6985.545939514119;7010.123734533184;6998.825029374307;7113.644317784194;7120.2167761547225;7139.643017849191;7209.134903811576;5673.149027645886;6179.6910154493;7020.368166865007;7080;7100.857982840211 19:34:29 INFO - PROCESS | 1682 | |5;yui.html;746.5893758432863;752.5898385379967;755.6033082631618;756.9356604688601;773.2538100732792;13003.349832508384;13892.166470011807;14869.330880110394;14889.255537223149;14892.627684307898;13413.865861341385;13462.394192261347;13478.797818032737;13484.460621575125;13511.527096551623;709.3084242863218;720.6540860387017;861.1216559109704;863.6372723456147;876.8553188723853;861.1990848510883;875.8817559629432;876;877.324460165672;877.6138499060393;933.6685476655791;934.9392289501161;937.8733870927406;938.2400255792795;938.7606160429115;742.0353540397489;755.5202446446518;758.1735907860403;758.7154816943646;761.0334874709089;616.5160349125914;678.6878036103399;700.908881845362;702.68379229347;703.0508813102322;14205.431782728678;14312.42750289987;14319.35562899672;14344.56966291013;14374.137551746824;12382.81425778614;12581.685457863536;12706.682332941658;13140.408681609255;13231.73536529264;10048.246381521341;10104.292699511037;10124.746881327952;10129.696109116738;10149.64476243328;3496.248306614065;3541.3094446582927;3543.114221444639;3544.556930383702;3544.7341449391397;73048.6347568264;73068.2693173072;79855;82467.92852786189;82536.17463825345;9391.577379017961;9418.434893906388;9539.236861051098;9678.080582344666;10009.199264059003;19577.902110489358;20196.29312974039;20378.796212037985;20394;20443.386698398775;6416.4142219387495;7325.706971721178;7496.475246732785;7508.587027713528;7746.109197442253;4092.7339722917914;4129.174165166979;4147.253494370982;4148.170365926766;4172.916541669149;3290.44062509374;3319.883804066846;3325.617553981323;3329.20099176196;3335.499675048762;580.4340767751493;598.5570677698558;607.4866737606716;608.2093278737624;627.2097157581389;520.6173462505055;531.8856445864158;542.8649548855392;559.8124628249582;576.6021445202797;8715.215630593277;8788.209061184523;8803.855354576153;8809.955950220336;8901.198892099743;553.4753391028407;590.2945979554477;624.1449214575969;637.6715991264502;646.6452781422912;3949.298342979491;3962.663173630216;3965.980170099131;4130.524989626171;4197.691269801597;74333.628331858;87337.25325493455;88617;90355;90682;77600.61199694079;78145.60927195328;78168.21831781723;79632;82035;64910;64931.02603460952;69043;69231;71623.97264382991;8760.693375731818;8796.164364385373;8840.557972101498;8914.108589141035;8916.910830891868;47676.523234767206;48067.75966120147;48275.79310517265;49058.52824415273;49081;65128.67435662791;65665;65930;69847;70707.58584828378;9526.904730952601;9923.357392662972;10909.236353455182;11141.610043648758;11275.492602833056;11815.291082535075;12137.150399472306;12349.506019759468;12660.493580256687;12694.174878632859;11400.828987565028;11679.474423650787;11940.46267917963;11956.76086478283;12305.815412768994;11240.586682370098;11689.766204676029;11715.589954351557;11977.341246231541;12287.017038637066;9922.751931201778;10517.894821051692;11578.073754099483;11978.64064078079;11989.820152697543;8018.238267364591;9156.313276504156;9309.348345615741;9803.166730827674;9970.451625160686;9529.952350238205;9624.230061594915;9630.614775408905;10196.235282353704;10247.897521024694 19:34:29 INFO - PROCESS | 1682 | __end_tp_report 19:34:29 INFO - PROCESS | 1682 | __start_cc_report 19:34:29 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1194 19:34:29 INFO - PROCESS | 1682 | __end_cc_report 19:34:29 INFO - PROCESS | 1682 | __startTimestamp1455161669340__endTimestamp 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | ------- Summary: start ------- 19:34:29 INFO - PROCESS | 1682 | Number of tests: 6 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | [#0] dojo.html Cycles:165 Average:5745.02 Median:6002.91 stddev:656.96 (10.9%) stddev-sans-first:634.14 19:34:29 INFO - PROCESS | 1682 | Values: 3463.9 3500.7 3517.8 3539.0 3600.7 4164.7 5665.0 5668.9 5720.9 5729.0 4764.0 5658.2 5776.5 5785.7 5786.9 5118.3 5142.4 5178.7 5187.2 5299.3 5264.8 5309.5 5326.8 5336.4 5340.8 5113.6 5163.1 5231.7 5235.9 5266.9 5182.5 5209.9 5249.9 5265.9 5286.1 5137.4 5163.0 5200.1 5209.2 5246.3 5572.9 5703.5 5707.9 5716.2 5731.4 5322.8 6125.7 6294.1 6301.8 6303.4 6243.6 6270.2 6288.1 6301.6 6311.1 5663.8 5712.7 5837.6 5846.1 5864.2 6222.2 6234.4 6271.8 6297.7 6307.3 6153.4 6173.8 6174.2 6180.2 6212.2 6147.7 6292.0 6294.1 6303.6 6310.5 6149.5 6182.0 6268.6 6271.8 6285.7 6241.3 6247.4 6273.9 6288.0 6312.1 4844.6 4917.1 4937.4 4939.3 4972.3 3703.6 4439.6 4442.2 4461.2 4487.0 5656.2 5682.0 5683.0 5707.6 5738.4 6085.7 6153.4 6156.0 6266.8 6297.7 5687.3 5692.3 5708.0 5720.9 5730.8 5414.1 5416.7 5424.5 5440.3 5447.5 6332.4 6335.0 6375.5 6393.3 6414.3 6246.6 6289.5 6291.0 6303.5 6305.3 6337.2 6353.6 6357.5 6364.3 6381.8 6085.6 6176.6 6203.0 6285.8 6292.2 6300.7 6303.3 6304.1 6306.3 6316.3 6019.1 6149.6 6154.4 6172.9 6182.7 6108.9 6127.9 6152.9 6178.6 6189.0 5997.2 6002.8 6004.9 6008.0 6044.0 5197.1 6019.3 6096.6 6135.7 6138.1 5848.9 5908.4 5938.2 6002.9 6020.3 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | [#1] ext.html Cycles:180 Average:61801.66 Median:374124.50 stddev:131706.73 (35.2%) stddev-sans-first:131995.83 19:34:29 INFO - PROCESS | 1682 | Values: 521.3 521.3 569.5 587.9 625.9 27367.9 37505.8 37517.8 37551.0 37659.4 39848.6 40223.0 40242.0 40260.8 40404.6 9413.1 9651.3 9653.9 9654.3 9665.3 9490.3 9596.7 9622.3 9625.5 9733.6 9725.0 9768.0 9777.8 9779.4 9787.9 9676.6 9748.6 9752.7 9752.9 9758.8 9581.5 9703.1 9703.1 9718.8 9727.2 37782.8 38099.9 38111.4 38226.0 38234.0 2768.7 3315.5 3358.0 3438.9 3526.2 28008.7 28117.6 28738.3 28791.7 29680.9 2771.0 2772.8 2834.6 2870.0 2968.9 406477.0 410705.0 411042.0 411194.0 411462.0 55602.7 56814.7 60877.4 61259.7 61426.0 66417.7 67700.7 68504.7 68539.7 68566.7 15912.9 16170.8 16176.7 16178.7 16192.5 10338.6 11373.1 11591.5 11985.0 12333.8 19522.2 20493.4 20502.1 20507.4 20639.6 7625.5 8987.0 9187.2 9292.0 9307.3 923.2 998.9 999.7 1000.1 1088.9 28887.6 29351.9 29483.3 29626.7 30280.4 1078.3 1084.2 1099.6 1129.3 1153.2 14423.9 14424.9 14454.7 14816.3 14848.6 647202.0 647537.0 648935.0 649800.0 654414.0 47005.1 54361.5 55020.0 55825.4 56489.4 1438.8 1443.6 1456.7 1460.3 1462.8 27770.0 28039.9 28049.2 28609.0 28636.3 45113.8 46119.0 50625.7 51873.0 51911.0 368193.0 370001.3 374113.0 374136.0 374630.0 30652.7 30964.1 31016.2 31027.5 31032.7 39525.6 40088.0 40174.8 40657.2 41251.4 34403.8 35670.9 35960.0 36008.5 37058.4 33140.5 33719.8 33843.8 34002.0 34311.3 34649.5 34865.8 35126.9 35127.5 36214.0 31400.1 32520.5 32556.0 32581.5 32617.8 23573.2 24037.6 24085.6 24312.8 24497.0 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | [#2] jquery.html Cycles:180 Average:36324.26 Median:370.86 stddev:118230.76 (31880.2%) stddev-sans-first:118531.59 19:34:29 INFO - PROCESS | 1682 | Values: 364.7 367.8 368.5 369.3 372.4 14782.7 15120.0 18809.5 19221.5 20028.4 11677.8 11941.2 11948.7 13027.3 19760.6 4522.4 5207.3 5398.3 5400.7 5404.2 3826.3 4038.1 5731.7 5993.3 5993.6 5959.3 5982.4 6025.8 6224.3 6422.1 6281.1 6370.5 6382.2 6385.2 6394.6 5537.6 5741.9 5743.0 5750.0 5751.6 23114.2 23362.6 23920.8 24028.9 24373.9 2098.8 2219.6 2286.5 2336.3 2368.0 9722.0 10117.8 10140.5 12186.1 13350.0 1640.9 1729.4 1800.5 1808.5 1836.9 99668.5 101700.0 101935.5 102636.5 103694.0 8910.9 10787.8 11102.7 11119.3 11191.8 13328.7 13464.5 13483.9 13496.2 13509.5 8301.1 8354.7 8369.2 8427.4 8461.9 8455.3 8471.8 8489.2 8571.0 8601.0 3959.6 4157.5 4319.7 4405.9 4457.9 1732.5 1784.8 1788.3 1791.1 1796.9 692.8 873.7 953.5 977.9 981.9 19425.7 19549.2 19803.4 20211.4 20283.0 892.4 915.2 926.7 946.6 949.6 9911.4 10614.9 10902.0 10902.2 10920.5 705880.0 710657.0 718297.2 725332.0 729459.0 106100.0 106352.0 106566.0 107325.0 109197.0 987.6 1117.9 1118.6 1138.7 1144.8 17585.6 17721.5 17728.7 17916.8 18159.0 46691.5 47555.8 47649.5 48033.5 49101.3 69780.3 70289.6 70491.9 71051.6 71801.6 5780.4 7357.2 7429.6 7565.2 7726.6 11094.0 11917.4 12041.0 12094.5 12281.1 6884.4 8145.3 8451.5 10298.8 10320.7 9917.7 9961.4 10261.9 10305.7 10352.8 4213.9 8894.6 10593.0 10651.6 10778.5 5820.4 7728.1 7729.7 7774.1 7775.7 9674.8 10462.4 10681.5 10866.2 10873.0 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | [#3] mootools.html Cycles:180 Average:6056.63 Median:528.11 stddev:3216.66 (609.1%) stddev-sans-first:3206.66 19:34:29 INFO - PROCESS | 1682 | Values: 1402.8 1540.8 1560.5 1807.8 1959.9 7882.7 8574.1 8763.2 8775.9 8777.4 8470.7 8658.9 8663.2 8682.2 8698.7 1778.6 2196.6 2197.8 2440.6 2472.7 2215.3 2221.8 2450.8 2509.8 2510.4 2423.8 2454.5 2458.7 2465.6 2479.3 2133.8 2206.1 2457.5 2466.1 2475.5 2096.9 2422.5 2483.3 2484.8 2487.4 8586.6 8659.0 8672.3 8674.6 8675.7 4463.2 5378.2 5409.8 5410.4 5411.8 3454.7 3606.1 3606.9 3616.6 3619.8 1032.3 1036.6 1054.9 1071.1 1071.4 11830.9 11852.9 11860.5 11898.9 11899.5 4801.0 4905.6 4937.6 4966.7 5007.6 10179.4 10206.5 10221.3 10222.0 10224.5 5507.9 5534.2 5535.9 5546.6 5547.6 4972.9 5017.9 5022.8 5023.3 5035.0 3959.7 4009.0 4026.8 4056.4 4065.9 1302.9 1321.7 1329.3 1334.5 1337.4 1296.1 1323.0 1323.2 1326.4 1343.0 8103.6 8232.4 8319.8 8320.5 8333.0 511.4 523.2 527.4 528.9 529.3 6042.6 6189.9 6247.0 6424.8 6545.2 10202.4 10553.2 10611.6 10747.1 10840.2 10440.3 10442.1 10474.3 10556.0 10563.3 7047.6 8016.4 8136.3 8280.8 8299.7 8127.5 8201.8 8237.4 8241.6 8251.5 9275.4 9574.0 9633.1 9720.7 9747.0 8463.5 9875.7 9995.2 10023.9 10029.9 7412.3 7558.5 7568.6 7574.7 7577.4 8087.8 8088.0 8154.7 8174.3 8251.2 7699.3 7722.3 7794.3 7798.5 7798.6 7666.7 7674.2 7742.0 7845.9 7866.3 7706.5 7862.8 7909.2 7911.0 7914.0 7095.5 7147.8 7153.0 7157.7 7176.0 6006.3 6507.8 7229.6 7265.8 7271.6 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | [#4] prototype.html Cycles:180 Average:5775.98 Median:6476.24 stddev:1841.49 (28.4%) stddev-sans-first:1800.61 19:34:29 INFO - PROCESS | 1682 | Values: 323.7 326.8 333.4 338.3 341.5 5507.0 6606.2 6677.1 6690.5 6711.9 6292.8 6444.4 6531.4 6545.5 6597.5 4318.7 4575.9 4874.4 4892.2 5026.5 4916.7 4925.1 4934.5 4944.2 4968.3 4574.8 4623.8 4715.8 4728.8 4742.1 4096.2 4131.2 4483.5 4739.8 4881.4 4158.3 4180.3 4207.0 4213.3 4213.4 6396.5 6412.2 6422.5 6444.7 6473.3 5656.4 5824.2 5844.4 5845.0 5851.6 7061.2 7064.9 7069.8 7070.9 7082.1 4714.0 4717.0 4718.9 4730.8 4733.5 7163.1 7474.7 7478.7 7481.9 7494.8 4802.3 4804.6 4819.4 4820.5 4823.5 4888.2 4894.4 4902.7 4903.0 4903.3 5814.9 5821.4 5830.5 5835.8 5843.8 5767.0 6878.2 7172.8 7175.3 7197.4 1670.3 1699.8 1700.4 1703.9 1704.2 994.7 1029.9 1037.5 1065.0 1082.4 5369.3 6501.5 6520.7 6522.1 6542.7 7312.2 7313.3 7313.6 7317.6 7324.0 6182.4 6473.3 6479.2 6482.5 6525.7 3851.6 3892.0 3898.1 3902.3 3905.6 7584.3 7590.1 7591.9 7602.0 7607.1 7275.2 7529.1 7540.4 7552.1 7561.2 6137.8 7564.7 7585.3 7588.2 7605.0 7290.4 7295.6 7296.7 7298.2 7308.9 5961.8 7054.9 7200.0 7305.4 7379.7 7793.3 7794.4 7794.8 7796.7 7798.3 4624.0 4669.9 4675.7 4677.8 4691.9 6723.6 7363.6 7412.4 7424.5 7443.7 7155.3 7191.2 7196.0 7208.5 7213.0 6180.9 7012.5 7185.6 7197.0 7217.4 6695.4 6849.5 6974.5 6985.5 7010.1 6998.8 7113.6 7120.2 7139.6 7209.1 5673.1 6179.7 7020.4 7080.0 7100.9 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - PROCESS | 1682 | [#5] yui.html Cycles:180 Average:17933.33 Median:612.36 stddev:24960.24 (4076.1%) stddev-sans-first:24996.90 19:34:29 INFO - PROCESS | 1682 | Values: 746.6 752.6 755.6 756.9 773.3 13003.3 13892.2 14869.3 14889.3 14892.6 13413.9 13462.4 13478.8 13484.5 13511.5 709.3 720.7 861.1 863.6 876.9 861.2 875.9 876.0 877.3 877.6 933.7 934.9 937.9 938.2 938.8 742.0 755.5 758.2 758.7 761.0 616.5 678.7 700.9 702.7 703.1 14205.4 14312.4 14319.4 14344.6 14374.1 12382.8 12581.7 12706.7 13140.4 13231.7 10048.2 10104.3 10124.7 10129.7 10149.6 3496.2 3541.3 3543.1 3544.6 3544.7 73048.6 73068.3 79855.0 82467.9 82536.2 9391.6 9418.4 9539.2 9678.1 10009.2 19577.9 20196.3 20378.8 20394.0 20443.4 6416.4 7325.7 7496.5 7508.6 7746.1 4092.7 4129.2 4147.3 4148.2 4172.9 3290.4 3319.9 3325.6 3329.2 3335.5 580.4 598.6 607.5 608.2 627.2 520.6 531.9 542.9 559.8 576.6 8715.2 8788.2 8803.9 8810.0 8901.2 553.5 590.3 624.1 637.7 646.6 3949.3 3962.7 3966.0 4130.5 4197.7 74333.6 87337.3 88617.0 90355.0 90682.0 77600.6 78145.6 78168.2 79632.0 82035.0 64910.0 64931.0 69043.0 69231.0 71624.0 8760.7 8796.2 8840.6 8914.1 8916.9 47676.5 48067.8 48275.8 49058.5 49081.0 65128.7 65665.0 65930.0 69847.0 70707.6 9526.9 9923.4 10909.2 11141.6 11275.5 11815.3 12137.2 12349.5 12660.5 12694.2 11400.8 11679.5 11940.5 11956.8 12305.8 11240.6 11689.8 11715.6 11977.3 12287.0 9922.8 10517.9 11578.1 11978.6 11989.8 8018.2 9156.3 9309.3 9803.2 9970.5 9530.0 9624.2 9630.6 10196.2 10247.9 19:34:29 INFO - PROCESS | 1682 | -------- Summary: end -------- 19:34:29 INFO - PROCESS | 1682 | 19:34:29 INFO - TEST-INFO | 1682: exit 0 19:34:29 INFO - TEST-OK | dromaeo_css | took 1114951ms 19:34:29 INFO - TEST-START | kraken 19:34:29 INFO - operating with platform_type : mac_ 19:34:29 INFO - Initialising browser for kraken test... 19:34:29 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpSh8bnn/profile http://localhost:49278/getInfo.html) 19:34:31 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 19:34:31 INFO - PROCESS | 1688 | colorDepth:24 19:34:31 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 19:34:31 INFO - PROCESS | 1688 | __metrics 19:34:32 INFO - PROCESS | 1688 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:34:32 INFO - PROCESS | 1688 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:34:32 INFO - TEST-INFO | 1688: exit 0 19:34:32 INFO - Browser initialized. 19:34:32 INFO - Running cycle 1/1 for kraken test... 19:34:32 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpSh8bnn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:34:44 INFO - PROCESS | 1690 | RSS: Main: 247238656 19:34:44 INFO - PROCESS | 1690 | 19:34:47 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 19:34:47 INFO - PROCESS | 1690 | RSS: Main: 292540416 19:34:47 INFO - PROCESS | 1690 | 19:34:50 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 19:34:50 INFO - PROCESS | 1690 | RSS: Main: 303616000 19:34:50 INFO - PROCESS | 1690 | 19:34:54 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 19:34:54 INFO - PROCESS | 1690 | RSS: Main: 290205696 19:34:54 INFO - PROCESS | 1690 | 19:34:56 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 19:34:57 INFO - PROCESS | 1690 | RSS: Main: 293670912 19:34:57 INFO - PROCESS | 1690 | 19:34:59 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:35:00 INFO - PROCESS | 1690 | RSS: Main: 292143104 19:35:00 INFO - PROCESS | 1690 | 19:35:02 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 19:35:03 INFO - PROCESS | 1690 | RSS: Main: 291090432 19:35:03 INFO - PROCESS | 1690 | 19:35:06 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 19:35:06 INFO - PROCESS | 1690 | RSS: Main: 293240832 19:35:06 INFO - PROCESS | 1690 | 19:35:09 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 19:35:10 INFO - PROCESS | 1690 | RSS: Main: 293257216 19:35:10 INFO - PROCESS | 1690 | 19:35:11 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:35:12 INFO - PROCESS | 1690 | RSS: Main: 326656000 19:35:12 INFO - PROCESS | 1690 | 19:35:13 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:35:14 INFO - PROCESS | 1690 | RSS: Main: 326025216 19:35:14 INFO - PROCESS | 1690 | 19:35:16 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:35:17 INFO - PROCESS | 1690 | RSS: Main: 333238272 19:35:17 INFO - PROCESS | 1690 | 19:35:19 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:35:20 INFO - PROCESS | 1690 | RSS: Main: 334999552 19:35:20 INFO - PROCESS | 1690 | 19:35:23 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:35:23 INFO - PROCESS | 1690 | RSS: Main: 335204352 19:35:23 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 19:35:25 INFO - PROCESS | 1690 | RSS: Main: 395415552 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | __start_tp_report 19:35:25 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 19:35:25 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 19:35:25 INFO - PROCESS | 1690 | |i|pagename|runs| 19:35:25 INFO - PROCESS | 1690 | |0;ai-astar;111;110;112;110;111;110;116;109;110;111 19:35:25 INFO - PROCESS | 1690 | |1;audio-beat-detection;176;117;178;176;118;146;138;120;153;119 19:35:25 INFO - PROCESS | 1690 | |2;audio-dft;186;185;189;184;184;184;185;184;180;183 19:35:25 INFO - PROCESS | 1690 | |3;audio-fft;73;79;75;115;54;59;59;58;109;57 19:35:25 INFO - PROCESS | 1690 | |4;audio-oscillator;91;93;134;79;80;84;115;82;112;150 19:35:25 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;86;90;84;91;86;90;84;91;85;91 19:35:25 INFO - PROCESS | 1690 | |6;imaging-darkroom;94;94;94;93;92;94;94;93;93;94 19:35:25 INFO - PROCESS | 1690 | |7;imaging-desaturate;87;85;87;86;86;88;86;85;85;85 19:35:25 INFO - PROCESS | 1690 | |8;json-parse-financial;56;55;53;54;53;52;52;63;51;54 19:35:25 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;63;66;66;73;69;67;67;66;68;71 19:35:25 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;83;83;106;84;81;82;81;83;84;84 19:35:25 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;133;127;129;122;122;112;146;125;127;124 19:35:25 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;138;163;164;136;138;125;169;173;133;134 19:35:25 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;66;67;69;66;67;67;65;66;65;66 19:35:25 INFO - PROCESS | 1690 | __end_tp_report 19:35:25 INFO - PROCESS | 1690 | __start_cc_report 19:35:25 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,1197 19:35:25 INFO - PROCESS | 1690 | __end_cc_report 19:35:25 INFO - PROCESS | 1690 | __startTimestamp1455161725710__endTimestamp 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | ------- Summary: start ------- 19:35:25 INFO - PROCESS | 1690 | Number of tests: 14 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:2.06 19:35:25 INFO - PROCESS | 1690 | Values: 111.0 110.0 112.0 110.0 111.0 110.0 116.0 109.0 110.0 111.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:149.50 stddev:25.67 (17.2%) stddev-sans-first:24.50 19:35:25 INFO - PROCESS | 1690 | Values: 176.0 117.0 178.0 176.0 118.0 146.0 138.0 120.0 153.0 119.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:2.27 (1.2%) stddev-sans-first:2.33 19:35:25 INFO - PROCESS | 1690 | Values: 186.0 185.0 189.0 184.0 184.0 184.0 185.0 184.0 180.0 183.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:73.80 Median:59.00 stddev:21.93 (37.2%) stddev-sans-first:23.26 19:35:25 INFO - PROCESS | 1690 | Values: 73.0 79.0 75.0 115.0 54.0 59.0 59.0 58.0 109.0 57.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:81.00 stddev:24.80 (30.6%) stddev-sans-first:25.98 19:35:25 INFO - PROCESS | 1690 | Values: 91.0 93.0 134.0 79.0 80.0 84.0 115.0 82.0 112.0 150.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:90.00 stddev:3.05 (3.4%) stddev-sans-first:3.16 19:35:25 INFO - PROCESS | 1690 | Values: 86.0 90.0 84.0 91.0 86.0 90.0 84.0 91.0 85.0 91.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.71 (0.8%) stddev-sans-first:0.73 19:35:25 INFO - PROCESS | 1690 | Values: 94.0 94.0 94.0 93.0 92.0 94.0 94.0 93.0 93.0 94.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:1.05 (1.2%) stddev-sans-first:1.05 19:35:25 INFO - PROCESS | 1690 | Values: 87.0 85.0 87.0 86.0 86.0 88.0 86.0 85.0 85.0 85.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:3.40 (6.3%) stddev-sans-first:3.55 19:35:25 INFO - PROCESS | 1690 | Values: 56.0 55.0 53.0 54.0 53.0 52.0 52.0 63.0 51.0 54.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:2.84 (4.2%) stddev-sans-first:2.47 19:35:25 INFO - PROCESS | 1690 | Values: 63.0 66.0 66.0 73.0 69.0 67.0 67.0 66.0 68.0 71.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:83.00 stddev:7.43 (9.0%) stddev-sans-first:7.84 19:35:25 INFO - PROCESS | 1690 | Values: 83.0 83.0 106.0 84.0 81.0 82.0 81.0 83.0 84.0 84.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:8.74 (6.9%) stddev-sans-first:8.97 19:35:25 INFO - PROCESS | 1690 | Values: 133.0 127.0 129.0 122.0 122.0 112.0 146.0 125.0 127.0 124.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:150.50 stddev:17.75 (11.8%) stddev-sans-first:18.51 19:35:25 INFO - PROCESS | 1690 | Values: 138.0 163.0 164.0 136.0 138.0 125.0 169.0 173.0 133.0 134.0 19:35:25 INFO - PROCESS | 1690 | 19:35:25 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.24 19:35:25 INFO - PROCESS | 1690 | Values: 66.0 67.0 69.0 66.0 67.0 67.0 65.0 66.0 65.0 66.0 19:35:25 INFO - PROCESS | 1690 | -------- Summary: end -------- 19:35:25 INFO - PROCESS | 1690 | 19:35:26 INFO - TEST-INFO | 1690: exit 0 19:35:26 INFO - TEST-OK | kraken | took 56549ms 19:35:26 INFO - SUITE-END | took 1171s 19:35:26 INFO - Completed test suite (00:19:31) 19:35:26 INFO - Working with test: dromaeo_css 19:35:26 INFO - Generating results file: dromaeo_css 19:35:26 INFO - Working with test: kraken 19:35:26 INFO - Generating results file: kraken 19:35:26 INFO - javascript benchmark 19:35:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:35:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 19:35:27 INFO - process_Request line: dromaeo_css 7429.50 graph.html#tests=[[72,64,59]] 19:35:27 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:35:27 INFO - process_Request line: kraken 1430.00 graph.html#tests=[[232,64,59]] 19:35:27 INFO - RETURN: dromaeo_css: 7429.50 19:35:27 INFO - RETURN: kraken: 1430.00 19:35:27 INFO - javascript benchmark 19:35:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3463.8960831175064, 3500.6849383555473, 3517.7863637045225, 3538.999999999999, 3600.657937495937, 4164.729292595983, 5665.036943719567, 5668.943310566893, 5720.856978575538, 5728.971355143219, 4764.047190561884, 5658.151277308396, 5776.451237132465, 5785.710714464281, 5786.855328616787, 5118.257852611369, 5142.434332223453, 5178.6892786432745, 5187.221916712486, 5299.311089558371, 5264.8157314494, 5309.469053094698, 5326.840194794143, 5336.4129945705945, 5340.839774806743, 5113.590912726973, 5163.14808056674, 5231.738413079331, 5235.921461178085, 5266.947330526684, 5182.53357197854, 5209.869753256161, 5249.921251181236, 5265.86835329116, 5286.127788914824, 5137.434882162959, 5162.974185129088, 5200.063988482072, 5209.2446595243855, 5246.265522826808, 5572.916406253868, 5703.5437165027115, 5707.942920570783, 5716.228309178291, 5731.398203188689, 5322.787088516455, 6125.662799505643, 6294.087357333161, 6301.842453938688, 6303.369663033705, 6243.594166379171, 6270.153529273535, 6288.119663247149, 6301.59039662425, 6311.147995020705, 5663.773449062074, 5712.714364281769, 5837.591368604157, 5846.064629659234, 5864.237649105632, 6222.222222222223, 6234.438900498977, 6271.7804876830005, 6297.685115744194, 6307.306196318401, 6153.353897840662, 6173.783917562953, 6174.228221472316, 6180.227471566054, 6212.161358216673, 6147.678249176449, 6292.024736165901, 6294.087357333253, 6303.558750887486, 6310.495160387158, 6149.477294429934, 6182.0, 6268.592541484789, 6271.7804876830005, 6285.717142728588, 6241.313455519889, 6247.406496382836, 6273.905891411632, 6288.0, 6312.147860038928, 4844.636652251095, 4917.139500587383, 4937.382827146606, 4939.2838038484215, 4972.303877457159, 3703.5555733312176, 4439.64482841372, 4442.222611043055, 4461.24158892989, 4486.955130448654, 5656.208130861683, 5681.971590142106, 5683.0, 5707.6290041147195, 5738.368779434342, 6085.695715214221, 6153.384661533811, 6156.015037593964, 6266.843328916813, 6297.716602752887, 5687.260656114761, 5692.288463942007, 5708.0, 5720.942790572124, 5730.77076916927, 5414.106672399089, 5416.729163541807, 5424.484673955968, 5440.319960004999, 5447.455254474521, 6332.430081292706, 6335.0, 6375.521835862329, 6393.296737358887, 6414.262359828493, 6246.625202487865, 6289.465395441439, 6291.02489114188, 6303.4642055423965, 6305.306416294296, 6337.176167098432, 6353.5870168438905, 6357.459615932513, 6364.268109167505, 6381.8085457436355, 6085.57400981927, 6176.629402235881, 6203.0, 6285.779997700059, 6292.1505596743855, 6300.684965751786, 6303.275123360689, 6304.148939893239, 6306.337834527309, 6316.305206427382, 6019.127226552037, 6149.569530132848, 6154.353792851686, 6172.938270617236, 6182.69086545662, 6108.938910610837, 6127.877442451215, 6152.876942461216, 6178.598391104564, 6188.9788184948975, 5997.16039754426, 6002.849928751816, 6004.939950600438, 6008.0, 6043.969780151071, 5197.0905091608065, 6019.277686677451, 6096.556923351527, 6135.655508508514, 6138.07928810682, 5848.941510584839, 5908.438698323653, 5938.168656388023, 6002.909956350571, 6020.277566692025], "unit": "score", "name": "dojo.html", "value": 5704.584377991618}, {"lowerIsBetter": false, "replicates": [521.2702216896342, 521.3066621393547, 569.5329829539778, 587.9441453061958, 625.9217597800275, 27367.863160684192, 37505.81247093764, 37517.81241093794, 37551.0, 37659.43510847339, 39848.60151398485, 40222.99442513938, 40241.99395015126, 40260.79869600648, 40404.59595404045, 9413.058694130601, 9651.276154288422, 9653.90346096537, 9654.324197306192, 9665.275104367165, 9490.335676502647, 9596.712098637052, 9622.326437149402, 9625.518724063804, 9733.56198971048, 9724.951375243114, 9768.0, 9777.804443911118, 9779.364341317827, 9787.902120978806, 9676.612935482608, 9748.561314740818, 9752.707418777378, 9752.90247097527, 9758.756031099208, 9581.520923953844, 9703.12671859529, 9703.12671859536, 9718.805623887554, 9727.221822254203, 37782.81108594467, 38099.857004289915, 38111.42832857509, 38226.0, 38234.0, 2768.709285525011, 3315.4529502632035, 3358.0, 3438.9312213755834, 3526.1713497328105, 28008.719912801018, 28117.57823632647, 28738.281542961384, 28791.712082879112, 29680.851595741882, 2770.986145069282, 2772.7643150332246, 2834.5606431003225, 2869.9856500717365, 2968.9163455338644, 406477.0, 410705.0, 411042.0, 411194.0, 411462.0, 55602.721986389806, 56814.715926420104, 60877.39122608717, 61259.6937015321, 61426.0, 66417.66791166013, 67700.6614966922, 68504.6574767123, 68539.65730171416, 68566.65716671385, 15912.92043539775, 16170.75743863843, 16176.676466470604, 16178.676426471404, 16192.514224573282, 10338.638147664946, 11373.090152787758, 11591.536338546532, 11985.041196704242, 12333.753324933452, 19522.219111235674, 20493.38519844407, 20502.077406516444, 20507.38477845667, 20639.58720825575, 7625.513024960191, 8987.0, 9187.2190863776, 9292.024337444605, 9307.3019523536, 923.1599244687302, 998.9250806189565, 999.7000899730052, 1000.1448761309122, 1088.896554827306, 28887.56668649972, 29351.85324073366, 29483.262918427212, 29626.703732962393, 30280.394392112034, 1078.2829418436809, 1084.1944773843866, 1099.6261271167682, 1129.3280498103616, 1153.2042890405594, 14423.855761442252, 14424.927875360556, 14454.710905782036, 14816.259187040605, 14848.554543363716, 647202.0, 647537.0, 648935.0, 649800.0, 654414.0, 47005.05989880183, 54361.45638543564, 55020.0, 55825.44174558284, 56489.43510564924, 1438.7769895666188, 1443.6318738721768, 1456.6722487440454, 1460.3355473259853, 1462.8317743459424, 27770.028049018187, 28039.859800700866, 28049.158525244275, 28608.998685045925, 28636.284092897844, 45113.77443112763, 46119.0, 50625.74687126541, 51873.0, 51911.0, 368193.0, 370001.2999869967, 374113.0, 374136.0, 374630.0, 30652.693473064985, 30964.0710778677, 31016.22459438532, 31027.534586981667, 31032.68967310298, 39525.60474395334, 40088.0, 40174.79912600418, 40657.18685626212, 41251.38122928098, 34403.79586714453, 35670.92987210388, 35960.0, 36008.459873102445, 37058.44412333871, 33140.50289245615, 33719.81980630666, 33843.830780845936, 34002.0, 34311.31377372389, 34649.48025779565, 34865.82567087148, 35126.94619161429, 35127.47308790421, 36214.0, 31400.05799826009, 32520.512192316663, 32556.02331930046, 32581.511277330384, 32617.836910815295, 23573.17493887706, 24037.639435408833, 24085.638715418932, 24312.756872431048, 24497.0], "unit": "score", "name": "ext.html", "value": 19331.473489083048}, {"lowerIsBetter": false, "replicates": [364.72463290215893, 367.82160652083735, 368.4933216826862, 369.34625712488895, 372.3725522494595, 14782.704345913075, 15120.0, 18809.529761755944, 19221.51946201344, 20028.399148025565, 11677.824832627517, 11941.223820451687, 11948.701282467942, 13027.28349940753, 19760.604787904234, 4522.4346956630425, 5207.323048003764, 5398.325209348832, 5400.729963501829, 5404.162354834987, 3826.2730081284467, 4038.0712436139706, 5731.742071606767, 5993.28080630325, 5993.640381577119, 5959.284885813709, 5982.371850955652, 6025.789097381593, 6224.253089629251, 6422.100905873158, 6281.120643109968, 6370.5222108341595, 6382.20222472191, 6385.201849768779, 6394.6482943438095, 5537.556995440355, 5741.942580574183, 5742.966266072105, 5750.02249617566, 5751.568632352549, 23114.191003314972, 23362.64956025661, 23920.7607923922, 24028.911471116062, 24373.903174357198, 2098.842586805996, 2219.6448568229007, 2286.531261091472, 2336.2874323331375, 2367.9526409471887, 9721.97919218479, 10117.797644047152, 10140.492975351202, 12186.146969712123, 13349.998750093684, 1640.9343626254936, 1729.3687803951593, 1800.486861244552, 1808.52074200337, 1836.917338719761, 99668.50165749124, 101699.96600067957, 101935.47096793554, 102636.48681756544, 103694.0, 8910.910890891138, 10787.83818242727, 11102.666919992413, 11119.332840029625, 11191.832122518168, 13328.733425331438, 13464.528741494001, 13483.865161348262, 13496.178015967718, 13509.459621615026, 8301.128381519853, 8354.749357519284, 8369.163083691583, 8427.429633961578, 8461.873071903927, 8455.281301089353, 8471.838639241443, 8489.235968762841, 8570.957145214234, 8600.956995215109, 3959.5644479107277, 4157.542670306264, 4319.654427645781, 4405.867823965286, 4457.866264012085, 1732.4581122800716, 1784.7679801625707, 1788.3472532525534, 1791.113398867569, 1796.9460916172536, 692.8129405060706, 873.7378786364065, 953.4708236928433, 977.9119879210905, 981.9214462842956, 19425.708614370797, 19549.218031278873, 19803.40589782309, 20211.393658190278, 20282.985850707406, 892.4377642085444, 915.2403505090758, 926.6988228825659, 946.5976959792199, 949.5964215208509, 9911.355761875455, 10614.89385106139, 10902.0, 10902.236843421044, 10920.542877852578, 705880.0, 710657.0, 718297.2255416173, 725332.0, 729459.0, 106100.0, 106352.0, 106566.0, 107325.0, 109197.0, 987.5605355616682, 1117.932924024561, 1118.5861231344454, 1138.6754774889116, 1144.765323108744, 17585.64828703393, 17721.468355949342, 17728.734068988717, 17916.820831791516, 18159.001254931107, 46691.53308466872, 47555.811104722656, 47649.52350476589, 48033.5196648029, 49101.263481048525, 69780.30219697738, 70289.64855175691, 70491.88524344073, 71051.64474177596, 71801.6409917947, 5780.393058728773, 7357.153927298215, 7429.5542267464125, 7565.167831538416, 7726.613669316399, 11094.0, 11917.404129793302, 12041.03671706244, 12094.455749491119, 12281.078919080926, 6884.449244060564, 8145.307648849915, 8451.45065570736, 10298.794024119326, 10320.741981450525, 9917.702468925943, 9961.40231586107, 10261.897381026392, 10305.749202816201, 10352.809426916001, 4213.894652633586, 8894.599743011451, 10592.981000414844, 10651.627193048205, 10778.514966826355, 5820.388859169726, 7728.149903510722, 7729.729459468892, 7774.144844067261, 7775.650095745592, 9674.75813104678, 10462.372257664565, 10681.46592670379, 10866.239363244496, 10872.967068128515], "unit": "score", "name": "jquery.html", "value": 8980.610997374613}, {"lowerIsBetter": false, "replicates": [1402.7825687018515, 1540.753479443289, 1560.469440390267, 1807.8372946434827, 1959.9314024009154, 7882.724104656339, 8574.099719529453, 8763.211310982011, 8775.912240877606, 8777.429467084636, 8470.66117355305, 8658.87011694825, 8663.220310172082, 8682.175193356621, 8698.695545655903, 1778.6353797471488, 2196.593630178414, 2197.7802219778055, 2440.6461063145834, 2472.6661900643453, 2215.29110684581, 2221.7889300516426, 2450.82844200906, 2509.77412032917, 2510.3724068982756, 2423.7697418745192, 2454.521368333176, 2458.6557881896547, 2465.568525508038, 2479.2686157583557, 2133.7866213378693, 2206.051397898903, 2457.508498300338, 2466.075221791828, 2475.517274131545, 2096.9056392462376, 2422.4549476367674, 2483.317087800869, 2484.776370126697, 2487.3657217409627, 8586.613602387908, 8658.960924689014, 8672.349573781992, 8674.56627168639, 8675.696350627697, 4463.218936686099, 5378.1663842104535, 5409.837704868821, 5410.404855465896, 5411.756470958816, 3454.671806178434, 3606.134527713356, 3606.9098272543397, 3616.6021737608844, 3619.7828130312, 1032.3496197395593, 1036.6268143468346, 1054.936703797767, 1071.1377341240297, 1071.44284971815, 11830.940845295805, 11852.88147118535, 11860.52557897683, 11898.92909638128, 11899.524019039229, 4800.975995120072, 4905.558499735041, 4937.5556199942175, 4966.726830024311, 5007.624428167902, 10179.389236645826, 10206.540705668263, 10221.284510084222, 10222.0, 10224.488775561193, 5507.944920550824, 5534.225208470817, 5535.916961245584, 5546.55627549795, 5547.611667183339, 4972.90054198914, 5017.949820501748, 5022.84931452057, 5023.271625614266, 5035.0, 3959.6832253419657, 4008.959910400917, 4026.7583944963394, 4056.3915412688334, 4065.8576949806616, 1302.908796384244, 1321.6960099177052, 1329.2689021038584, 1334.5195729537359, 1337.404854839587, 1296.1121631682329, 1323.0275747325709, 1323.2391374959245, 1326.4163767942075, 1343.0128855291352, 8103.554304513308, 8232.382571307176, 8319.8336033279, 8320.542370169578, 8333.000039995239, 511.40166005773335, 523.2151772341488, 527.3566249175999, 528.8624957510998, 529.2933933199222, 6042.577019608673, 6189.907151392733, 6246.968765156236, 6424.807255782334, 6545.181852268466, 10202.38785672862, 10553.208509361828, 10611.628592999208, 10747.140228781678, 10840.186985976083, 10440.269181157399, 10442.060214580724, 10474.266801323834, 10556.049955504042, 10563.313384629975, 7047.577145371294, 8016.358691304682, 8136.267735903797, 8280.8343833123, 8299.709510167115, 8127.512349259064, 8201.79495512617, 8237.382196335418, 8241.587920603826, 8251.463654862415, 9275.39709918853, 9574.0, 9633.08485693858, 9720.708378748648, 9747.0, 8463.53450560225, 9875.703728888146, 9995.200383969119, 10023.949880250551, 10029.943861508227, 7412.332890039922, 7558.508696934681, 7568.583727894798, 7574.697012119454, 7577.431692622965, 8087.797805054921, 8087.959560202161, 8154.673813047411, 8174.264316211569, 8251.174882511701, 7699.345555627834, 7722.26638469367, 7794.2985131338455, 7798.532088074507, 7798.610069496389, 7666.731664391719, 7674.155842857393, 7742.0, 7845.921540784748, 7866.252705992922, 7706.537607743553, 7862.842743145219, 7909.24862138096, 7910.9604451977375, 7913.971183746076, 7095.467839911924, 7147.785566433015, 7153.034340364193, 7157.749478768218, 7175.964120179366, 6006.279246490449, 6507.837304067436, 7229.63851807397, 7265.782026539212, 7271.563706177646], "unit": "score", "name": "mootools.html", "value": 4844.000572059285}, {"lowerIsBetter": false, "replicates": [323.70057696630613, 326.80555069733515, 333.3965522404448, 338.3351713882221, 341.53039570590437, 5507.008738427082, 6606.174228221473, 6677.131972843529, 6690.531662783607, 6711.8657626847435, 6292.779752708656, 6444.420002199801, 6531.444827189683, 6545.476361891049, 6597.505187110962, 4318.661215023345, 4575.908481830362, 4874.439439464454, 4892.241702536095, 5026.472220416858, 4916.729579873106, 4925.08885856116, 4934.5443094287275, 4944.233643785219, 4968.254761785743, 4574.773700471572, 4623.838165664202, 4715.834945776898, 4728.787204575785, 4742.075295317414, 4096.221717873595, 4131.194417088669, 4483.50681425043, 4739.834105806281, 4881.365422495089, 4158.251514727348, 4180.28935081037, 4206.957930420687, 4213.2837417639075, 4213.431186789775, 6396.456301214403, 6412.166418365629, 6422.454091402236, 6444.709988050549, 6473.28793832678, 5656.4060773619, 5824.155497452888, 5844.386339434383, 5845.0, 5851.561132915006, 7061.1526616805795, 7064.858702825966, 7069.787906362817, 7070.858582828366, 7082.104842336746, 4713.976430117862, 4716.95283047172, 4718.905621887578, 4730.834420795256, 4733.526647335273, 7163.140423149203, 7474.663640136207, 7478.663460144307, 7481.8877716834295, 7494.75157452762, 4802.255650374198, 4804.615630749532, 4819.445763737145, 4820.469748327681, 4823.493533178966, 4888.242322439956, 4894.412670479565, 4902.730349830794, 4902.950970490249, 4903.313536104948, 5814.912776308359, 5821.446962538552, 5830.5044071254415, 5835.795747148914, 5843.766249349978, 5766.971165144148, 6878.243393226741, 7172.784816455514, 7175.31834475724, 7197.352238298578, 1670.2734310574938, 1699.762033315312, 1700.3623641134575, 1703.897766134036, 1704.207543492282, 994.7314225159166, 1029.8815636201932, 1037.4501514197486, 1064.9733756656146, 1082.377632861108, 5369.301990741179, 6501.47988160946, 6520.673966301666, 6522.119513865662, 6542.672866356758, 7312.1956584775635, 7313.341799238094, 7313.597752123685, 7317.634118294171, 7323.963380183065, 6182.350853160443, 6473.320301368382, 6479.157709497829, 6482.546221764525, 6525.738970441129, 3851.614838516126, 3891.96108038916, 3898.1229223424502, 3902.2780785554764, 3905.6094390561284, 7584.317411432998, 7590.127135379392, 7591.924080759232, 7602.0, 7607.125180604191, 7275.236100209508, 7529.058867641545, 7540.396768258526, 7552.093748750185, 7561.243875612395, 6137.7851775187655, 7564.697412103455, 7585.279398457138, 7588.203238659971, 7604.961975190088, 7290.380317673057, 7295.562266263829, 7296.671649775667, 7298.160711518243, 7308.8903666443985, 5961.761529538943, 7054.894176587252, 7199.964000179965, 7305.379042781423, 7379.667914943733, 7793.337566306701, 7794.376449884109, 7794.805129871798, 7796.688132474637, 7798.298153166243, 4624.0, 4669.883252918568, 4675.6727029109, 4677.824811462686, 4691.929621055755, 6723.621657560287, 7363.631818408951, 7412.444066694911, 7424.480286379901, 7443.739469118555, 7155.3202445767565, 7191.244919283609, 7195.964020179866, 7208.4593655475, 7212.963935180501, 6180.918339290516, 7012.544184627983, 7185.568865868065, 7196.992421060951, 7217.350438460564, 6695.363940425652, 6849.520533562602, 6974.4769142315545, 6985.545939514119, 7010.123734533184, 6998.825029374307, 7113.644317784194, 7120.2167761547225, 7139.643017849191, 7209.134903811576, 5673.149027645886, 6179.6910154493, 7020.368166865007, 7080.0, 7100.857982840211], "unit": "score", "name": "prototype.html", "value": 5162.143377301916}, {"lowerIsBetter": false, "replicates": [746.5893758432863, 752.5898385379967, 755.6033082631618, 756.9356604688601, 773.2538100732792, 13003.349832508384, 13892.166470011807, 14869.330880110394, 14889.255537223149, 14892.627684307898, 13413.865861341385, 13462.394192261347, 13478.797818032737, 13484.460621575125, 13511.527096551623, 709.3084242863218, 720.6540860387017, 861.1216559109704, 863.6372723456147, 876.8553188723853, 861.1990848510883, 875.8817559629432, 876.0, 877.324460165672, 877.6138499060393, 933.6685476655791, 934.9392289501161, 937.8733870927406, 938.2400255792795, 938.7606160429115, 742.0353540397489, 755.5202446446518, 758.1735907860403, 758.7154816943646, 761.0334874709089, 616.5160349125914, 678.6878036103399, 700.908881845362, 702.68379229347, 703.0508813102322, 14205.431782728678, 14312.42750289987, 14319.35562899672, 14344.56966291013, 14374.137551746824, 12382.81425778614, 12581.685457863536, 12706.682332941658, 13140.408681609255, 13231.73536529264, 10048.246381521341, 10104.292699511037, 10124.746881327952, 10129.696109116738, 10149.64476243328, 3496.248306614065, 3541.3094446582927, 3543.114221444639, 3544.556930383702, 3544.7341449391397, 73048.6347568264, 73068.2693173072, 79855.0, 82467.92852786189, 82536.17463825345, 9391.577379017961, 9418.434893906388, 9539.236861051098, 9678.080582344666, 10009.199264059003, 19577.902110489358, 20196.29312974039, 20378.796212037985, 20394.0, 20443.386698398775, 6416.4142219387495, 7325.706971721178, 7496.475246732785, 7508.587027713528, 7746.109197442253, 4092.7339722917914, 4129.174165166979, 4147.253494370982, 4148.170365926766, 4172.916541669149, 3290.44062509374, 3319.883804066846, 3325.617553981323, 3329.20099176196, 3335.499675048762, 580.4340767751493, 598.5570677698558, 607.4866737606716, 608.2093278737624, 627.2097157581389, 520.6173462505055, 531.8856445864158, 542.8649548855392, 559.8124628249582, 576.6021445202797, 8715.215630593277, 8788.209061184523, 8803.855354576153, 8809.955950220336, 8901.198892099743, 553.4753391028407, 590.2945979554477, 624.1449214575969, 637.6715991264502, 646.6452781422912, 3949.298342979491, 3962.663173630216, 3965.980170099131, 4130.524989626171, 4197.691269801597, 74333.628331858, 87337.25325493455, 88617.0, 90355.0, 90682.0, 77600.61199694079, 78145.60927195328, 78168.21831781723, 79632.0, 82035.0, 64910.0, 64931.02603460952, 69043.0, 69231.0, 71623.97264382991, 8760.693375731818, 8796.164364385373, 8840.557972101498, 8914.108589141035, 8916.910830891868, 47676.523234767206, 48067.75966120147, 48275.79310517265, 49058.52824415273, 49081.0, 65128.67435662791, 65665.0, 65930.0, 69847.0, 70707.58584828378, 9526.904730952601, 9923.357392662972, 10909.236353455182, 11141.610043648758, 11275.492602833056, 11815.291082535075, 12137.150399472306, 12349.506019759468, 12660.493580256687, 12694.174878632859, 11400.828987565028, 11679.474423650787, 11940.46267917963, 11956.76086478283, 12305.815412768994, 11240.586682370098, 11689.766204676029, 11715.589954351557, 11977.341246231541, 12287.017038637066, 9922.751931201778, 10517.894821051692, 11578.073754099483, 11978.64064078079, 11989.820152697543, 8018.238267364591, 9156.313276504156, 9309.348345615741, 9803.166730827674, 9970.451625160686, 9529.952350238205, 9624.230061594915, 9630.614775408905, 10196.235282353704, 10247.897521024694], "unit": "score", "name": "yui.html", "value": 6790.380911047387}], "name": "dromaeo_css", "value": 7429.49906915619}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 112.0, 110.0, 111.0, 110.0, 116.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [176.0, 117.0, 178.0, 176.0, 118.0, 146.0, 138.0, 120.0, 153.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 189.0, 184.0, 184.0, 184.0, 185.0, 184.0, 180.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [73.0, 79.0, 75.0, 115.0, 54.0, 59.0, 59.0, 58.0, 109.0, 57.0], "unit": "score", "name": "audio-fft", "value": 73.8}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 134.0, 79.0, 80.0, 84.0, 115.0, 82.0, 112.0, 150.0], "unit": "score", "name": "audio-oscillator", "value": 102.0}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 84.0, 91.0, 86.0, 90.0, 84.0, 91.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 93.0, 92.0, 94.0, 94.0, 93.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 86.0, 86.0, 88.0, 86.0, 85.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 53.0, 54.0, 53.0, 52.0, 52.0, 63.0, 51.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 66.0, 73.0, 69.0, 67.0, 67.0, 66.0, 68.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 106.0, 84.0, 81.0, 82.0, 81.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [133.0, 127.0, 129.0, 122.0, 122.0, 112.0, 146.0, 125.0, 127.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [138.0, 163.0, 164.0, 136.0, 138.0, 125.0, 169.0, 173.0, 133.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 66.0, 67.0, 67.0, 65.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1430.0}]} 19:35:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1430.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7429.50"}}} 19:35:27 INFO - Return code: 0 19:35:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:35:27 INFO - # TBPL SUCCESS # 19:35:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:35:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:35:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:35:27 INFO - 2016-02-10 19:35:27.517 screenresolution[1694:10308] starting screenresolution argv=screenresolution get 19:35:27 INFO - 2016-02-10 19:35:27.520 screenresolution[1694:10308] Display 0: 1600x1200x32@60 19:35:27 INFO - 2016-02-10 19:35:27.526 screenresolution[1695:10311] starting screenresolution argv=screenresolution list 19:35:27 INFO - Available Modes on Display 0 19:35:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:35:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:35:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:35:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:35:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:35:27 INFO - Intel Iris: 19:35:27 INFO - Chipset Model: Intel Iris 19:35:27 INFO - Type: GPU 19:35:27 INFO - Bus: Built-In 19:35:27 INFO - VRAM (Dynamic, Max): 1536 MB 19:35:27 INFO - Vendor: Intel (0x8086) 19:35:27 INFO - Device ID: 0x0a2e 19:35:27 INFO - Revision ID: 0x0009 19:35:27 INFO - Displays: 19:35:27 INFO - Display: 19:35:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:35:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:35:27 INFO - Display Serial Number: 1600x1200 60 19:35:27 INFO - Main Display: Yes 19:35:27 INFO - Mirror: Off 19:35:27 INFO - Online: Yes 19:35:27 INFO - Rotation: Supported 19:35:27 INFO - Return code: 0 19:35:27 INFO - Running post-action listener: _resource_record_post_action 19:35:27 INFO - Running post-run listener: _resource_record_post_run 19:35:28 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33725952; Write bytes: 710625792; Read time: 352; Write time: 2147 19:35:28 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404623872; Write bytes: 406776832; Read time: 30216; Write time: 843 19:35:28 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 31940096; Write bytes: 302947840; Read time: 333; Write time: 1302 19:35:28 INFO - Running post-run listener: _upload_blobber_files 19:35:28 INFO - Blob upload gear active. 19:35:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:35:28 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 19:35:28 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'] 19:35:28 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 19:35:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:30 INFO - (blobuploader) - INFO - Done attempting. 19:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:35:31 INFO - (blobuploader) - INFO - Done attempting. 19:35:31 INFO - (blobuploader) - INFO - Iteration through files over. 19:35:31 INFO - Return code: 0 19:35:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:35:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:35:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fc84fa1434d0ee75b9be2d658600fbdea0f35461e82f2fa111284f71cf64dd829fd6d69ce0abd108c3aa576106a8435fb4235b94d78f838818636018cbad21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc72d36993d92ccdc974c3a73ba2ac0858ed72e061903edb6558353614372424207a34e7778454a1befb5398939327661be00de561fabf0ce90f229c99601419"} 19:35:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:35:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:35:31 INFO - Contents: 19:35:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fc84fa1434d0ee75b9be2d658600fbdea0f35461e82f2fa111284f71cf64dd829fd6d69ce0abd108c3aa576106a8435fb4235b94d78f838818636018cbad21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc72d36993d92ccdc974c3a73ba2ac0858ed72e061903edb6558353614372424207a34e7778454a1befb5398939327661be00de561fabf0ce90f229c99601419"} 19:35:31 INFO - Running post-run listener: copy_logs_to_upload_dir 19:35:31 INFO - Copying logs to upload dir... 19:35:31 INFO - mkdir: /builds/slave/test/build/upload/logs 19:35:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.600863 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-02-10 19:35:31.492872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 19:35:31.496817) ========= 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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fc84fa1434d0ee75b9be2d658600fbdea0f35461e82f2fa111284f71cf64dd829fd6d69ce0abd108c3aa576106a8435fb4235b94d78f838818636018cbad21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc72d36993d92ccdc974c3a73ba2ac0858ed72e061903edb6558353614372424207a34e7778454a1befb5398939327661be00de561fabf0ce90f229c99601419"} build_url:https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/RZH4wYy-Tra9It1B2RkNbg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00fc84fa1434d0ee75b9be2d658600fbdea0f35461e82f2fa111284f71cf64dd829fd6d69ce0abd108c3aa576106a8435fb4235b94d78f838818636018cbad21", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dc72d36993d92ccdc974c3a73ba2ac0858ed72e061903edb6558353614372424207a34e7778454a1befb5398939327661be00de561fabf0ce90f229c99601419"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-10 19:35:31.523376) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:35:31.523717) ========= 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.GtqzHJDZ0y/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.UXHbkmrPOE/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.004455 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-10 19:35:31.572510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 19:35:31.572838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-10 19:35:31.573272) ========= ========= Total master_lag: 0.62 =========