builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0174 starttime: 1454821800.15 results: success (0) buildid: 20160206191803 builduid: e0df068e76c240ae9d06d3bc5de21479 revision: c8ecda902de00888ff0ee2fb816970c1b15e4806 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.148628) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.149082) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.149369) ========= 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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.006093 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.184287) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.184623) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.221034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.221322) ========= 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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005422 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.269378) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.269715) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.270094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.270367) ========= 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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-06 21:10:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-02-06 21:10:00 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.520589 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.805518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.805839) ========= 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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.019797 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:00.854487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 21:10:00.854857) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c8ecda902de00888ff0ee2fb816970c1b15e4806 --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 c8ecda902de00888ff0ee2fb816970c1b15e4806 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-06 21:10:00,924 truncating revision to first 12 chars 2016-02-06 21:10:00,924 Setting DEBUG logging. 2016-02-06 21:10:00,924 attempt 1/10 2016-02-06 21:10:00,924 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c8ecda902de0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 21:10:02,041 unpacking tar archive at: fx-team-c8ecda902de0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.363789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 21:10:02.234257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:02.234631) ========= echo c8ecda902de00888ff0ee2fb816970c1b15e4806 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c8ecda902de00888ff0ee2fb816970c1b15e4806'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 c8ecda902de00888ff0ee2fb816970c1b15e4806 program finished with exit code 0 elapsedTime=0.005111 script_repo_revision: 'c8ecda902de00888ff0ee2fb816970c1b15e4806' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:02.284358) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:02.284692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 21:10:02.297521) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-06 21:10:02.297849) ========= /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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:02 INFO - MultiFileLogger online at 20160206 21:10:02 in /builds/slave/test 21:10:02 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 21:10:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:10:02 INFO - {'append_to_log': False, 21:10:02 INFO - 'base_work_dir': '/builds/slave/test', 21:10:02 INFO - 'blob_upload_branch': 'Fx-Team', 21:10:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:10:02 INFO - 'branch': 'Fx-Team', 21:10:02 INFO - 'buildbot_json_path': 'buildprops.json', 21:10:02 INFO - 'config_files': ('talos/mac_config.py',), 21:10:02 INFO - 'default_actions': ('clobber', 21:10:02 INFO - 'read-buildbot-config', 21:10:02 INFO - 'download-and-extract', 21:10:02 INFO - 'populate-webroot', 21:10:02 INFO - 'create-virtualenv', 21:10:02 INFO - 'install', 21:10:02 INFO - 'run-tests'), 21:10:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:10:02 INFO - 'download_minidump_stackwalk': True, 21:10:02 INFO - 'download_symbols': 'ondemand', 21:10:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:10:02 INFO - 'tooltool.py': '/tools/tooltool.py', 21:10:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:10:02 INFO - '/tools/misc-python/virtualenv.py')}, 21:10:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:10:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:10:02 INFO - 'installer_path': 'installer.exe', 21:10:02 INFO - 'log_level': 'info', 21:10:02 INFO - 'log_name': 'talos', 21:10:02 INFO - 'log_to_console': True, 21:10:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:10:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:10:02 INFO - 'opt_config_files': (), 21:10:02 INFO - 'pip_index': False, 21:10:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:10:02 INFO - 'cmd': ('bash', 21:10:02 INFO - '-c', 21:10:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:10:02 INFO - 'enabled': True, 21:10:02 INFO - 'halt_on_failure': False, 21:10:02 INFO - 'name': 'check_screen_resolution'},), 21:10:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:10:02 INFO - 'cmd': ('bash', 21:10:02 INFO - '-c', 21:10:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:10:02 INFO - 'enabled': True, 21:10:02 INFO - 'halt_on_failure': False, 21:10:02 INFO - 'name': 'check_screen_resolution'},), 21:10:02 INFO - 'run_cmd_checks_enabled': True, 21:10:02 INFO - 'sps_profile': False, 21:10:02 INFO - 'sps_profile_interval': 0, 21:10:02 INFO - 'suite': 'dromaeojs', 21:10:02 INFO - 'system_bits': '32', 21:10:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:10:02 INFO - 'title': 't-yosemite-r7-0174', 21:10:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:10:02 INFO - 'use_talos_json': True, 21:10:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:10:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:10:02 INFO - 'work_dir': 'build'} 21:10:02 INFO - ##### 21:10:02 INFO - ##### Running clobber step. 21:10:02 INFO - ##### 21:10:02 INFO - Running pre-action listener: _resource_record_pre_action 21:10:02 INFO - Running main action method: clobber 21:10:02 INFO - rmtree: /builds/slave/test/build 21:10:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:10:03 INFO - Running post-action listener: _resource_record_post_action 21:10:03 INFO - ##### 21:10:03 INFO - ##### Running read-buildbot-config step. 21:10:03 INFO - ##### 21:10:03 INFO - Running pre-action listener: _resource_record_pre_action 21:10:03 INFO - Running main action method: read_buildbot_config 21:10:03 INFO - Using buildbot properties: 21:10:03 INFO - { 21:10:03 INFO - "project": "", 21:10:03 INFO - "product": "firefox", 21:10:03 INFO - "script_repo_revision": "production", 21:10:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 21:10:03 INFO - "repository": "", 21:10:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 21:10:03 INFO - "buildid": "20160206191803", 21:10:03 INFO - "pgo_build": "False", 21:10:03 INFO - "basedir": "/builds/slave/test", 21:10:03 INFO - "buildnumber": 310, 21:10:03 INFO - "slavename": "t-yosemite-r7-0174", 21:10:03 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:10:03 INFO - "platform": "yosemite_r7", 21:10:03 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:10:03 INFO - "branch": "fx-team", 21:10:03 INFO - "repo_path": "integration/fx-team", 21:10:03 INFO - "revision": "c8ecda902de00888ff0ee2fb816970c1b15e4806", 21:10:03 INFO - "stage_platform": "macosx64", 21:10:03 INFO - "builduid": "e0df068e76c240ae9d06d3bc5de21479", 21:10:03 INFO - "slavebuilddir": "test" 21:10:03 INFO - } 21:10:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 21:10:03 INFO - Running post-action listener: _resource_record_post_action 21:10:03 INFO - ##### 21:10:03 INFO - ##### Running download-and-extract step. 21:10:03 INFO - ##### 21:10:03 INFO - Running pre-action listener: _resource_record_pre_action 21:10:03 INFO - Running main action method: download_and_extract 21:10:03 INFO - mkdir: /builds/slave/test/build/tests 21:10:03 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')]} 21:10:03 INFO - https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/test_packages.json 21:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/test_packages.json 21:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:10:05 INFO - Downloaded 1277 bytes. 21:10:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:10:05 INFO - Using the following test package requirements: 21:10:05 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:10:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 21:10:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 21:10:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'jsshell-mac.zip'], 21:10:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 21:10:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:10:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 21:10:05 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 21:10:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 21:10:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 21:10:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 21:10:05 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 21:10:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:10: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')]} 21:10:05 INFO - https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:08 INFO - Downloaded 17753594 bytes. 21:10:08 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'] 21:10:08 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 21:10:11 INFO - Return code: 0 21:10:11 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 21:10: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')]} 21:10:11 INFO - https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 21:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:15 INFO - Downloaded 17753594 bytes. 21:10:15 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'] 21:10:15 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 21:10:19 INFO - Return code: 0 21:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:19 INFO - https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:10:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:10:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 21:10:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:20 INFO - Downloaded 10706547 bytes. 21:10:20 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'] 21:10:20 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 21:10:20 INFO - Return code: 0 21:10:20 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')]} 21:10:20 INFO - https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:10:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:10:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:10:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 21:10:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RPefQtumRMKlziDWlyo5Yg/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 21:10:23 INFO - Downloaded 111824435 bytes. 21:10:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:10:23 INFO - mkdir: /builds/slave/test/properties 21:10:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:10:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:10:23 INFO - Contents: 21:10:23 INFO - build_url:https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 21:10:25 INFO - Running post-action listener: _resource_record_post_action 21:10:25 INFO - Running post-action listener: set_extra_try_arguments 21:10:25 INFO - ##### 21:10:25 INFO - ##### Running populate-webroot step. 21:10:25 INFO - ##### 21:10:25 INFO - Running pre-action listener: _resource_record_pre_action 21:10:25 INFO - Running main action method: populate_webroot 21:10:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:10:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:10:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:10:25 INFO - '--tppagecycles', 21:10:25 INFO - '7'], 21:10:25 INFO - 'tests': ['tsvgm']}}, 21:10:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:10:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:10:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:10:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:10:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:10:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'tests': ['damp', 'tps']}, 21:10:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['damp', 'tps']}, 21:10:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:10:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:10:25 INFO - 'other': {'tests': ['a11yr', 21:10:25 INFO - 'ts_paint', 21:10:25 INFO - 'tpaint', 21:10:25 INFO - 'sessionrestore', 21:10:25 INFO - 'sessionrestore_no_auto_restore']}, 21:10:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['a11yr', 21:10:25 INFO - 'ts_paint', 21:10:25 INFO - 'tpaint', 21:10:25 INFO - 'sessionrestore', 21:10:25 INFO - 'sessionrestore_no_auto_restore']}, 21:10:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['a11yr', 21:10:25 INFO - 'ts_paint', 21:10:25 INFO - 'tpaint', 21:10:25 INFO - 'sessionrestore', 21:10:25 INFO - 'sessionrestore_no_auto_restore']}, 21:10:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['a11yr', 21:10:25 INFO - 'ts_paint', 21:10:25 INFO - 'tpaint', 21:10:25 INFO - 'sessionrestore', 21:10:25 INFO - 'sessionrestore_no_auto_restore']}, 21:10:25 INFO - 'other_l64': {'tests': ['a11yr', 21:10:25 INFO - 'ts_paint', 21:10:25 INFO - 'tpaint', 21:10:25 INFO - 'sessionrestore', 21:10:25 INFO - 'sessionrestore_no_auto_restore']}, 21:10:25 INFO - 'other_nol64': {'tests': ['a11yr', 21:10:25 INFO - 'ts_paint', 21:10:25 INFO - 'tpaint', 21:10:25 INFO - 'sessionrestore', 21:10:25 INFO - 'sessionrestore_no_auto_restore']}, 21:10:25 INFO - 'svgr': {'tests': ['tsvgx', 21:10:25 INFO - 'tsvgr_opacity', 21:10:25 INFO - 'tart', 21:10:25 INFO - 'tscrollx', 21:10:25 INFO - 'cart']}, 21:10:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['tsvgx', 21:10:25 INFO - 'tsvgr_opacity', 21:10:25 INFO - 'tart', 21:10:25 INFO - 'tscrollx', 21:10:25 INFO - 'cart']}, 21:10:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'tests': ['tp5o']}, 21:10:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'talos_options': ['--e10s'], 21:10:25 INFO - 'tests': ['tp5o']}, 21:10:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'talos_options': ['--xperf_path', 21:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:25 INFO - 'tests': ['tp5n']}, 21:10:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:10:25 INFO - 'talos_options': ['--e10s', 21:10:25 INFO - '--xperf_path', 21:10:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:10:25 INFO - 'tests': ['tp5n']}}, 21:10:25 INFO - 'talos.zip': {'path': '', 21:10:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:10:25 INFO - Running post-action listener: _resource_record_post_action 21:10:25 INFO - ##### 21:10:25 INFO - ##### Running create-virtualenv step. 21:10:25 INFO - ##### 21:10:25 INFO - Running pre-action listener: _resource_record_pre_action 21:10:25 INFO - Running main action method: create_virtualenv 21:10:25 INFO - Creating virtualenv /builds/slave/test/build/venv 21:10:25 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 21:10:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:10:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:10:25 INFO - Using real prefix '/tools/python27' 21:10:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 21:10:28 INFO - Installing pip.................done. 21:10:28 INFO - Return code: 0 21:10:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:10:28 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')]} 21:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:28 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')]} 21:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:28 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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:28 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 21:10:28 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 21:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:28 INFO - 'HOME': '/Users/cltbld', 21:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:28 INFO - 'LOGNAME': 'cltbld', 21:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:28 INFO - 'MOZ_NO_REMOTE': '1', 21:10:28 INFO - 'NO_EM_RESTART': '1', 21:10:28 INFO - 'PAGER': '/bin/cat', 21:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:28 INFO - 'PWD': '/builds/slave/test', 21:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:28 INFO - 'SHELL': '/bin/bash', 21:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:28 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:28 INFO - 'USER': 'cltbld', 21:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:28 INFO - 'XPC_FLAGS': '0x0', 21:10:28 INFO - 'XPC_SERVICE_NAME': '0', 21:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:29 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 21:10:29 INFO - Cleaning up... 21:10:29 INFO - Return code: 0 21:10:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:29 INFO - 'HOME': '/Users/cltbld', 21:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:29 INFO - 'LOGNAME': 'cltbld', 21:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:29 INFO - 'MOZ_NO_REMOTE': '1', 21:10:29 INFO - 'NO_EM_RESTART': '1', 21:10:29 INFO - 'PAGER': '/bin/cat', 21:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:29 INFO - 'PWD': '/builds/slave/test', 21:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:29 INFO - 'SHELL': '/bin/bash', 21:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:29 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:29 INFO - 'USER': 'cltbld', 21:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:29 INFO - 'XPC_FLAGS': '0x0', 21:10:29 INFO - 'XPC_SERVICE_NAME': '0', 21:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:29 INFO - Downloading/unpacking psutil>=0.7.1 21:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:32 INFO - Installing collected packages: psutil 21:10:32 INFO - Running setup.py install for psutil 21:10:32 INFO - building 'psutil._psutil_osx' extension 21:10:32 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 21:10:32 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 21:10:32 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 21:10:32 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 21:10:32 INFO - building 'psutil._psutil_posix' extension 21:10:32 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 21:10:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:10:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:10:32 INFO - ^ 21:10:32 INFO - 1 warning generated. 21:10:32 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 21:10:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:10:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:10:32 INFO - Successfully installed psutil 21:10:32 INFO - Cleaning up... 21:10:33 INFO - Return code: 0 21:10:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:33 INFO - 'HOME': '/Users/cltbld', 21:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:33 INFO - 'LOGNAME': 'cltbld', 21:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:33 INFO - 'MOZ_NO_REMOTE': '1', 21:10:33 INFO - 'NO_EM_RESTART': '1', 21:10:33 INFO - 'PAGER': '/bin/cat', 21:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:33 INFO - 'PWD': '/builds/slave/test', 21:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:33 INFO - 'SHELL': '/bin/bash', 21:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:33 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:33 INFO - 'USER': 'cltbld', 21:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:33 INFO - 'XPC_FLAGS': '0x0', 21:10:33 INFO - 'XPC_SERVICE_NAME': '0', 21:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:10:35 INFO - Installing collected packages: mozsystemmonitor 21:10:35 INFO - Running setup.py install for mozsystemmonitor 21:10:35 INFO - Successfully installed mozsystemmonitor 21:10:35 INFO - Cleaning up... 21:10:35 INFO - Return code: 0 21:10:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:35 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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:35 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 21:10:35 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 21:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:35 INFO - 'HOME': '/Users/cltbld', 21:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:35 INFO - 'LOGNAME': 'cltbld', 21:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:35 INFO - 'MOZ_NO_REMOTE': '1', 21:10:35 INFO - 'NO_EM_RESTART': '1', 21:10:35 INFO - 'PAGER': '/bin/cat', 21:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:35 INFO - 'PWD': '/builds/slave/test', 21:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:35 INFO - 'SHELL': '/bin/bash', 21:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:35 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:35 INFO - 'USER': 'cltbld', 21:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:35 INFO - 'XPC_FLAGS': '0x0', 21:10:35 INFO - 'XPC_SERVICE_NAME': '0', 21:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:36 INFO - Downloading/unpacking blobuploader==1.2.4 21:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:38 INFO - Downloading blobuploader-1.2.4.tar.gz 21:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:10:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:10:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:10:39 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 21:10:39 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 21:10:39 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 21:10:39 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 21:10:39 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 21:10:39 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 21:10:39 INFO - Downloading docopt-0.6.1.tar.gz 21:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:10:39 INFO - Installing collected packages: blobuploader, requests, docopt 21:10:39 INFO - Running setup.py install for blobuploader 21:10:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:10:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:10:39 INFO - Running setup.py install for requests 21:10:40 INFO - Running setup.py install for docopt 21:10:40 INFO - Successfully installed blobuploader requests docopt 21:10:40 INFO - Cleaning up... 21:10:40 INFO - Return code: 0 21:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:40 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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:40 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 21:10:40 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 21:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:40 INFO - 'HOME': '/Users/cltbld', 21:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:40 INFO - 'LOGNAME': 'cltbld', 21:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:40 INFO - 'MOZ_NO_REMOTE': '1', 21:10:40 INFO - 'NO_EM_RESTART': '1', 21:10:40 INFO - 'PAGER': '/bin/cat', 21:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:40 INFO - 'PWD': '/builds/slave/test', 21:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:40 INFO - 'SHELL': '/bin/bash', 21:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:40 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:40 INFO - 'USER': 'cltbld', 21:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:40 INFO - 'XPC_FLAGS': '0x0', 21:10:40 INFO - 'XPC_SERVICE_NAME': '0', 21:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:10:40 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Z2BbKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:10:40 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-jq4oPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:10:40 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-jnjfOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-WJqAr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-J0sILL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-q8qswd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-SDCR61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-rR30OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-JGczDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-sfIB_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-XvygE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:10:41 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-MaySvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:10:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-DrnU2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:10:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-dKylQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-aTbTsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:10:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-xinGhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:10:42 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-qe0y1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:10:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:10:42 INFO - Running setup.py install for manifestparser 21:10:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:10:42 INFO - Running setup.py install for mozcrash 21:10:42 INFO - Running setup.py install for mozdebug 21:10:42 INFO - Running setup.py install for mozdevice 21:10:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Running setup.py install for mozfile 21:10:43 INFO - Running setup.py install for mozhttpd 21:10:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Running setup.py install for mozinfo 21:10:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Running setup.py install for mozInstall 21:10:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:10:43 INFO - Running setup.py install for mozleak 21:10:43 INFO - Running setup.py install for mozlog 21:10:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:10:44 INFO - Running setup.py install for moznetwork 21:10:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:10:44 INFO - Running setup.py install for mozprocess 21:10:44 INFO - Running setup.py install for mozprofile 21:10:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:10:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:10:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:10:44 INFO - Running setup.py install for mozrunner 21:10:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:10:44 INFO - Running setup.py install for mozscreenshot 21:10:44 INFO - Running setup.py install for moztest 21:10:44 INFO - Running setup.py install for mozversion 21:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:10:45 INFO - Cleaning up... 21:10:45 INFO - Return code: 0 21:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:45 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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:45 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 21:10:45 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 21:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:45 INFO - 'HOME': '/Users/cltbld', 21:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:45 INFO - 'LOGNAME': 'cltbld', 21:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:45 INFO - 'MOZ_NO_REMOTE': '1', 21:10:45 INFO - 'NO_EM_RESTART': '1', 21:10:45 INFO - 'PAGER': '/bin/cat', 21:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:45 INFO - 'PWD': '/builds/slave/test', 21:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:45 INFO - 'SHELL': '/bin/bash', 21:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:45 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:45 INFO - 'USER': 'cltbld', 21:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:45 INFO - 'XPC_FLAGS': '0x0', 21:10:45 INFO - 'XPC_SERVICE_NAME': '0', 21:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:10:45 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-c2WxoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:10:45 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)) 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:10:45 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_g84OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:10:45 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)) 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:10:45 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-0WSAtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:10:45 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)) 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:10:45 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Vso56Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:10:45 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)) 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:10:45 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-5NgFEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:10:45 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)) 21:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:10:45 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-AhlwAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Qx8Afj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Rmt7ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IXjpuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-d79jfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-qrIqIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-HLFEJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-VPcT0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gy606K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-LXEAMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:10:46 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)) 21:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:10:46 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-yM18my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:10:47 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)) 21:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:10:47 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-lFo5MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:10:47 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)) 21:10:47 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)) 21:10:47 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)) 21:10:47 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)) 21:10:47 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)) 21:10:47 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)) 21:10:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:10:47 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 21:10:47 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 21:10:47 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 21:10:47 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 21:10:47 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 21:10:47 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 21:10:49 INFO - Downloading blessings-1.6.tar.gz 21:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:10:49 INFO - Installing collected packages: blessings 21:10:49 INFO - Running setup.py install for blessings 21:10:49 INFO - Successfully installed blessings 21:10:49 INFO - Cleaning up... 21:10:49 INFO - Return code: 0 21:10:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:10:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:10:50 INFO - Reading from file tmpfile_stdout 21:10:50 INFO - Current package versions: 21:10:50 INFO - blessings == 1.6 21:10:50 INFO - blobuploader == 1.2.4 21:10:50 INFO - docopt == 0.6.1 21:10:50 INFO - manifestparser == 1.1 21:10:50 INFO - mozInstall == 1.12 21:10:50 INFO - mozcrash == 0.16 21:10:50 INFO - mozdebug == 0.1 21:10:50 INFO - mozdevice == 0.48 21:10:50 INFO - mozfile == 1.2 21:10:50 INFO - mozhttpd == 0.7 21:10:50 INFO - mozinfo == 0.9 21:10:50 INFO - mozleak == 0.1 21:10:50 INFO - mozlog == 3.1 21:10:50 INFO - moznetwork == 0.27 21:10:50 INFO - mozprocess == 0.22 21:10:50 INFO - mozprofile == 0.28 21:10:50 INFO - mozrunner == 6.11 21:10:50 INFO - mozscreenshot == 0.1 21:10:50 INFO - mozsystemmonitor == 0.0 21:10:50 INFO - moztest == 0.7 21:10:50 INFO - mozversion == 1.4 21:10:50 INFO - psutil == 3.1.1 21:10:50 INFO - requests == 1.2.3 21:10:50 INFO - wsgiref == 0.1.2 21:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:50 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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:50 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 21:10:50 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 21:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:50 INFO - 'HOME': '/Users/cltbld', 21:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:50 INFO - 'LOGNAME': 'cltbld', 21:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:50 INFO - 'MOZ_NO_REMOTE': '1', 21:10:50 INFO - 'NO_EM_RESTART': '1', 21:10:50 INFO - 'PAGER': '/bin/cat', 21:10:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:50 INFO - 'PWD': '/builds/slave/test', 21:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:50 INFO - 'SHELL': '/bin/bash', 21:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:50 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:50 INFO - 'USER': 'cltbld', 21:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:50 INFO - 'XPC_FLAGS': '0x0', 21:10:50 INFO - 'XPC_SERVICE_NAME': '0', 21:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 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)) 21:10:50 INFO - Cleaning up... 21:10:50 INFO - Return code: 0 21:10:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10:50 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 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10:50 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 21:10:50 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 21:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:50 INFO - 'HOME': '/Users/cltbld', 21:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:50 INFO - 'LOGNAME': 'cltbld', 21:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:50 INFO - 'MOZ_NO_REMOTE': '1', 21:10:50 INFO - 'NO_EM_RESTART': '1', 21:10:50 INFO - 'PAGER': '/bin/cat', 21:10:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:50 INFO - 'PWD': '/builds/slave/test', 21:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:50 INFO - 'SHELL': '/bin/bash', 21:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:50 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:50 INFO - 'USER': 'cltbld', 21:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:50 INFO - 'XPC_FLAGS': '0x0', 21:10:50 INFO - 'XPC_SERVICE_NAME': '0', 21:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:50 INFO - Downloading/unpacking jsonschema 21:10:50 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 21:10:50 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 21:10:50 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 21:10:50 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 21:10:50 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 21:10:50 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 21:10:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:10:52 INFO - Downloading/unpacking functools32 (from jsonschema) 21:10:52 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 21:10:52 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 21:10:52 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 21:10:52 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 21:10:52 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 21:10:52 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 21:10:53 INFO - Downloading functools32-3.2.3-2.tar.gz 21:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:10:53 INFO - warning: no files found matching '*.txt' 21:10:53 INFO - no previously-included directories found matching 'build' 21:10:53 INFO - no previously-included directories found matching 'dist' 21:10:53 INFO - no previously-included directories found matching '.git*' 21:10:53 INFO - Installing collected packages: jsonschema, functools32 21:10:53 INFO - Running setup.py install for functools32 21:10:53 INFO - warning: no files found matching '*.txt' 21:10:53 INFO - no previously-included directories found matching 'build' 21:10:53 INFO - no previously-included directories found matching 'dist' 21:10:53 INFO - no previously-included directories found matching '.git*' 21:10:53 INFO - Successfully installed jsonschema functools32 21:10:53 INFO - Cleaning up... 21:10:53 INFO - Return code: 0 21:10:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:10: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')]} 21:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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')]} 21:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b1b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66957c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, '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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 21:10: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', 'flake8'] in /builds/slave/test/build 21:10: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 flake8 21:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:10:53 INFO - 'HOME': '/Users/cltbld', 21:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:10:53 INFO - 'LOGNAME': 'cltbld', 21:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:10:53 INFO - 'MOZ_NO_REMOTE': '1', 21:10:53 INFO - 'NO_EM_RESTART': '1', 21:10:53 INFO - 'PAGER': '/bin/cat', 21:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:10:53 INFO - 'PWD': '/builds/slave/test', 21:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:10:53 INFO - 'SHELL': '/bin/bash', 21:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:10:53 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:10:53 INFO - 'USER': 'cltbld', 21:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:10:53 INFO - 'XPC_FLAGS': '0x0', 21:10:53 INFO - 'XPC_SERVICE_NAME': '0', 21:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:10:53 INFO - Downloading/unpacking flake8 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:10:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:10:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10: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 21:10:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:10:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:10:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:10:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:10:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:10:57 INFO - no previously-included directories found matching 'docs/_build' 21:10:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:10:57 INFO - Running setup.py install for pep8 21:10:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:10:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:10:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:10:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:10:57 INFO - no previously-included directories found matching 'docs/_build' 21:10:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:10:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:10:57 INFO - Cleaning up... 21:10:57 INFO - Return code: 0 21:10:57 INFO - Running post-action listener: _resource_record_post_action 21:10:57 INFO - Running post-action listener: _start_resource_monitoring 21:10:57 INFO - Starting resource monitoring. 21:10:57 INFO - ##### 21:10:57 INFO - ##### Running install step. 21:10:57 INFO - ##### 21:10:57 INFO - Running pre-action listener: _resource_record_pre_action 21:10:57 INFO - Running main action method: install 21:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:10:57 INFO - Reading from file tmpfile_stdout 21:10:57 INFO - Detecting whether we're running mozinstall >=1.0... 21:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:10:58 INFO - Reading from file tmpfile_stdout 21:10:58 INFO - Output received: 21:10:58 INFO - Usage: mozinstall [options] installer 21:10:58 INFO - Options: 21:10:58 INFO - -h, --help show this help message and exit 21:10:58 INFO - -d DEST, --destination=DEST 21:10:58 INFO - Directory to install application into. [default: 21:10:58 INFO - "/builds/slave/test"] 21:10:58 INFO - --app=APP Application being installed. [default: firefox] 21:10:58 INFO - mkdir: /builds/slave/test/build/application 21:10:58 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'] 21:10:58 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 21:11:31 INFO - Reading from file tmpfile_stdout 21:11:31 INFO - Output received: 21:11:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:11:31 INFO - Running post-action listener: _resource_record_post_action 21:11:31 INFO - ##### 21:11:31 INFO - ##### Running run-tests step. 21:11:31 INFO - ##### 21:11:31 INFO - Running pre-action listener: _resource_record_pre_action 21:11:31 INFO - Running main action method: run_tests 21:11:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:11:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:11:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:11:31 INFO - 2016-02-06 21:11:31.877 screenresolution[2339:29454] starting screenresolution argv=screenresolution get 21:11:31 INFO - 2016-02-06 21:11:31.880 screenresolution[2339:29454] Display 0: 1600x1200x32@60 21:11:31 INFO - 2016-02-06 21:11:31.886 screenresolution[2340:29456] starting screenresolution argv=screenresolution list 21:11:31 INFO - Available Modes on Display 0 21:11:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:11:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:11:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:11:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:11:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:11:32 INFO - Intel Iris: 21:11:32 INFO - Chipset Model: Intel Iris 21:11:32 INFO - Type: GPU 21:11:32 INFO - Bus: Built-In 21:11:32 INFO - VRAM (Dynamic, Max): 1536 MB 21:11:32 INFO - Vendor: Intel (0x8086) 21:11:32 INFO - Device ID: 0x0a2e 21:11:32 INFO - Revision ID: 0x0009 21:11:32 INFO - Displays: 21:11:32 INFO - Display: 21:11:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:11:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:11:32 INFO - Display Serial Number: 1600x1200 60 21:11:32 INFO - Main Display: Yes 21:11:32 INFO - Mirror: Off 21:11:32 INFO - Online: Yes 21:11:32 INFO - Rotation: Supported 21:11:32 INFO - Return code: 0 21:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:11:32 INFO - Python 2.7.3 21:11:32 INFO - Return code: 0 21:11:32 INFO - grabbing minidump binary from tooltool 21:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:11:32 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 0x1089b9d30>, '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 0x1087dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1089afb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:11:32 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 21:11:32 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 21:11:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:11:32 INFO - Return code: 0 21:11:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:11:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:11:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:11:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:11:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:11:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:11:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:11:33 INFO - Return code: 0 21:11:33 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/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 21:11:33 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/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --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 21:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pMmBRIhnnn/Render', 21:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:11:33 INFO - 'HOME': '/Users/cltbld', 21:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:11:33 INFO - 'LOGNAME': 'cltbld', 21:11:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:11:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:11:33 INFO - 'MOZ_NO_REMOTE': '1', 21:11:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:11:33 INFO - 'NO_EM_RESTART': '1', 21:11:33 INFO - 'PAGER': '/bin/cat', 21:11:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:11:33 INFO - 'PWD': '/builds/slave/test', 21:11:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:11:33 INFO - 'SHELL': '/bin/bash', 21:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hiwe80EoeV/Listeners', 21:11:33 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 21:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:11:33 INFO - 'USER': 'cltbld', 21:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:11:33 INFO - 'XPC_FLAGS': '0x0', 21:11:33 INFO - 'XPC_SERVICE_NAME': '0', 21:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:11:33 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/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 21:11:33 INFO - mozversion application_buildid: 20160206191803 21:11:33 INFO - mozversion application_changeset: c8ecda902de00888ff0ee2fb816970c1b15e4806 21:11:33 INFO - mozversion application_display_name: Nightly 21:11:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:11:33 INFO - mozversion application_name: Firefox 21:11:33 INFO - mozversion application_remotingname: firefox 21:11:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:11:33 INFO - mozversion application_vendor: Mozilla 21:11:33 INFO - mozversion application_version: 47.0a1 21:11:33 INFO - mozversion platform_buildid: 20160206191803 21:11:33 INFO - mozversion platform_changeset: c8ecda902de00888ff0ee2fb816970c1b15e4806 21:11:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:11:33 INFO - mozversion platform_version: 47.0a1 21:11:33 INFO - using testdate: 1454821893 21:11:33 INFO - actual date: 1454821893 21:11:34 INFO - starting webserver on 'localhost:51853' 21:11:34 INFO - SUITE-START | Running 2 tests 21:11:34 INFO - TEST-START | dromaeo_css 21:11:34 INFO - operating with platform_type : mac_ 21:11:34 INFO - Initialising browser for dromaeo_css test... 21:11:34 INFO - TEST-INFO | started process 2358 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpr7Dz55/profile http://localhost:51853/getInfo.html) 21:11:36 INFO - PROCESS | 2358 | __metrics Screen width/height:1600/1200 21:11:36 INFO - PROCESS | 2358 | colorDepth:24 21:11:36 INFO - PROCESS | 2358 | Browser inner width/height: 1024/689 21:11:36 INFO - PROCESS | 2358 | __metrics 21:11:36 INFO - PROCESS | 2358 | 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" 21:11:36 INFO - PROCESS | 2358 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:11:37 INFO - TEST-INFO | 2358: exit 0 21:11:37 INFO - Browser initialized. 21:11:37 INFO - Running cycle 1/1 for dromaeo_css test... 21:11:37 INFO - TEST-INFO | started process 2361 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpr7Dz55/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:11:49 INFO - PROCESS | 2361 | RSS: Main: 245415936 21:11:49 INFO - PROCESS | 2361 | 21:12:40 INFO - PROCESS | 2361 | 1454821960012 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] 21:14:51 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:51853/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51853/tests/dromaeo/cssquery-ext.html) 21:14:52 INFO - PROCESS | 2361 | RSS: Main: 364982272 21:14:52 INFO - PROCESS | 2361 | 21:17:55 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:51853/tests/dromaeo/cssquery-ext.html (next: http://localhost:51853/tests/dromaeo/cssquery-jquery.html) 21:17:55 INFO - PROCESS | 2361 | RSS: Main: 381239296 21:17:55 INFO - PROCESS | 2361 | 21:20:58 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:51853/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51853/tests/dromaeo/cssquery-mootools.html) 21:20:58 INFO - PROCESS | 2361 | RSS: Main: 379473920 21:20:58 INFO - PROCESS | 2361 | 21:24:00 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:51853/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51853/tests/dromaeo/cssquery-prototype.html) 21:24:01 INFO - PROCESS | 2361 | RSS: Main: 340766720 21:24:01 INFO - PROCESS | 2361 | 21:27:04 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:51853/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51853/tests/dromaeo/cssquery-yui.html) 21:27:05 INFO - PROCESS | 2361 | RSS: Main: 344604672 21:27:05 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | Cycle 1(1): loaded http://localhost:51853/tests/dromaeo/cssquery-yui.html (next: http://localhost:51853/tests/dromaeo/cssquery-dojo.html) 21:30:08 INFO - PROCESS | 2361 | RSS: Main: 384770048 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | __start_tp_report 21:30:08 INFO - PROCESS | 2361 | _x_x_mozilla_page_load 21:30:08 INFO - PROCESS | 2361 | _x_x_mozilla_page_load_details 21:30:08 INFO - PROCESS | 2361 | |i|pagename|runs| 21:30:08 INFO - PROCESS | 2361 | |0;dojo.html;3394.372041172383;3465.965340346596;3487.1805125795436;3497.6327485613992;3511.6839484446396;5410.377806552247;5577.44225577442;5577.553795696344;5602.971985140074;5622.859428514289;4894.531640507851;5412.2152287918225;5572.442755724425;5622.184783206432;5627.240322556454;5108.208227724699;5118.411382691001;5139.4346621871755;5203.011427828719;5213.895722085556;5135.255387968742;5200.895982080356;5207.140821764404;5212.374515058198;5215.58275337972;4522.977385113069;4952.975235123838;5198.92201616976;5213.296205012312;5214.243934629477;5199.324087868572;5205.531502164786;5206.765695543671;5210.218467229908;5210.452902445246;4569.383133277031;4943.950560494385;5166.43169251382;5194.532492075694;5206.01085793698;4793.496682848286;5527.695976721278;5597.3003374578175;5618.4662457066515;5623.26897503326;6159.291681456645;6162.137300777895;6178.783742568989;6195.721192546346;6198.535109866733;6100.206973093469;6135;6179.38206179383;6250.937490625081;6266.937330626681;5675.290588676416;5685.204071430003;5689.829305120853;5699;5728.513076388512;6190.566660333733;6302.338254483305;6302.4958003359625;6306;6309.990401535824;5727.11229759388;6002.819915402545;6074.635521868702;6103.206583144163;6141.815745527641;6193.318734939153;6207.689615519206;6213.875722485525;6214.875702485925;6223.595466294676;5994.550408719363;6136.478399336017;6136.815895523052;6144.078388241799;6155.876882462326;6129.08063790435;6196.566240363131;6206.410391012847;6207.96896015517;6215.098810672427;4825.203841366206;4861.878453038702;4863.367762190893;4863.635227357962;4873.098476781806;4288;4309.719868208556;4362.825486980549;4380.5838445347645;4397.1205758848355;5594.692291923902;5657.4908258256955;5663.688497132614;5679.574031947538;5686.9715651421475;6200.534959877937;6205.441510264098;6226.719797609118;6245.0320200369015;6245.219347581552;4625.306204069417;5613.017721898733;5634.3802181759975;5648.774049038075;5733.3406658234;5304.310439642822;5304.628675992643;5306.416294207634;5306.52241298285;5311.176767601028;5252.238425428368;6267.811965640947;6275.215598050152;6280.685965701788;6293.118963345135;6043.879122417615;6122.520135281246;6141.179174348115;6203.7828675996125;6211.9689401552705;4840.249761287007;5061.114304996685;6230.59501132425;6274.247090349188;6275.497960163085;6050.485708714633;6103.969480152571;6136.140940268277;6164.445199932027;6167.475764559883;6130.551011451029;6187.195664563578;6187.969060154671;6208.161898143693;6208.161898143693;6008.978473659401;6060.606060606046;6071.301800292847;6078.300995385587;6120.418560236771;5919.881602367843;6006.819795406145;6066.545009124245;6072.483838873745;6084.39156084388;5759.798407055733;5825.533957283492;5839.824805255849;5862.237909071793;5921.259842519685;5029.497050294941;5969.253843269591;5980.312264089685;5995.700214989146;6001.879962400641;5712.000399930079;5864.618799778001;5868.501177399798;5892.734826932712;5900.291964964232 21:30:08 INFO - PROCESS | 2361 | |1;ext.html;507.48490282363383;535.8960541284956;546.89335579562;568.6985897474339;649.2857856358007;29214.561781573266;32399.86600468984;38215.61784382155;38372.80813595935;38888.80555597221;41813.745587632344;42180.57819421805;42388;42451.36322955158;42471.78764106183;8291.543965081919;9500.477473738942;9751.804963900719;9755.902440975606;9761.853572196424;9482.241420686329;9621.230301575857;9626.278029147807;9636.807263854718;9815.558299876488;9725.319227654032;9773.56018979144;9782.461964591945;9782.510874456284;9787.608495660164;9633.325667203299;9732.805343893153;9740.75648108796;9743.512824358824;9746.122848943558;9622;9757.12185903272;9760.316777825556;9767.16979056781;9779.608815647365;39806.60193398087;40026.19947601061;40207.798961005006;40356.798216009025;40399;2887.3070463088916;3067.8005929614505;3126.6248050234117;3237.401080800036;3678.264347130558;28521.429571408455;29362.55956160638;29384.41231175386;29830;29995.550066749016;2803.742971967552;2827.1801177658454;2830.7593854522393;2835.688074311824;2885.9711402886123;474480;480512;481257;481698;482790;58527.41472585305;59190.70404647949;59834.40165598288;60507.09239361413;66559;50345.74827125841;60072.399276007556;60332.69833650804;60734.39265607287;60788;15728.05631662081;15839.891207615587;15934.601634958986;15962.04227746339;15965.840341596668;11218.934201250868;11415.714607134889;12200.938995304967;12382.257064576153;12669;20493.79506204919;20777.376678699664;20811.583768324548;20828.375148745563;20845.58308833815;7473.140588832245;7663;7740.8838867417035;7756.4182686298755;7876.094249161305;974.45917515778;996.9651062212788;1018.8777346718441;1040.5161599856103;1071.2875937501474;29702.554461683092;29973.25066873302;30122.849385752932;30164.54753178704;30226;1087.9129669626411;1126.8985791278824;1129.6159305836056;1136.2784631758727;1186.9554791783348;13356.73286534264;15005.474808381654;15070.547883563511;15096.773548396783;15170.620734481727;463277;544151;544179;546182;546216;46770.298445523345;54168.729156354755;54499;54656.18015729767;56680.71659641758;1399.104573073234;1416.419268100074;1429.063963104127;1429.8980498666942;1430.3777856632607;28334;28691.569626455203;28755.28111797222;28844.855775720986;28962.565561517014;44717.55282447134;45500.54499454963;48606.27090593715;49387.01225975389;49550.50449495603;351634;354843.22578386945;357766;357856.2107189447;359573;28429.573556396255;28657.713422865505;28680.856595716887;28723.856380717963;28731.42537149287;38987;39334.80332598319;39383.621573245946;39969.60030399659;40005.1998960025;30684.386312274077;33528;35903.28193436169;37209.25581488409;37665.870023899326;33660.61825625392;33702;33801;35550.46674299939;35580.11049723778;34372;34972.47541286934;35317.82341088381;35439.75960841358;35448.822755887086;30505.54241686421;32683.509747354285;32745.345093097527;32775.34449311048;32805.507917381736;19260;20988.47528811792;23063.538729225656;23757.574545527325;24341.14805981782 21:30:08 INFO - PROCESS | 2361 | |2;jquery.html;339.58231375408246;361.9873304434345;368.123865200822;371.25192736635665;373.69917216640596;14533.636659083502;15279.46521871732;18548.350807721734;19281.61436771264;20318;20638.1744730211;20826.16695332185;21020.264290749827;21032.89483552584;21155.682664760003;6088.573799834002;6463.57986730861;6464.191976003;6466.547341686084;6467.062275969982;4485.955140448603;4529.796159172829;5943.524518038568;6286.49708023357;7232.1683006454405;6989.475789315797;7199.2080871104135;7209.459290553204;7219.061522002158;7220.963895180543;5930.258717660293;7118.0390647262475;7214.494985351028;7218.169910460286;7222.277772222788;6801.115854938876;6811.931880681229;6824.897626535606;6826.761063362758;6833.384995350442;25259;25451.61822572663;25839.224823255332;26050.86974565134;26538.203853884414;2285.6914316567218;2299.1378233162563;2332.0493180837925;2929.945219720899;3052.6489453712884;14080;14752.262386880613;15046.398144074225;15172.848271517254;15367.769483457758;1755.6839768841603;1862.1061890292735;1874.3533480949052;1885.764279465067;1900.9049547522707;103904.48047759788;105900;105919.47040264827;106210.93789062164;106417.46791266072;17459.388921387945;18094.095295235187;18209.908950455163;18265.086745662662;18285.902845829292;23343.76656233416;23613;25073.37316567064;26854.328641784112;26941.326466838094;9836.311458198;10049.547770350351;10185.643502477378;10209.336393134423;10279.640212592523;8608.225259726654;8615.913840861636;8651;8696.13038696138;8724.607392667345;8019.478733882279;8163.877541836877;8293.585320733939;8331.583420828934;8338.916610833814;2767.488014717284;3193.1857376368876;3196.0755908343604;3299.637039925606;3323.8504267307544;852.6504133305439;857.7941294089499;872.9127087291347;944.5466176235445;1036.1141224253306;17083.572910677332;19006.334778282693;19071.237150513825;19340.323088691828;19737.901310493355;690.9136357955256;787.6691789448446;987.0721521769514;990.6087095597343;1028.1158203944601;9034.728958131134;9723.61105555784;10413.976339968212;10628.787424251472;10644.680659580225;478604;558923.4107658953;572708;579310;580910;88023.47906083813;96859;97491;102169.48915255377;110704;1098.2970898624887;1125.40916019089;1170.3153655111855;1175.4064197580167;1175.6473058082713;14380.784288235895;16669.74976876715;17256.964582125114;17298.481045568653;17693.91153044278;43727.56272437235;44732.77633611811;47207;49052.75473622609;50168.74915625399;64732.67633661802;66339;66714;71978.64010679912;73773.631131844;6235.908715974777;7376.96311518439;7655.1962043986805;7655.732049378245;7657.770266892002;9452.95273523628;11779.646610601696;11822.645320640395;12067.646808872185;12280.570180044013;9837.557309920927;10030.899691002996;10419.114375277883;10634.574617015232;10679.839802402816;9956.55195516218;10135.949320253352;10241.846372304273;10263;10267.94866025665;9025.909740902507;10199.796004080024;10464.63373781914;10892;10928.945355273172;6970.407515361048;7093.361597456254;7267.927320726725;7310.415166786538;7448.627568621656;10216.897831021595;10443.268971171945;10541.420221887869;10614.257002009785;10823.67528974132 21:30:08 INFO - PROCESS | 2361 | |3;mootools.html;1229.2562999385377;1475.800766896469;1495.9476418325357;1586.8336772472237;1616.2403670274973;7938.48399854009;8538.27424668903;8662.610182541785;8683.131686831313;8688.869666955;8326.875096873551;8616.224539791418;8621.956890215555;8622.008469026065;8632.741017769462;2451.3994071452476;2471.9629205561932;2472.49313890652;2474.344298760821;2478.30607429919;2415.9879200603973;2479.2810085075307;2485.589877670191;2490.7011158660985;2502.4744803591266;2455.5579995600783;2473.75262473753;2478.603423452248;2482.6027835546315;2486.4405508760474;2244.450109723112;2290.6370709427947;2453.4602387474815;2463.938401539958;2473.1714875516545;2417.4560723836994;2439.1950656283384;2449.473363226897;2454.6440766088995;2464.5194187133516;8716.041235464094;8761.255293300077;8779.385443018991;8789.25291350236;8793.648254069829;5231.476852314776;5328.866778330534;5345.4654534546235;5369.4362091980565;5378.838634840961;3508.859645614172;3594.3350480161253;3597;3600.6039335673054;3674;1044.8589440425521;1063.999840150264;1064.9574017039308;1086.006304231635;1089.3953855610134;11928.761424771455;11946.984506316974;11967.92288694013;11985.820212696817;11992.400379980965;4798.616110711135;4818;4860.343853579792;4875.171220892456;4895.681780684244;10195.643152489627;10207.897921020844;10208;10220.182385409149;10227.386356818615;5411.404745477994;5447.1829225616475;5448.564114870801;5457.836264912059;5458.235846981426;3949.861754838567;4414.911701765946;4534.410526631516;4899.951000490021;4960.107180707508;3895.454636350913;3922.2351641429645;3941.586133456003;3965.2862484752445;3994;1161.4773351991637;1197.2636828350676;1230.6492649594823;1298.9480420783252;1311.252586025975;1032.5972870580479;1078.3475997021847;1168.5968340922368;1196.9880301196877;1318.018076532989;7847.215278472221;7849.097353804272;7948.523088614702;7949.443538952218;7997.600119993977;978.4638118154429;1149.8735139134687;1151.5451396698256;1173.1142987044727;1185.13485155835;5128.692278463304;6114.38856114385;6137.386261373917;6184.257889053342;6210.72051757672;10113.595456181818;10382.480875956171;10497.895021049691;10588.788224235472;10596.31123976939;8784.165504277084;10373.84439233412;10463.267571269938;10465.058144766856;10476.842847357295;7921.683132674743;8250;8323.708670196515;8351.916480835236;8363.498190108492;6722.630255335808;8050.27547520726;8135.471194372347;8139.593020349077;8145.022597288364;9276.397034192756;9471.289653275893;9595.23238140933;9768.218542516439;9806.411615303105;9614.375065620712;9872.407655540403;9944.950275248866;10132.290739648153;10136.391816491034;7414.962925185339;7534.8493030138;7537;7538.434617403607;7553.811154720956;7925.0489941207425;8095.55474448911;8095.635696393794;8134.023917129983;8143.389245806707;6506.479481641552;7560.395168386626;7660.693572257047;7718.421118416029;7719.729809456642;7431.331180193809;7442.4790264683115;7443.4789564729945;7561.6597253122645;7602.961985190039;7567.394608431422;7623.085229772463;7623.69505219785;7634.312911837961;7635.656395462106;6844.965775171291;6863.622500762506;6905.033295338757;6917.031615573925;6928.272531384132;6996.335348141918;7056.6471676417;7060.470464715269;7095.82260443493;7097.077379940574 21:30:08 INFO - PROCESS | 2361 | |4;prototype.html;281.32762697153805;320.1899195036557;327.95900512435946;330.789948382777;335.5538127053778;6425.775097871576;6470.99699546571;6478.902816457751;6486.708098135583;6541.738330466787;6386.521010924176;6407.455366293871;6462.256840463348;6510.348965103487;6519.771807986722;4609.7323236110005;4690.366800481926;4767.261074533453;4809.182438985381;4838.983813399191;4592.954070459303;4765.475797662254;4861.902761944759;4876.487968763282;4891.437484689271;4797.208460603996;4807.822083589525;4825.20384136617;4831.396075490564;4834.323194752737;4542.318652202163;4803.279508073782;4819.325294458778;4823.710577365334;4828.17920953437;4000.6199411056195;4076.266272071026;4080.4287399764057;4104.42538044674;4107.281225785506;4873.951260487385;6158.507319414436;6177.9188641987475;6196.349383314777;6202.875942481171;5611.298587676541;5640.5769567282205;5651.135125408606;5661.8584535386535;5664.971675141598;6045.818625441244;6892.827679308008;6920.550164239308;6931.2375638679705;6940.895886561655;4336.956630433719;4360.41134446852;4435.733855968652;4436.134953684033;4448.7108337957925;7022.367986881154;7113.1464224292895;7154.177269614009;7206.855862882713;7220.241874603196;4559.316102584638;4606.374366611067;4653.185692503798;4663;4714.740689262055;4646.535346465326;4728.361671174416;4770.95229047712;4787.0904528139545;4798.760061996886;5620.297462817148;5632.859178520488;5650.971745141248;5655.915161272585;5662.716864156776;6960.269171736894;6964.79105626832;6964.965175174092;6978.267281935425;6986.510944233854;1643.7370020796616;1673.983260167407;1677.2871529599872;1677.8154403015658;1681.8234085420854;1063.2875973098044;1087.8531398261134;1088.613542192526;1101.4217535793773;1114.793763153819;4718.95281047192;6071.332153463116;6388.658381739887;6410.294867564564;6438.935610643927;7145.428365730729;7160.462965277521;7172.28277172289;7177.712891484282;7184.676689548983;6294.276158241861;6415.967920160463;6442.420182183532;6447.871042579122;6458.580192287486;3818.7326887118193;3842.7502212356108;3854.69162467002;3855.7300988930506;3864.555576108727;7615.276548727862;7634.465587408939;7636.007319048599;7638.197989211053;7648.694052237959;7219.278072192738;7479.326860582573;7494.925050749532;7498.062742157231;7550.244975502405;6160.845978850564;6339.5562310637815;7772.45592808498;7826.452148349675;7871.212878712083;6945.0971373721095;7306.4885458017425;7306.990577590992;7317.121945366377;7337.853242935218;6954.687039083152;7097.041899343522;7166.211716711262;7188.928110719035;7218.3503484686635;7597.924020759942;7621.733239336597;7638.465307428427;7646.617669116633;7659.502132361378;4495.77521123949;4579.93130103042;4625.398698169217;4627.6066534344955;4628.907421851612;7232.74685386009;7250.129984401906;7257.818554536178;7261.818454538678;7265.4550908681;5740.799072032459;6936.79189624312;6974.337437943387;6979.895301570379;6983.546069505466;6743.629100399525;6956.930430695628;6969.54697944632;7015.088038555159;7046.859062818818;6856.348646878539;6858.4856135791015;6866.382025617719;6866.656667166521;6876.896846547406;7001;7010.75462358815;7010.754623588354;7021.332973367522;7023.438124949889;6607.834804129935;6888.51780375389;6894.965525172342;6900.551464154814;6905.240423553506 21:30:08 INFO - PROCESS | 2361 | |5;yui.html;664.5746722097857;668.7826456401667;700.5936556797059;728.3517669274344;765.4832987733279;10613.31013484124;14372.13767173969;14695.118292902433;14706.705865882675;14720.411183552646;13252.13861099028;13305.933470332659;13306.733865322687;13330.266835324077;13370;867.2454964181155;885.2121611765534;888.9199972002518;889.4352086425134;889.5463313710022;715.967781449836;724.9057622509066;869.3783944479695;873.3319010956624;876.0407353947418;841.9284360829337;916.0656130746635;916.445550441983;916.8716379706847;919.9742287349591;806.6329819931917;902.6885724425063;903.4172958441768;907.6505545365048;908.604756930734;550.2324257660541;558.3801979802416;565.2877374508108;675.5102550650788;678.7929681447157;12960.287184204864;14586.92706536471;14968.401263949429;14984.625384365369;15051.021683590532;12390.504379824886;12428.565000225039;12448;13025.739485210242;13106.803397948943;9923.702288931343;10003.57660897728;10201;10226.539805708686;10760.78478430435;3399.3031428557088;3493.8777142800136;3496.6503349665086;3498.702610278129;3501.509788629594;73027.72757372523;73745.6312718433;74768;74851;74979.99999999946;9416.670416535526;9671.371360861522;9718.611255549698;9810.969848165983;10044.397336159855;16988.57528561771;21818.127274909144;22078.448038799157;22087.447813804785;22112.00495977685;7633;7633.465657403928;7721.189275126031;7745.07059152894;7880.605969701606;4170.395292682544;4215.536291007987;4222.809973551198;4226.936595951063;4299.118680670455;3555.7510974231554;3605.3690604144695;3606.855725770992;3610.7291953103622;3611.880317101707;559.8404454730382;673.0610797936948;675.6554157379771;683.4122654517112;688.5696439725172;505.4591587001946;571.2830397850671;589.78178074112;591.99952080983;614.0206370838505;8068.273855353046;8211.096779354266;8214.4660597061;8342.29090527312;8411.621477033548;467.5441444591496;506.62256618819214;533.5065064815108;541.5423966748092;589.5136512377306;3857.4792403025795;3937.1338305572726;4016.2369149861433;4149.668026557868;4199.307114326163;88864;90535.54732226297;91444;91684.54157729169;92105;60700.69649651724;78468.21531784724;79042;79715.60142199251;81534;69497.3050269501;69636.30363696399;71758;71853.64073179601;71995;7953.244441778022;8249.546274954935;8337.541435221121;8431.19903609156;8569.614367353359;46222.61332160041;46687.76339667357;47228.055438891715;47448.52551474441;48189;66664.33335666581;67542.32457675556;68439.97340039804;70036;70367;10250;10250.53872575721;10384.42885641297;10401.94799026;10883.23817332779;11879.703007424883;12038.699032524257;12183.634490965285;12551.560695375618;12608.936955315165;11576.47905844256;11828.17202795796;11928.403579821148;12043.819342710041;12051.33717645538;11512.884871151517;11548.653540393801;11555.075593952632;11600.955913967784;12033.217840840318;11053.723656908642;11252.099832013582;11278;11326.886731132912;11976.76046479083;8830.646774128963;8911.910880891108;9053.68312109073;9312.813743724952;9326.533673316171;6921.6193109379465;8976.506292153994;9792.657256995972;9809.803803924024;9979 21:30:08 INFO - PROCESS | 2361 | __end_tp_report 21:30:08 INFO - PROCESS | 2361 | __start_cc_report 21:30:08 INFO - PROCESS | 2361 | _x_x_mozilla_cycle_collect,1042 21:30:08 INFO - PROCESS | 2361 | __end_cc_report 21:30:08 INFO - PROCESS | 2361 | __startTimestamp1454823008476__endTimestamp 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | ------- Summary: start ------- 21:30:08 INFO - PROCESS | 2361 | Number of tests: 6 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | [#0] dojo.html Cycles:165 Average:5637.57 Median:5825.53 stddev:645.49 (11.1%) stddev-sans-first:623.02 21:30:08 INFO - PROCESS | 2361 | Values: 3394.4 3466.0 3487.2 3497.6 3511.7 5410.4 5577.4 5577.6 5603.0 5622.9 4894.5 5412.2 5572.4 5622.2 5627.2 5108.2 5118.4 5139.4 5203.0 5213.9 5135.3 5200.9 5207.1 5212.4 5215.6 4523.0 4953.0 5198.9 5213.3 5214.2 5199.3 5205.5 5206.8 5210.2 5210.5 4569.4 4944.0 5166.4 5194.5 5206.0 4793.5 5527.7 5597.3 5618.5 5623.3 6159.3 6162.1 6178.8 6195.7 6198.5 6100.2 6135.0 6179.4 6250.9 6266.9 5675.3 5685.2 5689.8 5699.0 5728.5 6190.6 6302.3 6302.5 6306.0 6310.0 5727.1 6002.8 6074.6 6103.2 6141.8 6193.3 6207.7 6213.9 6214.9 6223.6 5994.6 6136.5 6136.8 6144.1 6155.9 6129.1 6196.6 6206.4 6208.0 6215.1 4825.2 4861.9 4863.4 4863.6 4873.1 4288.0 4309.7 4362.8 4380.6 4397.1 5594.7 5657.5 5663.7 5679.6 5687.0 6200.5 6205.4 6226.7 6245.0 6245.2 4625.3 5613.0 5634.4 5648.8 5733.3 5304.3 5304.6 5306.4 5306.5 5311.2 5252.2 6267.8 6275.2 6280.7 6293.1 6043.9 6122.5 6141.2 6203.8 6212.0 4840.2 5061.1 6230.6 6274.2 6275.5 6050.5 6104.0 6136.1 6164.4 6167.5 6130.6 6187.2 6188.0 6208.2 6208.2 6009.0 6060.6 6071.3 6078.3 6120.4 5919.9 6006.8 6066.5 6072.5 6084.4 5759.8 5825.5 5839.8 5862.2 5921.3 5029.5 5969.3 5980.3 5995.7 6001.9 5712.0 5864.6 5868.5 5892.7 5900.3 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | [#1] ext.html Cycles:180 Average:59678.33 Median:197738.14 stddev:122672.26 (62.0%) stddev-sans-first:122935.94 21:30:08 INFO - PROCESS | 2361 | Values: 507.5 535.9 546.9 568.7 649.3 29214.6 32399.9 38215.6 38372.8 38888.8 41813.7 42180.6 42388.0 42451.4 42471.8 8291.5 9500.5 9751.8 9755.9 9761.9 9482.2 9621.2 9626.3 9636.8 9815.6 9725.3 9773.6 9782.5 9782.5 9787.6 9633.3 9732.8 9740.8 9743.5 9746.1 9622.0 9757.1 9760.3 9767.2 9779.6 39806.6 40026.2 40207.8 40356.8 40399.0 2887.3 3067.8 3126.6 3237.4 3678.3 28521.4 29362.6 29384.4 29830.0 29995.6 2803.7 2827.2 2830.8 2835.7 2886.0 474480.0 480512.0 481257.0 481698.0 482790.0 58527.4 59190.7 59834.4 60507.1 66559.0 50345.7 60072.4 60332.7 60734.4 60788.0 15728.1 15839.9 15934.6 15962.0 15965.8 11218.9 11415.7 12200.9 12382.3 12669.0 20493.8 20777.4 20811.6 20828.4 20845.6 7473.1 7663.0 7740.9 7756.4 7876.1 974.5 997.0 1018.9 1040.5 1071.3 29702.6 29973.3 30122.8 30164.5 30226.0 1087.9 1126.9 1129.6 1136.3 1187.0 13356.7 15005.5 15070.5 15096.8 15170.6 463277.0 544151.0 544179.0 546182.0 546216.0 46770.3 54168.7 54499.0 54656.2 56680.7 1399.1 1416.4 1429.1 1429.9 1430.4 28334.0 28691.6 28755.3 28844.9 28962.6 44717.6 45500.5 48606.3 49387.0 49550.5 351634.0 354843.2 357766.0 357856.2 359573.0 28429.6 28657.7 28680.9 28723.9 28731.4 38987.0 39334.8 39383.6 39969.6 40005.2 30684.4 33528.0 35903.3 37209.3 37665.9 33660.6 33702.0 33801.0 35550.5 35580.1 34372.0 34972.5 35317.8 35439.8 35448.8 30505.5 32683.5 32745.3 32775.3 32805.5 19260.0 20988.5 23063.5 23757.6 24341.1 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | [#2] jquery.html Cycles:180 Average:32800.73 Median:2848.72 stddev:91883.63 (3225.4%) stddev-sans-first:92109.06 21:30:08 INFO - PROCESS | 2361 | Values: 339.6 362.0 368.1 371.3 373.7 14533.6 15279.5 18548.4 19281.6 20318.0 20638.2 20826.2 21020.3 21032.9 21155.7 6088.6 6463.6 6464.2 6466.5 6467.1 4486.0 4529.8 5943.5 6286.5 7232.2 6989.5 7199.2 7209.5 7219.1 7221.0 5930.3 7118.0 7214.5 7218.2 7222.3 6801.1 6811.9 6824.9 6826.8 6833.4 25259.0 25451.6 25839.2 26050.9 26538.2 2285.7 2299.1 2332.0 2929.9 3052.6 14080.0 14752.3 15046.4 15172.8 15367.8 1755.7 1862.1 1874.4 1885.8 1900.9 103904.5 105900.0 105919.5 106210.9 106417.5 17459.4 18094.1 18209.9 18265.1 18285.9 23343.8 23613.0 25073.4 26854.3 26941.3 9836.3 10049.5 10185.6 10209.3 10279.6 8608.2 8615.9 8651.0 8696.1 8724.6 8019.5 8163.9 8293.6 8331.6 8338.9 2767.5 3193.2 3196.1 3299.6 3323.9 852.7 857.8 872.9 944.5 1036.1 17083.6 19006.3 19071.2 19340.3 19737.9 690.9 787.7 987.1 990.6 1028.1 9034.7 9723.6 10414.0 10628.8 10644.7 478604.0 558923.4 572708.0 579310.0 580910.0 88023.5 96859.0 97491.0 102169.5 110704.0 1098.3 1125.4 1170.3 1175.4 1175.6 14380.8 16669.7 17257.0 17298.5 17693.9 43727.6 44732.8 47207.0 49052.8 50168.7 64732.7 66339.0 66714.0 71978.6 73773.6 6235.9 7377.0 7655.2 7655.7 7657.8 9453.0 11779.6 11822.6 12067.6 12280.6 9837.6 10030.9 10419.1 10634.6 10679.8 9956.6 10135.9 10241.8 10263.0 10267.9 9025.9 10199.8 10464.6 10892.0 10928.9 6970.4 7093.4 7267.9 7310.4 7448.6 10216.9 10443.3 10541.4 10614.3 10823.7 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | [#3] mootools.html Cycles:180 Average:6004.81 Median:5180.08 stddev:3169.61 (61.2%) stddev-sans-first:3158.17 21:30:08 INFO - PROCESS | 2361 | Values: 1229.3 1475.8 1495.9 1586.8 1616.2 7938.5 8538.3 8662.6 8683.1 8688.9 8326.9 8616.2 8622.0 8622.0 8632.7 2451.4 2472.0 2472.5 2474.3 2478.3 2416.0 2479.3 2485.6 2490.7 2502.5 2455.6 2473.8 2478.6 2482.6 2486.4 2244.5 2290.6 2453.5 2463.9 2473.2 2417.5 2439.2 2449.5 2454.6 2464.5 8716.0 8761.3 8779.4 8789.3 8793.6 5231.5 5328.9 5345.5 5369.4 5378.8 3508.9 3594.3 3597.0 3600.6 3674.0 1044.9 1064.0 1065.0 1086.0 1089.4 11928.8 11947.0 11967.9 11985.8 11992.4 4798.6 4818.0 4860.3 4875.2 4895.7 10195.6 10207.9 10208.0 10220.2 10227.4 5411.4 5447.2 5448.6 5457.8 5458.2 3949.9 4414.9 4534.4 4900.0 4960.1 3895.5 3922.2 3941.6 3965.3 3994.0 1161.5 1197.3 1230.6 1298.9 1311.3 1032.6 1078.3 1168.6 1197.0 1318.0 7847.2 7849.1 7948.5 7949.4 7997.6 978.5 1149.9 1151.5 1173.1 1185.1 5128.7 6114.4 6137.4 6184.3 6210.7 10113.6 10382.5 10497.9 10588.8 10596.3 8784.2 10373.8 10463.3 10465.1 10476.8 7921.7 8250.0 8323.7 8351.9 8363.5 6722.6 8050.3 8135.5 8139.6 8145.0 9276.4 9471.3 9595.2 9768.2 9806.4 9614.4 9872.4 9945.0 10132.3 10136.4 7415.0 7534.8 7537.0 7538.4 7553.8 7925.0 8095.6 8095.6 8134.0 8143.4 6506.5 7560.4 7660.7 7718.4 7719.7 7431.3 7442.5 7443.5 7561.7 7603.0 7567.4 7623.1 7623.7 7634.3 7635.7 6845.0 6863.6 6905.0 6917.0 6928.3 6996.3 7056.6 7060.5 7095.8 7097.1 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | [#4] prototype.html Cycles:180 Average:5695.05 Median:6413.13 stddev:1815.43 (28.3%) stddev-sans-first:1774.46 21:30:08 INFO - PROCESS | 2361 | Values: 281.3 320.2 328.0 330.8 335.6 6425.8 6471.0 6478.9 6486.7 6541.7 6386.5 6407.5 6462.3 6510.3 6519.8 4609.7 4690.4 4767.3 4809.2 4839.0 4593.0 4765.5 4861.9 4876.5 4891.4 4797.2 4807.8 4825.2 4831.4 4834.3 4542.3 4803.3 4819.3 4823.7 4828.2 4000.6 4076.3 4080.4 4104.4 4107.3 4874.0 6158.5 6177.9 6196.3 6202.9 5611.3 5640.6 5651.1 5661.9 5665.0 6045.8 6892.8 6920.6 6931.2 6940.9 4337.0 4360.4 4435.7 4436.1 4448.7 7022.4 7113.1 7154.2 7206.9 7220.2 4559.3 4606.4 4653.2 4663.0 4714.7 4646.5 4728.4 4771.0 4787.1 4798.8 5620.3 5632.9 5651.0 5655.9 5662.7 6960.3 6964.8 6965.0 6978.3 6986.5 1643.7 1674.0 1677.3 1677.8 1681.8 1063.3 1087.9 1088.6 1101.4 1114.8 4719.0 6071.3 6388.7 6410.3 6438.9 7145.4 7160.5 7172.3 7177.7 7184.7 6294.3 6416.0 6442.4 6447.9 6458.6 3818.7 3842.8 3854.7 3855.7 3864.6 7615.3 7634.5 7636.0 7638.2 7648.7 7219.3 7479.3 7494.9 7498.1 7550.2 6160.8 6339.6 7772.5 7826.5 7871.2 6945.1 7306.5 7307.0 7317.1 7337.9 6954.7 7097.0 7166.2 7188.9 7218.4 7597.9 7621.7 7638.5 7646.6 7659.5 4495.8 4579.9 4625.4 4627.6 4628.9 7232.7 7250.1 7257.8 7261.8 7265.5 5740.8 6936.8 6974.3 6979.9 6983.5 6743.6 6956.9 6969.5 7015.1 7046.9 6856.3 6858.5 6866.4 6866.7 6876.9 7001.0 7010.8 7010.8 7021.3 7023.4 6607.8 6888.5 6895.0 6900.6 6905.2 21:30:08 INFO - PROCESS | 2361 | 21:30:08 INFO - PROCESS | 2361 | [#5] yui.html Cycles:180 Average:17918.21 Median:589.65 stddev:25067.55 (4251.3%) stddev-sans-first:25104.39 21:30:08 INFO - PROCESS | 2361 | Values: 664.6 668.8 700.6 728.4 765.5 10613.3 14372.1 14695.1 14706.7 14720.4 13252.1 13305.9 13306.7 13330.3 13370.0 867.2 885.2 888.9 889.4 889.5 716.0 724.9 869.4 873.3 876.0 841.9 916.1 916.4 916.9 920.0 806.6 902.7 903.4 907.7 908.6 550.2 558.4 565.3 675.5 678.8 12960.3 14586.9 14968.4 14984.6 15051.0 12390.5 12428.6 12448.0 13025.7 13106.8 9923.7 10003.6 10201.0 10226.5 10760.8 3399.3 3493.9 3496.7 3498.7 3501.5 73027.7 73745.6 74768.0 74851.0 74980.0 9416.7 9671.4 9718.6 9811.0 10044.4 16988.6 21818.1 22078.4 22087.4 22112.0 7633.0 7633.5 7721.2 7745.1 7880.6 4170.4 4215.5 4222.8 4226.9 4299.1 3555.8 3605.4 3606.9 3610.7 3611.9 559.8 673.1 675.7 683.4 688.6 505.5 571.3 589.8 592.0 614.0 8068.3 8211.1 8214.5 8342.3 8411.6 467.5 506.6 533.5 541.5 589.5 3857.5 3937.1 4016.2 4149.7 4199.3 88864.0 90535.5 91444.0 91684.5 92105.0 60700.7 78468.2 79042.0 79715.6 81534.0 69497.3 69636.3 71758.0 71853.6 71995.0 7953.2 8249.5 8337.5 8431.2 8569.6 46222.6 46687.8 47228.1 47448.5 48189.0 66664.3 67542.3 68440.0 70036.0 70367.0 10250.0 10250.5 10384.4 10401.9 10883.2 11879.7 12038.7 12183.6 12551.6 12608.9 11576.5 11828.2 11928.4 12043.8 12051.3 11512.9 11548.7 11555.1 11601.0 12033.2 11053.7 11252.1 11278.0 11326.9 11976.8 8830.6 8911.9 9053.7 9312.8 9326.5 6921.6 8976.5 9792.7 9809.8 9979.0 21:30:08 INFO - PROCESS | 2361 | -------- Summary: end -------- 21:30:08 INFO - PROCESS | 2361 | 21:30:09 INFO - TEST-INFO | 2361: exit 0 21:30:09 INFO - TEST-OK | dromaeo_css | took 1114852ms 21:30:09 INFO - TEST-START | kraken 21:30:09 INFO - operating with platform_type : mac_ 21:30:09 INFO - Initialising browser for kraken test... 21:30:09 INFO - TEST-INFO | started process 2365 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp4B8yP2/profile http://localhost:51853/getInfo.html) 21:30:11 INFO - PROCESS | 2365 | __metrics Screen width/height:1600/1200 21:30:11 INFO - PROCESS | 2365 | colorDepth:24 21:30:11 INFO - PROCESS | 2365 | Browser inner width/height: 1024/689 21:30:11 INFO - PROCESS | 2365 | __metrics 21:30:11 INFO - PROCESS | 2365 | 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" 21:30:11 INFO - PROCESS | 2365 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:30:12 INFO - TEST-INFO | 2365: exit 0 21:30:12 INFO - Browser initialized. 21:30:12 INFO - Running cycle 1/1 for kraken test... 21:30:12 INFO - TEST-INFO | started process 2367 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp4B8yP2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:30:24 INFO - PROCESS | 2367 | RSS: Main: 245411840 21:30:24 INFO - PROCESS | 2367 | 21:30:26 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51853/tests/kraken/driver.html?testName=audio-beat-detection) 21:30:27 INFO - PROCESS | 2367 | RSS: Main: 292487168 21:30:27 INFO - PROCESS | 2367 | 21:30:29 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51853/tests/kraken/driver.html?testName=audio-dft) 21:30:30 INFO - PROCESS | 2367 | RSS: Main: 304381952 21:30:30 INFO - PROCESS | 2367 | 21:30:33 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51853/tests/kraken/driver.html?testName=audio-fft) 21:30:34 INFO - PROCESS | 2367 | RSS: Main: 290152448 21:30:34 INFO - PROCESS | 2367 | 21:30:36 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51853/tests/kraken/driver.html?testName=audio-oscillator) 21:30:36 INFO - PROCESS | 2367 | RSS: Main: 292315136 21:30:36 INFO - PROCESS | 2367 | 21:30:39 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51853/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:30:39 INFO - PROCESS | 2367 | RSS: Main: 294633472 21:30:39 INFO - PROCESS | 2367 | 21:30:42 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51853/tests/kraken/driver.html?testName=imaging-darkroom) 21:30:42 INFO - PROCESS | 2367 | RSS: Main: 295206912 21:30:42 INFO - PROCESS | 2367 | 21:30:45 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51853/tests/kraken/driver.html?testName=imaging-desaturate) 21:30:46 INFO - PROCESS | 2367 | RSS: Main: 293232640 21:30:46 INFO - PROCESS | 2367 | 21:30:48 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51853/tests/kraken/driver.html?testName=json-parse-financial) 21:30:49 INFO - PROCESS | 2367 | RSS: Main: 295706624 21:30:49 INFO - PROCESS | 2367 | 21:30:51 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51853/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:30:51 INFO - PROCESS | 2367 | RSS: Main: 329846784 21:30:51 INFO - PROCESS | 2367 | 21:30:53 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:30:54 INFO - PROCESS | 2367 | RSS: Main: 329543680 21:30:54 INFO - PROCESS | 2367 | 21:30:56 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:30:56 INFO - PROCESS | 2367 | RSS: Main: 334696448 21:30:56 INFO - PROCESS | 2367 | 21:30:59 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:30:59 INFO - PROCESS | 2367 | RSS: Main: 335859712 21:30:59 INFO - PROCESS | 2367 | 21:31:02 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:31:03 INFO - PROCESS | 2367 | RSS: Main: 336789504 21:31:03 INFO - PROCESS | 2367 | 21:31:04 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:51853/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51853/tests/kraken/driver.html?testName=ai-astar) 21:31:05 INFO - PROCESS | 2367 | RSS: Main: 396660736 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | __start_tp_report 21:31:05 INFO - PROCESS | 2367 | _x_x_mozilla_page_load 21:31:05 INFO - PROCESS | 2367 | _x_x_mozilla_page_load_details 21:31:05 INFO - PROCESS | 2367 | |i|pagename|runs| 21:31:05 INFO - PROCESS | 2367 | |0;ai-astar;111;106;110;110;110;111;114;111;109;107 21:31:05 INFO - PROCESS | 2367 | |1;audio-beat-detection;157;121;144;156;122;141;140;120;160;115 21:31:05 INFO - PROCESS | 2367 | |2;audio-dft;187;185;187;185;188;185;188;187;179;261 21:31:05 INFO - PROCESS | 2367 | |3;audio-fft;71;75;88;105;83;85;61;88;76;55 21:31:05 INFO - PROCESS | 2367 | |4;audio-oscillator;95;95;125;79;80;84;112;77;78;117 21:31:05 INFO - PROCESS | 2367 | |5;imaging-gaussian-blur;83;89;83;90;83;89;83;89;82;89 21:31:05 INFO - PROCESS | 2367 | |6;imaging-darkroom;93;91;92;92;100;104;93;92;91;93 21:31:05 INFO - PROCESS | 2367 | |7;imaging-desaturate;87;86;88;87;88;88;88;86;86;85 21:31:05 INFO - PROCESS | 2367 | |8;json-parse-financial;57;56;54;53;56;54;56;68;53;54 21:31:05 INFO - PROCESS | 2367 | |9;json-stringify-tinderbox;63;63;70;74;73;70;68;68;70;70 21:31:05 INFO - PROCESS | 2367 | |10;stanford-crypto-aes;83;80;85;83;81;82;81;84;82;82 21:31:05 INFO - PROCESS | 2367 | |11;stanford-crypto-ccm;128;130;128;115;142;134;125;130;118;133 21:31:05 INFO - PROCESS | 2367 | |12;stanford-crypto-pbkdf2;137;107;154;173;174;130;139;137;139;177 21:31:05 INFO - PROCESS | 2367 | |13;stanford-crypto-sha256-iterative;67;67;69;67;68;66;67;68;67;67 21:31:05 INFO - PROCESS | 2367 | __end_tp_report 21:31:05 INFO - PROCESS | 2367 | __start_cc_report 21:31:05 INFO - PROCESS | 2367 | _x_x_mozilla_cycle_collect,1175 21:31:05 INFO - PROCESS | 2367 | __end_cc_report 21:31:05 INFO - PROCESS | 2367 | __startTimestamp1454823065117__endTimestamp 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | ------- Summary: start ------- 21:31:05 INFO - PROCESS | 2367 | Number of tests: 14 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.23 (2.0%) stddev-sans-first:2.33 21:31:05 INFO - PROCESS | 2367 | Values: 111.0 106.0 110.0 110.0 110.0 111.0 114.0 111.0 109.0 107.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:142.50 stddev:17.04 (12.0%) stddev-sans-first:16.57 21:31:05 INFO - PROCESS | 2367 | Values: 157.0 121.0 144.0 156.0 122.0 141.0 140.0 120.0 160.0 115.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#2] audio-dft Cycles:10 Average:193.20 Median:187.00 stddev:23.97 (12.8%) stddev-sans-first:25.32 21:31:05 INFO - PROCESS | 2367 | Values: 187.0 185.0 187.0 185.0 188.0 185.0 188.0 187.0 179.0 261.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#3] audio-fft Cycles:10 Average:78.70 Median:79.50 stddev:14.45 (18.2%) stddev-sans-first:15.05 21:31:05 INFO - PROCESS | 2367 | Values: 71.0 75.0 88.0 105.0 83.0 85.0 61.0 88.0 76.0 55.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.50 stddev:17.89 (22.5%) stddev-sans-first:18.98 21:31:05 INFO - PROCESS | 2367 | Values: 95.0 95.0 125.0 79.0 80.0 84.0 112.0 77.0 78.0 117.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:89.00 stddev:3.40 (3.8%) stddev-sans-first:3.43 21:31:05 INFO - PROCESS | 2367 | Values: 83.0 89.0 83.0 90.0 83.0 89.0 83.0 89.0 82.0 89.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:92.00 stddev:4.33 (4.7%) stddev-sans-first:4.58 21:31:05 INFO - PROCESS | 2367 | Values: 93.0 91.0 92.0 92.0 100.0 104.0 93.0 92.0 91.0 93.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#7] imaging-desaturate Cycles:10 Average:86.90 Median:87.50 stddev:1.10 (1.3%) stddev-sans-first:1.17 21:31:05 INFO - PROCESS | 2367 | Values: 87.0 86.0 88.0 87.0 88.0 88.0 88.0 86.0 86.0 85.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:4.41 (7.9%) stddev-sans-first:4.66 21:31:05 INFO - PROCESS | 2367 | Values: 57.0 56.0 54.0 53.0 56.0 54.0 56.0 68.0 53.0 54.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:70.00 stddev:3.63 (5.2%) stddev-sans-first:3.17 21:31:05 INFO - PROCESS | 2367 | Values: 63.0 63.0 70.0 74.0 73.0 70.0 68.0 68.0 70.0 70.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.49 (1.8%) stddev-sans-first:1.56 21:31:05 INFO - PROCESS | 2367 | Values: 83.0 80.0 85.0 83.0 81.0 82.0 81.0 84.0 82.0 82.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:130.00 stddev:7.76 (6.0%) stddev-sans-first:8.23 21:31:05 INFO - PROCESS | 2367 | Values: 128.0 130.0 128.0 115.0 142.0 134.0 125.0 130.0 118.0 133.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:146.50 stddev:22.53 (15.4%) stddev-sans-first:23.63 21:31:05 INFO - PROCESS | 2367 | Values: 137.0 107.0 154.0 173.0 174.0 130.0 139.0 137.0 139.0 177.0 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - PROCESS | 2367 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 21:31:05 INFO - PROCESS | 2367 | Values: 67.0 67.0 69.0 67.0 68.0 66.0 67.0 68.0 67.0 67.0 21:31:05 INFO - PROCESS | 2367 | -------- Summary: end -------- 21:31:05 INFO - PROCESS | 2367 | 21:31:05 INFO - TEST-INFO | 2367: exit 0 21:31:05 INFO - TEST-OK | kraken | took 56792ms 21:31:05 INFO - SUITE-END | took 1171s 21:31:06 INFO - Completed test suite (00:19:32) 21:31:06 INFO - Working with test: dromaeo_css 21:31:06 INFO - Generating results file: dromaeo_css 21:31:06 INFO - Working with test: kraken 21:31:06 INFO - Generating results file: kraken 21:31:06 INFO - javascript benchmark 21:31:06 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 21:31:06 INFO - process_Request line: dromaeo_css 7521.22 graph.html#tests=[[72,64,59]] 21:31:06 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:31:06 INFO - process_Request line: kraken 1430.20 graph.html#tests=[[232,64,59]] 21:31:06 INFO - RETURN: dromaeo_css: 7521.22 21:31:06 INFO - RETURN: kraken: 1430.20 21:31:06 INFO - javascript benchmark 21:31:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3394.372041172383, 3465.965340346596, 3487.1805125795436, 3497.6327485613992, 3511.6839484446396, 5410.377806552247, 5577.44225577442, 5577.553795696344, 5602.971985140074, 5622.859428514289, 4894.531640507851, 5412.2152287918225, 5572.442755724425, 5622.184783206432, 5627.240322556454, 5108.208227724699, 5118.411382691001, 5139.4346621871755, 5203.011427828719, 5213.895722085556, 5135.255387968742, 5200.895982080356, 5207.140821764404, 5212.374515058198, 5215.58275337972, 4522.977385113069, 4952.975235123838, 5198.92201616976, 5213.296205012312, 5214.243934629477, 5199.324087868572, 5205.531502164786, 5206.765695543671, 5210.218467229908, 5210.452902445246, 4569.383133277031, 4943.950560494385, 5166.43169251382, 5194.532492075694, 5206.01085793698, 4793.496682848286, 5527.695976721278, 5597.3003374578175, 5618.4662457066515, 5623.26897503326, 6159.291681456645, 6162.137300777895, 6178.783742568989, 6195.721192546346, 6198.535109866733, 6100.206973093469, 6135.0, 6179.38206179383, 6250.937490625081, 6266.937330626681, 5675.290588676416, 5685.204071430003, 5689.829305120853, 5699.0, 5728.513076388512, 6190.566660333733, 6302.338254483305, 6302.4958003359625, 6306.0, 6309.990401535824, 5727.11229759388, 6002.819915402545, 6074.635521868702, 6103.206583144163, 6141.815745527641, 6193.318734939153, 6207.689615519206, 6213.875722485525, 6214.875702485925, 6223.595466294676, 5994.550408719363, 6136.478399336017, 6136.815895523052, 6144.078388241799, 6155.876882462326, 6129.08063790435, 6196.566240363131, 6206.410391012847, 6207.96896015517, 6215.098810672427, 4825.203841366206, 4861.878453038702, 4863.367762190893, 4863.635227357962, 4873.098476781806, 4288.0, 4309.719868208556, 4362.825486980549, 4380.5838445347645, 4397.1205758848355, 5594.692291923902, 5657.4908258256955, 5663.688497132614, 5679.574031947538, 5686.9715651421475, 6200.534959877937, 6205.441510264098, 6226.719797609118, 6245.0320200369015, 6245.219347581552, 4625.306204069417, 5613.017721898733, 5634.3802181759975, 5648.774049038075, 5733.3406658234, 5304.310439642822, 5304.628675992643, 5306.416294207634, 5306.52241298285, 5311.176767601028, 5252.238425428368, 6267.811965640947, 6275.215598050152, 6280.685965701788, 6293.118963345135, 6043.879122417615, 6122.520135281246, 6141.179174348115, 6203.7828675996125, 6211.9689401552705, 4840.249761287007, 5061.114304996685, 6230.59501132425, 6274.247090349188, 6275.497960163085, 6050.485708714633, 6103.969480152571, 6136.140940268277, 6164.445199932027, 6167.475764559883, 6130.551011451029, 6187.195664563578, 6187.969060154671, 6208.161898143693, 6208.161898143693, 6008.978473659401, 6060.606060606046, 6071.301800292847, 6078.300995385587, 6120.418560236771, 5919.881602367843, 6006.819795406145, 6066.545009124245, 6072.483838873745, 6084.39156084388, 5759.798407055733, 5825.533957283492, 5839.824805255849, 5862.237909071793, 5921.259842519685, 5029.497050294941, 5969.253843269591, 5980.312264089685, 5995.700214989146, 6001.879962400641, 5712.000399930079, 5864.618799778001, 5868.501177399798, 5892.734826932712, 5900.291964964232], "unit": "score", "name": "dojo.html", "value": 5599.14671959762}, {"lowerIsBetter": false, "replicates": [507.48490282363383, 535.8960541284956, 546.89335579562, 568.6985897474339, 649.2857856358007, 29214.561781573266, 32399.86600468984, 38215.61784382155, 38372.80813595935, 38888.80555597221, 41813.745587632344, 42180.57819421805, 42388.0, 42451.36322955158, 42471.78764106183, 8291.543965081919, 9500.477473738942, 9751.804963900719, 9755.902440975606, 9761.853572196424, 9482.241420686329, 9621.230301575857, 9626.278029147807, 9636.807263854718, 9815.558299876488, 9725.319227654032, 9773.56018979144, 9782.461964591945, 9782.510874456284, 9787.608495660164, 9633.325667203299, 9732.805343893153, 9740.75648108796, 9743.512824358824, 9746.122848943558, 9622.0, 9757.12185903272, 9760.316777825556, 9767.16979056781, 9779.608815647365, 39806.60193398087, 40026.19947601061, 40207.798961005006, 40356.798216009025, 40399.0, 2887.3070463088916, 3067.8005929614505, 3126.6248050234117, 3237.401080800036, 3678.264347130558, 28521.429571408455, 29362.55956160638, 29384.41231175386, 29830.0, 29995.550066749016, 2803.742971967552, 2827.1801177658454, 2830.7593854522393, 2835.688074311824, 2885.9711402886123, 474480.0, 480512.0, 481257.0, 481698.0, 482790.0, 58527.41472585305, 59190.70404647949, 59834.40165598288, 60507.09239361413, 66559.0, 50345.74827125841, 60072.399276007556, 60332.69833650804, 60734.39265607287, 60788.0, 15728.05631662081, 15839.891207615587, 15934.601634958986, 15962.04227746339, 15965.840341596668, 11218.934201250868, 11415.714607134889, 12200.938995304967, 12382.257064576153, 12669.0, 20493.79506204919, 20777.376678699664, 20811.583768324548, 20828.375148745563, 20845.58308833815, 7473.140588832245, 7663.0, 7740.8838867417035, 7756.4182686298755, 7876.094249161305, 974.45917515778, 996.9651062212788, 1018.8777346718441, 1040.5161599856103, 1071.2875937501474, 29702.554461683092, 29973.25066873302, 30122.849385752932, 30164.54753178704, 30226.0, 1087.9129669626411, 1126.8985791278824, 1129.6159305836056, 1136.2784631758727, 1186.9554791783348, 13356.73286534264, 15005.474808381654, 15070.547883563511, 15096.773548396783, 15170.620734481727, 463277.0, 544151.0, 544179.0, 546182.0, 546216.0, 46770.298445523345, 54168.729156354755, 54499.0, 54656.18015729767, 56680.71659641758, 1399.104573073234, 1416.419268100074, 1429.063963104127, 1429.8980498666942, 1430.3777856632607, 28334.0, 28691.569626455203, 28755.28111797222, 28844.855775720986, 28962.565561517014, 44717.55282447134, 45500.54499454963, 48606.27090593715, 49387.01225975389, 49550.50449495603, 351634.0, 354843.22578386945, 357766.0, 357856.2107189447, 359573.0, 28429.573556396255, 28657.713422865505, 28680.856595716887, 28723.856380717963, 28731.42537149287, 38987.0, 39334.80332598319, 39383.621573245946, 39969.60030399659, 40005.1998960025, 30684.386312274077, 33528.0, 35903.28193436169, 37209.25581488409, 37665.870023899326, 33660.61825625392, 33702.0, 33801.0, 35550.46674299939, 35580.11049723778, 34372.0, 34972.47541286934, 35317.82341088381, 35439.75960841358, 35448.822755887086, 30505.54241686421, 32683.509747354285, 32745.345093097527, 32775.34449311048, 32805.507917381736, 19260.0, 20988.47528811792, 23063.538729225656, 23757.574545527325, 24341.14805981782], "unit": "score", "name": "ext.html", "value": 19120.679546508658}, {"lowerIsBetter": false, "replicates": [339.58231375408246, 361.9873304434345, 368.123865200822, 371.25192736635665, 373.69917216640596, 14533.636659083502, 15279.46521871732, 18548.350807721734, 19281.61436771264, 20318.0, 20638.1744730211, 20826.16695332185, 21020.264290749827, 21032.89483552584, 21155.682664760003, 6088.573799834002, 6463.57986730861, 6464.191976003, 6466.547341686084, 6467.062275969982, 4485.955140448603, 4529.796159172829, 5943.524518038568, 6286.49708023357, 7232.1683006454405, 6989.475789315797, 7199.2080871104135, 7209.459290553204, 7219.061522002158, 7220.963895180543, 5930.258717660293, 7118.0390647262475, 7214.494985351028, 7218.169910460286, 7222.277772222788, 6801.115854938876, 6811.931880681229, 6824.897626535606, 6826.761063362758, 6833.384995350442, 25259.0, 25451.61822572663, 25839.224823255332, 26050.86974565134, 26538.203853884414, 2285.6914316567218, 2299.1378233162563, 2332.0493180837925, 2929.945219720899, 3052.6489453712884, 14080.0, 14752.262386880613, 15046.398144074225, 15172.848271517254, 15367.769483457758, 1755.6839768841603, 1862.1061890292735, 1874.3533480949052, 1885.764279465067, 1900.9049547522707, 103904.48047759788, 105900.0, 105919.47040264827, 106210.93789062164, 106417.46791266072, 17459.388921387945, 18094.095295235187, 18209.908950455163, 18265.086745662662, 18285.902845829292, 23343.76656233416, 23613.0, 25073.37316567064, 26854.328641784112, 26941.326466838094, 9836.311458198, 10049.547770350351, 10185.643502477378, 10209.336393134423, 10279.640212592523, 8608.225259726654, 8615.913840861636, 8651.0, 8696.13038696138, 8724.607392667345, 8019.478733882279, 8163.877541836877, 8293.585320733939, 8331.583420828934, 8338.916610833814, 2767.488014717284, 3193.1857376368876, 3196.0755908343604, 3299.637039925606, 3323.8504267307544, 852.6504133305439, 857.7941294089499, 872.9127087291347, 944.5466176235445, 1036.1141224253306, 17083.572910677332, 19006.334778282693, 19071.237150513825, 19340.323088691828, 19737.901310493355, 690.9136357955256, 787.6691789448446, 987.0721521769514, 990.6087095597343, 1028.1158203944601, 9034.728958131134, 9723.61105555784, 10413.976339968212, 10628.787424251472, 10644.680659580225, 478604.0, 558923.4107658953, 572708.0, 579310.0, 580910.0, 88023.47906083813, 96859.0, 97491.0, 102169.48915255377, 110704.0, 1098.2970898624887, 1125.40916019089, 1170.3153655111855, 1175.4064197580167, 1175.6473058082713, 14380.784288235895, 16669.74976876715, 17256.964582125114, 17298.481045568653, 17693.91153044278, 43727.56272437235, 44732.77633611811, 47207.0, 49052.75473622609, 50168.74915625399, 64732.67633661802, 66339.0, 66714.0, 71978.64010679912, 73773.631131844, 6235.908715974777, 7376.96311518439, 7655.1962043986805, 7655.732049378245, 7657.770266892002, 9452.95273523628, 11779.646610601696, 11822.645320640395, 12067.646808872185, 12280.570180044013, 9837.557309920927, 10030.899691002996, 10419.114375277883, 10634.574617015232, 10679.839802402816, 9956.55195516218, 10135.949320253352, 10241.846372304273, 10263.0, 10267.94866025665, 9025.909740902507, 10199.796004080024, 10464.63373781914, 10892.0, 10928.945355273172, 6970.407515361048, 7093.361597456254, 7267.927320726725, 7310.415166786538, 7448.627568621656, 10216.897831021595, 10443.268971171945, 10541.420221887869, 10614.257002009785, 10823.67528974132], "unit": "score", "name": "jquery.html", "value": 10054.590838330361}, {"lowerIsBetter": false, "replicates": [1229.2562999385377, 1475.800766896469, 1495.9476418325357, 1586.8336772472237, 1616.2403670274973, 7938.48399854009, 8538.27424668903, 8662.610182541785, 8683.131686831313, 8688.869666955, 8326.875096873551, 8616.224539791418, 8621.956890215555, 8622.008469026065, 8632.741017769462, 2451.3994071452476, 2471.9629205561932, 2472.49313890652, 2474.344298760821, 2478.30607429919, 2415.9879200603973, 2479.2810085075307, 2485.589877670191, 2490.7011158660985, 2502.4744803591266, 2455.5579995600783, 2473.75262473753, 2478.603423452248, 2482.6027835546315, 2486.4405508760474, 2244.450109723112, 2290.6370709427947, 2453.4602387474815, 2463.938401539958, 2473.1714875516545, 2417.4560723836994, 2439.1950656283384, 2449.473363226897, 2454.6440766088995, 2464.5194187133516, 8716.041235464094, 8761.255293300077, 8779.385443018991, 8789.25291350236, 8793.648254069829, 5231.476852314776, 5328.866778330534, 5345.4654534546235, 5369.4362091980565, 5378.838634840961, 3508.859645614172, 3594.3350480161253, 3597.0, 3600.6039335673054, 3674.0, 1044.8589440425521, 1063.999840150264, 1064.9574017039308, 1086.006304231635, 1089.3953855610134, 11928.761424771455, 11946.984506316974, 11967.92288694013, 11985.820212696817, 11992.400379980965, 4798.616110711135, 4818.0, 4860.343853579792, 4875.171220892456, 4895.681780684244, 10195.643152489627, 10207.897921020844, 10208.0, 10220.182385409149, 10227.386356818615, 5411.404745477994, 5447.1829225616475, 5448.564114870801, 5457.836264912059, 5458.235846981426, 3949.861754838567, 4414.911701765946, 4534.410526631516, 4899.951000490021, 4960.107180707508, 3895.454636350913, 3922.2351641429645, 3941.586133456003, 3965.2862484752445, 3994.0, 1161.4773351991637, 1197.2636828350676, 1230.6492649594823, 1298.9480420783252, 1311.252586025975, 1032.5972870580479, 1078.3475997021847, 1168.5968340922368, 1196.9880301196877, 1318.018076532989, 7847.215278472221, 7849.097353804272, 7948.523088614702, 7949.443538952218, 7997.600119993977, 978.4638118154429, 1149.8735139134687, 1151.5451396698256, 1173.1142987044727, 1185.13485155835, 5128.692278463304, 6114.38856114385, 6137.386261373917, 6184.257889053342, 6210.72051757672, 10113.595456181818, 10382.480875956171, 10497.895021049691, 10588.788224235472, 10596.31123976939, 8784.165504277084, 10373.84439233412, 10463.267571269938, 10465.058144766856, 10476.842847357295, 7921.683132674743, 8250.0, 8323.708670196515, 8351.916480835236, 8363.498190108492, 6722.630255335808, 8050.27547520726, 8135.471194372347, 8139.593020349077, 8145.022597288364, 9276.397034192756, 9471.289653275893, 9595.23238140933, 9768.218542516439, 9806.411615303105, 9614.375065620712, 9872.407655540403, 9944.950275248866, 10132.290739648153, 10136.391816491034, 7414.962925185339, 7534.8493030138, 7537.0, 7538.434617403607, 7553.811154720956, 7925.0489941207425, 8095.55474448911, 8095.635696393794, 8134.023917129983, 8143.389245806707, 6506.479481641552, 7560.395168386626, 7660.693572257047, 7718.421118416029, 7719.729809456642, 7431.331180193809, 7442.4790264683115, 7443.4789564729945, 7561.6597253122645, 7602.961985190039, 7567.394608431422, 7623.085229772463, 7623.69505219785, 7634.312911837961, 7635.656395462106, 6844.965775171291, 6863.622500762506, 6905.033295338757, 6917.031615573925, 6928.272531384132, 6996.335348141918, 7056.6471676417, 7060.470464715269, 7095.82260443493, 7097.077379940574], "unit": "score", "name": "mootools.html", "value": 4882.453738645551}, {"lowerIsBetter": false, "replicates": [281.32762697153805, 320.1899195036557, 327.95900512435946, 330.789948382777, 335.5538127053778, 6425.775097871576, 6470.99699546571, 6478.902816457751, 6486.708098135583, 6541.738330466787, 6386.521010924176, 6407.455366293871, 6462.256840463348, 6510.348965103487, 6519.771807986722, 4609.7323236110005, 4690.366800481926, 4767.261074533453, 4809.182438985381, 4838.983813399191, 4592.954070459303, 4765.475797662254, 4861.902761944759, 4876.487968763282, 4891.437484689271, 4797.208460603996, 4807.822083589525, 4825.20384136617, 4831.396075490564, 4834.323194752737, 4542.318652202163, 4803.279508073782, 4819.325294458778, 4823.710577365334, 4828.17920953437, 4000.6199411056195, 4076.266272071026, 4080.4287399764057, 4104.42538044674, 4107.281225785506, 4873.951260487385, 6158.507319414436, 6177.9188641987475, 6196.349383314777, 6202.875942481171, 5611.298587676541, 5640.5769567282205, 5651.135125408606, 5661.8584535386535, 5664.971675141598, 6045.818625441244, 6892.827679308008, 6920.550164239308, 6931.2375638679705, 6940.895886561655, 4336.956630433719, 4360.41134446852, 4435.733855968652, 4436.134953684033, 4448.7108337957925, 7022.367986881154, 7113.1464224292895, 7154.177269614009, 7206.855862882713, 7220.241874603196, 4559.316102584638, 4606.374366611067, 4653.185692503798, 4663.0, 4714.740689262055, 4646.535346465326, 4728.361671174416, 4770.95229047712, 4787.0904528139545, 4798.760061996886, 5620.297462817148, 5632.859178520488, 5650.971745141248, 5655.915161272585, 5662.716864156776, 6960.269171736894, 6964.79105626832, 6964.965175174092, 6978.267281935425, 6986.510944233854, 1643.7370020796616, 1673.983260167407, 1677.2871529599872, 1677.8154403015658, 1681.8234085420854, 1063.2875973098044, 1087.8531398261134, 1088.613542192526, 1101.4217535793773, 1114.793763153819, 4718.95281047192, 6071.332153463116, 6388.658381739887, 6410.294867564564, 6438.935610643927, 7145.428365730729, 7160.462965277521, 7172.28277172289, 7177.712891484282, 7184.676689548983, 6294.276158241861, 6415.967920160463, 6442.420182183532, 6447.871042579122, 6458.580192287486, 3818.7326887118193, 3842.7502212356108, 3854.69162467002, 3855.7300988930506, 3864.555576108727, 7615.276548727862, 7634.465587408939, 7636.007319048599, 7638.197989211053, 7648.694052237959, 7219.278072192738, 7479.326860582573, 7494.925050749532, 7498.062742157231, 7550.244975502405, 6160.845978850564, 6339.5562310637815, 7772.45592808498, 7826.452148349675, 7871.212878712083, 6945.0971373721095, 7306.4885458017425, 7306.990577590992, 7317.121945366377, 7337.853242935218, 6954.687039083152, 7097.041899343522, 7166.211716711262, 7188.928110719035, 7218.3503484686635, 7597.924020759942, 7621.733239336597, 7638.465307428427, 7646.617669116633, 7659.502132361378, 4495.77521123949, 4579.93130103042, 4625.398698169217, 4627.6066534344955, 4628.907421851612, 7232.74685386009, 7250.129984401906, 7257.818554536178, 7261.818454538678, 7265.4550908681, 5740.799072032459, 6936.79189624312, 6974.337437943387, 6979.895301570379, 6983.546069505466, 6743.629100399525, 6956.930430695628, 6969.54697944632, 7015.088038555159, 7046.859062818818, 6856.348646878539, 6858.4856135791015, 6866.382025617719, 6866.656667166521, 6876.896846547406, 7001.0, 7010.75462358815, 7010.754623588354, 7021.332973367522, 7023.438124949889, 6607.834804129935, 6888.51780375389, 6894.965525172342, 6900.551464154814, 6905.240423553506], "unit": "score", "name": "prototype.html", "value": 5091.794380540615}, {"lowerIsBetter": false, "replicates": [664.5746722097857, 668.7826456401667, 700.5936556797059, 728.3517669274344, 765.4832987733279, 10613.31013484124, 14372.13767173969, 14695.118292902433, 14706.705865882675, 14720.411183552646, 13252.13861099028, 13305.933470332659, 13306.733865322687, 13330.266835324077, 13370.0, 867.2454964181155, 885.2121611765534, 888.9199972002518, 889.4352086425134, 889.5463313710022, 715.967781449836, 724.9057622509066, 869.3783944479695, 873.3319010956624, 876.0407353947418, 841.9284360829337, 916.0656130746635, 916.445550441983, 916.8716379706847, 919.9742287349591, 806.6329819931917, 902.6885724425063, 903.4172958441768, 907.6505545365048, 908.604756930734, 550.2324257660541, 558.3801979802416, 565.2877374508108, 675.5102550650788, 678.7929681447157, 12960.287184204864, 14586.92706536471, 14968.401263949429, 14984.625384365369, 15051.021683590532, 12390.504379824886, 12428.565000225039, 12448.0, 13025.739485210242, 13106.803397948943, 9923.702288931343, 10003.57660897728, 10201.0, 10226.539805708686, 10760.78478430435, 3399.3031428557088, 3493.8777142800136, 3496.6503349665086, 3498.702610278129, 3501.509788629594, 73027.72757372523, 73745.6312718433, 74768.0, 74851.0, 74979.99999999946, 9416.670416535526, 9671.371360861522, 9718.611255549698, 9810.969848165983, 10044.397336159855, 16988.57528561771, 21818.127274909144, 22078.448038799157, 22087.447813804785, 22112.00495977685, 7633.0, 7633.465657403928, 7721.189275126031, 7745.07059152894, 7880.605969701606, 4170.395292682544, 4215.536291007987, 4222.809973551198, 4226.936595951063, 4299.118680670455, 3555.7510974231554, 3605.3690604144695, 3606.855725770992, 3610.7291953103622, 3611.880317101707, 559.8404454730382, 673.0610797936948, 675.6554157379771, 683.4122654517112, 688.5696439725172, 505.4591587001946, 571.2830397850671, 589.78178074112, 591.99952080983, 614.0206370838505, 8068.273855353046, 8211.096779354266, 8214.4660597061, 8342.29090527312, 8411.621477033548, 467.5441444591496, 506.62256618819214, 533.5065064815108, 541.5423966748092, 589.5136512377306, 3857.4792403025795, 3937.1338305572726, 4016.2369149861433, 4149.668026557868, 4199.307114326163, 88864.0, 90535.54732226297, 91444.0, 91684.54157729169, 92105.0, 60700.69649651724, 78468.21531784724, 79042.0, 79715.60142199251, 81534.0, 69497.3050269501, 69636.30363696399, 71758.0, 71853.64073179601, 71995.0, 7953.244441778022, 8249.546274954935, 8337.541435221121, 8431.19903609156, 8569.614367353359, 46222.61332160041, 46687.76339667357, 47228.055438891715, 47448.52551474441, 48189.0, 66664.33335666581, 67542.32457675556, 68439.97340039804, 70036.0, 70367.0, 10250.0, 10250.53872575721, 10384.42885641297, 10401.94799026, 10883.23817332779, 11879.703007424883, 12038.699032524257, 12183.634490965285, 12551.560695375618, 12608.936955315165, 11576.47905844256, 11828.17202795796, 11928.403579821148, 12043.819342710041, 12051.33717645538, 11512.884871151517, 11548.653540393801, 11555.075593952632, 11600.955913967784, 12033.217840840318, 11053.723656908642, 11252.099832013582, 11278.0, 11326.886731132912, 11976.76046479083, 8830.646774128963, 8911.910880891108, 9053.68312109073, 9312.813743724952, 9326.533673316171, 6921.6193109379465, 8976.506292153994, 9792.657256995972, 9809.803803924024, 9979.0], "unit": "score", "name": "yui.html", "value": 6763.914952335377}], "name": "dromaeo_css", "value": 7521.226957419985}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 110.0, 110.0, 111.0, 114.0, 111.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 144.0, 156.0, 122.0, 141.0, 140.0, 120.0, 160.0, 115.0], "unit": "score", "name": "audio-beat-detection", "value": 137.6}, {"lowerIsBetter": true, "replicates": [187.0, 185.0, 187.0, 185.0, 188.0, 185.0, 188.0, 187.0, 179.0, 261.0], "unit": "score", "name": "audio-dft", "value": 193.2}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 88.0, 105.0, 83.0, 85.0, 61.0, 88.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 125.0, 79.0, 80.0, 84.0, 112.0, 77.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 83.0, 90.0, 83.0, 89.0, 83.0, 89.0, 82.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.0}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 92.0, 92.0, 100.0, 104.0, 93.0, 92.0, 91.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 87.0, 88.0, 88.0, 88.0, 86.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.9}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 54.0, 53.0, 56.0, 54.0, 56.0, 68.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 70.0, 74.0, 73.0, 70.0, 68.0, 68.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 85.0, 83.0, 81.0, 82.0, 81.0, 84.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [128.0, 130.0, 128.0, 115.0, 142.0, 134.0, 125.0, 130.0, 118.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.3}, {"lowerIsBetter": true, "replicates": [137.0, 107.0, 154.0, 173.0, 174.0, 130.0, 139.0, 137.0, 139.0, 177.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 67.0, 68.0, 66.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1430.2}]} 21:31:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1430.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7521.22"}}} 21:31:07 INFO - Return code: 0 21:31:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:31:07 INFO - # TBPL SUCCESS # 21:31:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:31:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:31:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:31:07 INFO - 2016-02-06 21:31:07.100 screenresolution[2371:31527] starting screenresolution argv=screenresolution get 21:31:07 INFO - 2016-02-06 21:31:07.103 screenresolution[2371:31527] Display 0: 1600x1200x32@60 21:31:07 INFO - 2016-02-06 21:31:07.109 screenresolution[2372:31530] starting screenresolution argv=screenresolution list 21:31:07 INFO - Available Modes on Display 0 21:31:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:31:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:31:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:31:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:31:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:31:07 INFO - Intel Iris: 21:31:07 INFO - Chipset Model: Intel Iris 21:31:07 INFO - Type: GPU 21:31:07 INFO - Bus: Built-In 21:31:07 INFO - VRAM (Dynamic, Max): 1536 MB 21:31:07 INFO - Vendor: Intel (0x8086) 21:31:07 INFO - Device ID: 0x0a2e 21:31:07 INFO - Revision ID: 0x0009 21:31:07 INFO - Displays: 21:31:07 INFO - Display: 21:31:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:31:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:31:07 INFO - Display Serial Number: 1600x1200 60 21:31:07 INFO - Main Display: Yes 21:31:07 INFO - Mirror: Off 21:31:07 INFO - Online: Yes 21:31:07 INFO - Rotation: Supported 21:31:07 INFO - Return code: 0 21:31:07 INFO - Running post-action listener: _resource_record_post_action 21:31:07 INFO - Running post-run listener: _resource_record_post_run 21:31:08 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 196608; Write bytes: 712891904; Read time: 1; Write time: 1893 21:31:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406196736; Write bytes: 408761856; Read time: 30271; Write time: 751 21:31:08 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 196608; Write bytes: 302544896; Read time: 1; Write time: 1138 21:31:08 INFO - Running post-run listener: _upload_blobber_files 21:31:08 INFO - Blob upload gear active. 21:31:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:31:08 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 21:31:08 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'] 21:31:08 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 21:31:08 INFO - (blobuploader) - INFO - Open directory for files ... 21:31:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:31:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:31:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:10 INFO - (blobuploader) - INFO - Done attempting. 21:31:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:31:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:31:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:31:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:31:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:31:11 INFO - (blobuploader) - INFO - Done attempting. 21:31:11 INFO - (blobuploader) - INFO - Iteration through files over. 21:31:11 INFO - Return code: 0 21:31:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:31:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:31:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dfc7650b383b6fd2aa3b221b7fef140e55a8c4749e8dd34cf7e58178b7fd6ad2813697783a009af0d09b6c84dd22fab2bf2365e76540556c0d037dc000e38d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4af71dc966ad868657dbfdd8de255883ca9f1a25d1241542686e186fa8d572f85d52b2bf2972ed06f47c24df9f508a8a9142be41f74f263ea4aea437a285ed0"} 21:31:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:31:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:31:11 INFO - Contents: 21:31:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dfc7650b383b6fd2aa3b221b7fef140e55a8c4749e8dd34cf7e58178b7fd6ad2813697783a009af0d09b6c84dd22fab2bf2365e76540556c0d037dc000e38d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4af71dc966ad868657dbfdd8de255883ca9f1a25d1241542686e186fa8d572f85d52b2bf2972ed06f47c24df9f508a8a9142be41f74f263ea4aea437a285ed0"} 21:31:11 INFO - Running post-run listener: copy_logs_to_upload_dir 21:31:11 INFO - Copying logs to upload dir... 21:31:11 INFO - mkdir: /builds/slave/test/build/upload/logs 21:31:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.940354 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-06 21:31:11.315081) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 21:31:11.320059) ========= 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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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/4dfc7650b383b6fd2aa3b221b7fef140e55a8c4749e8dd34cf7e58178b7fd6ad2813697783a009af0d09b6c84dd22fab2bf2365e76540556c0d037dc000e38d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4af71dc966ad868657dbfdd8de255883ca9f1a25d1241542686e186fa8d572f85d52b2bf2972ed06f47c24df9f508a8a9142be41f74f263ea4aea437a285ed0"} build_url:https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011390 build_url: 'https://queue.taskcluster.net/v1/task/RPefQtumRMKlziDWlyo5Yg/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/4dfc7650b383b6fd2aa3b221b7fef140e55a8c4749e8dd34cf7e58178b7fd6ad2813697783a009af0d09b6c84dd22fab2bf2365e76540556c0d037dc000e38d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4af71dc966ad868657dbfdd8de255883ca9f1a25d1241542686e186fa8d572f85d52b2bf2972ed06f47c24df9f508a8a9142be41f74f263ea4aea437a285ed0"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 21:31:11.496896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:31:11.497538) ========= 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.pMmBRIhnnn/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.Hiwe80EoeV/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.004666 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 21:31:11.530928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 21:31:11.534650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 21:31:11.540737) ========= ========= Total master_lag: 0.45 =========