builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1455060095.58 results: success (0) buildid: 20160209134218 builduid: 18f6776c2f92445a9c46374cac228e92 revision: e4c297c3a475db2b8b57fc249826fc59daefd288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.582346) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.582934) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.583321) ========= 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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.005661 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.609042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.609404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.626360) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.626697) ========= 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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.005547 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.678490) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.679154) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.679952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.680563) ========= 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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-09 15:21:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 136M=0s 2016-02-09 15:21:35 (136 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177168 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.876565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.877282) ========= 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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.026852 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:35.928625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 15:21:35.929299) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4c297c3a475db2b8b57fc249826fc59daefd288 --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 e4c297c3a475db2b8b57fc249826fc59daefd288 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-09 15:21:35,998 truncating revision to first 12 chars 2016-02-09 15:21:35,998 Setting DEBUG logging. 2016-02-09 15:21:35,998 attempt 1/10 2016-02-09 15:21:35,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4c297c3a475?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 15:21:37,260 unpacking tar archive at: fx-team-e4c297c3a475/testing/mozharness/ program finished with exit code 0 elapsedTime=1.495985 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 15:21:37.445258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:37.445672) ========= echo e4c297c3a475db2b8b57fc249826fc59daefd288 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e4c297c3a475db2b8b57fc249826fc59daefd288'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 e4c297c3a475db2b8b57fc249826fc59daefd288 program finished with exit code 0 elapsedTime=0.005347 script_repo_revision: 'e4c297c3a475db2b8b57fc249826fc59daefd288' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:37.495894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:37.496244) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 15:21:37.509477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-09 15:21:37.509846) ========= /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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:21:37 INFO - MultiFileLogger online at 20160209 15:21:37 in /builds/slave/test 15:21:37 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 15:21:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:37 INFO - {'append_to_log': False, 15:21:37 INFO - 'base_work_dir': '/builds/slave/test', 15:21:37 INFO - 'blob_upload_branch': 'Fx-Team', 15:21:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:37 INFO - 'branch': 'Fx-Team', 15:21:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:37 INFO - 'config_files': ('talos/mac_config.py',), 15:21:37 INFO - 'default_actions': ('clobber', 15:21:37 INFO - 'read-buildbot-config', 15:21:37 INFO - 'download-and-extract', 15:21:37 INFO - 'populate-webroot', 15:21:37 INFO - 'create-virtualenv', 15:21:37 INFO - 'install', 15:21:37 INFO - 'run-tests'), 15:21:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:37 INFO - 'download_minidump_stackwalk': True, 15:21:37 INFO - 'download_symbols': 'ondemand', 15:21:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:21:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:21:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:21:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:21:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:37 INFO - 'installer_path': 'installer.exe', 15:21:37 INFO - 'log_level': 'info', 15:21:37 INFO - 'log_name': 'talos', 15:21:37 INFO - 'log_to_console': True, 15:21:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:21:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:21:37 INFO - 'opt_config_files': (), 15:21:37 INFO - 'pip_index': False, 15:21:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:21:37 INFO - 'cmd': ('bash', 15:21:37 INFO - '-c', 15:21:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:21:37 INFO - 'enabled': True, 15:21:37 INFO - 'halt_on_failure': False, 15:21:37 INFO - 'name': 'check_screen_resolution'},), 15:21:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:21:37 INFO - 'cmd': ('bash', 15:21:37 INFO - '-c', 15:21:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:21:37 INFO - 'enabled': True, 15:21:37 INFO - 'halt_on_failure': False, 15:21:37 INFO - 'name': 'check_screen_resolution'},), 15:21:37 INFO - 'run_cmd_checks_enabled': True, 15:21:37 INFO - 'sps_profile': False, 15:21:37 INFO - 'sps_profile_interval': 0, 15:21:37 INFO - 'suite': 'dromaeojs', 15:21:37 INFO - 'system_bits': '32', 15:21:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:37 INFO - 'title': 't-yosemite-r7-0022', 15:21:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:37 INFO - 'use_talos_json': True, 15:21:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:37 INFO - 'work_dir': 'build'} 15:21:37 INFO - ##### 15:21:37 INFO - ##### Running clobber step. 15:21:37 INFO - ##### 15:21:37 INFO - Running pre-action listener: _resource_record_pre_action 15:21:37 INFO - Running main action method: clobber 15:21:37 INFO - rmtree: /builds/slave/test/build 15:21:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:39 INFO - Running post-action listener: _resource_record_post_action 15:21:39 INFO - ##### 15:21:39 INFO - ##### Running read-buildbot-config step. 15:21:39 INFO - ##### 15:21:39 INFO - Running pre-action listener: _resource_record_pre_action 15:21:39 INFO - Running main action method: read_buildbot_config 15:21:39 INFO - Using buildbot properties: 15:21:39 INFO - { 15:21:39 INFO - "project": "", 15:21:39 INFO - "product": "firefox", 15:21:39 INFO - "script_repo_revision": "production", 15:21:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:21:39 INFO - "repository": "", 15:21:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:21:39 INFO - "buildid": "20160209134218", 15:21:39 INFO - "pgo_build": "False", 15:21:39 INFO - "basedir": "/builds/slave/test", 15:21:39 INFO - "buildnumber": 357, 15:21:39 INFO - "slavename": "t-yosemite-r7-0022", 15:21:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:21:39 INFO - "platform": "yosemite_r7", 15:21:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:21:39 INFO - "branch": "fx-team", 15:21:39 INFO - "repo_path": "integration/fx-team", 15:21:39 INFO - "revision": "e4c297c3a475db2b8b57fc249826fc59daefd288", 15:21:39 INFO - "stage_platform": "macosx64", 15:21:39 INFO - "builduid": "18f6776c2f92445a9c46374cac228e92", 15:21:39 INFO - "slavebuilddir": "test" 15:21:39 INFO - } 15:21:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:21:39 INFO - Running post-action listener: _resource_record_post_action 15:21:39 INFO - ##### 15:21:39 INFO - ##### Running download-and-extract step. 15:21:39 INFO - ##### 15:21:39 INFO - Running pre-action listener: _resource_record_pre_action 15:21:39 INFO - Running main action method: download_and_extract 15:21:39 INFO - mkdir: /builds/slave/test/build/tests 15:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:39 INFO - https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/test_packages.json 15:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/test_packages.json 15:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:21:40 INFO - Downloaded 1277 bytes. 15:21:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:21:40 INFO - Using the following test package requirements: 15:21:40 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:21:40 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:21:40 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:21:40 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'jsshell-mac.zip'], 15:21:40 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:21:40 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:21:40 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:21:40 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:21:40 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:21:40 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:21:40 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:21:40 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:21:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:21: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')]} 15:21:40 INFO - https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:21:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:21:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:21:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:42 INFO - Downloaded 17747091 bytes. 15:21:42 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'] 15:21:42 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 15:21:45 INFO - Return code: 0 15:21:45 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 15:21: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')]} 15:21:45 INFO - https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:21:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:21:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:21:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:46 INFO - Downloaded 17747091 bytes. 15:21:46 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'] 15:21:46 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 15:21:49 INFO - Return code: 0 15:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:49 INFO - https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:21:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:21:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:21:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:50 INFO - Downloaded 10706547 bytes. 15:21:50 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'] 15:21:50 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 15:21:50 INFO - Return code: 0 15:21: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')]} 15:21:50 INFO - https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:21:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:21:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:21:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:21:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DveTaO1YTC6T16T5WgKbhw/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 15:21:54 INFO - Downloaded 111244756 bytes. 15:21:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:21:54 INFO - mkdir: /builds/slave/test/properties 15:21:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:21:54 INFO - Writing to file /builds/slave/test/properties/build_url 15:21:54 INFO - Contents: 15:21:54 INFO - build_url:https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:21:55 INFO - Running post-action listener: _resource_record_post_action 15:21:55 INFO - Running post-action listener: set_extra_try_arguments 15:21:55 INFO - ##### 15:21:55 INFO - ##### Running populate-webroot step. 15:21:55 INFO - ##### 15:21:55 INFO - Running pre-action listener: _resource_record_pre_action 15:21:55 INFO - Running main action method: populate_webroot 15:21:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:21:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:21:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:21:55 INFO - '--tppagecycles', 15:21:55 INFO - '7'], 15:21:55 INFO - 'tests': ['tsvgm']}}, 15:21:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:21:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:21:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:21:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:21:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'tests': ['damp', 'tps']}, 15:21:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['damp', 'tps']}, 15:21:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:21:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:21:55 INFO - 'other': {'tests': ['a11yr', 15:21:55 INFO - 'ts_paint', 15:21:55 INFO - 'tpaint', 15:21:55 INFO - 'sessionrestore', 15:21:55 INFO - 'sessionrestore_no_auto_restore']}, 15:21:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['a11yr', 15:21:55 INFO - 'ts_paint', 15:21:55 INFO - 'tpaint', 15:21:55 INFO - 'sessionrestore', 15:21:55 INFO - 'sessionrestore_no_auto_restore']}, 15:21:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['a11yr', 15:21:55 INFO - 'ts_paint', 15:21:55 INFO - 'tpaint', 15:21:55 INFO - 'sessionrestore', 15:21:55 INFO - 'sessionrestore_no_auto_restore']}, 15:21:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['a11yr', 15:21:55 INFO - 'ts_paint', 15:21:55 INFO - 'tpaint', 15:21:55 INFO - 'sessionrestore', 15:21:55 INFO - 'sessionrestore_no_auto_restore']}, 15:21:55 INFO - 'other_l64': {'tests': ['a11yr', 15:21:55 INFO - 'ts_paint', 15:21:55 INFO - 'tpaint', 15:21:55 INFO - 'sessionrestore', 15:21:55 INFO - 'sessionrestore_no_auto_restore']}, 15:21:55 INFO - 'other_nol64': {'tests': ['a11yr', 15:21:55 INFO - 'ts_paint', 15:21:55 INFO - 'tpaint', 15:21:55 INFO - 'sessionrestore', 15:21:55 INFO - 'sessionrestore_no_auto_restore']}, 15:21:55 INFO - 'svgr': {'tests': ['tsvgx', 15:21:55 INFO - 'tsvgr_opacity', 15:21:55 INFO - 'tart', 15:21:55 INFO - 'tscrollx', 15:21:55 INFO - 'cart']}, 15:21:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['tsvgx', 15:21:55 INFO - 'tsvgr_opacity', 15:21:55 INFO - 'tart', 15:21:55 INFO - 'tscrollx', 15:21:55 INFO - 'cart']}, 15:21:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'tests': ['tp5o']}, 15:21:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'talos_options': ['--e10s'], 15:21:55 INFO - 'tests': ['tp5o']}, 15:21:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'talos_options': ['--xperf_path', 15:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:55 INFO - 'tests': ['tp5n']}, 15:21:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:55 INFO - 'talos_options': ['--e10s', 15:21:55 INFO - '--xperf_path', 15:21:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:55 INFO - 'tests': ['tp5n']}}, 15:21:55 INFO - 'talos.zip': {'path': '', 15:21:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:21:55 INFO - Running post-action listener: _resource_record_post_action 15:21:55 INFO - ##### 15:21:55 INFO - ##### Running create-virtualenv step. 15:21:55 INFO - ##### 15:21:55 INFO - Running pre-action listener: _resource_record_pre_action 15:21:55 INFO - Running main action method: create_virtualenv 15:21:55 INFO - Creating virtualenv /builds/slave/test/build/venv 15:21:55 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 15:21:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:21:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:21:55 INFO - Using real prefix '/tools/python27' 15:21:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:21:56 INFO - Installing distribute.............................................................................................................................................................................................done. 15:21:59 INFO - Installing pip.................done. 15:21:59 INFO - Return code: 0 15:21:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:21:59 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 15:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:59 INFO - 'HOME': '/Users/cltbld', 15:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:59 INFO - 'LOGNAME': 'cltbld', 15:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:59 INFO - 'MOZ_NO_REMOTE': '1', 15:21:59 INFO - 'NO_EM_RESTART': '1', 15:21:59 INFO - 'PAGER': '/bin/cat', 15:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:59 INFO - 'PWD': '/builds/slave/test', 15:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:59 INFO - 'SHELL': '/bin/bash', 15:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:21:59 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:59 INFO - 'USER': 'cltbld', 15:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:59 INFO - 'XPC_FLAGS': '0x0', 15:21:59 INFO - 'XPC_SERVICE_NAME': '0', 15:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:59 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 15:21:59 INFO - Cleaning up... 15:21:59 INFO - Return code: 0 15:21:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:21:59 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 15:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:21:59 INFO - 'HOME': '/Users/cltbld', 15:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:21:59 INFO - 'LOGNAME': 'cltbld', 15:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:59 INFO - 'MOZ_NO_REMOTE': '1', 15:21:59 INFO - 'NO_EM_RESTART': '1', 15:21:59 INFO - 'PAGER': '/bin/cat', 15:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:59 INFO - 'PWD': '/builds/slave/test', 15:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:21:59 INFO - 'SHELL': '/bin/bash', 15:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:21:59 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:21:59 INFO - 'USER': 'cltbld', 15:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:59 INFO - 'XPC_FLAGS': '0x0', 15:21:59 INFO - 'XPC_SERVICE_NAME': '0', 15:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:00 INFO - Downloading/unpacking psutil>=0.7.1 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:02 INFO - Installing collected packages: psutil 15:22:02 INFO - Running setup.py install for psutil 15:22:02 INFO - building 'psutil._psutil_osx' extension 15:22:02 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 15:22:03 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 15:22:03 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 15:22:03 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 15:22:03 INFO - building 'psutil._psutil_posix' extension 15:22:03 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 15:22:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:22:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:22:03 INFO - ^ 15:22:03 INFO - 1 warning generated. 15:22:03 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 15:22:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:03 INFO - Successfully installed psutil 15:22:03 INFO - Cleaning up... 15:22:04 INFO - Return code: 0 15:22:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:04 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:04 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 15:22:04 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 15:22:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:04 INFO - 'HOME': '/Users/cltbld', 15:22:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:04 INFO - 'LOGNAME': 'cltbld', 15:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:04 INFO - 'MOZ_NO_REMOTE': '1', 15:22:04 INFO - 'NO_EM_RESTART': '1', 15:22:04 INFO - 'PAGER': '/bin/cat', 15:22:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:04 INFO - 'PWD': '/builds/slave/test', 15:22:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:04 INFO - 'SHELL': '/bin/bash', 15:22:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:04 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:04 INFO - 'USER': 'cltbld', 15:22:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:04 INFO - 'XPC_FLAGS': '0x0', 15:22:04 INFO - 'XPC_SERVICE_NAME': '0', 15:22:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:22:04 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 15:22:04 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 15:22:04 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 15:22:04 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 15:22:04 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 15:22:04 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 15:22:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:22:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:22:06 INFO - Installing collected packages: mozsystemmonitor 15:22:06 INFO - Running setup.py install for mozsystemmonitor 15:22:06 INFO - Successfully installed mozsystemmonitor 15:22:06 INFO - Cleaning up... 15:22:06 INFO - Return code: 0 15:22:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:06 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:06 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 15:22:06 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 15:22:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:06 INFO - 'HOME': '/Users/cltbld', 15:22:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:06 INFO - 'LOGNAME': 'cltbld', 15:22:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:06 INFO - 'MOZ_NO_REMOTE': '1', 15:22:06 INFO - 'NO_EM_RESTART': '1', 15:22:06 INFO - 'PAGER': '/bin/cat', 15:22:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:06 INFO - 'PWD': '/builds/slave/test', 15:22:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:06 INFO - 'SHELL': '/bin/bash', 15:22:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:06 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:06 INFO - 'USER': 'cltbld', 15:22:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:06 INFO - 'XPC_FLAGS': '0x0', 15:22:06 INFO - 'XPC_SERVICE_NAME': '0', 15:22:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:09 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 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 15:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:10 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 15:22:10 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 15:22:10 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 15:22:10 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 15:22:10 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 15:22:10 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 15:22:10 INFO - Downloading docopt-0.6.1.tar.gz 15:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:10 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:10 INFO - Running setup.py install for blobuploader 15:22:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:10 INFO - Running setup.py install for requests 15:22:11 INFO - Running setup.py install for docopt 15:22:11 INFO - Successfully installed blobuploader requests docopt 15:22:11 INFO - Cleaning up... 15:22:11 INFO - Return code: 0 15:22:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:11 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:11 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 15:22:11 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 15:22:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:11 INFO - 'HOME': '/Users/cltbld', 15:22:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:11 INFO - 'LOGNAME': 'cltbld', 15:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:11 INFO - 'MOZ_NO_REMOTE': '1', 15:22:11 INFO - 'NO_EM_RESTART': '1', 15:22:11 INFO - 'PAGER': '/bin/cat', 15:22:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:11 INFO - 'PWD': '/builds/slave/test', 15:22:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:11 INFO - 'SHELL': '/bin/bash', 15:22:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:11 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:11 INFO - 'USER': 'cltbld', 15:22:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:11 INFO - 'XPC_FLAGS': '0x0', 15:22:11 INFO - 'XPC_SERVICE_NAME': '0', 15:22:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:11 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-Cyi81T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:11 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-pEzhx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:11 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-n6AWsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-1z7YnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-eudxtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-uFCZc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-R93lid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-1VfNR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-cl1Hj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-CuwMoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-uCW5i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:12 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-EgIDbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:13 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-3NXlT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:13 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-sgFdlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:13 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-yBOhQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:13 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-BchE75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:13 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-cAuxcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:13 INFO - Running setup.py install for manifestparser 15:22:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:13 INFO - Running setup.py install for mozcrash 15:22:13 INFO - Running setup.py install for mozdebug 15:22:13 INFO - Running setup.py install for mozdevice 15:22:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Running setup.py install for mozfile 15:22:14 INFO - Running setup.py install for mozhttpd 15:22:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Running setup.py install for mozinfo 15:22:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Running setup.py install for mozInstall 15:22:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:14 INFO - Running setup.py install for mozleak 15:22:14 INFO - Running setup.py install for mozlog 15:22:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:15 INFO - Running setup.py install for moznetwork 15:22:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:15 INFO - Running setup.py install for mozprocess 15:22:15 INFO - Running setup.py install for mozprofile 15:22:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:15 INFO - Running setup.py install for mozrunner 15:22:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:15 INFO - Running setup.py install for mozscreenshot 15:22:15 INFO - Running setup.py install for moztest 15:22:15 INFO - Running setup.py install for mozversion 15:22:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:16 INFO - Cleaning up... 15:22:16 INFO - Return code: 0 15:22:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:16 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')]} 15:22:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 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')]} 15:22:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:16 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:16 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 15:22:16 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 15:22:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:16 INFO - 'HOME': '/Users/cltbld', 15:22:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:16 INFO - 'LOGNAME': 'cltbld', 15:22:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:16 INFO - 'MOZ_NO_REMOTE': '1', 15:22:16 INFO - 'NO_EM_RESTART': '1', 15:22:16 INFO - 'PAGER': '/bin/cat', 15:22:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:16 INFO - 'PWD': '/builds/slave/test', 15:22:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:16 INFO - 'SHELL': '/bin/bash', 15:22:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:16 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:16 INFO - 'USER': 'cltbld', 15:22:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:16 INFO - 'XPC_FLAGS': '0x0', 15:22:16 INFO - 'XPC_SERVICE_NAME': '0', 15:22:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-dxMArZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:16 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)) 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-UlM4IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:16 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)) 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-PcSDf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:16 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)) 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-7rb8SH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:16 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)) 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-3wcXK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:16 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)) 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-T08f4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:16 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)) 15:22:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:16 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-ksPt_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-QG0yen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-KdZvKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-pQ6kSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-GOSFeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-PQWo5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-vg5iWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-KQuzC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-6mSF6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:17 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)) 15:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:17 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-PiQpOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:18 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)) 15:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:18 INFO - Running setup.py (path:/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/pip-vy_tAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:18 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)) 15:22:18 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)) 15:22:18 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)) 15:22:18 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)) 15:22:18 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)) 15:22:18 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)) 15:22:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:20 INFO - Downloading blessings-1.6.tar.gz 15:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:20 INFO - Installing collected packages: blessings 15:22:20 INFO - Running setup.py install for blessings 15:22:20 INFO - Successfully installed blessings 15:22:20 INFO - Cleaning up... 15:22:20 INFO - Return code: 0 15:22:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:21 INFO - Reading from file tmpfile_stdout 15:22:21 INFO - Current package versions: 15:22:21 INFO - blessings == 1.6 15:22:21 INFO - blobuploader == 1.2.4 15:22:21 INFO - docopt == 0.6.1 15:22:21 INFO - manifestparser == 1.1 15:22:21 INFO - mozInstall == 1.12 15:22:21 INFO - mozcrash == 0.16 15:22:21 INFO - mozdebug == 0.1 15:22:21 INFO - mozdevice == 0.48 15:22:21 INFO - mozfile == 1.2 15:22:21 INFO - mozhttpd == 0.7 15:22:21 INFO - mozinfo == 0.9 15:22:21 INFO - mozleak == 0.1 15:22:21 INFO - mozlog == 3.1 15:22:21 INFO - moznetwork == 0.27 15:22:21 INFO - mozprocess == 0.22 15:22:21 INFO - mozprofile == 0.28 15:22:21 INFO - mozrunner == 6.11 15:22:21 INFO - mozscreenshot == 0.1 15:22:21 INFO - mozsystemmonitor == 0.0 15:22:21 INFO - moztest == 0.7 15:22:21 INFO - mozversion == 1.4 15:22:21 INFO - psutil == 3.1.1 15:22:21 INFO - requests == 1.2.3 15:22:21 INFO - wsgiref == 0.1.2 15:22:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:21 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')]} 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:21 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')]} 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:21 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:21 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 15:22:21 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 15:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:21 INFO - 'HOME': '/Users/cltbld', 15:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:21 INFO - 'LOGNAME': 'cltbld', 15:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:21 INFO - 'MOZ_NO_REMOTE': '1', 15:22:21 INFO - 'NO_EM_RESTART': '1', 15:22:21 INFO - 'PAGER': '/bin/cat', 15:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:21 INFO - 'PWD': '/builds/slave/test', 15:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:21 INFO - 'SHELL': '/bin/bash', 15:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:21 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:21 INFO - 'USER': 'cltbld', 15:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:21 INFO - 'XPC_FLAGS': '0x0', 15:22:21 INFO - 'XPC_SERVICE_NAME': '0', 15:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 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)) 15:22:21 INFO - Cleaning up... 15:22:21 INFO - Return code: 0 15:22:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:21 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')]} 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:21 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')]} 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:21 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:21 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 15:22:21 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 15:22:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:21 INFO - 'HOME': '/Users/cltbld', 15:22:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:21 INFO - 'LOGNAME': 'cltbld', 15:22:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:21 INFO - 'MOZ_NO_REMOTE': '1', 15:22:21 INFO - 'NO_EM_RESTART': '1', 15:22:21 INFO - 'PAGER': '/bin/cat', 15:22:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:21 INFO - 'PWD': '/builds/slave/test', 15:22:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:21 INFO - 'SHELL': '/bin/bash', 15:22:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:21 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:21 INFO - 'USER': 'cltbld', 15:22:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:21 INFO - 'XPC_FLAGS': '0x0', 15:22:21 INFO - 'XPC_SERVICE_NAME': '0', 15:22:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:21 INFO - Downloading/unpacking jsonschema 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:23 INFO - Downloading/unpacking functools32 (from jsonschema) 15:22:23 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 15:22:23 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 15:22:23 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 15:22:23 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 15:22:23 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 15:22:23 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 15:22:24 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:24 INFO - warning: no files found matching '*.txt' 15:22:24 INFO - no previously-included directories found matching 'build' 15:22:24 INFO - no previously-included directories found matching 'dist' 15:22:24 INFO - no previously-included directories found matching '.git*' 15:22:24 INFO - Installing collected packages: jsonschema, functools32 15:22:24 INFO - Running setup.py install for functools32 15:22:24 INFO - warning: no files found matching '*.txt' 15:22:24 INFO - no previously-included directories found matching 'build' 15:22:24 INFO - no previously-included directories found matching 'dist' 15:22:24 INFO - no previously-included directories found matching '.git*' 15:22:24 INFO - Successfully installed jsonschema functools32 15:22:24 INFO - Cleaning up... 15:22:24 INFO - Return code: 0 15:22:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:24 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 0x101104a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10110c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90acd70c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, '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.EjDohkx3qu/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.1NXfh6YOvH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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 15:22:24 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 15:22:24 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 15:22:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:22:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:22:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:22:24 INFO - 'HOME': '/Users/cltbld', 15:22:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:22:24 INFO - 'LOGNAME': 'cltbld', 15:22:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:24 INFO - 'MOZ_NO_REMOTE': '1', 15:22:24 INFO - 'NO_EM_RESTART': '1', 15:22:24 INFO - 'PAGER': '/bin/cat', 15:22:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:22:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:24 INFO - 'PWD': '/builds/slave/test', 15:22:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:22:24 INFO - 'SHELL': '/bin/bash', 15:22:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:22:24 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:22:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:22:24 INFO - 'USER': 'cltbld', 15:22:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:22:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:22:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:24 INFO - 'XPC_FLAGS': '0x0', 15:22:24 INFO - 'XPC_SERVICE_NAME': '0', 15:22:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:22:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:24 INFO - Downloading/unpacking flake8 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:22:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:22:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:27 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 15:22:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:22:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:22:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:22:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:22:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:22:28 INFO - no previously-included directories found matching 'docs/_build' 15:22:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:22:28 INFO - Running setup.py install for pep8 15:22:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:22:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:22:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:22:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:22:28 INFO - no previously-included directories found matching 'docs/_build' 15:22:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:22:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:22:28 INFO - Cleaning up... 15:22:28 INFO - Return code: 0 15:22:28 INFO - Running post-action listener: _resource_record_post_action 15:22:28 INFO - Running post-action listener: _start_resource_monitoring 15:22:28 INFO - Starting resource monitoring. 15:22:28 INFO - ##### 15:22:28 INFO - ##### Running install step. 15:22:28 INFO - ##### 15:22:28 INFO - Running pre-action listener: _resource_record_pre_action 15:22:28 INFO - Running main action method: install 15:22:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:29 INFO - Reading from file tmpfile_stdout 15:22:29 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:29 INFO - Reading from file tmpfile_stdout 15:22:29 INFO - Output received: 15:22:29 INFO - Usage: mozinstall [options] installer 15:22:29 INFO - Options: 15:22:29 INFO - -h, --help show this help message and exit 15:22:29 INFO - -d DEST, --destination=DEST 15:22:29 INFO - Directory to install application into. [default: 15:22:29 INFO - "/builds/slave/test"] 15:22:29 INFO - --app=APP Application being installed. [default: firefox] 15:22:29 INFO - mkdir: /builds/slave/test/build/application 15:22:29 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'] 15:22:29 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 15:23:03 INFO - Reading from file tmpfile_stdout 15:23:03 INFO - Output received: 15:23:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:23:03 INFO - Running post-action listener: _resource_record_post_action 15:23:03 INFO - ##### 15:23:03 INFO - ##### Running run-tests step. 15:23:03 INFO - ##### 15:23:03 INFO - Running pre-action listener: _resource_record_pre_action 15:23:03 INFO - Running main action method: run_tests 15:23:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:23:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:23:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:23:03 INFO - 2016-02-09 15:23:03.900 screenresolution[1651:7325] starting screenresolution argv=screenresolution get 15:23:03 INFO - 2016-02-09 15:23:03.903 screenresolution[1651:7325] Display 0: 1600x1200x32@60 15:23:03 INFO - 2016-02-09 15:23:03.909 screenresolution[1652:7327] starting screenresolution argv=screenresolution list 15:23:03 INFO - Available Modes on Display 0 15:23:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:23:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:23:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:23:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:23:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:23:04 INFO - Intel Iris: 15:23:04 INFO - Chipset Model: Intel Iris 15:23:04 INFO - Type: GPU 15:23:04 INFO - Bus: Built-In 15:23:04 INFO - VRAM (Dynamic, Max): 1536 MB 15:23:04 INFO - Vendor: Intel (0x8086) 15:23:04 INFO - Device ID: 0x0a2e 15:23:04 INFO - Revision ID: 0x0009 15:23:04 INFO - Displays: 15:23:04 INFO - Display: 15:23:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:23:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:23:04 INFO - Display Serial Number: 1600x1200 60 15:23:04 INFO - Main Display: Yes 15:23:04 INFO - Mirror: Off 15:23:04 INFO - Online: Yes 15:23:04 INFO - Rotation: Supported 15:23:04 INFO - Return code: 0 15:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:04 INFO - Python 2.7.3 15:23:04 INFO - Return code: 0 15:23:04 INFO - grabbing minidump binary from tooltool 15:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:23:04 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 0x100fa8d30>, '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 0x100dccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:04 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 15:23:04 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 15:23:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:04 INFO - Return code: 0 15:23:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:23:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:23:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:23:05 INFO - Return code: 0 15:23:05 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/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 15:23:05 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/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 15:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EjDohkx3qu/Render', 15:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:05 INFO - 'HOME': '/Users/cltbld', 15:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:05 INFO - 'LOGNAME': 'cltbld', 15:23:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:05 INFO - 'MOZ_NO_REMOTE': '1', 15:23:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:05 INFO - 'NO_EM_RESTART': '1', 15:23:05 INFO - 'PAGER': '/bin/cat', 15:23:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:05 INFO - 'PWD': '/builds/slave/test', 15:23:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:05 INFO - 'SHELL': '/bin/bash', 15:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1NXfh6YOvH/Listeners', 15:23:05 INFO - 'TMPDIR': '/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/', 15:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:05 INFO - 'USER': 'cltbld', 15:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:05 INFO - 'XPC_FLAGS': '0x0', 15:23:05 INFO - 'XPC_SERVICE_NAME': '0', 15:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:05 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/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 15:23:05 INFO - mozversion application_buildid: 20160209134218 15:23:05 INFO - mozversion application_changeset: e4c297c3a475db2b8b57fc249826fc59daefd288 15:23:05 INFO - mozversion application_display_name: Nightly 15:23:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:05 INFO - mozversion application_name: Firefox 15:23:05 INFO - mozversion application_remotingname: firefox 15:23:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:23:05 INFO - mozversion application_vendor: Mozilla 15:23:05 INFO - mozversion application_version: 47.0a1 15:23:05 INFO - mozversion platform_buildid: 20160209134218 15:23:05 INFO - mozversion platform_changeset: e4c297c3a475db2b8b57fc249826fc59daefd288 15:23:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:23:05 INFO - mozversion platform_version: 47.0a1 15:23:05 INFO - using testdate: 1455060185 15:23:05 INFO - actual date: 1455060185 15:23:06 INFO - starting webserver on 'localhost:49277' 15:23:06 INFO - SUITE-START | Running 2 tests 15:23:06 INFO - TEST-START | dromaeo_css 15:23:06 INFO - operating with platform_type : mac_ 15:23:06 INFO - Initialising browser for dromaeo_css test... 15:23:06 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpzpoKqI/profile http://localhost:49277/getInfo.html) 15:23:08 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 15:23:08 INFO - PROCESS | 1670 | colorDepth:24 15:23:08 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 15:23:08 INFO - PROCESS | 1670 | __metrics 15:23:08 INFO - PROCESS | 1670 | 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" 15:23:08 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:23:09 INFO - TEST-INFO | 1670: exit 0 15:23:09 INFO - Browser initialized. 15:23:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:23:09 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpzpoKqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:21 INFO - PROCESS | 1673 | RSS: Main: 247529472 15:23:21 INFO - PROCESS | 1673 | 15:24:12 INFO - PROCESS | 1673 | 1455060251999 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] 15:26:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 15:26:23 INFO - PROCESS | 1673 | RSS: Main: 403464192 15:26:23 INFO - PROCESS | 1673 | 15:29:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 15:29:26 INFO - PROCESS | 1673 | RSS: Main: 379944960 15:29:26 INFO - PROCESS | 1673 | 15:32:29 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 15:32:29 INFO - PROCESS | 1673 | RSS: Main: 379105280 15:32:29 INFO - PROCESS | 1673 | 15:35:32 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 15:35:32 INFO - PROCESS | 1673 | RSS: Main: 379363328 15:35:32 INFO - PROCESS | 1673 | 15:38:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 15:38:36 INFO - PROCESS | 1673 | RSS: Main: 350552064 15:38:36 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 15:41:39 INFO - PROCESS | 1673 | RSS: Main: 430411776 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | __start_tp_report 15:41:39 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 15:41:39 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 15:41:39 INFO - PROCESS | 1673 | |i|pagename|runs| 15:41:39 INFO - PROCESS | 1673 | |0;dojo.html;3231.1437469070693;3424.6404127566607;3442.0706409269496;3445.896623101308;3473.149078475772;5453.536449401806;5477.986572484088;5500.339959204896;5501.862453438656;5529.5023447889735;5502.504774570288;5545.140503222007;5638.323401191852;5663.971680141593;5666.121751128571;4981.701097934136;5031.270465782469;5070.188769796833;5077.289179514871;5218.139007063849;5146.897062058775;5169.017886601552;5178.430372659004;5196.740162991854;5209.609279304048;4910.5089491050785;4995.975020124913;5047.167217409123;5118.181091025455;5138.5889128869785;5136.075506408845;5160.948390516084;5166.173412254059;5166.819161329373;5178.844634660966;5080.085584594772;5102.923456148161;5104.2088476286235;5109.540141387293;5164.690118592896;5358.91961620576;5360.088784906575;5483.670979741189;5487.64330318528;5520.171974203861;6086.056661217518;6094.872448597023;6095.908561371583;6109.755609775648;6111.144439778434;5050.570701490377;6151.87696246077;6161.7535298588;6170.475509581691;6194.349593292684;5548.528375088082;5588.385277619459;5654.095344744821;5682.488576028178;5685.118806584986;6225.937740622627;6236.656983865931;6249.96875015622;6263.812085637438;6278.340774218733;5781.306243250837;5872.765089396376;5878.2358293421585;5884.0585506318785;5895.322037965603;5963.5527335450015;6084.056971169476;6132.01899668756;6163.044728067157;6174.25908890927;6029.6683682397015;6030.6080104793045;6031.125486804389;6033.456988871023;6069.908951365733;5841.591088623755;5954.255718035246;6097.359777223416;6104.38956104386;6108.205933228652;4767.261074533453;4796.992631547344;4799.544043315879;4810.59109975656;4847.175980083394;4247.384129301234;4261.21167583998;4261.97869010653;4270.12462445198;4294.677899157576;5458.4541545845095;5533.889322213614;5537.667739935617;5568;5575.498205161555;6096.817219442842;6129.23653806838;6143.754249830046;6145.385461453819;6146.108814221912;5533.059379905426;5538.6399884007415;5543.695096769636;5556.444355564492;5594.664320140804;5176.2494438306985;5208;5211.557017653542;5249.842504724865;5336.306280183629;5232.581393488588;6301.684915754194;6325.177726895567;6326.715297811609;6352.650604216812;6174.8147555573405;6177.907331389943;6186.19579454668;6191.25704915413;6204.565680402509;6214.689265536615;6223.471004964629;6333.113364128933;6334.271558770801;6342.968285158545;5968.432998865101;5970.522358211246;5975.133605627247;6016.518678505797;6058.242719660043;5982.641041537521;6110.816675499742;6139.386061393825;6140.447359737466;6141.324454309933;4982.053409852117;5762.078067509178;5812.389699081536;5937;6009.939900600938;5419.701916394636;5889.94110058894;5894.498967587803;5896.410358964241;5906.350301466749;5686.488216060575;5724.084146536534;5729.312482502127;5748.568857335633;5765.106408506688;5834.066549352084;5834.095715164156;5859.414058594107;5870.55970802183;5881;5696.686682232517;5697.401772813795;5735.598508104393;5738.426157384395;5745.1382292656435 15:41:39 INFO - PROCESS | 1673 | |1;ext.html;455.2033940603943;456.78302806167056;478.88746144656;490.62957467112324;572.2875020599352;24210.515789684196;37491;38367.232655346874;38416.61583384165;38468;40990.18019639605;41166.38250426239;41354.172916541655;41440.17119657613;41462.963425914364;9507.572159252833;9764.414135151877;9768.658096966608;9768.658096966608;9778.608855645765;9577.56900939456;9748;9749.220062395027;9749.317547771623;9868.753281167956;9806.411615303068;9858.01419858012;9868.506574671273;9899.15857152143;9926.106650401462;9786.510674466284;9875.555599998017;9880.20958323336;9881.802363952753;9882.456464894429;9708.126268635786;9844.90155098447;9867.358621689567;9869.309148359618;9875.851862222073;40218.99452513681;40573.985650358685;40604.39093413601;40614.78155655335;40701.592984070376;3164.145680666207;3230.144011836865;3355.9496607550905;3571.1250743567734;3758.962410375889;28397.00610478644;28661.85352585894;28794.424111517652;29182.854085729436;29463.410731785458;2799.7060308667706;2829.463938302528;2840.375117474173;2896.391757730879;2971.524556071018;449664;450292;450536;450810.23784643254;452087;57922.71038644864;59246.037698114924;62269.37730622727;62687.373126268154;62712;65392.34607653958;66386;66401.66799165973;66553;66580.66709666421;15748.133852638215;16159.757603635955;16181.867269291271;16185.514434566981;16188.352465901233;10394.68815935508;10554.313969591953;11662.542182227222;11682.76634467323;12349.93825030869;19042.238310467703;19053.523661908563;19097.618047639247;19115.228291897598;19179.32872349489;7909.3277071449575;8064.096925106956;8065.112837587861;8069.515829050276;8223.876641850376;953.9856902146473;995.3729150635054;997.7876879591331;1017.3692310767372;1116.3692513729716;27406;28337.433251334856;28585.142445726244;28704.569431458545;28906;1043.9791204175874;1099.4942326529886;1137.0278411957822;1138.9031932285682;1191.9106067045007;14341.856581434053;14503.92748036253;14768.852311476963;14841.480548180762;14893.63827024885;524965;528323;529206.3539682277;531012.3449382728;531387;57728.556786080684;57895;57924.262272131906;58002.709986449794;58192.4180758187;1417.723543908928;1423.558696803994;1443.6102252391795;1445.4796273341378;1451.3831621560794;27304.863475682494;27840.72159278381;27895.16314510568;30121.849390752905;31075.223119422197;47605;53061;53732;53745;54649.45350546444;352406.52138046845;357820;360289;360930;361166;29917.55123673103;30250.394992100475;30378.84810575933;30420.84789576038;30436;42018.94952626209;42417.575824241365;42464;42802;43629.34555981599;36050.73822416203;37103;37522;38047.239055219296;38572.22855542817;28520.714792851806;36236.63763362333;36933.81533092317;37252.06869828276;37467.25065498729;36218.63781362153;36278.8186059068;37352.813235933645;37437;37492.250154997295;29256.56115158232;31073.8446307767;31104.377912442076;31209;31225.219369515034;23689.881550592825;23768.64347034761;23925.52148957046;24072.638910416706;24092.75907240905 15:41:39 INFO - PROCESS | 1673 | |2;jquery.html;311.7396973527105;360.0889748935194;363.6309146216589;364.45150049175993;370.2982847503982;13504.887840297011;15090.39638414465;16617.83382166178;18501.629967400644;19414.126364313604;19415.22339106434;19579.825210487346;19596;19660.508487287825;20153;5407.405185429599;5710.086386178213;6238.00191969285;6559.409653131217;6577.112089867878;4503.572160644733;4709.387779588648;5846.532277417797;6704.832379190535;6850.1779786425695;7146.213916469184;7243.818904527377;7346.338829505344;7409.48133630646;7418.22108678589;7125.7149714011375;7289.927100729031;7305.634718264092;7313.524620899624;7508.737194198232;6996.440284777256;7064.364207221323;7110.253423390522;7129.18014428337;7133.144022717255;23809.880950595136;25050.874745626337;25278.747212527822;25494.745052549424;25613.359666008313;2266.8299877509253;2293.0827668932393;2391.4499665076955;2742.3281296082587;3060.8928687496054;14365.018446529886;15039.849601504064;15261.694766104727;15640.217989100613;15776.526704198892;1900.790912999569;1965.2237366240256;1967.891765952872;1985.1563085688524;1995.0722913844986;108426.45786771094;111086;111148.44425777819;111225;111350;18068.277268909096;18201;18373.54066148357;18483.98338091418;18494.537636558925;25753.74246257551;26600.866995665285;26678;26705.599416008776;26719.46561068768;8487.660493580188;9885.308028438085;9902;9909.900900991042;9997.400155990665;8340.666373344999;8347.749567512985;8383.874241886377;8396.328293736486;8413.957930210432;6945.501832367892;8000.959995199987;8286.4613800104;8441.029281632567;8455.408121431441;3298.950515742266;3392.728581713457;3413.4367829308385;3504.7897126172;3551.183227857607;867.4621734524509;916.244098618629;932.2541966426832;953.990460095404;989.5250279865561;14770.335334909954;17409.129543522773;18597.07014649262;18914.05429728508;19110.044497775056;892.2460520859863;932.1610550504464;943.2689665509286;944.527736131934;988.8121256961298;8802.691905783267;10021.344343748913;10148;10171.69484915439;10204.744881378025;551616;621260;681928.590357055;700501;723131;89958.20083598292;103027;113239;114336;120639;1189.4647408666135;1191.8152686333633;1195.7190060335813;1199.8920097191294;1210.1287073307205;18060.006699631645;18159.45644620222;18171.909140454212;18223.271069157086;18518.44444666662;36848;40594.78215653535;45297.54702452933;47833.56499305026;49218.50781492283;69570.65214673894;70326.94509582258;70640.29359706337;71018;71081.64459177671;7234;7494.213107623839;7538.246175382637;7540.9622951884885;7557.979672744329;7732.68544347451;9909.801803963735;11493.138014649103;11925.761484770082;12051.698707532381;10030.197584193102;10298.536565854405;10484.52819623134;10623;10662.680119596425;3986.6412022918075;9420.811583768149;9963.103320701171;10466.476676166314;10655.733606659585;8757.824843502967;10577.36535807854;10763.246572739834;10948.671539853816;11162.44187790591;7611.543307401574;7770.300672939463;7776.41676874248;7790.298873101448;7798.727044553413;10173.949130254301;10834.187435942178;10891.618793342195;11020.393878336768;11022.779544408906 15:41:39 INFO - PROCESS | 1673 | |3;mootools.html;1240.2992309345213;1513.6896936128094;1549.4511528535559;1757.7451269565913;1899.8955057471833;7829.138794732582;8483.575821208939;8639.611217495205;8643.697470588531;8651.69719059833;8261.339092872571;8598.140185981414;8604.483730976146;8610.182032706898;8610.225079742822;2105.7367829021373;2165.3936897668677;2169.4901698100934;2410.758924107584;2433.7687919647606;2379.7501262367464;2442.3039433761382;2451.705795304566;2452.865092419916;2454.9263522094366;2360.8583484990954;2388.0209114263157;2411.686480757499;2417.721961974369;2421.6004359280696;2398.2205783120557;2417.492326611414;2417.516496700658;2422.4428381472185;2437.293184976355;2404.9398765031015;2420.8789560521905;2430.1251549442186;2432.2946345559767;2439.1828737373003;8671.913280867173;8721.520316382597;8722.433041852322;8725.650973961034;8728.083551227093;5234.869128271824;5356.330458692663;5369.24830523727;5396.677813935572;5398.325209348832;3481.425564781808;3554.040409089557;3593.802340871251;3605.3149901518627;3624.1483251435893;1036.9948150259277;1052.0584077250894;1060.750723579958;1087.429099722652;1088.2436706488993;11675.241109327866;11742.823857642228;11751.529938802438;11764.823527647091;11784.88215117855;4662.6269898408045;4722.362481065081;4732.976335118303;4760.119377915097;4779.737114458669;9800.31397802147;9804;9809.656662016796;9818.852717209247;9825.803483930424;5308.469153084738;5310.575153987672;5313.973430132824;5317.654352467077;5343.118385466354;4816.277558366203;4816.614670826326;4825.179719447632;4828.565429111397;4848.200046992278;3629.709623230135;3718.925621487609;3829.2532956073856;3831.5976822433245;3924.60753924611;1284.389914790467;1303.7653222419865;1303.8761317674805;1314.2705798282045;1316.210273835691;1290.748304080714;1298.2340419152745;1312.9934350328188;1326.4893016188644;1334.4328660319325;8019.478733882279;8096.635651395702;8111.432199745961;8114.513129212266;8120.593970301579;1155.9017483513996;1165.877582853805;1177.7644471105814;1191.1840389333333;1195.384377045822;5344.759485823147;6247.00047992319;6331.240251169797;6344.143540621957;6349.238091429058;10326.225533084898;10382.169426445866;10474.947625261824;10487.26589138753;10606.204534659777;10117.038881306264;10312.845307320396;10443.94778026105;10454.581816727246;10458;8037.35701143907;8239.917600823916;8244.752657420288;8250.669973201126;8250.793730156674;7955.965724455784;7993.12075671664;7998.960005199937;8045.83908321842;8135.67457301725;8732.78168045804;9343.53282335867;9590.520473976134;9666.95166524163;9694.418334899929;9691.5154242289;9824.508774561386;10003.14973227284;10110.49447527606;10128.74678133023;7435.256474352522;7454.105507339154;7466.664000120117;7543.094828620381;7587.165411804807;7409.740659076906;7620.1998790128455;7622.428317876293;7623;7626.885596716164;6868.381845633917;7363.41092712571;7669.309762121213;7708.614569271626;7829.7259595913865;7459.738909138154;7603.505772124794;7636.160022397421;7674.731384401743;7726.884096738441;7610.657520411484;7736.651850666621;7756.185600511865;7758.185390533913;7760.3403710685225;6994.405475534637;7064.187618423947;7076.787696369117;7147.392471639969;7165.462590305644;7024.468032092653;7220.711171553289;7229.060222171084;7236.095488063992;7244.746433874789 15:41:39 INFO - PROCESS | 1673 | |4;prototype.html;315.9984200079;323.41946206559226;326.8316816839328;326.9977518904559;331.6964977046003;5449.863753406167;6610.041543976126;6622.47020238381;6649.634270115142;6674.466042716583;6194.59735117217;6403.61578305302;6411.487081033518;6422.454091402225;6520.902186467207;4759.928601070987;4788.257820037891;4795.976020119894;4873.366462359906;4875.293082503035;4850.12697714413;4881.023795240966;4889.608831293488;4902.926456103161;4914.189158788796;4754.9762251188695;4807.086653535835;4815.951840481585;4837.467878533358;4838.274258861182;4811.855644330658;4842;4856.878578035577;4862.173430516803;4869.2939523768855;4153.06556024895;4164.7709375984305;4165.291900376913;4166.66666666669;4188.5811418858175;6198.2871969723155;6220.844478888064;6242.6878656067465;6271;6291.496680265614;5551.390096871903;5691.004074287024;5698.6865722385255;5739;5748.540116790647;5782.10377391505;6218.4714299284615;6459.83850403739;6981.5461994970165;6991.615461149635;4647.070585882803;4682.4381074271305;4686.9765651171865;4691.601213896789;4691.7184968901975;7088.43292536601;7313.597752123631;7407.814804629874;7419.962900185465;7425.814354641123;3875.612438756158;4563.657725670588;4613.746243956548;4614.815407383734;4627.028324051987;4679.602233810164;4694.389729335165;4695.413073365829;4698.130845793539;4703.717776933395;4728.148933192058;5398.973005135028;5555.694436806015;5568.1091025435735;5571.498565129158;6837.692303846339;7035.753748618774;7040.92959070413;7049.577025378494;7079.2920707929825;1397.503886120433;1586.3099551694818;1654.586353411647;1682.6382327799581;1689.0372487681902;1036.72008557689;1087.4073629871739;1108.5898217659355;1120.2046546951592;1125.6735546691368;5413.593980451482;6597.3072827352435;6598.60408375499;6611.801645950629;6618.669066546653;6530;6558.639274839834;7235.89146162808;7248.130224373109;7272.345488906024;5330.333708286465;6312.905306420407;6504.479641628658;6510.837229069311;6525.184351956005;3096.303331750338;3763.0592351912023;3821.121142137324;3821.2739579479808;3823.101571130782;5402.297701298806;7542.622868856535;7561.243875612505;7577.507462014952;7585.772426827204;7136.714531418789;7399.704011839466;7403.481756277117;7414.740484083031;7441.702331906771;7253.492255542062;7553.7356192533;7572.053493313336;7580;7594.8101297468;6153.84615384619;7181.533200341961;7194.784156475314;7202.387797037101;7206.243344448757;7050.224475307609;7115.288471152843;7128.607926564089;7138.464615153988;7309.561426314438;7753.224677532202;7778.844423111619;7784.766457006299;7787.260210280015;7793.220677932161;4050.716449848482;4576.359309696579;4609.147307748078;4629.213033784197;4637.698549594265;5957.314908785545;7137.892931605927;7281.8179545509665;7309.707611695685;7347.412207023318;6774.695138718671;6892.931070689429;6993.475489338218;7117.43060555144;7130.714771409085;7055.470839686941;7103.431725461847;7112.182099058675;7124.430045596237;7139.8572028560175;6615.966920165369;6855.5543889647015;6940.02839602446;6947.44420446353;6959.478039146983;5974.6713930732485;6810.659467026728;7041.471889608198;7047.929520704727;7051.400630946427;6851.2806155354965;6865.485088618274;6873.450123989969;6877.277885822116;6878.243393226841 15:41:39 INFO - PROCESS | 1673 | |5;yui.html;635.6440393379706;663.1644128398217;720.8197950512371;737.454283829966;763.0652450747834;13723.696248856355;13724.17654940703;15121.84878151218;15130.546083617495;15149.848501514982;12633.178843375197;12691.175073620208;12697.047721420884;12723.363831808396;12761.553345632905;851.8935133108362;869.4652788535037;872.2934423117264;873.7902903303225;874.4622057434696;697.2330436519813;705.939995100417;866.3545658484406;873.7247766953421;878.8681697745326;892.2638822971043;910.6493999810054;912.1289168843738;913.392593925039;915.6840889892976;730.9707611695526;778.3073064972123;904.606496174163;906.5150144672568;908.0646933658343;544.6051612580848;545.8362491252608;546.0880329849161;548.6378989866669;659.5383231737754;14882;14949.626259343495;14967.401303947938;14976.550703478913;14989.0257133286;12606.117571769979;12693.746125077447;12785.264914726642;12979.41592628334;12985.610431687064;10206.713180464223;10227.051524574399;10238;10253.897461025443;10313.535890884854;3497.1257185703575;3529.2588556403184;3536.8231588420476;3540.2211513466996;3542.2384187399834;78427.99999999943;80150.19849801486;80303.7954430684;81480.59259703723;87216.25567488615;8052.798680032929;9698.224142068617;9708.90291097094;10049;10394.948025259826;21827.890860545594;22056.558868822856;22068.00693968775;22085.447863803533;22119.668204976937;7454.291842274975;7636.427267954926;7753.651085701157;7761.8447631047065;7886.763397098096;4002.1795531915886;4027.81874815634;4079.265732168238;4101.610347017028;4117.649999749995;3468.670476304747;3484.303139372136;3505.4040813061843;3506.631803660579;3510.420780571228;629.1003864473846;643.231338550437;645.309518814873;664.6842749693953;667.4093427316762;556.2074044486671;569.3480964295858;578.2396149064051;618.0821480102045;624.3662682377391;8458.534780587004;8474.915250847413;8634.43876148061;8670.402798630395;8765.38642295046;494.4239960446112;548.7503186050337;612.1277180018456;622.3807311724863;623.1711823275033;3874.767513949172;3909.843606255718;4017.397390391465;4018.5378681452007;4107.67138628909;91044.08955910357;93983;94252;94398.0560194403;94417.0558294422;78625.60687196527;78779;80156.99607509743;80969.38061238742;81491.59254203692;70594.64702676557;70792.64603677051;71309;71517.6424117876;72087.63956180186;7898.091719452336;8008.559529225949;8157.3881958852135;8200.466969647192;8224.506529608003;48381;49358.07551935684;51562;51948.96102078013;52241.47758522366;66930.66534667296;67463.98804018041;68385;69011.30988690049;69031.96452053323;10764.835929155302;10967.451627418757;11078.556857725924;11287.43562821872;11304.547818087185;11942.283462992249;12263.93868030654;12315.93842030784;12800.35998200105;12852.678683032998;11014.889851101707;11372.79948904259;11385.26910771784;11665.59170429031;12371.69070773238;10993.285436446606;11193.27243729155;11239.60661376848;11432.199746017699;12111.515539378326;10705.89294107049;10924.016838484575;11059.612913547988;11080.002799748061;11599.07207423421;9032.90967090347;9227.492487913229;9294.302927280616;9389.812203756022;10103.646372377225;8406.831863362577;8802.312379460147;8979.910200898168;9517.904820951702;9950 15:41:39 INFO - PROCESS | 1673 | __end_tp_report 15:41:39 INFO - PROCESS | 1673 | __start_cc_report 15:41:39 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1422 15:41:39 INFO - PROCESS | 1673 | __end_cc_report 15:41:39 INFO - PROCESS | 1673 | __startTimestamp1455061299273__endTimestamp 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | ------- Summary: start ------- 15:41:39 INFO - PROCESS | 1673 | Number of tests: 6 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5590.65 Median:5724.08 stddev:620.86 (10.8%) stddev-sans-first:594.53 15:41:39 INFO - PROCESS | 1673 | Values: 3231.1 3424.6 3442.1 3445.9 3473.1 5453.5 5478.0 5500.3 5501.9 5529.5 5502.5 5545.1 5638.3 5664.0 5666.1 4981.7 5031.3 5070.2 5077.3 5218.1 5146.9 5169.0 5178.4 5196.7 5209.6 4910.5 4996.0 5047.2 5118.2 5138.6 5136.1 5160.9 5166.2 5166.8 5178.8 5080.1 5102.9 5104.2 5109.5 5164.7 5358.9 5360.1 5483.7 5487.6 5520.2 6086.1 6094.9 6095.9 6109.8 6111.1 5050.6 6151.9 6161.8 6170.5 6194.3 5548.5 5588.4 5654.1 5682.5 5685.1 6225.9 6236.7 6250.0 6263.8 6278.3 5781.3 5872.8 5878.2 5884.1 5895.3 5963.6 6084.1 6132.0 6163.0 6174.3 6029.7 6030.6 6031.1 6033.5 6069.9 5841.6 5954.3 6097.4 6104.4 6108.2 4767.3 4797.0 4799.5 4810.6 4847.2 4247.4 4261.2 4262.0 4270.1 4294.7 5458.5 5533.9 5537.7 5568.0 5575.5 6096.8 6129.2 6143.8 6145.4 6146.1 5533.1 5538.6 5543.7 5556.4 5594.7 5176.2 5208.0 5211.6 5249.8 5336.3 5232.6 6301.7 6325.2 6326.7 6352.7 6174.8 6177.9 6186.2 6191.3 6204.6 6214.7 6223.5 6333.1 6334.3 6343.0 5968.4 5970.5 5975.1 6016.5 6058.2 5982.6 6110.8 6139.4 6140.4 6141.3 4982.1 5762.1 5812.4 5937.0 6009.9 5419.7 5889.9 5894.5 5896.4 5906.4 5686.5 5724.1 5729.3 5748.6 5765.1 5834.1 5834.1 5859.4 5870.6 5881.0 5696.7 5697.4 5735.6 5738.4 5745.1 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:59589.51 Median:20640.48 stddev:119918.43 (581.0%) stddev-sans-first:120172.64 15:41:39 INFO - PROCESS | 1673 | Values: 455.2 456.8 478.9 490.6 572.3 24210.5 37491.0 38367.2 38416.6 38468.0 40990.2 41166.4 41354.2 41440.2 41463.0 9507.6 9764.4 9768.7 9768.7 9778.6 9577.6 9748.0 9749.2 9749.3 9868.8 9806.4 9858.0 9868.5 9899.2 9926.1 9786.5 9875.6 9880.2 9881.8 9882.5 9708.1 9844.9 9867.4 9869.3 9875.9 40219.0 40574.0 40604.4 40614.8 40701.6 3164.1 3230.1 3355.9 3571.1 3759.0 28397.0 28661.9 28794.4 29182.9 29463.4 2799.7 2829.5 2840.4 2896.4 2971.5 449664.0 450292.0 450536.0 450810.2 452087.0 57922.7 59246.0 62269.4 62687.4 62712.0 65392.3 66386.0 66401.7 66553.0 66580.7 15748.1 16159.8 16181.9 16185.5 16188.4 10394.7 10554.3 11662.5 11682.8 12349.9 19042.2 19053.5 19097.6 19115.2 19179.3 7909.3 8064.1 8065.1 8069.5 8223.9 954.0 995.4 997.8 1017.4 1116.4 27406.0 28337.4 28585.1 28704.6 28906.0 1044.0 1099.5 1137.0 1138.9 1191.9 14341.9 14503.9 14768.9 14841.5 14893.6 524965.0 528323.0 529206.4 531012.3 531387.0 57728.6 57895.0 57924.3 58002.7 58192.4 1417.7 1423.6 1443.6 1445.5 1451.4 27304.9 27840.7 27895.2 30121.8 31075.2 47605.0 53061.0 53732.0 53745.0 54649.5 352406.5 357820.0 360289.0 360930.0 361166.0 29917.6 30250.4 30378.8 30420.8 30436.0 42018.9 42417.6 42464.0 42802.0 43629.3 36050.7 37103.0 37522.0 38047.2 38572.2 28520.7 36236.6 36933.8 37252.1 37467.3 36218.6 36278.8 37352.8 37437.0 37492.3 29256.6 31073.8 31104.4 31209.0 31225.2 23689.9 23768.6 23925.5 24072.6 24092.8 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:35934.37 Median:3459.11 stddev:108666.76 (3141.5%) stddev-sans-first:108938.68 15:41:39 INFO - PROCESS | 1673 | Values: 311.7 360.1 363.6 364.5 370.3 13504.9 15090.4 16617.8 18501.6 19414.1 19415.2 19579.8 19596.0 19660.5 20153.0 5407.4 5710.1 6238.0 6559.4 6577.1 4503.6 4709.4 5846.5 6704.8 6850.2 7146.2 7243.8 7346.3 7409.5 7418.2 7125.7 7289.9 7305.6 7313.5 7508.7 6996.4 7064.4 7110.3 7129.2 7133.1 23809.9 25050.9 25278.7 25494.7 25613.4 2266.8 2293.1 2391.4 2742.3 3060.9 14365.0 15039.8 15261.7 15640.2 15776.5 1900.8 1965.2 1967.9 1985.2 1995.1 108426.5 111086.0 111148.4 111225.0 111350.0 18068.3 18201.0 18373.5 18484.0 18494.5 25753.7 26600.9 26678.0 26705.6 26719.5 8487.7 9885.3 9902.0 9909.9 9997.4 8340.7 8347.7 8383.9 8396.3 8414.0 6945.5 8001.0 8286.5 8441.0 8455.4 3299.0 3392.7 3413.4 3504.8 3551.2 867.5 916.2 932.3 954.0 989.5 14770.3 17409.1 18597.1 18914.1 19110.0 892.2 932.2 943.3 944.5 988.8 8802.7 10021.3 10148.0 10171.7 10204.7 551616.0 621260.0 681928.6 700501.0 723131.0 89958.2 103027.0 113239.0 114336.0 120639.0 1189.5 1191.8 1195.7 1199.9 1210.1 18060.0 18159.5 18171.9 18223.3 18518.4 36848.0 40594.8 45297.5 47833.6 49218.5 69570.7 70326.9 70640.3 71018.0 71081.6 7234.0 7494.2 7538.2 7541.0 7558.0 7732.7 9909.8 11493.1 11925.8 12051.7 10030.2 10298.5 10484.5 10623.0 10662.7 3986.6 9420.8 9963.1 10466.5 10655.7 8757.8 10577.4 10763.2 10948.7 11162.4 7611.5 7770.3 7776.4 7790.3 7798.7 10173.9 10834.2 10891.6 11020.4 11022.8 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6001.09 Median:5312.27 stddev:3142.79 (59.2%) stddev-sans-first:3131.23 15:41:39 INFO - PROCESS | 1673 | Values: 1240.3 1513.7 1549.5 1757.7 1899.9 7829.1 8483.6 8639.6 8643.7 8651.7 8261.3 8598.1 8604.5 8610.2 8610.2 2105.7 2165.4 2169.5 2410.8 2433.8 2379.8 2442.3 2451.7 2452.9 2454.9 2360.9 2388.0 2411.7 2417.7 2421.6 2398.2 2417.5 2417.5 2422.4 2437.3 2404.9 2420.9 2430.1 2432.3 2439.2 8671.9 8721.5 8722.4 8725.7 8728.1 5234.9 5356.3 5369.2 5396.7 5398.3 3481.4 3554.0 3593.8 3605.3 3624.1 1037.0 1052.1 1060.8 1087.4 1088.2 11675.2 11742.8 11751.5 11764.8 11784.9 4662.6 4722.4 4733.0 4760.1 4779.7 9800.3 9804.0 9809.7 9818.9 9825.8 5308.5 5310.6 5314.0 5317.7 5343.1 4816.3 4816.6 4825.2 4828.6 4848.2 3629.7 3718.9 3829.3 3831.6 3924.6 1284.4 1303.8 1303.9 1314.3 1316.2 1290.7 1298.2 1313.0 1326.5 1334.4 8019.5 8096.6 8111.4 8114.5 8120.6 1155.9 1165.9 1177.8 1191.2 1195.4 5344.8 6247.0 6331.2 6344.1 6349.2 10326.2 10382.2 10474.9 10487.3 10606.2 10117.0 10312.8 10443.9 10454.6 10458.0 8037.4 8239.9 8244.8 8250.7 8250.8 7956.0 7993.1 7999.0 8045.8 8135.7 8732.8 9343.5 9590.5 9667.0 9694.4 9691.5 9824.5 10003.1 10110.5 10128.7 7435.3 7454.1 7466.7 7543.1 7587.2 7409.7 7620.2 7622.4 7623.0 7626.9 6868.4 7363.4 7669.3 7708.6 7829.7 7459.7 7603.5 7636.2 7674.7 7726.9 7610.7 7736.7 7756.2 7758.2 7760.3 6994.4 7064.2 7076.8 7147.4 7165.5 7024.5 7220.7 7229.1 7236.1 7244.7 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5682.64 Median:6358.26 stddev:1817.75 (28.6%) stddev-sans-first:1777.66 15:41:39 INFO - PROCESS | 1673 | Values: 316.0 323.4 326.8 327.0 331.7 5449.9 6610.0 6622.5 6649.6 6674.5 6194.6 6403.6 6411.5 6422.5 6520.9 4759.9 4788.3 4796.0 4873.4 4875.3 4850.1 4881.0 4889.6 4902.9 4914.2 4755.0 4807.1 4816.0 4837.5 4838.3 4811.9 4842.0 4856.9 4862.2 4869.3 4153.1 4164.8 4165.3 4166.7 4188.6 6198.3 6220.8 6242.7 6271.0 6291.5 5551.4 5691.0 5698.7 5739.0 5748.5 5782.1 6218.5 6459.8 6981.5 6991.6 4647.1 4682.4 4687.0 4691.6 4691.7 7088.4 7313.6 7407.8 7420.0 7425.8 3875.6 4563.7 4613.7 4614.8 4627.0 4679.6 4694.4 4695.4 4698.1 4703.7 4728.1 5399.0 5555.7 5568.1 5571.5 6837.7 7035.8 7040.9 7049.6 7079.3 1397.5 1586.3 1654.6 1682.6 1689.0 1036.7 1087.4 1108.6 1120.2 1125.7 5413.6 6597.3 6598.6 6611.8 6618.7 6530.0 6558.6 7235.9 7248.1 7272.3 5330.3 6312.9 6504.5 6510.8 6525.2 3096.3 3763.1 3821.1 3821.3 3823.1 5402.3 7542.6 7561.2 7577.5 7585.8 7136.7 7399.7 7403.5 7414.7 7441.7 7253.5 7553.7 7572.1 7580.0 7594.8 6153.8 7181.5 7194.8 7202.4 7206.2 7050.2 7115.3 7128.6 7138.5 7309.6 7753.2 7778.8 7784.8 7787.3 7793.2 4050.7 4576.4 4609.1 4629.2 4637.7 5957.3 7137.9 7281.8 7309.7 7347.4 6774.7 6892.9 6993.5 7117.4 7130.7 7055.5 7103.4 7112.2 7124.4 7139.9 6616.0 6855.6 6940.0 6947.4 6959.5 5974.7 6810.7 7041.5 7047.9 7051.4 6851.3 6865.5 6873.5 6877.3 6878.2 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18450.98 Median:573.79 stddev:26110.22 (4550.5%) stddev-sans-first:26149.20 15:41:39 INFO - PROCESS | 1673 | Values: 635.6 663.2 720.8 737.5 763.1 13723.7 13724.2 15121.8 15130.5 15149.8 12633.2 12691.2 12697.0 12723.4 12761.6 851.9 869.5 872.3 873.8 874.5 697.2 705.9 866.4 873.7 878.9 892.3 910.6 912.1 913.4 915.7 731.0 778.3 904.6 906.5 908.1 544.6 545.8 546.1 548.6 659.5 14882.0 14949.6 14967.4 14976.6 14989.0 12606.1 12693.7 12785.3 12979.4 12985.6 10206.7 10227.1 10238.0 10253.9 10313.5 3497.1 3529.3 3536.8 3540.2 3542.2 78428.0 80150.2 80303.8 81480.6 87216.3 8052.8 9698.2 9708.9 10049.0 10394.9 21827.9 22056.6 22068.0 22085.4 22119.7 7454.3 7636.4 7753.7 7761.8 7886.8 4002.2 4027.8 4079.3 4101.6 4117.6 3468.7 3484.3 3505.4 3506.6 3510.4 629.1 643.2 645.3 664.7 667.4 556.2 569.3 578.2 618.1 624.4 8458.5 8474.9 8634.4 8670.4 8765.4 494.4 548.8 612.1 622.4 623.2 3874.8 3909.8 4017.4 4018.5 4107.7 91044.1 93983.0 94252.0 94398.1 94417.1 78625.6 78779.0 80157.0 80969.4 81491.6 70594.6 70792.6 71309.0 71517.6 72087.6 7898.1 8008.6 8157.4 8200.5 8224.5 48381.0 49358.1 51562.0 51949.0 52241.5 66930.7 67464.0 68385.0 69011.3 69032.0 10764.8 10967.5 11078.6 11287.4 11304.5 11942.3 12263.9 12315.9 12800.4 12852.7 11014.9 11372.8 11385.3 11665.6 12371.7 10993.3 11193.3 11239.6 11432.2 12111.5 10705.9 10924.0 11059.6 11080.0 11599.1 9032.9 9227.5 9294.3 9389.8 10103.6 8406.8 8802.3 8979.9 9517.9 9950.0 15:41:39 INFO - PROCESS | 1673 | -------- Summary: end -------- 15:41:39 INFO - PROCESS | 1673 | 15:41:39 INFO - TEST-INFO | 1673: exit 0 15:41:39 INFO - TEST-OK | dromaeo_css | took 1113719ms 15:41:39 INFO - TEST-START | kraken 15:41:39 INFO - operating with platform_type : mac_ 15:41:39 INFO - Initialising browser for kraken test... 15:41:39 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpbAR8Gp/profile http://localhost:49277/getInfo.html) 15:41:41 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 15:41:41 INFO - PROCESS | 1684 | colorDepth:24 15:41:41 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 15:41:41 INFO - PROCESS | 1684 | __metrics 15:41:42 INFO - PROCESS | 1684 | 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" 15:41:42 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:42 INFO - TEST-INFO | 1684: exit 0 15:41:42 INFO - Browser initialized. 15:41:42 INFO - Running cycle 1/1 for kraken test... 15:41:42 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/T/tmpbAR8Gp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:41:54 INFO - PROCESS | 1686 | RSS: Main: 245547008 15:41:54 INFO - PROCESS | 1686 | 15:41:56 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 15:41:57 INFO - PROCESS | 1686 | RSS: Main: 293478400 15:41:57 INFO - PROCESS | 1686 | 15:42:00 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 15:42:00 INFO - PROCESS | 1686 | RSS: Main: 302043136 15:42:00 INFO - PROCESS | 1686 | 15:42:04 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 15:42:04 INFO - PROCESS | 1686 | RSS: Main: 284569600 15:42:04 INFO - PROCESS | 1686 | 15:42:06 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 15:42:07 INFO - PROCESS | 1686 | RSS: Main: 288927744 15:42:07 INFO - PROCESS | 1686 | 15:42:09 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:09 INFO - PROCESS | 1686 | RSS: Main: 289910784 15:42:09 INFO - PROCESS | 1686 | 15:42:12 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:13 INFO - PROCESS | 1686 | RSS: Main: 290750464 15:42:13 INFO - PROCESS | 1686 | 15:42:16 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:16 INFO - PROCESS | 1686 | RSS: Main: 290623488 15:42:16 INFO - PROCESS | 1686 | 15:42:19 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 15:42:20 INFO - PROCESS | 1686 | RSS: Main: 289292288 15:42:20 INFO - PROCESS | 1686 | 15:42:21 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:22 INFO - PROCESS | 1686 | RSS: Main: 324005888 15:42:22 INFO - PROCESS | 1686 | 15:42:24 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:24 INFO - PROCESS | 1686 | RSS: Main: 322478080 15:42:24 INFO - PROCESS | 1686 | 15:42:27 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:27 INFO - PROCESS | 1686 | RSS: Main: 332427264 15:42:27 INFO - PROCESS | 1686 | 15:42:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:30 INFO - PROCESS | 1686 | RSS: Main: 333500416 15:42:30 INFO - PROCESS | 1686 | 15:42:33 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:33 INFO - PROCESS | 1686 | RSS: Main: 334139392 15:42:33 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 15:42:35 INFO - PROCESS | 1686 | RSS: Main: 393687040 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | __start_tp_report 15:42:35 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 15:42:35 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 15:42:35 INFO - PROCESS | 1686 | |i|pagename|runs| 15:42:35 INFO - PROCESS | 1686 | |0;ai-astar;110;108;109;110;110;111;115;111;112;110 15:42:35 INFO - PROCESS | 1686 | |1;audio-beat-detection;161;136;143;158;122;144;140;116;157;118 15:42:35 INFO - PROCESS | 1686 | |2;audio-dft;185;186;186;186;184;184;184;185;183;182 15:42:35 INFO - PROCESS | 1686 | |3;audio-fft;77;79;86;81;58;57;59;79;76;56 15:42:35 INFO - PROCESS | 1686 | |4;audio-oscillator;91;97;130;81;116;117;149;112;77;119 15:42:35 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;88;94;88;95;88;94;88;93;88;94 15:42:35 INFO - PROCESS | 1686 | |6;imaging-darkroom;92;95;97;96;97;112;95;130;149;126 15:42:35 INFO - PROCESS | 1686 | |7;imaging-desaturate;86;85;107;71;128;145;142;86;86;86 15:42:35 INFO - PROCESS | 1686 | |8;json-parse-financial;53;54;56;53;55;53;53;62;52;52 15:42:35 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;63;66;81;73;69;67;67;66;67;67 15:42:35 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;83;83;83;83;82;81;96;104;84;83 15:42:35 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;124;132;122;121;126;126;126;140;131;117 15:42:35 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;135;124;139;138;132;120;136;137;136;139 15:42:35 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;66;67;69;91;92;89;81;69;66;66 15:42:35 INFO - PROCESS | 1686 | __end_tp_report 15:42:35 INFO - PROCESS | 1686 | __start_cc_report 15:42:35 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1172 15:42:35 INFO - PROCESS | 1686 | __end_cc_report 15:42:35 INFO - PROCESS | 1686 | __startTimestamp1455061355911__endTimestamp 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | ------- Summary: start ------- 15:42:35 INFO - PROCESS | 1686 | Number of tests: 14 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:110.60 Median:110.50 stddev:1.90 (1.7%) stddev-sans-first:2.00 15:42:35 INFO - PROCESS | 1686 | Values: 110.0 108.0 109.0 110.0 110.0 111.0 115.0 111.0 112.0 110.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:143.50 stddev:16.59 (11.6%) stddev-sans-first:15.66 15:42:35 INFO - PROCESS | 1686 | Values: 161.0 136.0 143.0 158.0 122.0 144.0 140.0 116.0 157.0 118.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.35 (0.7%) stddev-sans-first:1.42 15:42:35 INFO - PROCESS | 1686 | Values: 185.0 186.0 186.0 186.0 184.0 184.0 184.0 185.0 183.0 182.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:70.80 Median:78.00 stddev:11.77 (15.1%) stddev-sans-first:12.27 15:42:35 INFO - PROCESS | 1686 | Values: 77.0 79.0 86.0 81.0 58.0 57.0 59.0 79.0 76.0 56.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:113.00 stddev:22.46 (19.9%) stddev-sans-first:22.87 15:42:35 INFO - PROCESS | 1686 | Values: 91.0 97.0 130.0 81.0 116.0 117.0 149.0 112.0 77.0 119.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:93.50 stddev:3.20 (3.4%) stddev-sans-first:3.20 15:42:35 INFO - PROCESS | 1686 | Values: 88.0 94.0 88.0 95.0 88.0 94.0 88.0 93.0 88.0 94.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:95.00 stddev:19.66 (20.7%) stddev-sans-first:19.87 15:42:35 INFO - PROCESS | 1686 | Values: 92.0 95.0 97.0 96.0 97.0 112.0 95.0 130.0 149.0 126.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:85.50 stddev:26.72 (31.2%) stddev-sans-first:27.69 15:42:35 INFO - PROCESS | 1686 | Values: 86.0 85.0 107.0 71.0 128.0 145.0 142.0 86.0 86.0 86.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:2.98 (5.6%) stddev-sans-first:3.13 15:42:35 INFO - PROCESS | 1686 | Values: 53.0 54.0 56.0 53.0 55.0 53.0 53.0 62.0 52.0 52.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:67.00 stddev:5.04 (7.5%) stddev-sans-first:4.92 15:42:35 INFO - PROCESS | 1686 | Values: 63.0 66.0 81.0 73.0 69.0 67.0 67.0 66.0 67.0 67.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:83.00 stddev:7.55 (9.1%) stddev-sans-first:7.92 15:42:35 INFO - PROCESS | 1686 | Values: 83.0 83.0 83.0 83.0 82.0 81.0 96.0 104.0 84.0 83.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.00 stddev:6.50 (5.2%) stddev-sans-first:6.83 15:42:35 INFO - PROCESS | 1686 | Values: 124.0 132.0 122.0 121.0 126.0 126.0 126.0 140.0 131.0 117.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.60 Median:136.50 stddev:6.52 (4.8%) stddev-sans-first:6.89 15:42:35 INFO - PROCESS | 1686 | Values: 135.0 124.0 139.0 138.0 132.0 120.0 136.0 137.0 136.0 139.0 15:42:35 INFO - PROCESS | 1686 | 15:42:35 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:75.00 stddev:11.32 (15.1%) stddev-sans-first:11.46 15:42:35 INFO - PROCESS | 1686 | Values: 66.0 67.0 69.0 91.0 92.0 89.0 81.0 69.0 66.0 66.0 15:42:35 INFO - PROCESS | 1686 | -------- Summary: end -------- 15:42:35 INFO - PROCESS | 1686 | 15:42:36 INFO - TEST-INFO | 1686: exit 0 15:42:36 INFO - TEST-OK | kraken | took 56818ms 15:42:36 INFO - SUITE-END | took 1170s 15:42:37 INFO - Completed test suite (00:19:30) 15:42:37 INFO - Working with test: dromaeo_css 15:42:37 INFO - Generating results file: dromaeo_css 15:42:37 INFO - Working with test: kraken 15:42:37 INFO - Generating results file: kraken 15:42:37 INFO - javascript benchmark 15:42:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:42:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 15:42:37 INFO - process_Request line: dromaeo_css 7547.89 graph.html#tests=[[72,64,59]] 15:42:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:42:37 INFO - process_Request line: kraken 1461.20 graph.html#tests=[[232,64,59]] 15:42:37 INFO - RETURN: dromaeo_css: 7547.89 15:42:37 INFO - RETURN: kraken: 1461.20 15:42:37 INFO - javascript benchmark 15:42:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3231.1437469070693, 3424.6404127566607, 3442.0706409269496, 3445.896623101308, 3473.149078475772, 5453.536449401806, 5477.986572484088, 5500.339959204896, 5501.862453438656, 5529.5023447889735, 5502.504774570288, 5545.140503222007, 5638.323401191852, 5663.971680141593, 5666.121751128571, 4981.701097934136, 5031.270465782469, 5070.188769796833, 5077.289179514871, 5218.139007063849, 5146.897062058775, 5169.017886601552, 5178.430372659004, 5196.740162991854, 5209.609279304048, 4910.5089491050785, 4995.975020124913, 5047.167217409123, 5118.181091025455, 5138.5889128869785, 5136.075506408845, 5160.948390516084, 5166.173412254059, 5166.819161329373, 5178.844634660966, 5080.085584594772, 5102.923456148161, 5104.2088476286235, 5109.540141387293, 5164.690118592896, 5358.91961620576, 5360.088784906575, 5483.670979741189, 5487.64330318528, 5520.171974203861, 6086.056661217518, 6094.872448597023, 6095.908561371583, 6109.755609775648, 6111.144439778434, 5050.570701490377, 6151.87696246077, 6161.7535298588, 6170.475509581691, 6194.349593292684, 5548.528375088082, 5588.385277619459, 5654.095344744821, 5682.488576028178, 5685.118806584986, 6225.937740622627, 6236.656983865931, 6249.96875015622, 6263.812085637438, 6278.340774218733, 5781.306243250837, 5872.765089396376, 5878.2358293421585, 5884.0585506318785, 5895.322037965603, 5963.5527335450015, 6084.056971169476, 6132.01899668756, 6163.044728067157, 6174.25908890927, 6029.6683682397015, 6030.6080104793045, 6031.125486804389, 6033.456988871023, 6069.908951365733, 5841.591088623755, 5954.255718035246, 6097.359777223416, 6104.38956104386, 6108.205933228652, 4767.261074533453, 4796.992631547344, 4799.544043315879, 4810.59109975656, 4847.175980083394, 4247.384129301234, 4261.21167583998, 4261.97869010653, 4270.12462445198, 4294.677899157576, 5458.4541545845095, 5533.889322213614, 5537.667739935617, 5568.0, 5575.498205161555, 6096.817219442842, 6129.23653806838, 6143.754249830046, 6145.385461453819, 6146.108814221912, 5533.059379905426, 5538.6399884007415, 5543.695096769636, 5556.444355564492, 5594.664320140804, 5176.2494438306985, 5208.0, 5211.557017653542, 5249.842504724865, 5336.306280183629, 5232.581393488588, 6301.684915754194, 6325.177726895567, 6326.715297811609, 6352.650604216812, 6174.8147555573405, 6177.907331389943, 6186.19579454668, 6191.25704915413, 6204.565680402509, 6214.689265536615, 6223.471004964629, 6333.113364128933, 6334.271558770801, 6342.968285158545, 5968.432998865101, 5970.522358211246, 5975.133605627247, 6016.518678505797, 6058.242719660043, 5982.641041537521, 6110.816675499742, 6139.386061393825, 6140.447359737466, 6141.324454309933, 4982.053409852117, 5762.078067509178, 5812.389699081536, 5937.0, 6009.939900600938, 5419.701916394636, 5889.94110058894, 5894.498967587803, 5896.410358964241, 5906.350301466749, 5686.488216060575, 5724.084146536534, 5729.312482502127, 5748.568857335633, 5765.106408506688, 5834.066549352084, 5834.095715164156, 5859.414058594107, 5870.55970802183, 5881.0, 5696.686682232517, 5697.401772813795, 5735.598508104393, 5738.426157384395, 5745.1382292656435], "unit": "score", "name": "dojo.html", "value": 5552.680157816831}, {"lowerIsBetter": false, "replicates": [455.2033940603943, 456.78302806167056, 478.88746144656, 490.62957467112324, 572.2875020599352, 24210.515789684196, 37491.0, 38367.232655346874, 38416.61583384165, 38468.0, 40990.18019639605, 41166.38250426239, 41354.172916541655, 41440.17119657613, 41462.963425914364, 9507.572159252833, 9764.414135151877, 9768.658096966608, 9768.658096966608, 9778.608855645765, 9577.56900939456, 9748.0, 9749.220062395027, 9749.317547771623, 9868.753281167956, 9806.411615303068, 9858.01419858012, 9868.506574671273, 9899.15857152143, 9926.106650401462, 9786.510674466284, 9875.555599998017, 9880.20958323336, 9881.802363952753, 9882.456464894429, 9708.126268635786, 9844.90155098447, 9867.358621689567, 9869.309148359618, 9875.851862222073, 40218.99452513681, 40573.985650358685, 40604.39093413601, 40614.78155655335, 40701.592984070376, 3164.145680666207, 3230.144011836865, 3355.9496607550905, 3571.1250743567734, 3758.962410375889, 28397.00610478644, 28661.85352585894, 28794.424111517652, 29182.854085729436, 29463.410731785458, 2799.7060308667706, 2829.463938302528, 2840.375117474173, 2896.391757730879, 2971.524556071018, 449664.0, 450292.0, 450536.0, 450810.23784643254, 452087.0, 57922.71038644864, 59246.037698114924, 62269.37730622727, 62687.373126268154, 62712.0, 65392.34607653958, 66386.0, 66401.66799165973, 66553.0, 66580.66709666421, 15748.133852638215, 16159.757603635955, 16181.867269291271, 16185.514434566981, 16188.352465901233, 10394.68815935508, 10554.313969591953, 11662.542182227222, 11682.76634467323, 12349.93825030869, 19042.238310467703, 19053.523661908563, 19097.618047639247, 19115.228291897598, 19179.32872349489, 7909.3277071449575, 8064.096925106956, 8065.112837587861, 8069.515829050276, 8223.876641850376, 953.9856902146473, 995.3729150635054, 997.7876879591331, 1017.3692310767372, 1116.3692513729716, 27406.0, 28337.433251334856, 28585.142445726244, 28704.569431458545, 28906.0, 1043.9791204175874, 1099.4942326529886, 1137.0278411957822, 1138.9031932285682, 1191.9106067045007, 14341.856581434053, 14503.92748036253, 14768.852311476963, 14841.480548180762, 14893.63827024885, 524965.0, 528323.0, 529206.3539682277, 531012.3449382728, 531387.0, 57728.556786080684, 57895.0, 57924.262272131906, 58002.709986449794, 58192.4180758187, 1417.723543908928, 1423.558696803994, 1443.6102252391795, 1445.4796273341378, 1451.3831621560794, 27304.863475682494, 27840.72159278381, 27895.16314510568, 30121.849390752905, 31075.223119422197, 47605.0, 53061.0, 53732.0, 53745.0, 54649.45350546444, 352406.52138046845, 357820.0, 360289.0, 360930.0, 361166.0, 29917.55123673103, 30250.394992100475, 30378.84810575933, 30420.84789576038, 30436.0, 42018.94952626209, 42417.575824241365, 42464.0, 42802.0, 43629.34555981599, 36050.73822416203, 37103.0, 37522.0, 38047.239055219296, 38572.22855542817, 28520.714792851806, 36236.63763362333, 36933.81533092317, 37252.06869828276, 37467.25065498729, 36218.63781362153, 36278.8186059068, 37352.813235933645, 37437.0, 37492.250154997295, 29256.56115158232, 31073.8446307767, 31104.377912442076, 31209.0, 31225.219369515034, 23689.881550592825, 23768.64347034761, 23925.52148957046, 24072.638910416706, 24092.75907240905], "unit": "score", "name": "ext.html", "value": 19331.605878322975}, {"lowerIsBetter": false, "replicates": [311.7396973527105, 360.0889748935194, 363.6309146216589, 364.45150049175993, 370.2982847503982, 13504.887840297011, 15090.39638414465, 16617.83382166178, 18501.629967400644, 19414.126364313604, 19415.22339106434, 19579.825210487346, 19596.0, 19660.508487287825, 20153.0, 5407.405185429599, 5710.086386178213, 6238.00191969285, 6559.409653131217, 6577.112089867878, 4503.572160644733, 4709.387779588648, 5846.532277417797, 6704.832379190535, 6850.1779786425695, 7146.213916469184, 7243.818904527377, 7346.338829505344, 7409.48133630646, 7418.22108678589, 7125.7149714011375, 7289.927100729031, 7305.634718264092, 7313.524620899624, 7508.737194198232, 6996.440284777256, 7064.364207221323, 7110.253423390522, 7129.18014428337, 7133.144022717255, 23809.880950595136, 25050.874745626337, 25278.747212527822, 25494.745052549424, 25613.359666008313, 2266.8299877509253, 2293.0827668932393, 2391.4499665076955, 2742.3281296082587, 3060.8928687496054, 14365.018446529886, 15039.849601504064, 15261.694766104727, 15640.217989100613, 15776.526704198892, 1900.790912999569, 1965.2237366240256, 1967.891765952872, 1985.1563085688524, 1995.0722913844986, 108426.45786771094, 111086.0, 111148.44425777819, 111225.0, 111350.0, 18068.277268909096, 18201.0, 18373.54066148357, 18483.98338091418, 18494.537636558925, 25753.74246257551, 26600.866995665285, 26678.0, 26705.599416008776, 26719.46561068768, 8487.660493580188, 9885.308028438085, 9902.0, 9909.900900991042, 9997.400155990665, 8340.666373344999, 8347.749567512985, 8383.874241886377, 8396.328293736486, 8413.957930210432, 6945.501832367892, 8000.959995199987, 8286.4613800104, 8441.029281632567, 8455.408121431441, 3298.950515742266, 3392.728581713457, 3413.4367829308385, 3504.7897126172, 3551.183227857607, 867.4621734524509, 916.244098618629, 932.2541966426832, 953.990460095404, 989.5250279865561, 14770.335334909954, 17409.129543522773, 18597.07014649262, 18914.05429728508, 19110.044497775056, 892.2460520859863, 932.1610550504464, 943.2689665509286, 944.527736131934, 988.8121256961298, 8802.691905783267, 10021.344343748913, 10148.0, 10171.69484915439, 10204.744881378025, 551616.0, 621260.0, 681928.590357055, 700501.0, 723131.0, 89958.20083598292, 103027.0, 113239.0, 114336.0, 120639.0, 1189.4647408666135, 1191.8152686333633, 1195.7190060335813, 1199.8920097191294, 1210.1287073307205, 18060.006699631645, 18159.45644620222, 18171.909140454212, 18223.271069157086, 18518.44444666662, 36848.0, 40594.78215653535, 45297.54702452933, 47833.56499305026, 49218.50781492283, 69570.65214673894, 70326.94509582258, 70640.29359706337, 71018.0, 71081.64459177671, 7234.0, 7494.213107623839, 7538.246175382637, 7540.9622951884885, 7557.979672744329, 7732.68544347451, 9909.801803963735, 11493.138014649103, 11925.761484770082, 12051.698707532381, 10030.197584193102, 10298.536565854405, 10484.52819623134, 10623.0, 10662.680119596425, 3986.6412022918075, 9420.811583768149, 9963.103320701171, 10466.476676166314, 10655.733606659585, 8757.824843502967, 10577.36535807854, 10763.246572739834, 10948.671539853816, 11162.44187790591, 7611.543307401574, 7770.300672939463, 7776.41676874248, 7790.298873101448, 7798.727044553413, 10173.949130254301, 10834.187435942178, 10891.618793342195, 11020.393878336768, 11022.779544408906], "unit": "score", "name": "jquery.html", "value": 10142.450675438959}, {"lowerIsBetter": false, "replicates": [1240.2992309345213, 1513.6896936128094, 1549.4511528535559, 1757.7451269565913, 1899.8955057471833, 7829.138794732582, 8483.575821208939, 8639.611217495205, 8643.697470588531, 8651.69719059833, 8261.339092872571, 8598.140185981414, 8604.483730976146, 8610.182032706898, 8610.225079742822, 2105.7367829021373, 2165.3936897668677, 2169.4901698100934, 2410.758924107584, 2433.7687919647606, 2379.7501262367464, 2442.3039433761382, 2451.705795304566, 2452.865092419916, 2454.9263522094366, 2360.8583484990954, 2388.0209114263157, 2411.686480757499, 2417.721961974369, 2421.6004359280696, 2398.2205783120557, 2417.492326611414, 2417.516496700658, 2422.4428381472185, 2437.293184976355, 2404.9398765031015, 2420.8789560521905, 2430.1251549442186, 2432.2946345559767, 2439.1828737373003, 8671.913280867173, 8721.520316382597, 8722.433041852322, 8725.650973961034, 8728.083551227093, 5234.869128271824, 5356.330458692663, 5369.24830523727, 5396.677813935572, 5398.325209348832, 3481.425564781808, 3554.040409089557, 3593.802340871251, 3605.3149901518627, 3624.1483251435893, 1036.9948150259277, 1052.0584077250894, 1060.750723579958, 1087.429099722652, 1088.2436706488993, 11675.241109327866, 11742.823857642228, 11751.529938802438, 11764.823527647091, 11784.88215117855, 4662.6269898408045, 4722.362481065081, 4732.976335118303, 4760.119377915097, 4779.737114458669, 9800.31397802147, 9804.0, 9809.656662016796, 9818.852717209247, 9825.803483930424, 5308.469153084738, 5310.575153987672, 5313.973430132824, 5317.654352467077, 5343.118385466354, 4816.277558366203, 4816.614670826326, 4825.179719447632, 4828.565429111397, 4848.200046992278, 3629.709623230135, 3718.925621487609, 3829.2532956073856, 3831.5976822433245, 3924.60753924611, 1284.389914790467, 1303.7653222419865, 1303.8761317674805, 1314.2705798282045, 1316.210273835691, 1290.748304080714, 1298.2340419152745, 1312.9934350328188, 1326.4893016188644, 1334.4328660319325, 8019.478733882279, 8096.635651395702, 8111.432199745961, 8114.513129212266, 8120.593970301579, 1155.9017483513996, 1165.877582853805, 1177.7644471105814, 1191.1840389333333, 1195.384377045822, 5344.759485823147, 6247.00047992319, 6331.240251169797, 6344.143540621957, 6349.238091429058, 10326.225533084898, 10382.169426445866, 10474.947625261824, 10487.26589138753, 10606.204534659777, 10117.038881306264, 10312.845307320396, 10443.94778026105, 10454.581816727246, 10458.0, 8037.35701143907, 8239.917600823916, 8244.752657420288, 8250.669973201126, 8250.793730156674, 7955.965724455784, 7993.12075671664, 7998.960005199937, 8045.83908321842, 8135.67457301725, 8732.78168045804, 9343.53282335867, 9590.520473976134, 9666.95166524163, 9694.418334899929, 9691.5154242289, 9824.508774561386, 10003.14973227284, 10110.49447527606, 10128.74678133023, 7435.256474352522, 7454.105507339154, 7466.664000120117, 7543.094828620381, 7587.165411804807, 7409.740659076906, 7620.1998790128455, 7622.428317876293, 7623.0, 7626.885596716164, 6868.381845633917, 7363.41092712571, 7669.309762121213, 7708.614569271626, 7829.7259595913865, 7459.738909138154, 7603.505772124794, 7636.160022397421, 7674.731384401743, 7726.884096738441, 7610.657520411484, 7736.651850666621, 7756.185600511865, 7758.185390533913, 7760.3403710685225, 6994.405475534637, 7064.187618423947, 7076.787696369117, 7147.392471639969, 7165.462590305644, 7024.468032092653, 7220.711171553289, 7229.060222171084, 7236.095488063992, 7244.746433874789], "unit": "score", "name": "mootools.html", "value": 4901.989519783068}, {"lowerIsBetter": false, "replicates": [315.9984200079, 323.41946206559226, 326.8316816839328, 326.9977518904559, 331.6964977046003, 5449.863753406167, 6610.041543976126, 6622.47020238381, 6649.634270115142, 6674.466042716583, 6194.59735117217, 6403.61578305302, 6411.487081033518, 6422.454091402225, 6520.902186467207, 4759.928601070987, 4788.257820037891, 4795.976020119894, 4873.366462359906, 4875.293082503035, 4850.12697714413, 4881.023795240966, 4889.608831293488, 4902.926456103161, 4914.189158788796, 4754.9762251188695, 4807.086653535835, 4815.951840481585, 4837.467878533358, 4838.274258861182, 4811.855644330658, 4842.0, 4856.878578035577, 4862.173430516803, 4869.2939523768855, 4153.06556024895, 4164.7709375984305, 4165.291900376913, 4166.66666666669, 4188.5811418858175, 6198.2871969723155, 6220.844478888064, 6242.6878656067465, 6271.0, 6291.496680265614, 5551.390096871903, 5691.004074287024, 5698.6865722385255, 5739.0, 5748.540116790647, 5782.10377391505, 6218.4714299284615, 6459.83850403739, 6981.5461994970165, 6991.615461149635, 4647.070585882803, 4682.4381074271305, 4686.9765651171865, 4691.601213896789, 4691.7184968901975, 7088.43292536601, 7313.597752123631, 7407.814804629874, 7419.962900185465, 7425.814354641123, 3875.612438756158, 4563.657725670588, 4613.746243956548, 4614.815407383734, 4627.028324051987, 4679.602233810164, 4694.389729335165, 4695.413073365829, 4698.130845793539, 4703.717776933395, 4728.148933192058, 5398.973005135028, 5555.694436806015, 5568.1091025435735, 5571.498565129158, 6837.692303846339, 7035.753748618774, 7040.92959070413, 7049.577025378494, 7079.2920707929825, 1397.503886120433, 1586.3099551694818, 1654.586353411647, 1682.6382327799581, 1689.0372487681902, 1036.72008557689, 1087.4073629871739, 1108.5898217659355, 1120.2046546951592, 1125.6735546691368, 5413.593980451482, 6597.3072827352435, 6598.60408375499, 6611.801645950629, 6618.669066546653, 6530.0, 6558.639274839834, 7235.89146162808, 7248.130224373109, 7272.345488906024, 5330.333708286465, 6312.905306420407, 6504.479641628658, 6510.837229069311, 6525.184351956005, 3096.303331750338, 3763.0592351912023, 3821.121142137324, 3821.2739579479808, 3823.101571130782, 5402.297701298806, 7542.622868856535, 7561.243875612505, 7577.507462014952, 7585.772426827204, 7136.714531418789, 7399.704011839466, 7403.481756277117, 7414.740484083031, 7441.702331906771, 7253.492255542062, 7553.7356192533, 7572.053493313336, 7580.0, 7594.8101297468, 6153.84615384619, 7181.533200341961, 7194.784156475314, 7202.387797037101, 7206.243344448757, 7050.224475307609, 7115.288471152843, 7128.607926564089, 7138.464615153988, 7309.561426314438, 7753.224677532202, 7778.844423111619, 7784.766457006299, 7787.260210280015, 7793.220677932161, 4050.716449848482, 4576.359309696579, 4609.147307748078, 4629.213033784197, 4637.698549594265, 5957.314908785545, 7137.892931605927, 7281.8179545509665, 7309.707611695685, 7347.412207023318, 6774.695138718671, 6892.931070689429, 6993.475489338218, 7117.43060555144, 7130.714771409085, 7055.470839686941, 7103.431725461847, 7112.182099058675, 7124.430045596237, 7139.8572028560175, 6615.966920165369, 6855.5543889647015, 6940.02839602446, 6947.44420446353, 6959.478039146983, 5974.6713930732485, 6810.659467026728, 7041.471889608198, 7047.929520704727, 7051.400630946427, 6851.2806155354965, 6865.485088618274, 6873.450123989969, 6877.277885822116, 6878.243393226841], "unit": "score", "name": "prototype.html", "value": 5080.902852565697}, {"lowerIsBetter": false, "replicates": [635.6440393379706, 663.1644128398217, 720.8197950512371, 737.454283829966, 763.0652450747834, 13723.696248856355, 13724.17654940703, 15121.84878151218, 15130.546083617495, 15149.848501514982, 12633.178843375197, 12691.175073620208, 12697.047721420884, 12723.363831808396, 12761.553345632905, 851.8935133108362, 869.4652788535037, 872.2934423117264, 873.7902903303225, 874.4622057434696, 697.2330436519813, 705.939995100417, 866.3545658484406, 873.7247766953421, 878.8681697745326, 892.2638822971043, 910.6493999810054, 912.1289168843738, 913.392593925039, 915.6840889892976, 730.9707611695526, 778.3073064972123, 904.606496174163, 906.5150144672568, 908.0646933658343, 544.6051612580848, 545.8362491252608, 546.0880329849161, 548.6378989866669, 659.5383231737754, 14882.0, 14949.626259343495, 14967.401303947938, 14976.550703478913, 14989.0257133286, 12606.117571769979, 12693.746125077447, 12785.264914726642, 12979.41592628334, 12985.610431687064, 10206.713180464223, 10227.051524574399, 10238.0, 10253.897461025443, 10313.535890884854, 3497.1257185703575, 3529.2588556403184, 3536.8231588420476, 3540.2211513466996, 3542.2384187399834, 78427.99999999943, 80150.19849801486, 80303.7954430684, 81480.59259703723, 87216.25567488615, 8052.798680032929, 9698.224142068617, 9708.90291097094, 10049.0, 10394.948025259826, 21827.890860545594, 22056.558868822856, 22068.00693968775, 22085.447863803533, 22119.668204976937, 7454.291842274975, 7636.427267954926, 7753.651085701157, 7761.8447631047065, 7886.763397098096, 4002.1795531915886, 4027.81874815634, 4079.265732168238, 4101.610347017028, 4117.649999749995, 3468.670476304747, 3484.303139372136, 3505.4040813061843, 3506.631803660579, 3510.420780571228, 629.1003864473846, 643.231338550437, 645.309518814873, 664.6842749693953, 667.4093427316762, 556.2074044486671, 569.3480964295858, 578.2396149064051, 618.0821480102045, 624.3662682377391, 8458.534780587004, 8474.915250847413, 8634.43876148061, 8670.402798630395, 8765.38642295046, 494.4239960446112, 548.7503186050337, 612.1277180018456, 622.3807311724863, 623.1711823275033, 3874.767513949172, 3909.843606255718, 4017.397390391465, 4018.5378681452007, 4107.67138628909, 91044.08955910357, 93983.0, 94252.0, 94398.0560194403, 94417.0558294422, 78625.60687196527, 78779.0, 80156.99607509743, 80969.38061238742, 81491.59254203692, 70594.64702676557, 70792.64603677051, 71309.0, 71517.6424117876, 72087.63956180186, 7898.091719452336, 8008.559529225949, 8157.3881958852135, 8200.466969647192, 8224.506529608003, 48381.0, 49358.07551935684, 51562.0, 51948.96102078013, 52241.47758522366, 66930.66534667296, 67463.98804018041, 68385.0, 69011.30988690049, 69031.96452053323, 10764.835929155302, 10967.451627418757, 11078.556857725924, 11287.43562821872, 11304.547818087185, 11942.283462992249, 12263.93868030654, 12315.93842030784, 12800.35998200105, 12852.678683032998, 11014.889851101707, 11372.79948904259, 11385.26910771784, 11665.59170429031, 12371.69070773238, 10993.285436446606, 11193.27243729155, 11239.60661376848, 11432.199746017699, 12111.515539378326, 10705.89294107049, 10924.016838484575, 11059.612913547988, 11080.002799748061, 11599.07207423421, 9032.90967090347, 9227.492487913229, 9294.302927280616, 9389.812203756022, 10103.646372377225, 8406.831863362577, 8802.312379460147, 8979.910200898168, 9517.904820951702, 9950.0], "unit": "score", "name": "yui.html", "value": 6818.544700415584}], "name": "dromaeo_css", "value": 7547.893202995362}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 109.0, 110.0, 110.0, 111.0, 115.0, 111.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [161.0, 136.0, 143.0, 158.0, 122.0, 144.0, 140.0, 116.0, 157.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 139.5}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 186.0, 186.0, 184.0, 184.0, 184.0, 185.0, 183.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 86.0, 81.0, 58.0, 57.0, 59.0, 79.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.8}, {"lowerIsBetter": true, "replicates": [91.0, 97.0, 130.0, 81.0, 116.0, 117.0, 149.0, 112.0, 77.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [88.0, 94.0, 88.0, 95.0, 88.0, 94.0, 88.0, 93.0, 88.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.0}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 97.0, 96.0, 97.0, 112.0, 95.0, 130.0, 149.0, 126.0], "unit": "score", "name": "imaging-darkroom", "value": 108.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 107.0, 71.0, 128.0, 145.0, 142.0, 86.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 102.2}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 56.0, 53.0, 55.0, 53.0, 53.0, 62.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 81.0, 73.0, 69.0, 67.0, 67.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 81.0, 96.0, 104.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [124.0, 132.0, 122.0, 121.0, 126.0, 126.0, 126.0, 140.0, 131.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [135.0, 124.0, 139.0, 138.0, 132.0, 120.0, 136.0, 137.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.6}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 91.0, 92.0, 89.0, 81.0, 69.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.6}], "name": "kraken", "value": 1461.1999999999998}]} 15:42:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1461.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7547.89"}}} 15:42:37 INFO - Return code: 0 15:42:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:42:37 INFO - # TBPL SUCCESS # 15:42:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:42:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:42:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:42:37 INFO - 2016-02-09 15:42:37.650 screenresolution[1690:9513] starting screenresolution argv=screenresolution get 15:42:37 INFO - 2016-02-09 15:42:37.652 screenresolution[1690:9513] Display 0: 1600x1200x32@60 15:42:37 INFO - 2016-02-09 15:42:37.658 screenresolution[1691:9516] starting screenresolution argv=screenresolution list 15:42:37 INFO - Available Modes on Display 0 15:42:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:42:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:42:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:42:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:42:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:42:37 INFO - Intel Iris: 15:42:37 INFO - Chipset Model: Intel Iris 15:42:37 INFO - Type: GPU 15:42:37 INFO - Bus: Built-In 15:42:37 INFO - VRAM (Dynamic, Max): 1536 MB 15:42:37 INFO - Vendor: Intel (0x8086) 15:42:37 INFO - Device ID: 0x0a2e 15:42:37 INFO - Revision ID: 0x0009 15:42:37 INFO - Displays: 15:42:37 INFO - Display: 15:42:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:42:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:42:37 INFO - Display Serial Number: 1600x1200 60 15:42:37 INFO - Main Display: Yes 15:42:37 INFO - Mirror: Off 15:42:37 INFO - Online: Yes 15:42:37 INFO - Rotation: Supported 15:42:37 INFO - Return code: 0 15:42:37 INFO - Running post-action listener: _resource_record_post_action 15:42:37 INFO - Running post-run listener: _resource_record_post_run 15:42:38 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39613952; Write bytes: 706397184; Read time: 479; Write time: 1878 15:42:38 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 405037568; Write bytes: 405972480; Read time: 31104; Write time: 700 15:42:38 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37774848; Write bytes: 299576832; Read time: 458; Write time: 1176 15:42:38 INFO - Running post-run listener: _upload_blobber_files 15:42:38 INFO - Blob upload gear active. 15:42:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:38 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 15:42:38 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'] 15:42:38 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 15:42:39 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:42:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:40 INFO - (blobuploader) - INFO - Done attempting. 15:42:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:42:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:42:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:40 INFO - (blobuploader) - INFO - Done attempting. 15:42:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:42:40 INFO - Return code: 0 15:42:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:42:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:42:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d290dcb930ea01997c6318a0501a1f44d623d8f4bd1f2dfda03e50bd0728c6c60d050857c41aaf5d32cf0ae3972d308ed2d02fba02fb8513aeabb70c943ba53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaea5bd7c3e386f6003125676f2cc26fa0f0e20bcd008302f2efee4f48640d701345db19d2991ccd6871442c66a8fab030ab63abe755d021bed73341ebc0908e"} 15:42:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:42:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:42:40 INFO - Contents: 15:42:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1d290dcb930ea01997c6318a0501a1f44d623d8f4bd1f2dfda03e50bd0728c6c60d050857c41aaf5d32cf0ae3972d308ed2d02fba02fb8513aeabb70c943ba53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaea5bd7c3e386f6003125676f2cc26fa0f0e20bcd008302f2efee4f48640d701345db19d2991ccd6871442c66a8fab030ab63abe755d021bed73341ebc0908e"} 15:42:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:42:41 INFO - Copying logs to upload dir... 15:42:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:42:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.517084 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-09 15:42:41.059209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 15:42:41.062216) ========= 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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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/1d290dcb930ea01997c6318a0501a1f44d623d8f4bd1f2dfda03e50bd0728c6c60d050857c41aaf5d32cf0ae3972d308ed2d02fba02fb8513aeabb70c943ba53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaea5bd7c3e386f6003125676f2cc26fa0f0e20bcd008302f2efee4f48640d701345db19d2991ccd6871442c66a8fab030ab63abe755d021bed73341ebc0908e"} build_url:https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010548 build_url: 'https://queue.taskcluster.net/v1/task/DveTaO1YTC6T16T5WgKbhw/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/1d290dcb930ea01997c6318a0501a1f44d623d8f4bd1f2dfda03e50bd0728c6c60d050857c41aaf5d32cf0ae3972d308ed2d02fba02fb8513aeabb70c943ba53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aaea5bd7c3e386f6003125676f2cc26fa0f0e20bcd008302f2efee4f48640d701345db19d2991ccd6871442c66a8fab030ab63abe755d021bed73341ebc0908e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 15:42:41.088205) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:42:41.088509) ========= 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.EjDohkx3qu/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.1NXfh6YOvH/Listeners TMPDIR=/var/folders/hw/_ylr8d0j0wd8qb404l04fbrh00000w/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.005012 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 15:42:41.136781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 15:42:41.137084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 15:42:41.137453) ========= ========= Total master_lag: 0.27 =========