builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0196 starttime: 1457014436.81 results: success (0) buildid: 20160303025739 builduid: 56d871a8432a4ad59a91ca54dea685d1 revision: 68b6defee155efdc00bb6b4602b30bcb26da5a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:56.805641) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:56.806510) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:56.806806) ========= 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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005947 basedir: '/builds/slave/test' ========= master_lag: 0.21 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.023030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.023307) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.126457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.126730) ========= 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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005450 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.180053) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.180314) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.180634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.180919) ========= 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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-03-03 06:13:57-- 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% 16.3M=0.001s 2016-03-03 06:13:57 (16.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133227 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.329437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.329715) ========= 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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.026256 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:13:57.377297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-03 06:13:57.377618) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 68b6defee155efdc00bb6b4602b30bcb26da5a5a --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 68b6defee155efdc00bb6b4602b30bcb26da5a5a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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-03-03 06:13:57,453 truncating revision to first 12 chars 2016-03-03 06:13:57,453 Setting DEBUG logging. 2016-03-03 06:13:57,453 attempt 1/10 2016-03-03 06:13:57,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/68b6defee155?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 06:13:58,535 unpacking tar archive at: fx-team-68b6defee155/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322198 ========= master_lag: 2.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-03 06:14:01.214053) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 06:14:01.214354) ========= echo 68b6defee155efdc00bb6b4602b30bcb26da5a5a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68b6defee155efdc00bb6b4602b30bcb26da5a5a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 68b6defee155efdc00bb6b4602b30bcb26da5a5a program finished with exit code 0 elapsedTime=0.005435 script_repo_revision: '68b6defee155efdc00bb6b4602b30bcb26da5a5a' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 06:14:01.275275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 06:14:01.275545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 06:14:01.435491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-03-03 06:14:01.435746) ========= /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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:01 INFO - MultiFileLogger online at 20160303 06:14:01 in /builds/slave/test 06:14:01 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 06:14:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:01 INFO - {'append_to_log': False, 06:14:01 INFO - 'base_work_dir': '/builds/slave/test', 06:14:01 INFO - 'blob_upload_branch': 'Fx-Team', 06:14:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:01 INFO - 'branch': 'Fx-Team', 06:14:01 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:01 INFO - 'config_files': ('talos/mac_config.py',), 06:14:01 INFO - 'default_actions': ('clobber', 06:14:01 INFO - 'read-buildbot-config', 06:14:01 INFO - 'download-and-extract', 06:14:01 INFO - 'populate-webroot', 06:14:01 INFO - 'create-virtualenv', 06:14:01 INFO - 'install', 06:14:01 INFO - 'run-tests'), 06:14:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:01 INFO - 'download_minidump_stackwalk': True, 06:14:01 INFO - 'download_symbols': 'ondemand', 06:14:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:01 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:01 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:01 INFO - 'installer_path': 'installer.exe', 06:14:01 INFO - 'log_level': 'info', 06:14:01 INFO - 'log_name': 'talos', 06:14:01 INFO - 'log_to_console': True, 06:14:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:14:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:14:01 INFO - 'opt_config_files': (), 06:14:01 INFO - 'pip_index': False, 06:14:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:14:01 INFO - 'cmd': ('bash', 06:14:01 INFO - '-c', 06:14:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:14:01 INFO - 'enabled': True, 06:14:01 INFO - 'halt_on_failure': False, 06:14:01 INFO - 'name': 'check_screen_resolution'},), 06:14:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:14:01 INFO - 'cmd': ('bash', 06:14:01 INFO - '-c', 06:14:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:14:01 INFO - 'enabled': True, 06:14:01 INFO - 'halt_on_failure': False, 06:14:01 INFO - 'name': 'check_screen_resolution'},), 06:14:01 INFO - 'run_cmd_checks_enabled': True, 06:14:01 INFO - 'sps_profile': False, 06:14:01 INFO - 'sps_profile_interval': 0, 06:14:01 INFO - 'suite': 'dromaeojs', 06:14:01 INFO - 'system_bits': '32', 06:14:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:01 INFO - 'title': 't-yosemite-r7-0196', 06:14:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:01 INFO - 'use_talos_json': True, 06:14:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:01 INFO - 'work_dir': 'build'} 06:14:01 INFO - ##### 06:14:01 INFO - ##### Running clobber step. 06:14:01 INFO - ##### 06:14:01 INFO - Running pre-action listener: _resource_record_pre_action 06:14:01 INFO - Running main action method: clobber 06:14:01 INFO - rmtree: /builds/slave/test/build 06:14:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:03 INFO - Running post-action listener: _resource_record_post_action 06:14:03 INFO - ##### 06:14:03 INFO - ##### Running read-buildbot-config step. 06:14:03 INFO - ##### 06:14:03 INFO - Running pre-action listener: _resource_record_pre_action 06:14:03 INFO - Running main action method: read_buildbot_config 06:14:03 INFO - Using buildbot properties: 06:14:03 INFO - { 06:14:03 INFO - "project": "", 06:14:03 INFO - "product": "firefox", 06:14:03 INFO - "script_repo_revision": "production", 06:14:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:14:03 INFO - "repository": "", 06:14:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:14:03 INFO - "buildid": "20160303025739", 06:14:03 INFO - "pgo_build": "False", 06:14:03 INFO - "basedir": "/builds/slave/test", 06:14:03 INFO - "buildnumber": 444, 06:14:03 INFO - "slavename": "t-yosemite-r7-0196", 06:14:03 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:14:03 INFO - "platform": "yosemite_r7", 06:14:03 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:14:03 INFO - "branch": "fx-team", 06:14:03 INFO - "repo_path": "integration/fx-team", 06:14:03 INFO - "revision": "68b6defee155efdc00bb6b4602b30bcb26da5a5a", 06:14:03 INFO - "stage_platform": "macosx64", 06:14:03 INFO - "builduid": "56d871a8432a4ad59a91ca54dea685d1", 06:14:03 INFO - "slavebuilddir": "test" 06:14:03 INFO - } 06:14:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:14:03 INFO - Running post-action listener: _resource_record_post_action 06:14:03 INFO - ##### 06:14:03 INFO - ##### Running download-and-extract step. 06:14:03 INFO - ##### 06:14:03 INFO - Running pre-action listener: _resource_record_pre_action 06:14:03 INFO - Running main action method: download_and_extract 06:14:03 INFO - mkdir: /builds/slave/test/build/tests 06:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:03 INFO - https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:14:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 06:14:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 06:14:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 06:14:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 06:14:10 INFO - Downloaded 1277 bytes. 06:14:10 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 06:14:10 INFO - Using the following test package requirements: 06:14:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:14:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:14:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:14:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'jsshell-mac.zip'], 06:14:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:14:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:14:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:14:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:14:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:14:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:14:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:14:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:14:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:14:10 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')]} 06:14:10 INFO - https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:20 INFO - Downloaded 17855047 bytes. 06:14:20 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'] 06:14:20 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 06:14:23 INFO - Return code: 0 06:14:23 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 06:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:23 INFO - https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:24 INFO - Downloaded 17855047 bytes. 06:14:24 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'] 06:14:24 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 06:14:27 INFO - Return code: 0 06:14:27 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')]} 06:14:27 INFO - https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:28 INFO - Downloaded 10808282 bytes. 06:14:28 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'] 06:14:28 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 06:14:29 INFO - Return code: 0 06:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:29 INFO - https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RNpyu0_gQjiffyz5Oem_dw/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 06:14:34 INFO - Downloaded 110945035 bytes. 06:14:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:14:34 INFO - mkdir: /builds/slave/test/properties 06:14:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:34 INFO - Contents: 06:14:34 INFO - build_url:https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:14:35 INFO - Running post-action listener: _resource_record_post_action 06:14:35 INFO - Running post-action listener: set_extra_try_arguments 06:14:35 INFO - ##### 06:14:35 INFO - ##### Running populate-webroot step. 06:14:35 INFO - ##### 06:14:35 INFO - Running pre-action listener: _resource_record_pre_action 06:14:35 INFO - Running main action method: populate_webroot 06:14:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:35 INFO - '--tppagecycles', 06:14:35 INFO - '7'], 06:14:35 INFO - 'tests': ['tsvgm']}}, 06:14:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:14:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:14:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'tests': ['damp', 'tps']}, 06:14:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['damp', 'tps']}, 06:14:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:14:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:35 INFO - 'other': {'tests': ['a11yr', 06:14:35 INFO - 'ts_paint', 06:14:35 INFO - 'tpaint', 06:14:35 INFO - 'sessionrestore', 06:14:35 INFO - 'sessionrestore_no_auto_restore']}, 06:14:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['a11yr', 06:14:35 INFO - 'ts_paint', 06:14:35 INFO - 'tpaint', 06:14:35 INFO - 'sessionrestore', 06:14:35 INFO - 'sessionrestore_no_auto_restore']}, 06:14:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['a11yr', 06:14:35 INFO - 'ts_paint', 06:14:35 INFO - 'tpaint', 06:14:35 INFO - 'sessionrestore', 06:14:35 INFO - 'sessionrestore_no_auto_restore']}, 06:14:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['a11yr', 06:14:35 INFO - 'ts_paint', 06:14:35 INFO - 'tpaint', 06:14:35 INFO - 'sessionrestore', 06:14:35 INFO - 'sessionrestore_no_auto_restore']}, 06:14:35 INFO - 'other_l64': {'tests': ['a11yr', 06:14:35 INFO - 'ts_paint', 06:14:35 INFO - 'tpaint', 06:14:35 INFO - 'sessionrestore', 06:14:35 INFO - 'sessionrestore_no_auto_restore']}, 06:14:35 INFO - 'other_nol64': {'tests': ['a11yr', 06:14:35 INFO - 'ts_paint', 06:14:35 INFO - 'tpaint', 06:14:35 INFO - 'sessionrestore', 06:14:35 INFO - 'sessionrestore_no_auto_restore']}, 06:14:35 INFO - 'svgr': {'tests': ['tsvgx', 06:14:35 INFO - 'tsvgr_opacity', 06:14:35 INFO - 'tart', 06:14:35 INFO - 'tscrollx', 06:14:35 INFO - 'cart']}, 06:14:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['tsvgx', 06:14:35 INFO - 'tsvgr_opacity', 06:14:35 INFO - 'tart', 06:14:35 INFO - 'tscrollx', 06:14:35 INFO - 'cart']}, 06:14:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'tests': ['tp5o']}, 06:14:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'talos_options': ['--e10s'], 06:14:35 INFO - 'tests': ['tp5o']}, 06:14:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'talos_options': ['--xperf_path', 06:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:35 INFO - 'tests': ['tp5n']}, 06:14:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:35 INFO - 'talos_options': ['--e10s', 06:14:35 INFO - '--xperf_path', 06:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:35 INFO - 'tests': ['tp5n']}}, 06:14:35 INFO - 'talos.zip': {'path': '', 06:14:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:35 INFO - Running post-action listener: _resource_record_post_action 06:14:35 INFO - ##### 06:14:35 INFO - ##### Running create-virtualenv step. 06:14:35 INFO - ##### 06:14:35 INFO - Running pre-action listener: _resource_record_pre_action 06:14:35 INFO - Running main action method: create_virtualenv 06:14:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:35 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 06:14:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:35 INFO - Using real prefix '/tools/python27' 06:14:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:39 INFO - Installing pip.................done. 06:14:39 INFO - Return code: 0 06:14:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:39 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:39 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 06:14:39 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 06:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:39 INFO - 'HOME': '/Users/cltbld', 06:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:39 INFO - 'LOGNAME': 'cltbld', 06:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:39 INFO - 'MOZ_NO_REMOTE': '1', 06:14:39 INFO - 'NO_EM_RESTART': '1', 06:14:39 INFO - 'PAGER': '/bin/cat', 06:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:39 INFO - 'PWD': '/builds/slave/test', 06:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:39 INFO - 'SHELL': '/bin/bash', 06:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:14:39 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:39 INFO - 'USER': 'cltbld', 06:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:39 INFO - 'XPC_FLAGS': '0x0', 06:14:39 INFO - 'XPC_SERVICE_NAME': '0', 06:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:39 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 06:14:39 INFO - Cleaning up... 06:14:39 INFO - Return code: 0 06:14:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:39 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:39 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 06:14:39 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 06:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:39 INFO - 'HOME': '/Users/cltbld', 06:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:39 INFO - 'LOGNAME': 'cltbld', 06:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:39 INFO - 'MOZ_NO_REMOTE': '1', 06:14:39 INFO - 'NO_EM_RESTART': '1', 06:14:39 INFO - 'PAGER': '/bin/cat', 06:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:39 INFO - 'PWD': '/builds/slave/test', 06:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:39 INFO - 'SHELL': '/bin/bash', 06:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:14:39 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:39 INFO - 'USER': 'cltbld', 06:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:39 INFO - 'XPC_FLAGS': '0x0', 06:14:39 INFO - 'XPC_SERVICE_NAME': '0', 06:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:40 INFO - Downloading/unpacking psutil>=0.7.1 06:14:40 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 06:14:40 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 06:14:40 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 06:14:40 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 06:14:40 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 06:14:40 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 06:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:42 INFO - Installing collected packages: psutil 06:14:42 INFO - Running setup.py install for psutil 06:14:42 INFO - building 'psutil._psutil_osx' extension 06:14:42 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 06:14:43 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 06:14:43 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 06:14:43 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 06:14:43 INFO - building 'psutil._psutil_posix' extension 06:14:43 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 06:14:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:14:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:14:43 INFO - ^ 06:14:43 INFO - 1 warning generated. 06:14:43 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 06:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:44 INFO - Successfully installed psutil 06:14:44 INFO - Cleaning up... 06:14:44 INFO - Return code: 0 06:14:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:44 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:44 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 06:14:44 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 06:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:44 INFO - 'HOME': '/Users/cltbld', 06:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:44 INFO - 'LOGNAME': 'cltbld', 06:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:44 INFO - 'MOZ_NO_REMOTE': '1', 06:14:44 INFO - 'NO_EM_RESTART': '1', 06:14:44 INFO - 'PAGER': '/bin/cat', 06:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:44 INFO - 'PWD': '/builds/slave/test', 06:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:44 INFO - 'SHELL': '/bin/bash', 06:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:14:44 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:44 INFO - 'USER': 'cltbld', 06:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:44 INFO - 'XPC_FLAGS': '0x0', 06:14:44 INFO - 'XPC_SERVICE_NAME': '0', 06:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:14:44 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 06:14:44 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 06:14:44 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 06:14:44 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 06:14:44 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 06:14:44 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 06:14:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:14:46 INFO - Installing collected packages: mozsystemmonitor 06:14:46 INFO - Running setup.py install for mozsystemmonitor 06:14:46 INFO - Successfully installed mozsystemmonitor 06:14:46 INFO - Cleaning up... 06:14:47 INFO - Return code: 0 06:14:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14:47 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')]} 06:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:47 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')]} 06:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:47 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:47 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 06:14:47 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 06:14:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:14:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:47 INFO - 'HOME': '/Users/cltbld', 06:14:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:47 INFO - 'LOGNAME': 'cltbld', 06:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:47 INFO - 'MOZ_NO_REMOTE': '1', 06:14:47 INFO - 'NO_EM_RESTART': '1', 06:14:47 INFO - 'PAGER': '/bin/cat', 06:14:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:47 INFO - 'PWD': '/builds/slave/test', 06:14:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:47 INFO - 'SHELL': '/bin/bash', 06:14:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:14:47 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:14:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:47 INFO - 'USER': 'cltbld', 06:14:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:47 INFO - 'XPC_FLAGS': '0x0', 06:14:47 INFO - 'XPC_SERVICE_NAME': '0', 06:14:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:47 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:49 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:50 INFO - Downloading docopt-0.6.1.tar.gz 06:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:50 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:50 INFO - Running setup.py install for blobuploader 06:14:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:51 INFO - Running setup.py install for requests 06:14:51 INFO - Running setup.py install for docopt 06:14:51 INFO - Successfully installed blobuploader requests docopt 06:14:51 INFO - Cleaning up... 06:14:51 INFO - Return code: 0 06:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:51 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')]} 06:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:52 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')]} 06:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:52 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:52 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 06:14:52 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 06:14:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:14:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:52 INFO - 'HOME': '/Users/cltbld', 06:14:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:52 INFO - 'LOGNAME': 'cltbld', 06:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:52 INFO - 'MOZ_NO_REMOTE': '1', 06:14:52 INFO - 'NO_EM_RESTART': '1', 06:14:52 INFO - 'PAGER': '/bin/cat', 06:14:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:52 INFO - 'PWD': '/builds/slave/test', 06:14:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:52 INFO - 'SHELL': '/bin/bash', 06:14:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:14:52 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:14:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:52 INFO - 'USER': 'cltbld', 06:14:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:52 INFO - 'XPC_FLAGS': '0x0', 06:14:52 INFO - 'XPC_SERVICE_NAME': '0', 06:14:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ph2B74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-HszegY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-PR613x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-LT6TkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-K5gN8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-3KLUux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:52 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-3EASHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-tcLEGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-wW41tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-wrNDF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-N403fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-vX_Zbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-IKCx0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-xAWV3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-kaAZM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:53 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-1XcD5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:54 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-rcAXwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:54 INFO - Running setup.py install for manifestparser 06:14:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Running setup.py install for mozcrash 06:14:54 INFO - Running setup.py install for mozdebug 06:14:54 INFO - Running setup.py install for mozdevice 06:14:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:54 INFO - Running setup.py install for mozfile 06:14:54 INFO - Running setup.py install for mozhttpd 06:14:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozinfo 06:14:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozInstall 06:14:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozleak 06:14:55 INFO - Running setup.py install for mozlog 06:14:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for moznetwork 06:14:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:55 INFO - Running setup.py install for mozprocess 06:14:55 INFO - Running setup.py install for mozprofile 06:14:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Running setup.py install for mozrunner 06:14:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Running setup.py install for mozscreenshot 06:14:56 INFO - Running setup.py install for moztest 06:14:56 INFO - Running setup.py install for mozversion 06:14:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:56 INFO - Cleaning up... 06:14:56 INFO - Return code: 0 06:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:56 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:14:56 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 06:14:56 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 06:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:56 INFO - 'HOME': '/Users/cltbld', 06:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:56 INFO - 'LOGNAME': 'cltbld', 06:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:56 INFO - 'MOZ_NO_REMOTE': '1', 06:14:56 INFO - 'NO_EM_RESTART': '1', 06:14:56 INFO - 'PAGER': '/bin/cat', 06:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:56 INFO - 'PWD': '/builds/slave/test', 06:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:56 INFO - 'SHELL': '/bin/bash', 06:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:14:56 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:56 INFO - 'USER': 'cltbld', 06:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:56 INFO - 'XPC_FLAGS': '0x0', 06:14:56 INFO - 'XPC_SERVICE_NAME': '0', 06:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:56 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-SDeotA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ZWkMkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-xet_Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-dbPBCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-nRnYps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-GErk9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-jfUtHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-rx2oOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-PMJwFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:57 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)) 06:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:57 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-l9QWme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-GnWxwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-ebaKuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-9uWDNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-bN6fuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-JnFJcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-c_8jbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:58 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)) 06:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:58 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-IiINDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 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)) 06:14:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:58 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 06:14:58 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 06:14:58 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 06:14:58 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 06:14:58 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 06:14:58 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 06:15:01 INFO - Downloading blessings-1.6.tar.gz 06:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:01 INFO - Installing collected packages: blessings 06:15:01 INFO - Running setup.py install for blessings 06:15:01 INFO - Successfully installed blessings 06:15:01 INFO - Cleaning up... 06:15:01 INFO - Return code: 0 06:15:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:02 INFO - Reading from file tmpfile_stdout 06:15:02 INFO - Current package versions: 06:15:02 INFO - blessings == 1.6 06:15:02 INFO - blobuploader == 1.2.4 06:15:02 INFO - docopt == 0.6.1 06:15:02 INFO - manifestparser == 1.1 06:15:02 INFO - mozInstall == 1.12 06:15:02 INFO - mozcrash == 0.16 06:15:02 INFO - mozdebug == 0.1 06:15:02 INFO - mozdevice == 0.48 06:15:02 INFO - mozfile == 1.2 06:15:02 INFO - mozhttpd == 0.7 06:15:02 INFO - mozinfo == 0.9 06:15:02 INFO - mozleak == 0.1 06:15:02 INFO - mozlog == 3.1 06:15:02 INFO - moznetwork == 0.27 06:15:02 INFO - mozprocess == 0.22 06:15:02 INFO - mozprofile == 0.28 06:15:02 INFO - mozrunner == 6.11 06:15:02 INFO - mozscreenshot == 0.1 06:15:02 INFO - mozsystemmonitor == 0.0 06:15:02 INFO - moztest == 0.7 06:15:02 INFO - mozversion == 1.4 06:15:02 INFO - psutil == 3.1.1 06:15:02 INFO - requests == 1.2.3 06:15:02 INFO - wsgiref == 0.1.2 06:15:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:02 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')]} 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:02 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')]} 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:02 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:15:02 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 06:15:02 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 06:15:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:15:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:02 INFO - 'HOME': '/Users/cltbld', 06:15:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:02 INFO - 'LOGNAME': 'cltbld', 06:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:02 INFO - 'MOZ_NO_REMOTE': '1', 06:15:02 INFO - 'NO_EM_RESTART': '1', 06:15:02 INFO - 'PAGER': '/bin/cat', 06:15:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:02 INFO - 'PWD': '/builds/slave/test', 06:15:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:02 INFO - 'SHELL': '/bin/bash', 06:15:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:15:02 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:15:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:02 INFO - 'USER': 'cltbld', 06:15:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:02 INFO - 'XPC_FLAGS': '0x0', 06:15:02 INFO - 'XPC_SERVICE_NAME': '0', 06:15:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 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)) 06:15:02 INFO - Cleaning up... 06:15:02 INFO - Return code: 0 06:15:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:02 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')]} 06:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:02 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')]} 06:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:02 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 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:15:02 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 06:15:02 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 06:15:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:15:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:02 INFO - 'HOME': '/Users/cltbld', 06:15:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:02 INFO - 'LOGNAME': 'cltbld', 06:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:02 INFO - 'MOZ_NO_REMOTE': '1', 06:15:02 INFO - 'NO_EM_RESTART': '1', 06:15:02 INFO - 'PAGER': '/bin/cat', 06:15:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:02 INFO - 'PWD': '/builds/slave/test', 06:15:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:02 INFO - 'SHELL': '/bin/bash', 06:15:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:15:02 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:15:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:02 INFO - 'USER': 'cltbld', 06:15:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:02 INFO - 'XPC_FLAGS': '0x0', 06:15:02 INFO - 'XPC_SERVICE_NAME': '0', 06:15:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:02 INFO - Downloading/unpacking jsonschema 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 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 06:15:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:05 INFO - Downloading/unpacking functools32 (from jsonschema) 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:05 INFO - warning: no files found matching '*.txt' 06:15:05 INFO - no previously-included directories found matching 'build' 06:15:05 INFO - no previously-included directories found matching 'dist' 06:15:05 INFO - no previously-included directories found matching '.git*' 06:15:05 INFO - Installing collected packages: jsonschema, functools32 06:15:05 INFO - Running setup.py install for functools32 06:15:05 INFO - warning: no files found matching '*.txt' 06:15:05 INFO - no previously-included directories found matching 'build' 06:15:05 INFO - no previously-included directories found matching 'dist' 06:15:05 INFO - no previously-included directories found matching '.git*' 06:15:05 INFO - Successfully installed jsonschema functools32 06:15:05 INFO - Cleaning up... 06:15:06 INFO - Return code: 0 06:15:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:15: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')]} 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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')]} 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1e84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc13c8aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, '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.iHlgPxJ675/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.r57HMGauMI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:15: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', 'flake8'] in /builds/slave/test/build 06:15: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 flake8 06:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:06 INFO - 'HOME': '/Users/cltbld', 06:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:06 INFO - 'LOGNAME': 'cltbld', 06:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:06 INFO - 'MOZ_NO_REMOTE': '1', 06:15:06 INFO - 'NO_EM_RESTART': '1', 06:15:06 INFO - 'PAGER': '/bin/cat', 06:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:06 INFO - 'PWD': '/builds/slave/test', 06:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:06 INFO - 'SHELL': '/bin/bash', 06:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:15:06 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:06 INFO - 'USER': 'cltbld', 06:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:06 INFO - 'XPC_FLAGS': '0x0', 06:15:06 INFO - 'XPC_SERVICE_NAME': '0', 06:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:06 INFO - Downloading/unpacking flake8 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:15:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:15:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:15: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 06:15: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 06:15: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 06:15: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 06:15: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 06:15: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 06:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:15:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:09 INFO - no previously-included directories found matching 'docs/_build' 06:15:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:15:09 INFO - Running setup.py install for pep8 06:15:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:15:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:15:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:15:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:15:10 INFO - no previously-included directories found matching 'docs/_build' 06:15:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:15:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:15:10 INFO - Cleaning up... 06:15:10 INFO - Return code: 0 06:15:10 INFO - Running post-action listener: _resource_record_post_action 06:15:10 INFO - Running post-action listener: _start_resource_monitoring 06:15:10 INFO - Starting resource monitoring. 06:15:10 INFO - ##### 06:15:10 INFO - ##### Running install step. 06:15:10 INFO - ##### 06:15:10 INFO - Running pre-action listener: _resource_record_pre_action 06:15:10 INFO - Running main action method: install 06:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:10 INFO - Reading from file tmpfile_stdout 06:15:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:10 INFO - Reading from file tmpfile_stdout 06:15:10 INFO - Output received: 06:15:10 INFO - Usage: mozinstall [options] installer 06:15:10 INFO - Options: 06:15:10 INFO - -h, --help show this help message and exit 06:15:10 INFO - -d DEST, --destination=DEST 06:15:10 INFO - Directory to install application into. [default: 06:15:10 INFO - "/builds/slave/test"] 06:15:10 INFO - --app=APP Application being installed. [default: firefox] 06:15:10 INFO - mkdir: /builds/slave/test/build/application 06:15:10 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'] 06:15:10 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 06:15:45 INFO - Reading from file tmpfile_stdout 06:15:45 INFO - Output received: 06:15:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:15:45 INFO - Running post-action listener: _resource_record_post_action 06:15:45 INFO - ##### 06:15:45 INFO - ##### Running run-tests step. 06:15:45 INFO - ##### 06:15:45 INFO - Running pre-action listener: _resource_record_pre_action 06:15:45 INFO - Running main action method: run_tests 06:15:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:15:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:15:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:15:45 INFO - 2016-03-03 06:15:45.100 screenresolution[1643:7520] starting screenresolution argv=screenresolution get 06:15:45 INFO - 2016-03-03 06:15:45.103 screenresolution[1643:7520] Display 0: 1600x1200x32@60 06:15:45 INFO - 2016-03-03 06:15:45.109 screenresolution[1644:7522] starting screenresolution argv=screenresolution list 06:15:45 INFO - Available Modes on Display 0 06:15:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:15:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:15:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:15:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:15:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:15:45 INFO - Intel Iris: 06:15:45 INFO - Chipset Model: Intel Iris 06:15:45 INFO - Type: GPU 06:15:45 INFO - Bus: Built-In 06:15:45 INFO - VRAM (Dynamic, Max): 1536 MB 06:15:45 INFO - Vendor: Intel (0x8086) 06:15:45 INFO - Device ID: 0x0a2e 06:15:45 INFO - Revision ID: 0x0009 06:15:45 INFO - Displays: 06:15:45 INFO - Display: 06:15:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:15:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:15:45 INFO - Display Serial Number: 1600x1200 60 06:15:45 INFO - Main Display: Yes 06:15:45 INFO - Mirror: Off 06:15:45 INFO - Online: Yes 06:15:45 INFO - Rotation: Supported 06:15:45 INFO - Return code: 0 06:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:45 INFO - Python 2.7.3 06:15:45 INFO - Return code: 0 06:15:45 INFO - grabbing minidump binary from tooltool 06:15: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')]} 06:15:45 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 0x10c084d30>, '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 0x10bea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c07bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:45 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 06:15:45 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 06:15:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:45 INFO - Return code: 0 06:15:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:15:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:15:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:15:46 INFO - Return code: 0 06:15:46 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/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 06:15:46 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/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --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 06:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iHlgPxJ675/Render', 06:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:15:46 INFO - 'HOME': '/Users/cltbld', 06:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:15:46 INFO - 'LOGNAME': 'cltbld', 06:15:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:46 INFO - 'MOZ_NO_REMOTE': '1', 06:15:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:46 INFO - 'NO_EM_RESTART': '1', 06:15:46 INFO - 'PAGER': '/bin/cat', 06:15:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:46 INFO - 'PWD': '/builds/slave/test', 06:15:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:15:46 INFO - 'SHELL': '/bin/bash', 06:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r57HMGauMI/Listeners', 06:15:46 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:15:46 INFO - 'USER': 'cltbld', 06:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:46 INFO - 'XPC_FLAGS': '0x0', 06:15:46 INFO - 'XPC_SERVICE_NAME': '0', 06:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:15:46 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/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 06:15:46 INFO - mozversion application_buildid: 20160303025739 06:15:46 INFO - mozversion application_changeset: 68b6defee155efdc00bb6b4602b30bcb26da5a5a 06:15:46 INFO - mozversion application_display_name: Nightly 06:15:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:46 INFO - mozversion application_name: Firefox 06:15:46 INFO - mozversion application_remotingname: firefox 06:15:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:15:46 INFO - mozversion application_vendor: Mozilla 06:15:46 INFO - mozversion application_version: 47.0a1 06:15:46 INFO - mozversion platform_buildid: 20160303025739 06:15:46 INFO - mozversion platform_changeset: 68b6defee155efdc00bb6b4602b30bcb26da5a5a 06:15:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:15:46 INFO - mozversion platform_version: 47.0a1 06:15:46 INFO - using testdate: 1457014546 06:15:46 INFO - actual date: 1457014546 06:15:47 INFO - starting webserver on 'localhost:49270' 06:15:47 INFO - SUITE-START | Running 2 tests 06:15:47 INFO - TEST-START | dromaeo_css 06:15:47 INFO - operating with platform_type : mac_ 06:15:47 INFO - Initialising browser for dromaeo_css test... 06:15:47 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpC1qbyB/profile http://localhost:49270/getInfo.html) 06:15:49 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:15:49 INFO - PROCESS | 1662 | colorDepth:24 06:15:49 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:15:49 INFO - PROCESS | 1662 | __metrics 06:15:49 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:15:49 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:50 INFO - TEST-INFO | 1662: exit 0 06:15:50 INFO - Browser initialized. 06:15:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:50 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpC1qbyB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:02 INFO - PROCESS | 1665 | RSS: Main: 243609600 06:16:02 INFO - PROCESS | 1665 | 06:16:53 INFO - PROCESS | 1665 | 1457014613520 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] 06:19:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:19:05 INFO - PROCESS | 1665 | RSS: Main: 494026752 06:19:05 INFO - PROCESS | 1665 | 06:22:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:22:09 INFO - PROCESS | 1665 | RSS: Main: 382906368 06:22:09 INFO - PROCESS | 1665 | 06:25:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:25:11 INFO - PROCESS | 1665 | RSS: Main: 378712064 06:25:11 INFO - PROCESS | 1665 | 06:28:13 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 06:28:14 INFO - PROCESS | 1665 | RSS: Main: 341516288 06:28:14 INFO - PROCESS | 1665 | 06:31:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 06:31:18 INFO - PROCESS | 1665 | RSS: Main: 341233664 06:31:18 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 06:34:21 INFO - PROCESS | 1665 | RSS: Main: 403828736 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | __start_tp_report 06:34:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:34:21 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:34:21 INFO - PROCESS | 1665 | |i|pagename|runs| 06:34:21 INFO - PROCESS | 1665 | |0;dojo.html;3440.9311813763725;3507.8669074026325;3508.7193024558023;3533.222691007979;3568.286342731453;5602.719864006804;5612;5723.570732195081;5739.856503587413;5778.971105144474;5757.078867381219;5770.509506691926;5778.913316300248;5898.321693005306;5923.022701254298;5110.361204849394;5116.795328186868;5166.509181627739;5177.352830896138;5281.8943621127555;5256.448072952342;5264.42091369949;5287.41838397776;5311.601629877755;5341.225522299264;5113.846584602468;5115.820946266881;5170.560502357304;5205.505476979681;5220.1647736362;5143.614228932807;5155.2524883892;5159.793608255665;5170.612204084671;5172.482751724835;5109.080365534202;5148.768305426265;5152.587792976553;5169.405518365398;5174.948250517522;5530.2810634617645;5625.634333768292;5628.0713682242385;5630.268065151504;5660.490555849952;6101.5804940036605;6157.507399408037;6257.936150854366;6262.2172228471445;6271.153394291758;6185.505159587222;6237.688115594247;6239.0329498927285;6267.373262673696;6271.6864156792435;5180.678926873623;5464.371597266286;5799.217105690762;5803.303603567599;5824.184614154022;6231.4391704746795;6276.529260305404;6282.465990390777;6290.528210384239;6309.842253943688;6167.136600875881;6171.876562468726;6177.382261773877;6191.783287584913;6199.814005579839;6242.250929888442;6274.560780745304;6302.4958003359625;6315.147455093595;6329.620222786648;5029.346184996;6039.456448919618;6124.472479235402;6162.414570615784;6212;6204.348543402878;6206.627602343874;6213.96893015532;6215.036669316263;6220.782272620437;4730.976345118322;4872.342233798392;4879.707217566957;4893.584045356185;4927.975360123248;4330.328799036154;4333.393324934512;4427.601515863587;4429.80065897029;4430.269005614037;5723.885522289531;5753.539716822645;5755.395683453261;5757.424257574293;5773.480386765212;6282.905756413657;6333.556651034383;6337.7781777637565;6337.859185346681;6343.492520598341;5640.182173584889;5738.741756620962;5740.856478587985;5809.390014048548;5838.5329173666005;5322.494363035583;5327.493888080704;5335.626506144533;5340.893182136336;5346.599005074635;6287.559870809091;6290.4653104485715;6293.118963345135;6295.874082518232;6307.779227727007;5696.487316141567;5928.9110663339225;6144.419343875672;6218.595791273553;6276.309605943434;5553.72231388437;6000.399960003964;6284.371562843679;6299.96850015747;6322.367763223825;6141.201643786279;6189.566730328834;6198.535109866868;6217.720202590985;6223.253209614694;6286.057091436322;6296.590721603081;6305.306416294112;6311.368863113652;6320.62076275425;5402.810901618424;5985.970070149796;6091.60404573719;6114.908276375769;6128.295246046761;5871.559633027455;6045.425684559959;6072.483838873569;6075.1191077294425;6078.240219972504;5884.411558844081;5903.380145084876;5914.467697907209;5924.585279030426;5937.821865344046;6020.969895150496;6021.7591296347655;6025.671737134335;6026.528258362161;6077.361877002851;5925.466707996128;6005.279366476051;6008.459238668541;6014.1580178775885;6019.488343490677 06:34:21 INFO - PROCESS | 1665 | |1;ext.html;448.2670833187737;489.96617137839155;579.4813641790597;637.0666972884724;640.6860638287237;37984;38362.61637383625;38721.61278387215;38819.611803881955;38837;41390;41603.543875964344;41722.7913860431;41816.79091604538;41910;9534.618615255398;9778.951105244463;9782.510874456284;9799.657012004582;9817.901820981806;9541.093596108358;9707.223422126213;9707.660231891885;9820.558074886612;9857.852132218022;8528.616212270463;9784.95107524465;9864.654737084204;9882.901170988305;9886.752831179207;9750.512474376288;9829.164521015722;9837;9850.359726617819;9855.753606159831;9664.323497355188;9793.412395256308;9802.215822734235;9807.607695692164;9819.705408837746;39520.60479395198;39772.80681579528;39865.80067099675;39883.8005809972;39888.800555997324;3099;3178.3802158578856;3243.5459035735016;3267.4608689566194;3349.866005359807;28125.43749125006;28396.432071358457;29056.41887162266;29122.271943201376;29166.97915572966;2771.1270949651;2792.9720702792915;2805.340744924941;2868.182567968119;2921.532554791223;498633;499152.5042374765;499467.50266248436;500245;500772;44625;63098.684506578094;63106.68446657829;63553;63618;44190.779046104566;44282.55717442849;44399.33400998988;44454.77772611116;44486.555134448885;15247.61880952963;15550.688986220212;15559.22203889801;15560.92219538895;15625.531234062997;12480;12542.05934554912;12545.811812822814;12546.937265313798;12556.372181390894;14249.85750142506;14267.928660356632;14527.709445811024;14540.63648408777;14702.338394772261;6292.653904035231;6393.840153996187;6396.584222025554;6441;6441.871162576722;938.7512309238058;965.4110992294694;997.8303688372849;1047.6909311753052;1082.734729991157;28746.425071498452;28988.42023159525;29186.270343241587;29261;29473.85263073714;930.7580029192459;1076.4886678827652;1124.859392575928;1138.408027825526;1199.682084247675;13910;13943.58169254924;14053.648658783612;14236.644083897778;14344.784828227585;533947;534231;543939;545140;547319;52235.955280894166;52929;56652.433475664715;57084.28747137592;57236.14145787816;1217.4278089298016;1301.8502872169631;1403.6982048859545;1416.362636813438;1462.4881291547872;26704.465910682065;26722.732772672804;28269.57595636026;28571.712711577627;28900;46443.83890402767;46867.53132468768;46983;47056;47259.291110634054;374611;386398.06800965813;386699;387367;387787;26251;30471.390572188877;31470.213244669067;32395.866144684824;33193.668063319055;33337.666623333454;34123.317533649686;34142.975710728715;34224.82887585546;34276.48585271273;32773.836130819196;34353.14117147091;35260.82369588136;36051.459228111074;36465.27069458543;29164.7083529162;34788.130296742784;35232.823835880656;35749.28501430009;36103.27793444169;34825.303493930485;35407.82296088503;35553.82223088868;35743.821280893426;35799.64200357963;30223.395532088794;31420.685793141776;31504.36991260116;31518.369632606762;31544.526832097996;21106.78893211048;22096.33710988673;23283.417914551595;23546;23809.9285532148 06:34:21 INFO - PROCESS | 1665 | |2;jquery.html;349.5106850409427;354.6294122641837;354.8119496666767;359.8110991729342;362.04239785766663;19957.301494447696;20490.385288441354;20703.896480517597;21118;21132.683009754866;14478.710425791478;19521.511962200915;20092.59814803707;21040.789592104073;21110.472238194052;5840.591158618909;6054.061620448838;6130.44825965663;6137.478314343286;6142.447179753821;4282.03654177809;4449.955500445003;5682.607761098537;5876.089206173028;6655.833604159886;6566.835829104263;6582.243042050154;6585.374389432996;6586.8682626347445;6592.703328350211;6251.843703907416;6532.5753826001155;6535.21577410709;6541.705623246941;6543.051257567674;3776.2636285924254;5398.757055932492;5614.691191984439;5618.887622247532;5625.353084395306;10784.622538211204;13584.932075339659;13602;24841.6273755892;25125.87437062821;1991.2532800199924;2061.6082944240547;2124.9893750531305;2184.9563008739738;2626.93432664183;8466.280366168883;9591.760205994837;9704.854427183598;9773.560189791406;10010.749731256705;1645.5145732009087;1690.8140104588485;1747.1177055586975;1777.680017596845;1816.9182386792627;108745;109613;109614.45192774065;110382;112546;11224.943875280735;11275.32348059119;11346.602868899548;11364.920332568392;11489.195756297146;13663.453461861613;13778.862211377758;13800.171989680652;13813.654658633413;13835.79246311306;8334.583270836434;8488.618012189467;8548.700795472252;8671;8700.651973921098;8759.430637008574;8785.692500762443;8798.20816126539;8927.24118449926;8933.330000250007;4365.148795984816;4449.866504004885;4477.462704475419;4514.029483661028;4518.728876267369;1712.0925909268108;1784.3219576560823;1795.1293622593032;1800.7659004329353;1845.640100180452;880.423322723617;940.7177846645978;962.8459446488528;975.6682727872558;994.3884511025667;18837.43487695344;19512.609747804963;19654.803451965297;19818.4054478363;19827.702584461244;952.5713428956997;954.2175416158822;982.5627595719836;1042.358949246208;1087.255230167338;10381.532831022621;10536.262461627612;10569.9958503942;10606.734831629272;10634.30876992993;494548;589182.0540897268;609802;610360;644419;121422.39288803676;122768.38615806864;122852.15721764181;122945;128614;1010.8685870836745;1019.8317277649253;1036.9377837329785;1037.4034929915329;1038.4911393417322;15717.371305148123;16979.916389045626;17053.147342633067;17368;17667.204975776378;53323.93352132858;53411.93176136533;53492.73253633707;54275.45724542704;56094.99999999837;60152.69923650354;78586;79099.20900790919;79429.2057079445;79887;7479.214682458482;8082.393820463606;8083.353331733565;8083.757487275391;8089.959550202211;12267.263964162179;12571.057170712416;12730.936345318214;12937;13060.869391305965;10002.649907253211;10977.890221097687;11258.38078905668;11451.370174640475;11502.309861408343;8381.95809020951;10619.575216991234;10864.619738309122;10976.12191024732;11165;11251.606193783178;11297.71755706114;11489.310641361544;11538.653840384803;11569.826452603049;7800.024996875391;7815.570143642154;8085.757427277191;8094.271515563628;8097.959510202411;9812.165965892978;9957.352772069793;11335.829962550404;11692.415379231175;11714.1800073994 06:34:21 INFO - PROCESS | 1665 | |3;mootools.html;1335.3056410666459;1525.610969202853;1549.566121485984;1799.1813724755239;1960.4510736993648;7818.335441487473;8357.498550086999;8511.446755960873;8520.190581894718;8554.272886804629;8225.835483290346;8500.192481714243;8503.957480212606;8509.44688595241;8519.829603407943;2129.4889226585665;2186.6719992001167;2189.3979155732222;2373.7982271506944;2414.6619473273668;2418.600930846417;2484.043643197364;2484.416162201881;2487.0300582772734;2488.029668429314;2405.4109285205204;2422.4791669790993;2426.980668119394;2431.9756802431925;2450.6079027355627;2411.915582954588;2431.088341871798;2432.622943443769;2437.0251899240357;2444.4499987502845;2345.9765402346097;2352.2120089769946;2352.6706261123454;2354.9882250588807;2356.9410764730846;8575.742727718178;8638.956805215996;8649.956750216208;8653.394262401634;8678.609462574199;5239;5410.567154627621;5416;5422.376426710939;5429.294191755047;3070.4626690329105;3482.669146431085;3490.057684425191;3646.7994260315672;3671.687906527948;1039.5789705169418;1048.2976405808126;1064.9148068154607;1065.5631191211567;1071.9088877445427;11358.60244891425;11498.770024599462;11546.249493782962;11549.826752598718;11554.711132221677;4734.19518681825;4827.2035114206465;4850.563449289511;4850.83022094225;4905.705657660552;9802.362846415102;9866.506674666238;9884.061014203782;9889.60441582343;9891;5343.118385466354;5362.061639213122;5365.08793505105;5365.195220716846;5376.327959005124;4359.673024523174;4461.460796025366;4509.188346097734;4868.756562171877;4875.658703890694;3653.104989277644;3718.9070273242846;3827.78947157909;3893.766374017568;3898.629630185128;1243.7139457924727;1288.5039259885011;1301.8958483321312;1307.3528603341217;1311.5540716156552;1297.4615534553243;1306.915050521713;1327.9933600332129;1330.6274243211917;1363.8977076719286;7795.22047795216;7885.526868387915;7890.289873911375;7898.960505197438;7919.485233459806;1150.3672979861044;1165.8600967883908;1171.9472623731951;1173.7417768091007;1195.1992165249303;5181.81863634771;6231.813045608639;6263.31103578606;6263.404976527223;6266.965950618188;9938.354006989523;10373.429461379546;10500.684979450629;10508.789824203473;10521.579136834594;10000.14998725102;10284.228682848816;10307;10392.688219353431;10410.635627752992;7633.732819351296;8105.797355066288;8162.469439486533;8180.6318715657935;8201.384896132813;7566.35685966677;7609.124950630749;7641.083070031632;7681.577513236825;7690.307872291521;9237.861432078389;9280.72157835266;9348.626054957998;9351.579178936829;9432.481213533047;9448.858267126136;9674.661386851427;9736.756581085247;9755.122039016522;9860.16188623975;7296.96351518239;7345.412367010733;7361.26387361281;7369;7380;7066.222715501393;7552.773416797505;7881.802954926173;7927.088384835818;7942.404319675932;7124.180719217149;7145.892811607934;7162.89255661155;7220.8916866246;7252.238514955854;7007.929920700728;7026.297370262932;7112.35988761014;7140.821479463055;7175.03137076488;7361.926380736124;7370.44721645868;7438.144613369532;7441.776746697607;7488.625568721433;6805.285445028201;6809.182898052265;6814.046033555405;6826.795196144124;6843.794686159423;6833.214180369122;6936.271691472524;6998.16022077354;7005.859882802213;7011.088558487364 06:34:21 INFO - PROCESS | 1665 | |4;prototype.html;317.793434267726;320.1116900600832;328.1975569732006;329.05561039815746;331.70643980077654;6679.131712877325;6697.397234248922;6760.594364338143;6763.391294783469;6787.540678754067;6695.665216739168;6722.193336799591;6727.091842601248;6731.562448440848;6750.22372427171;3982.6216509431556;4438.999999999992;4813.542713442217;4827.517248275162;4880.780364883571;4819.228923372261;4889.266610008492;4894.730789806559;4902.264660300948;4918.631102667297;4375.890602734925;4494.1910456117885;4869.756512174377;4877.51224877513;4889.3888263967;4686.039361930813;4750.287456881478;4809.591184749301;4856.611471082305;4877.6585639004925;4140.130572579762;4145.54399016108;4149.585041495857;4155.937660935088;4157.3140431828715;6391.360863913618;6449.35506449356;6481.384268494486;6505.60966342021;6505.6421896795655;5828.912566311508;5830.067189249742;5831;5833.32916714579;5840.7079646017955;5994.670293133876;7084.858302833966;7086.681099350541;7086.787396378117;7098.36114749675;3375.2743160220425;4516.977415112936;4555.157295900269;4579;4601.44782626087;7513.962430187868;7576.393888488963;7599.6580153892655;7599.886001710034;7603.125640551352;4644.767761611906;4646.744429056367;4658.301254811738;4658.534146585314;4658.813647454064;4702.341672165831;4702.482726900038;4703;4712.52874712526;4713.222318317507;5700.914486282626;5710.971445142831;5713;5714.457126572969;5715.399883012307;6537.280899101095;6606.306337834554;6867.175938887365;7099.112610923635;7200.747973820996;1460.9926950365393;1541.0984574024321;1601.5195441367543;1635.7219272723667;1637.6479057002564;972.3048020665258;1020.4081632653043;1037.5071840875523;1042.2756184451732;1054.2936232724094;6556.508261880378;6595.307492713292;6606.669666516751;6653.234877988996;6777.457803375718;7482.28918252776;7485.588292643848;7502.17476077631;7502.287282708134;7504.287092726182;6778.93221067783;6788.151481064867;6790.796276111724;6793.796186114425;6794.184697836291;3802.5018239446445;3908.687305015592;3951.881443556698;3956.584558621303;3958.851932939473;7787.29914307715;7914.762557123296;7920.841583168304;7922.881156782653;7926.801829954297;7638.618069096523;7728.690852365955;7732.806679833049;7754.92245077542;7772.145064042951;7875.645595948196;7882.881756773539;7885.487443316166;7886.881696774553;7896.565688887166;7187.598418308379;7405.96297018533;7469.887951680837;7475.88786168197;7487.5507469552;7271.3455788979245;7276.05411296528;7310.59791711461;7319.121705395173;7324.340809327186;7880.960595196987;7884.84230315402;7884.921150788418;7889.447738658238;7902.051753789352;4356.716813407118;4574.611158051603;4792.496787837227;4848.903021939612;4859.416869975626;7184.676689548878;7348.265173482609;7352.228016058237;7363.595002274927;7441.330280274801;7186.89219661695;7227.891581626385;7247.855042899218;7260.96369518149;7266.781996540112;7225.458090643117;7232.493725439169;7232.927670723226;7239.529430586995;7243.7464688735645;7041.5775053496955;7042.366187043191;7046.4715146363205;7048.894266586108;7049.647517624201;6939.6877140529805;7240.52936559122;7248.710051598088;7251.746188883364;7257.745978890714;5511.972440137773;6776.796696099125;6908.965455172893;6998.825029374103;7070 06:34:21 INFO - PROCESS | 1665 | |5;yui.html;657.7106073327735;663.1743479368185;665.8102440804372;676.8950812624045;710.2897102897105;14677.266136693162;14766.557003289892;14829.110253384777;14830.851691483096;14837.109773413602;10932.726681832959;13445.394957226923;13629.114107583026;13789.241591712453;13820.447182112728;698.3121625199175;704.4962851561132;858.1675774498742;861.1044513705739;875.2341701011615;877.6313948141764;879.4547380624022;880.5509190312922;880.5861245214771;883.6421249394006;927.3740225347897;927.4713413354391;927.8561822917459;927.8793756811639;929.665320484625;736.3630459652389;905.1265528764708;919.3977944446399;922.5110691333604;930.5719369090226;679.8062552172607;681.7886455198905;682.9180498340181;683.723092147681;684.2302409788988;14820.62948426298;14876;14911.478098266509;14939.701205975929;14996.400143994228;12633.431495582721;12638.49446022158;12667.683307917283;12918.095733298673;13033.608991730263;9910.157636600898;10087.646932357406;10322.845157322647;10588.047075763141;10910.836337454944;3597.94603080954;3667.229881724841;3673.265346930598;3746.4380342948502;3780.0549862534367;84972;85580;85617.57191214066;85764.99999999937;85861;9258.305627077862;9318.39430437033;9342.626294948126;9377.953110234404;9587.568559414844;20550.58898822015;20678.58642827165;20681.069351879203;20695.27566535164;20772.68840967387;7342.559446433231;7449.106107267163;7459.925400746031;7484.663190156456;7527.435442341737;4031.0728532437115;4098.7130900836655;4099.938500922489;4111.6299533042165;4112.3420252759415;3447.793132412013;3487.7035451986358;3489.3021395720957;3490.9301813964084;3492.1444246159854;514.6243242433045;584.4016614559177;591.5504216795266;634.2230767310008;646.0245030004633;540.7999040355015;561.4609974424517;568.0031544639214;571.4456976732563;593.5251798561134;7917.920820791718;7924.524528528307;7938.603069846485;8110.310623596943;8299.219934779812;430.35876543949917;570.4637640617806;583.5564970622357;609.3966972696998;619.3991827926903;3590.281943611288;3737.2712321097124;3798.5631652360335;3870.07118291608;3932.7239633582185;94230;96036;96177.55733663861;96762;97267;80634.59682701548;81584;81599.18400816034;82540.17459825445;83460.58269708612;67606.66196668985;70218.24454388578;70251.64874175597;72994.63502682559;74975;8269.131741167332;8374.958125209336;8526.147385261424;8566.957165214384;8623.956880215559;46829;46998.29502557533;49206;50567.74716126396;51024.74487627538;67105.32894670991;68530;69059.96410053753;69904;69974;10847.011033649598;11048;11336.829947550958;11458.71353216143;11746.471408786796;10969.945150274198;11585.07319414428;11865.228760130563;11891.82162267584;12229.69425764363;11100.944495277472;11437.256578322382;11455.770884582429;11675.065994720571;11693.590724324948;9154.908450915673;11471.885281147082;11524.59663911759;11792.490275462304;12023.338716370683;11115.555377784798;11356.545738170711;11358.829617555579;11629;11668.358240296866;9684.661036863676;9688.273379496706;9729.367591106555;9733.707988760349;9806.705798826046;8812.911870881466;9113.77215569616;9594.829480750426;9665.468399238109;9716.465594392377 06:34:21 INFO - PROCESS | 1665 | __end_tp_report 06:34:21 INFO - PROCESS | 1665 | __start_cc_report 06:34:21 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2657 06:34:21 INFO - PROCESS | 1665 | __end_cc_report 06:34:21 INFO - PROCESS | 1665 | __startTimestamp1457015661551__endTimestamp 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:34:21 INFO - PROCESS | 1665 | Number of tests: 6 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5721.17 Median:5923.02 stddev:630.36 (10.6%) stddev-sans-first:606.38 06:34:21 INFO - PROCESS | 1665 | Values: 3440.9 3507.9 3508.7 3533.2 3568.3 5602.7 5612.0 5723.6 5739.9 5779.0 5757.1 5770.5 5778.9 5898.3 5923.0 5110.4 5116.8 5166.5 5177.4 5281.9 5256.4 5264.4 5287.4 5311.6 5341.2 5113.8 5115.8 5170.6 5205.5 5220.2 5143.6 5155.3 5159.8 5170.6 5172.5 5109.1 5148.8 5152.6 5169.4 5174.9 5530.3 5625.6 5628.1 5630.3 5660.5 6101.6 6157.5 6257.9 6262.2 6271.2 6185.5 6237.7 6239.0 6267.4 6271.7 5180.7 5464.4 5799.2 5803.3 5824.2 6231.4 6276.5 6282.5 6290.5 6309.8 6167.1 6171.9 6177.4 6191.8 6199.8 6242.3 6274.6 6302.5 6315.1 6329.6 5029.3 6039.5 6124.5 6162.4 6212.0 6204.3 6206.6 6214.0 6215.0 6220.8 4731.0 4872.3 4879.7 4893.6 4928.0 4330.3 4333.4 4427.6 4429.8 4430.3 5723.9 5753.5 5755.4 5757.4 5773.5 6282.9 6333.6 6337.8 6337.9 6343.5 5640.2 5738.7 5740.9 5809.4 5838.5 5322.5 5327.5 5335.6 5340.9 5346.6 6287.6 6290.5 6293.1 6295.9 6307.8 5696.5 5928.9 6144.4 6218.6 6276.3 5553.7 6000.4 6284.4 6300.0 6322.4 6141.2 6189.6 6198.5 6217.7 6223.3 6286.1 6296.6 6305.3 6311.4 6320.6 5402.8 5986.0 6091.6 6114.9 6128.3 5871.6 6045.4 6072.5 6075.1 6078.2 5884.4 5903.4 5914.5 5924.6 5937.8 6021.0 6021.8 6025.7 6026.5 6077.4 5925.5 6005.3 6008.5 6014.2 6019.5 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:60616.33 Median:205538.14 stddev:127789.71 (62.2%) stddev-sans-first:128068.34 06:34:21 INFO - PROCESS | 1665 | Values: 448.3 490.0 579.5 637.1 640.7 37984.0 38362.6 38721.6 38819.6 38837.0 41390.0 41603.5 41722.8 41816.8 41910.0 9534.6 9779.0 9782.5 9799.7 9817.9 9541.1 9707.2 9707.7 9820.6 9857.9 8528.6 9785.0 9864.7 9882.9 9886.8 9750.5 9829.2 9837.0 9850.4 9855.8 9664.3 9793.4 9802.2 9807.6 9819.7 39520.6 39772.8 39865.8 39883.8 39888.8 3099.0 3178.4 3243.5 3267.5 3349.9 28125.4 28396.4 29056.4 29122.3 29167.0 2771.1 2793.0 2805.3 2868.2 2921.5 498633.0 499152.5 499467.5 500245.0 500772.0 44625.0 63098.7 63106.7 63553.0 63618.0 44190.8 44282.6 44399.3 44454.8 44486.6 15247.6 15550.7 15559.2 15560.9 15625.5 12480.0 12542.1 12545.8 12546.9 12556.4 14249.9 14267.9 14527.7 14540.6 14702.3 6292.7 6393.8 6396.6 6441.0 6441.9 938.8 965.4 997.8 1047.7 1082.7 28746.4 28988.4 29186.3 29261.0 29473.9 930.8 1076.5 1124.9 1138.4 1199.7 13910.0 13943.6 14053.6 14236.6 14344.8 533947.0 534231.0 543939.0 545140.0 547319.0 52236.0 52929.0 56652.4 57084.3 57236.1 1217.4 1301.9 1403.7 1416.4 1462.5 26704.5 26722.7 28269.6 28571.7 28900.0 46443.8 46867.5 46983.0 47056.0 47259.3 374611.0 386398.1 386699.0 387367.0 387787.0 26251.0 30471.4 31470.2 32395.9 33193.7 33337.7 34123.3 34143.0 34224.8 34276.5 32773.8 34353.1 35260.8 36051.5 36465.3 29164.7 34788.1 35232.8 35749.3 36103.3 34825.3 35407.8 35553.8 35743.8 35799.6 30223.4 31420.7 31504.4 31518.4 31544.5 21106.8 22096.3 23283.4 23546.0 23809.9 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34037.64 Median:2154.97 stddev:98618.76 (4576.3%) stddev-sans-first:98862.97 06:34:21 INFO - PROCESS | 1665 | Values: 349.5 354.6 354.8 359.8 362.0 19957.3 20490.4 20703.9 21118.0 21132.7 14478.7 19521.5 20092.6 21040.8 21110.5 5840.6 6054.1 6130.4 6137.5 6142.4 4282.0 4450.0 5682.6 5876.1 6655.8 6566.8 6582.2 6585.4 6586.9 6592.7 6251.8 6532.6 6535.2 6541.7 6543.1 3776.3 5398.8 5614.7 5618.9 5625.4 10784.6 13584.9 13602.0 24841.6 25125.9 1991.3 2061.6 2125.0 2185.0 2626.9 8466.3 9591.8 9704.9 9773.6 10010.7 1645.5 1690.8 1747.1 1777.7 1816.9 108745.0 109613.0 109614.5 110382.0 112546.0 11224.9 11275.3 11346.6 11364.9 11489.2 13663.5 13778.9 13800.2 13813.7 13835.8 8334.6 8488.6 8548.7 8671.0 8700.7 8759.4 8785.7 8798.2 8927.2 8933.3 4365.1 4449.9 4477.5 4514.0 4518.7 1712.1 1784.3 1795.1 1800.8 1845.6 880.4 940.7 962.8 975.7 994.4 18837.4 19512.6 19654.8 19818.4 19827.7 952.6 954.2 982.6 1042.4 1087.3 10381.5 10536.3 10570.0 10606.7 10634.3 494548.0 589182.1 609802.0 610360.0 644419.0 121422.4 122768.4 122852.2 122945.0 128614.0 1010.9 1019.8 1036.9 1037.4 1038.5 15717.4 16979.9 17053.1 17368.0 17667.2 53323.9 53411.9 53492.7 54275.5 56095.0 60152.7 78586.0 79099.2 79429.2 79887.0 7479.2 8082.4 8083.4 8083.8 8090.0 12267.3 12571.1 12730.9 12937.0 13060.9 10002.6 10977.9 11258.4 11451.4 11502.3 8382.0 10619.6 10864.6 10976.1 11165.0 11251.6 11297.7 11489.3 11538.7 11569.8 7800.0 7815.6 8085.8 8094.3 8098.0 9812.2 9957.4 11335.8 11692.4 11714.2 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5902.26 Median:5393.45 stddev:3076.70 (57.0%) stddev-sans-first:3066.18 06:34:21 INFO - PROCESS | 1665 | Values: 1335.3 1525.6 1549.6 1799.2 1960.5 7818.3 8357.5 8511.4 8520.2 8554.3 8225.8 8500.2 8504.0 8509.4 8519.8 2129.5 2186.7 2189.4 2373.8 2414.7 2418.6 2484.0 2484.4 2487.0 2488.0 2405.4 2422.5 2427.0 2432.0 2450.6 2411.9 2431.1 2432.6 2437.0 2444.4 2346.0 2352.2 2352.7 2355.0 2356.9 8575.7 8639.0 8650.0 8653.4 8678.6 5239.0 5410.6 5416.0 5422.4 5429.3 3070.5 3482.7 3490.1 3646.8 3671.7 1039.6 1048.3 1064.9 1065.6 1071.9 11358.6 11498.8 11546.2 11549.8 11554.7 4734.2 4827.2 4850.6 4850.8 4905.7 9802.4 9866.5 9884.1 9889.6 9891.0 5343.1 5362.1 5365.1 5365.2 5376.3 4359.7 4461.5 4509.2 4868.8 4875.7 3653.1 3718.9 3827.8 3893.8 3898.6 1243.7 1288.5 1301.9 1307.4 1311.6 1297.5 1306.9 1328.0 1330.6 1363.9 7795.2 7885.5 7890.3 7899.0 7919.5 1150.4 1165.9 1171.9 1173.7 1195.2 5181.8 6231.8 6263.3 6263.4 6267.0 9938.4 10373.4 10500.7 10508.8 10521.6 10000.1 10284.2 10307.0 10392.7 10410.6 7633.7 8105.8 8162.5 8180.6 8201.4 7566.4 7609.1 7641.1 7681.6 7690.3 9237.9 9280.7 9348.6 9351.6 9432.5 9448.9 9674.7 9736.8 9755.1 9860.2 7297.0 7345.4 7361.3 7369.0 7380.0 7066.2 7552.8 7881.8 7927.1 7942.4 7124.2 7145.9 7162.9 7220.9 7252.2 7007.9 7026.3 7112.4 7140.8 7175.0 7361.9 7370.4 7438.1 7441.8 7488.6 6805.3 6809.2 6814.0 6826.8 6843.8 6833.2 6936.3 6998.2 7005.9 7011.1 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5856.63 Median:6724.64 stddev:1926.17 (28.6%) stddev-sans-first:1886.18 06:34:21 INFO - PROCESS | 1665 | Values: 317.8 320.1 328.2 329.1 331.7 6679.1 6697.4 6760.6 6763.4 6787.5 6695.7 6722.2 6727.1 6731.6 6750.2 3982.6 4439.0 4813.5 4827.5 4880.8 4819.2 4889.3 4894.7 4902.3 4918.6 4375.9 4494.2 4869.8 4877.5 4889.4 4686.0 4750.3 4809.6 4856.6 4877.7 4140.1 4145.5 4149.6 4155.9 4157.3 6391.4 6449.4 6481.4 6505.6 6505.6 5828.9 5830.1 5831.0 5833.3 5840.7 5994.7 7084.9 7086.7 7086.8 7098.4 3375.3 4517.0 4555.2 4579.0 4601.4 7514.0 7576.4 7599.7 7599.9 7603.1 4644.8 4646.7 4658.3 4658.5 4658.8 4702.3 4702.5 4703.0 4712.5 4713.2 5700.9 5711.0 5713.0 5714.5 5715.4 6537.3 6606.3 6867.2 7099.1 7200.7 1461.0 1541.1 1601.5 1635.7 1637.6 972.3 1020.4 1037.5 1042.3 1054.3 6556.5 6595.3 6606.7 6653.2 6777.5 7482.3 7485.6 7502.2 7502.3 7504.3 6778.9 6788.2 6790.8 6793.8 6794.2 3802.5 3908.7 3951.9 3956.6 3958.9 7787.3 7914.8 7920.8 7922.9 7926.8 7638.6 7728.7 7732.8 7754.9 7772.1 7875.6 7882.9 7885.5 7886.9 7896.6 7187.6 7406.0 7469.9 7475.9 7487.6 7271.3 7276.1 7310.6 7319.1 7324.3 7881.0 7884.8 7884.9 7889.4 7902.1 4356.7 4574.6 4792.5 4848.9 4859.4 7184.7 7348.3 7352.2 7363.6 7441.3 7186.9 7227.9 7247.9 7261.0 7266.8 7225.5 7232.5 7232.9 7239.5 7243.7 7041.6 7042.4 7046.5 7048.9 7049.6 6939.7 7240.5 7248.7 7251.7 7257.7 5512.0 6776.8 6909.0 6998.8 7070.0 06:34:21 INFO - PROCESS | 1665 | 06:34:21 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18624.00 Median:626.81 stddev:26690.26 (4258.1%) stddev-sans-first:26731.04 06:34:21 INFO - PROCESS | 1665 | Values: 657.7 663.2 665.8 676.9 710.3 14677.3 14766.6 14829.1 14830.9 14837.1 10932.7 13445.4 13629.1 13789.2 13820.4 698.3 704.5 858.2 861.1 875.2 877.6 879.5 880.6 880.6 883.6 927.4 927.5 927.9 927.9 929.7 736.4 905.1 919.4 922.5 930.6 679.8 681.8 682.9 683.7 684.2 14820.6 14876.0 14911.5 14939.7 14996.4 12633.4 12638.5 12667.7 12918.1 13033.6 9910.2 10087.6 10322.8 10588.0 10910.8 3597.9 3667.2 3673.3 3746.4 3780.1 84972.0 85580.0 85617.6 85765.0 85861.0 9258.3 9318.4 9342.6 9378.0 9587.6 20550.6 20678.6 20681.1 20695.3 20772.7 7342.6 7449.1 7459.9 7484.7 7527.4 4031.1 4098.7 4099.9 4111.6 4112.3 3447.8 3487.7 3489.3 3490.9 3492.1 514.6 584.4 591.6 634.2 646.0 540.8 561.5 568.0 571.4 593.5 7917.9 7924.5 7938.6 8110.3 8299.2 430.4 570.5 583.6 609.4 619.4 3590.3 3737.3 3798.6 3870.1 3932.7 94230.0 96036.0 96177.6 96762.0 97267.0 80634.6 81584.0 81599.2 82540.2 83460.6 67606.7 70218.2 70251.6 72994.6 74975.0 8269.1 8375.0 8526.1 8567.0 8624.0 46829.0 46998.3 49206.0 50567.7 51024.7 67105.3 68530.0 69060.0 69904.0 69974.0 10847.0 11048.0 11336.8 11458.7 11746.5 10969.9 11585.1 11865.2 11891.8 12229.7 11100.9 11437.3 11455.8 11675.1 11693.6 9154.9 11471.9 11524.6 11792.5 12023.3 11115.6 11356.5 11358.8 11629.0 11668.4 9684.7 9688.3 9729.4 9733.7 9806.7 8812.9 9113.8 9594.8 9665.5 9716.5 06:34:21 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:34:21 INFO - PROCESS | 1665 | 06:34:22 INFO - TEST-INFO | 1665: exit 0 06:34:22 INFO - TEST-OK | dromaeo_css | took 1114762ms 06:34:22 INFO - TEST-START | kraken 06:34:22 INFO - operating with platform_type : mac_ 06:34:22 INFO - Initialising browser for kraken test... 06:34:22 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp7PWysk/profile http://localhost:49270/getInfo.html) 06:34:24 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 06:34:24 INFO - PROCESS | 1673 | colorDepth:24 06:34:24 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 06:34:24 INFO - PROCESS | 1673 | __metrics 06:34:24 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:34:24 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:34:24 INFO - TEST-INFO | 1673: exit 0 06:34:24 INFO - Browser initialized. 06:34:24 INFO - Running cycle 1/1 for kraken test... 06:34:24 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmp7PWysk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:36 INFO - PROCESS | 1675 | RSS: Main: 243699712 06:34:36 INFO - PROCESS | 1675 | 06:34:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:40 INFO - PROCESS | 1675 | RSS: Main: 287911936 06:34:40 INFO - PROCESS | 1675 | 06:34:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 06:34:43 INFO - PROCESS | 1675 | RSS: Main: 297955328 06:34:43 INFO - PROCESS | 1675 | 06:34:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 06:34:47 INFO - PROCESS | 1675 | RSS: Main: 285728768 06:34:47 INFO - PROCESS | 1675 | 06:34:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 06:34:49 INFO - PROCESS | 1675 | RSS: Main: 288976896 06:34:49 INFO - PROCESS | 1675 | 06:34:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:52 INFO - PROCESS | 1675 | RSS: Main: 289103872 06:34:52 INFO - PROCESS | 1675 | 06:34:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:55 INFO - PROCESS | 1675 | RSS: Main: 291811328 06:34:55 INFO - PROCESS | 1675 | 06:34:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:59 INFO - PROCESS | 1675 | RSS: Main: 291708928 06:34:59 INFO - PROCESS | 1675 | 06:35:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 06:35:02 INFO - PROCESS | 1675 | RSS: Main: 291790848 06:35:02 INFO - PROCESS | 1675 | 06:35:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:35:04 INFO - PROCESS | 1675 | RSS: Main: 322334720 06:35:04 INFO - PROCESS | 1675 | 06:35:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:35:06 INFO - PROCESS | 1675 | RSS: Main: 323813376 06:35:06 INFO - PROCESS | 1675 | 06:35:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:09 INFO - PROCESS | 1675 | RSS: Main: 330375168 06:35:09 INFO - PROCESS | 1675 | 06:35:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:12 INFO - PROCESS | 1675 | RSS: Main: 332595200 06:35:12 INFO - PROCESS | 1675 | 06:35:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:15 INFO - PROCESS | 1675 | RSS: Main: 332472320 06:35:15 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 06:35:17 INFO - PROCESS | 1675 | RSS: Main: 393609216 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | __start_tp_report 06:35:17 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 06:35:17 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 06:35:17 INFO - PROCESS | 1675 | |i|pagename|runs| 06:35:17 INFO - PROCESS | 1675 | |0;ai-astar;109;106;107;109;110;108;117;158;164;89 06:35:17 INFO - PROCESS | 1675 | |1;audio-beat-detection;155;148;166;184;114;139;138;116;159;113 06:35:17 INFO - PROCESS | 1675 | |2;audio-dft;182;182;184;186;184;184;190;190;179;182 06:35:17 INFO - PROCESS | 1675 | |3;audio-fft;72;76;85;77;55;57;58;78;75;60 06:35:17 INFO - PROCESS | 1675 | |4;audio-oscillator;95;90;124;78;75;112;146;109;80;109 06:35:17 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;87;91;88;90;86;90;87;90;87 06:35:17 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;94;94;95;95;94;94;94;94;99 06:35:17 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;85;86;86;85;85;88;84;86;84 06:35:17 INFO - PROCESS | 1675 | |8;json-parse-financial;56;54;54;54;54;53;54;63;56;52 06:35:17 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;64;61;75;80;71;68;67;68;67;68 06:35:17 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;82;83;83;82;74;81;78;84;84 06:35:17 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;123;128;130;124;133;119;120;129;115;122 06:35:17 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;132;127;138;135;135;127;138;137;136;136 06:35:17 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;66;65;68;67;67;67;67;66;66 06:35:17 INFO - PROCESS | 1675 | __end_tp_report 06:35:17 INFO - PROCESS | 1675 | __start_cc_report 06:35:17 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1238 06:35:17 INFO - PROCESS | 1675 | __end_cc_report 06:35:17 INFO - PROCESS | 1675 | __startTimestamp1457015717650__endTimestamp 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | ------- Summary: start ------- 06:35:17 INFO - PROCESS | 1675 | Number of tests: 14 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:117.70 Median:113.50 stddev:23.92 (21.1%) stddev-sans-first:25.16 06:35:17 INFO - PROCESS | 1675 | Values: 109.0 106.0 107.0 109.0 110.0 108.0 117.0 158.0 164.0 89.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:151.50 stddev:23.91 (15.8%) stddev-sans-first:24.98 06:35:17 INFO - PROCESS | 1675 | Values: 155.0 148.0 166.0 184.0 114.0 139.0 138.0 116.0 159.0 113.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.00 stddev:3.53 (1.9%) stddev-sans-first:3.64 06:35:17 INFO - PROCESS | 1675 | Values: 182.0 182.0 184.0 186.0 184.0 184.0 190.0 190.0 179.0 182.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:69.30 Median:75.50 stddev:10.73 (14.2%) stddev-sans-first:11.34 06:35:17 INFO - PROCESS | 1675 | Values: 72.0 76.0 85.0 77.0 55.0 57.0 58.0 78.0 75.0 60.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:76.50 stddev:22.61 (29.6%) stddev-sans-first:23.84 06:35:17 INFO - PROCESS | 1675 | Values: 95.0 90.0 124.0 78.0 75.0 112.0 146.0 109.0 80.0 109.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:90.00 stddev:1.78 (2.0%) stddev-sans-first:1.81 06:35:17 INFO - PROCESS | 1675 | Values: 90.0 87.0 91.0 88.0 90.0 86.0 90.0 87.0 90.0 87.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:1.78 (1.9%) stddev-sans-first:1.64 06:35:17 INFO - PROCESS | 1675 | Values: 92.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 99.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 06:35:17 INFO - PROCESS | 1675 | Values: 85.0 85.0 86.0 86.0 85.0 85.0 88.0 84.0 86.0 84.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:3.06 (5.7%) stddev-sans-first:3.22 06:35:17 INFO - PROCESS | 1675 | Values: 56.0 54.0 54.0 54.0 54.0 53.0 54.0 63.0 56.0 52.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:5.38 (7.9%) stddev-sans-first:5.41 06:35:17 INFO - PROCESS | 1675 | Values: 64.0 61.0 75.0 80.0 71.0 68.0 67.0 68.0 67.0 68.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.50 stddev:3.09 (3.7%) stddev-sans-first:3.27 06:35:17 INFO - PROCESS | 1675 | Values: 82.0 82.0 83.0 83.0 82.0 74.0 81.0 78.0 84.0 84.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:126.00 stddev:5.62 (4.5%) stddev-sans-first:5.94 06:35:17 INFO - PROCESS | 1675 | Values: 123.0 128.0 130.0 124.0 133.0 119.0 120.0 129.0 115.0 122.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.10 Median:136.00 stddev:4.12 (3.0%) stddev-sans-first:4.30 06:35:17 INFO - PROCESS | 1675 | Values: 132.0 127.0 138.0 135.0 135.0 127.0 138.0 137.0 136.0 136.0 06:35:17 INFO - PROCESS | 1675 | 06:35:17 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 06:35:17 INFO - PROCESS | 1675 | Values: 67.0 66.0 65.0 68.0 67.0 67.0 67.0 67.0 66.0 66.0 06:35:17 INFO - PROCESS | 1675 | -------- Summary: end -------- 06:35:17 INFO - PROCESS | 1675 | 06:35:18 INFO - TEST-INFO | 1675: exit 0 06:35:18 INFO - TEST-OK | kraken | took 56294ms 06:35:18 INFO - SUITE-END | took 1171s 06:35:18 INFO - Completed test suite (00:19:31) 06:35:18 INFO - Working with test: dromaeo_css 06:35:18 INFO - Generating results file: dromaeo_css 06:35:18 INFO - Working with test: kraken 06:35:18 INFO - Generating results file: kraken 06:35:18 INFO - javascript benchmark 06:35:18 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:35:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 06:35:19 INFO - process_Request line: dromaeo_css 7443.38 graph.html#tests=[[72,64,59]] 06:35:19 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:35:19 INFO - process_Request line: kraken 1415.00 graph.html#tests=[[232,64,59]] 06:35:19 INFO - RETURN: dromaeo_css: 7443.38 06:35:19 INFO - RETURN: kraken: 1415.00 06:35:19 INFO - javascript benchmark 06:35:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3440.9311813763725, 3507.8669074026325, 3508.7193024558023, 3533.222691007979, 3568.286342731453, 5602.719864006804, 5612.0, 5723.570732195081, 5739.856503587413, 5778.971105144474, 5757.078867381219, 5770.509506691926, 5778.913316300248, 5898.321693005306, 5923.022701254298, 5110.361204849394, 5116.795328186868, 5166.509181627739, 5177.352830896138, 5281.8943621127555, 5256.448072952342, 5264.42091369949, 5287.41838397776, 5311.601629877755, 5341.225522299264, 5113.846584602468, 5115.820946266881, 5170.560502357304, 5205.505476979681, 5220.1647736362, 5143.614228932807, 5155.2524883892, 5159.793608255665, 5170.612204084671, 5172.482751724835, 5109.080365534202, 5148.768305426265, 5152.587792976553, 5169.405518365398, 5174.948250517522, 5530.2810634617645, 5625.634333768292, 5628.0713682242385, 5630.268065151504, 5660.490555849952, 6101.5804940036605, 6157.507399408037, 6257.936150854366, 6262.2172228471445, 6271.153394291758, 6185.505159587222, 6237.688115594247, 6239.0329498927285, 6267.373262673696, 6271.6864156792435, 5180.678926873623, 5464.371597266286, 5799.217105690762, 5803.303603567599, 5824.184614154022, 6231.4391704746795, 6276.529260305404, 6282.465990390777, 6290.528210384239, 6309.842253943688, 6167.136600875881, 6171.876562468726, 6177.382261773877, 6191.783287584913, 6199.814005579839, 6242.250929888442, 6274.560780745304, 6302.4958003359625, 6315.147455093595, 6329.620222786648, 5029.346184996, 6039.456448919618, 6124.472479235402, 6162.414570615784, 6212.0, 6204.348543402878, 6206.627602343874, 6213.96893015532, 6215.036669316263, 6220.782272620437, 4730.976345118322, 4872.342233798392, 4879.707217566957, 4893.584045356185, 4927.975360123248, 4330.328799036154, 4333.393324934512, 4427.601515863587, 4429.80065897029, 4430.269005614037, 5723.885522289531, 5753.539716822645, 5755.395683453261, 5757.424257574293, 5773.480386765212, 6282.905756413657, 6333.556651034383, 6337.7781777637565, 6337.859185346681, 6343.492520598341, 5640.182173584889, 5738.741756620962, 5740.856478587985, 5809.390014048548, 5838.5329173666005, 5322.494363035583, 5327.493888080704, 5335.626506144533, 5340.893182136336, 5346.599005074635, 6287.559870809091, 6290.4653104485715, 6293.118963345135, 6295.874082518232, 6307.779227727007, 5696.487316141567, 5928.9110663339225, 6144.419343875672, 6218.595791273553, 6276.309605943434, 5553.72231388437, 6000.399960003964, 6284.371562843679, 6299.96850015747, 6322.367763223825, 6141.201643786279, 6189.566730328834, 6198.535109866868, 6217.720202590985, 6223.253209614694, 6286.057091436322, 6296.590721603081, 6305.306416294112, 6311.368863113652, 6320.62076275425, 5402.810901618424, 5985.970070149796, 6091.60404573719, 6114.908276375769, 6128.295246046761, 5871.559633027455, 6045.425684559959, 6072.483838873569, 6075.1191077294425, 6078.240219972504, 5884.411558844081, 5903.380145084876, 5914.467697907209, 5924.585279030426, 5937.821865344046, 6020.969895150496, 6021.7591296347655, 6025.671737134335, 6026.528258362161, 6077.361877002851, 5925.466707996128, 6005.279366476051, 6008.459238668541, 6014.1580178775885, 6019.488343490677], "unit": "score", "name": "dojo.html", "value": 5682.558716459911}, {"lowerIsBetter": false, "replicates": [448.2670833187737, 489.96617137839155, 579.4813641790597, 637.0666972884724, 640.6860638287237, 37984.0, 38362.61637383625, 38721.61278387215, 38819.611803881955, 38837.0, 41390.0, 41603.543875964344, 41722.7913860431, 41816.79091604538, 41910.0, 9534.618615255398, 9778.951105244463, 9782.510874456284, 9799.657012004582, 9817.901820981806, 9541.093596108358, 9707.223422126213, 9707.660231891885, 9820.558074886612, 9857.852132218022, 8528.616212270463, 9784.95107524465, 9864.654737084204, 9882.901170988305, 9886.752831179207, 9750.512474376288, 9829.164521015722, 9837.0, 9850.359726617819, 9855.753606159831, 9664.323497355188, 9793.412395256308, 9802.215822734235, 9807.607695692164, 9819.705408837746, 39520.60479395198, 39772.80681579528, 39865.80067099675, 39883.8005809972, 39888.800555997324, 3099.0, 3178.3802158578856, 3243.5459035735016, 3267.4608689566194, 3349.866005359807, 28125.43749125006, 28396.432071358457, 29056.41887162266, 29122.271943201376, 29166.97915572966, 2771.1270949651, 2792.9720702792915, 2805.340744924941, 2868.182567968119, 2921.532554791223, 498633.0, 499152.5042374765, 499467.50266248436, 500245.0, 500772.0, 44625.0, 63098.684506578094, 63106.68446657829, 63553.0, 63618.0, 44190.779046104566, 44282.55717442849, 44399.33400998988, 44454.77772611116, 44486.555134448885, 15247.61880952963, 15550.688986220212, 15559.22203889801, 15560.92219538895, 15625.531234062997, 12480.0, 12542.05934554912, 12545.811812822814, 12546.937265313798, 12556.372181390894, 14249.85750142506, 14267.928660356632, 14527.709445811024, 14540.63648408777, 14702.338394772261, 6292.653904035231, 6393.840153996187, 6396.584222025554, 6441.0, 6441.871162576722, 938.7512309238058, 965.4110992294694, 997.8303688372849, 1047.6909311753052, 1082.734729991157, 28746.425071498452, 28988.42023159525, 29186.270343241587, 29261.0, 29473.85263073714, 930.7580029192459, 1076.4886678827652, 1124.859392575928, 1138.408027825526, 1199.682084247675, 13910.0, 13943.58169254924, 14053.648658783612, 14236.644083897778, 14344.784828227585, 533947.0, 534231.0, 543939.0, 545140.0, 547319.0, 52235.955280894166, 52929.0, 56652.433475664715, 57084.28747137592, 57236.14145787816, 1217.4278089298016, 1301.8502872169631, 1403.6982048859545, 1416.362636813438, 1462.4881291547872, 26704.465910682065, 26722.732772672804, 28269.57595636026, 28571.712711577627, 28900.0, 46443.83890402767, 46867.53132468768, 46983.0, 47056.0, 47259.291110634054, 374611.0, 386398.06800965813, 386699.0, 387367.0, 387787.0, 26251.0, 30471.390572188877, 31470.213244669067, 32395.866144684824, 33193.668063319055, 33337.666623333454, 34123.317533649686, 34142.975710728715, 34224.82887585546, 34276.48585271273, 32773.836130819196, 34353.14117147091, 35260.82369588136, 36051.459228111074, 36465.27069458543, 29164.7083529162, 34788.130296742784, 35232.823835880656, 35749.28501430009, 36103.27793444169, 34825.303493930485, 35407.82296088503, 35553.82223088868, 35743.821280893426, 35799.64200357963, 30223.395532088794, 31420.685793141776, 31504.36991260116, 31518.369632606762, 31544.526832097996, 21106.78893211048, 22096.33710988673, 23283.417914551595, 23546.0, 23809.9285532148], "unit": "score", "name": "ext.html", "value": 18664.170692483254}, {"lowerIsBetter": false, "replicates": [349.5106850409427, 354.6294122641837, 354.8119496666767, 359.8110991729342, 362.04239785766663, 19957.301494447696, 20490.385288441354, 20703.896480517597, 21118.0, 21132.683009754866, 14478.710425791478, 19521.511962200915, 20092.59814803707, 21040.789592104073, 21110.472238194052, 5840.591158618909, 6054.061620448838, 6130.44825965663, 6137.478314343286, 6142.447179753821, 4282.03654177809, 4449.955500445003, 5682.607761098537, 5876.089206173028, 6655.833604159886, 6566.835829104263, 6582.243042050154, 6585.374389432996, 6586.8682626347445, 6592.703328350211, 6251.843703907416, 6532.5753826001155, 6535.21577410709, 6541.705623246941, 6543.051257567674, 3776.2636285924254, 5398.757055932492, 5614.691191984439, 5618.887622247532, 5625.353084395306, 10784.622538211204, 13584.932075339659, 13602.0, 24841.6273755892, 25125.87437062821, 1991.2532800199924, 2061.6082944240547, 2124.9893750531305, 2184.9563008739738, 2626.93432664183, 8466.280366168883, 9591.760205994837, 9704.854427183598, 9773.560189791406, 10010.749731256705, 1645.5145732009087, 1690.8140104588485, 1747.1177055586975, 1777.680017596845, 1816.9182386792627, 108745.0, 109613.0, 109614.45192774065, 110382.0, 112546.0, 11224.943875280735, 11275.32348059119, 11346.602868899548, 11364.920332568392, 11489.195756297146, 13663.453461861613, 13778.862211377758, 13800.171989680652, 13813.654658633413, 13835.79246311306, 8334.583270836434, 8488.618012189467, 8548.700795472252, 8671.0, 8700.651973921098, 8759.430637008574, 8785.692500762443, 8798.20816126539, 8927.24118449926, 8933.330000250007, 4365.148795984816, 4449.866504004885, 4477.462704475419, 4514.029483661028, 4518.728876267369, 1712.0925909268108, 1784.3219576560823, 1795.1293622593032, 1800.7659004329353, 1845.640100180452, 880.423322723617, 940.7177846645978, 962.8459446488528, 975.6682727872558, 994.3884511025667, 18837.43487695344, 19512.609747804963, 19654.803451965297, 19818.4054478363, 19827.702584461244, 952.5713428956997, 954.2175416158822, 982.5627595719836, 1042.358949246208, 1087.255230167338, 10381.532831022621, 10536.262461627612, 10569.9958503942, 10606.734831629272, 10634.30876992993, 494548.0, 589182.0540897268, 609802.0, 610360.0, 644419.0, 121422.39288803676, 122768.38615806864, 122852.15721764181, 122945.0, 128614.0, 1010.8685870836745, 1019.8317277649253, 1036.9377837329785, 1037.4034929915329, 1038.4911393417322, 15717.371305148123, 16979.916389045626, 17053.147342633067, 17368.0, 17667.204975776378, 53323.93352132858, 53411.93176136533, 53492.73253633707, 54275.45724542704, 56094.99999999837, 60152.69923650354, 78586.0, 79099.20900790919, 79429.2057079445, 79887.0, 7479.214682458482, 8082.393820463606, 8083.353331733565, 8083.757487275391, 8089.959550202211, 12267.263964162179, 12571.057170712416, 12730.936345318214, 12937.0, 13060.869391305965, 10002.649907253211, 10977.890221097687, 11258.38078905668, 11451.370174640475, 11502.309861408343, 8381.95809020951, 10619.575216991234, 10864.619738309122, 10976.12191024732, 11165.0, 11251.606193783178, 11297.71755706114, 11489.310641361544, 11538.653840384803, 11569.826452603049, 7800.024996875391, 7815.570143642154, 8085.757427277191, 8094.271515563628, 8097.959510202411, 9812.165965892978, 9957.352772069793, 11335.829962550404, 11692.415379231175, 11714.1800073994], "unit": "score", "name": "jquery.html", "value": 9325.520311514978}, {"lowerIsBetter": false, "replicates": [1335.3056410666459, 1525.610969202853, 1549.566121485984, 1799.1813724755239, 1960.4510736993648, 7818.335441487473, 8357.498550086999, 8511.446755960873, 8520.190581894718, 8554.272886804629, 8225.835483290346, 8500.192481714243, 8503.957480212606, 8509.44688595241, 8519.829603407943, 2129.4889226585665, 2186.6719992001167, 2189.3979155732222, 2373.7982271506944, 2414.6619473273668, 2418.600930846417, 2484.043643197364, 2484.416162201881, 2487.0300582772734, 2488.029668429314, 2405.4109285205204, 2422.4791669790993, 2426.980668119394, 2431.9756802431925, 2450.6079027355627, 2411.915582954588, 2431.088341871798, 2432.622943443769, 2437.0251899240357, 2444.4499987502845, 2345.9765402346097, 2352.2120089769946, 2352.6706261123454, 2354.9882250588807, 2356.9410764730846, 8575.742727718178, 8638.956805215996, 8649.956750216208, 8653.394262401634, 8678.609462574199, 5239.0, 5410.567154627621, 5416.0, 5422.376426710939, 5429.294191755047, 3070.4626690329105, 3482.669146431085, 3490.057684425191, 3646.7994260315672, 3671.687906527948, 1039.5789705169418, 1048.2976405808126, 1064.9148068154607, 1065.5631191211567, 1071.9088877445427, 11358.60244891425, 11498.770024599462, 11546.249493782962, 11549.826752598718, 11554.711132221677, 4734.19518681825, 4827.2035114206465, 4850.563449289511, 4850.83022094225, 4905.705657660552, 9802.362846415102, 9866.506674666238, 9884.061014203782, 9889.60441582343, 9891.0, 5343.118385466354, 5362.061639213122, 5365.08793505105, 5365.195220716846, 5376.327959005124, 4359.673024523174, 4461.460796025366, 4509.188346097734, 4868.756562171877, 4875.658703890694, 3653.104989277644, 3718.9070273242846, 3827.78947157909, 3893.766374017568, 3898.629630185128, 1243.7139457924727, 1288.5039259885011, 1301.8958483321312, 1307.3528603341217, 1311.5540716156552, 1297.4615534553243, 1306.915050521713, 1327.9933600332129, 1330.6274243211917, 1363.8977076719286, 7795.22047795216, 7885.526868387915, 7890.289873911375, 7898.960505197438, 7919.485233459806, 1150.3672979861044, 1165.8600967883908, 1171.9472623731951, 1173.7417768091007, 1195.1992165249303, 5181.81863634771, 6231.813045608639, 6263.31103578606, 6263.404976527223, 6266.965950618188, 9938.354006989523, 10373.429461379546, 10500.684979450629, 10508.789824203473, 10521.579136834594, 10000.14998725102, 10284.228682848816, 10307.0, 10392.688219353431, 10410.635627752992, 7633.732819351296, 8105.797355066288, 8162.469439486533, 8180.6318715657935, 8201.384896132813, 7566.35685966677, 7609.124950630749, 7641.083070031632, 7681.577513236825, 7690.307872291521, 9237.861432078389, 9280.72157835266, 9348.626054957998, 9351.579178936829, 9432.481213533047, 9448.858267126136, 9674.661386851427, 9736.756581085247, 9755.122039016522, 9860.16188623975, 7296.96351518239, 7345.412367010733, 7361.26387361281, 7369.0, 7380.0, 7066.222715501393, 7552.773416797505, 7881.802954926173, 7927.088384835818, 7942.404319675932, 7124.180719217149, 7145.892811607934, 7162.89255661155, 7220.8916866246, 7252.238514955854, 7007.929920700728, 7026.297370262932, 7112.35988761014, 7140.821479463055, 7175.03137076488, 7361.926380736124, 7370.44721645868, 7438.144613369532, 7441.776746697607, 7488.625568721433, 6805.285445028201, 6809.182898052265, 6814.046033555405, 6826.795196144124, 6843.794686159423, 6833.214180369122, 6936.271691472524, 6998.16022077354, 7005.859882802213, 7011.088558487364], "unit": "score", "name": "mootools.html", "value": 4840.242256196371}, {"lowerIsBetter": false, "replicates": [317.793434267726, 320.1116900600832, 328.1975569732006, 329.05561039815746, 331.70643980077654, 6679.131712877325, 6697.397234248922, 6760.594364338143, 6763.391294783469, 6787.540678754067, 6695.665216739168, 6722.193336799591, 6727.091842601248, 6731.562448440848, 6750.22372427171, 3982.6216509431556, 4438.999999999992, 4813.542713442217, 4827.517248275162, 4880.780364883571, 4819.228923372261, 4889.266610008492, 4894.730789806559, 4902.264660300948, 4918.631102667297, 4375.890602734925, 4494.1910456117885, 4869.756512174377, 4877.51224877513, 4889.3888263967, 4686.039361930813, 4750.287456881478, 4809.591184749301, 4856.611471082305, 4877.6585639004925, 4140.130572579762, 4145.54399016108, 4149.585041495857, 4155.937660935088, 4157.3140431828715, 6391.360863913618, 6449.35506449356, 6481.384268494486, 6505.60966342021, 6505.6421896795655, 5828.912566311508, 5830.067189249742, 5831.0, 5833.32916714579, 5840.7079646017955, 5994.670293133876, 7084.858302833966, 7086.681099350541, 7086.787396378117, 7098.36114749675, 3375.2743160220425, 4516.977415112936, 4555.157295900269, 4579.0, 4601.44782626087, 7513.962430187868, 7576.393888488963, 7599.6580153892655, 7599.886001710034, 7603.125640551352, 4644.767761611906, 4646.744429056367, 4658.301254811738, 4658.534146585314, 4658.813647454064, 4702.341672165831, 4702.482726900038, 4703.0, 4712.52874712526, 4713.222318317507, 5700.914486282626, 5710.971445142831, 5713.0, 5714.457126572969, 5715.399883012307, 6537.280899101095, 6606.306337834554, 6867.175938887365, 7099.112610923635, 7200.747973820996, 1460.9926950365393, 1541.0984574024321, 1601.5195441367543, 1635.7219272723667, 1637.6479057002564, 972.3048020665258, 1020.4081632653043, 1037.5071840875523, 1042.2756184451732, 1054.2936232724094, 6556.508261880378, 6595.307492713292, 6606.669666516751, 6653.234877988996, 6777.457803375718, 7482.28918252776, 7485.588292643848, 7502.17476077631, 7502.287282708134, 7504.287092726182, 6778.93221067783, 6788.151481064867, 6790.796276111724, 6793.796186114425, 6794.184697836291, 3802.5018239446445, 3908.687305015592, 3951.881443556698, 3956.584558621303, 3958.851932939473, 7787.29914307715, 7914.762557123296, 7920.841583168304, 7922.881156782653, 7926.801829954297, 7638.618069096523, 7728.690852365955, 7732.806679833049, 7754.92245077542, 7772.145064042951, 7875.645595948196, 7882.881756773539, 7885.487443316166, 7886.881696774553, 7896.565688887166, 7187.598418308379, 7405.96297018533, 7469.887951680837, 7475.88786168197, 7487.5507469552, 7271.3455788979245, 7276.05411296528, 7310.59791711461, 7319.121705395173, 7324.340809327186, 7880.960595196987, 7884.84230315402, 7884.921150788418, 7889.447738658238, 7902.051753789352, 4356.716813407118, 4574.611158051603, 4792.496787837227, 4848.903021939612, 4859.416869975626, 7184.676689548878, 7348.265173482609, 7352.228016058237, 7363.595002274927, 7441.330280274801, 7186.89219661695, 7227.891581626385, 7247.855042899218, 7260.96369518149, 7266.781996540112, 7225.458090643117, 7232.493725439169, 7232.927670723226, 7239.529430586995, 7243.7464688735645, 7041.5775053496955, 7042.366187043191, 7046.4715146363205, 7048.894266586108, 7049.647517624201, 6939.6877140529805, 7240.52936559122, 7248.710051598088, 7251.746188883364, 7257.745978890714, 5511.972440137773, 6776.796696099125, 6908.965455172893, 6998.825029374103, 7070.0], "unit": "score", "name": "prototype.html", "value": 5201.0207225487175}, {"lowerIsBetter": false, "replicates": [657.7106073327735, 663.1743479368185, 665.8102440804372, 676.8950812624045, 710.2897102897105, 14677.266136693162, 14766.557003289892, 14829.110253384777, 14830.851691483096, 14837.109773413602, 10932.726681832959, 13445.394957226923, 13629.114107583026, 13789.241591712453, 13820.447182112728, 698.3121625199175, 704.4962851561132, 858.1675774498742, 861.1044513705739, 875.2341701011615, 877.6313948141764, 879.4547380624022, 880.5509190312922, 880.5861245214771, 883.6421249394006, 927.3740225347897, 927.4713413354391, 927.8561822917459, 927.8793756811639, 929.665320484625, 736.3630459652389, 905.1265528764708, 919.3977944446399, 922.5110691333604, 930.5719369090226, 679.8062552172607, 681.7886455198905, 682.9180498340181, 683.723092147681, 684.2302409788988, 14820.62948426298, 14876.0, 14911.478098266509, 14939.701205975929, 14996.400143994228, 12633.431495582721, 12638.49446022158, 12667.683307917283, 12918.095733298673, 13033.608991730263, 9910.157636600898, 10087.646932357406, 10322.845157322647, 10588.047075763141, 10910.836337454944, 3597.94603080954, 3667.229881724841, 3673.265346930598, 3746.4380342948502, 3780.0549862534367, 84972.0, 85580.0, 85617.57191214066, 85764.99999999937, 85861.0, 9258.305627077862, 9318.39430437033, 9342.626294948126, 9377.953110234404, 9587.568559414844, 20550.58898822015, 20678.58642827165, 20681.069351879203, 20695.27566535164, 20772.68840967387, 7342.559446433231, 7449.106107267163, 7459.925400746031, 7484.663190156456, 7527.435442341737, 4031.0728532437115, 4098.7130900836655, 4099.938500922489, 4111.6299533042165, 4112.3420252759415, 3447.793132412013, 3487.7035451986358, 3489.3021395720957, 3490.9301813964084, 3492.1444246159854, 514.6243242433045, 584.4016614559177, 591.5504216795266, 634.2230767310008, 646.0245030004633, 540.7999040355015, 561.4609974424517, 568.0031544639214, 571.4456976732563, 593.5251798561134, 7917.920820791718, 7924.524528528307, 7938.603069846485, 8110.310623596943, 8299.219934779812, 430.35876543949917, 570.4637640617806, 583.5564970622357, 609.3966972696998, 619.3991827926903, 3590.281943611288, 3737.2712321097124, 3798.5631652360335, 3870.07118291608, 3932.7239633582185, 94230.0, 96036.0, 96177.55733663861, 96762.0, 97267.0, 80634.59682701548, 81584.0, 81599.18400816034, 82540.17459825445, 83460.58269708612, 67606.66196668985, 70218.24454388578, 70251.64874175597, 72994.63502682559, 74975.0, 8269.131741167332, 8374.958125209336, 8526.147385261424, 8566.957165214384, 8623.956880215559, 46829.0, 46998.29502557533, 49206.0, 50567.74716126396, 51024.74487627538, 67105.32894670991, 68530.0, 69059.96410053753, 69904.0, 69974.0, 10847.011033649598, 11048.0, 11336.829947550958, 11458.71353216143, 11746.471408786796, 10969.945150274198, 11585.07319414428, 11865.228760130563, 11891.82162267584, 12229.69425764363, 11100.944495277472, 11437.256578322382, 11455.770884582429, 11675.065994720571, 11693.590724324948, 9154.908450915673, 11471.885281147082, 11524.59663911759, 11792.490275462304, 12023.338716370683, 11115.555377784798, 11356.545738170711, 11358.829617555579, 11629.0, 11668.358240296866, 9684.661036863676, 9688.273379496706, 9729.367591106555, 9733.707988760349, 9806.705798826046, 8812.911870881466, 9113.77215569616, 9594.829480750426, 9665.468399238109, 9716.465594392377], "unit": "score", "name": "yui.html", "value": 6829.79682466481}], "name": "dromaeo_css", "value": 7443.382903434403}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 106.0, 107.0, 109.0, 110.0, 108.0, 117.0, 158.0, 164.0, 89.0], "unit": "score", "name": "ai-astar", "value": 117.7}, {"lowerIsBetter": true, "replicates": [155.0, 148.0, 166.0, 184.0, 114.0, 139.0, 138.0, 116.0, 159.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [182.0, 182.0, 184.0, 186.0, 184.0, 184.0, 190.0, 190.0, 179.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 85.0, 77.0, 55.0, 57.0, 58.0, 78.0, 75.0, 60.0], "unit": "score", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [95.0, 90.0, 124.0, 78.0, 75.0, 112.0, 146.0, 109.0, 80.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 101.8}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 91.0, 88.0, 90.0, 86.0, 90.0, 87.0, 90.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 99.0], "unit": "score", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 86.0, 85.0, 85.0, 88.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 63.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [64.0, 61.0, 75.0, 80.0, 71.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 82.0, 74.0, 81.0, 78.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.3}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 130.0, 124.0, 133.0, 119.0, 120.0, 129.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [132.0, 127.0, 138.0, 135.0, 135.0, 127.0, 138.0, 137.0, 136.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1414.9999999999998}]} 06:35:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1415.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7443.38"}}} 06:35:19 INFO - Return code: 0 06:35:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:35:19 INFO - # TBPL SUCCESS # 06:35:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:35:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:35:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:35:19 INFO - 2016-03-03 06:35:19.614 screenresolution[1679:9620] starting screenresolution argv=screenresolution get 06:35:19 INFO - 2016-03-03 06:35:19.617 screenresolution[1679:9620] Display 0: 1600x1200x32@60 06:35:19 INFO - 2016-03-03 06:35:19.623 screenresolution[1680:9623] starting screenresolution argv=screenresolution list 06:35:19 INFO - Available Modes on Display 0 06:35:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:35:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:35:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:35:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:35:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:35:19 INFO - Intel Iris: 06:35:19 INFO - Chipset Model: Intel Iris 06:35:19 INFO - Type: GPU 06:35:19 INFO - Bus: Built-In 06:35:19 INFO - VRAM (Dynamic, Max): 1536 MB 06:35:19 INFO - Vendor: Intel (0x8086) 06:35:19 INFO - Device ID: 0x0a2e 06:35:19 INFO - Revision ID: 0x0009 06:35:19 INFO - Displays: 06:35:19 INFO - Display: 06:35:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:35:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:35:19 INFO - Display Serial Number: 1600x1200 60 06:35:19 INFO - Main Display: Yes 06:35:19 INFO - Mirror: Off 06:35:19 INFO - Online: Yes 06:35:19 INFO - Rotation: Supported 06:35:19 INFO - Return code: 0 06:35:19 INFO - Running post-action listener: _resource_record_post_action 06:35:19 INFO - Running post-run listener: _resource_record_post_run 06:35:20 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 39134720; Write bytes: 705562624; Read time: 432; Write time: 1963 06:35:20 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389319168; Write bytes: 379430912; Read time: 29604; Write time: 736 06:35:20 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 32845312; Write bytes: 300691456; Read time: 347; Write time: 1174 06:35:20 INFO - Running post-run listener: _upload_blobber_files 06:35:20 INFO - Blob upload gear active. 06:35:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:20 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 06:35:20 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'] 06:35:20 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 06:35:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:35:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:35:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:22 INFO - (blobuploader) - INFO - Done attempting. 06:35:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:35:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:35:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:23 INFO - (blobuploader) - INFO - Done attempting. 06:35:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:23 INFO - Return code: 0 06:35:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f1b3f2a08602292b1ab4c962f3731ec54d293f49f67260e233fcc3bb75855b3ee47a8ea975c00044cb84942ac18ada9575c5a31e91361625986f876336de568", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9641f32d4a837d4f3aa0bc62cd063a7ba35aff5ac64fd71877508e2b8ec65fb2d45a5741a715b1116b4068719a37d59728fdef29c479718e9c039f983bf7387b"} 06:35:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:23 INFO - Contents: 06:35:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f1b3f2a08602292b1ab4c962f3731ec54d293f49f67260e233fcc3bb75855b3ee47a8ea975c00044cb84942ac18ada9575c5a31e91361625986f876336de568", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9641f32d4a837d4f3aa0bc62cd063a7ba35aff5ac64fd71877508e2b8ec65fb2d45a5741a715b1116b4068719a37d59728fdef29c479718e9c039f983bf7387b"} 06:35:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:23 INFO - Copying logs to upload dir... 06:35:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.649844 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-03-03 06:35:23.893221) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 06:35:23.894400) ========= 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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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/7f1b3f2a08602292b1ab4c962f3731ec54d293f49f67260e233fcc3bb75855b3ee47a8ea975c00044cb84942ac18ada9575c5a31e91361625986f876336de568", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9641f32d4a837d4f3aa0bc62cd063a7ba35aff5ac64fd71877508e2b8ec65fb2d45a5741a715b1116b4068719a37d59728fdef29c479718e9c039f983bf7387b"} build_url:https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010949 build_url: 'https://queue.taskcluster.net/v1/task/RNpyu0_gQjiffyz5Oem_dw/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/7f1b3f2a08602292b1ab4c962f3731ec54d293f49f67260e233fcc3bb75855b3ee47a8ea975c00044cb84942ac18ada9575c5a31e91361625986f876336de568", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9641f32d4a837d4f3aa0bc62cd063a7ba35aff5ac64fd71877508e2b8ec65fb2d45a5741a715b1116b4068719a37d59728fdef29c479718e9c039f983bf7387b"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 06:35:24.126493) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:35:24.126805) ========= 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.iHlgPxJ675/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.r57HMGauMI/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 06:35:24.168963) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-03 06:35:24.169243) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-03 06:35:28.283327) ========= ========= Total master_lag: 3.93 =========