builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0106 starttime: 1457037763.26 results: success (0) buildid: 20160303105838 builduid: e7940af702934d2187c49fe5ea0fb13e revision: 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.258644) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.259079) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.259364) ========= 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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.006015 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.330492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.330797) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.349052) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.349417) ========= 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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005684 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.397618) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.397935) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.398308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.398582) ========= 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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 12:42:43-- 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% 24.8M=0s 2016-03-03 12:42:43 (24.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136600 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.549720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.550031) ========= 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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.026504 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:43.598975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 12:42:43.599325) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec --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 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 12:42:43,668 truncating revision to first 12 chars 2016-03-03 12:42:43,668 Setting DEBUG logging. 2016-03-03 12:42:43,668 attempt 1/10 2016-03-03 12:42:43,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fe81a6dbaa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 12:42:45,251 unpacking tar archive at: fx-team-6fe81a6dbaa8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.821882 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 12:42:45.437264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:45.437599) ========= echo 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec program finished with exit code 0 elapsedTime=0.005765 script_repo_revision: '6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:45.486622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:45.486941) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 12:42:45.499712) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-03-03 12:42:45.500106) ========= /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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:42:45 INFO - MultiFileLogger online at 20160303 12:42:45 in /builds/slave/test 12:42:45 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 12:42:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:42:45 INFO - {'append_to_log': False, 12:42:45 INFO - 'base_work_dir': '/builds/slave/test', 12:42:45 INFO - 'blob_upload_branch': 'Fx-Team', 12:42:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:42:45 INFO - 'branch': 'Fx-Team', 12:42:45 INFO - 'buildbot_json_path': 'buildprops.json', 12:42:45 INFO - 'config_files': ('talos/mac_config.py',), 12:42:45 INFO - 'default_actions': ('clobber', 12:42:45 INFO - 'read-buildbot-config', 12:42:45 INFO - 'download-and-extract', 12:42:45 INFO - 'populate-webroot', 12:42:45 INFO - 'create-virtualenv', 12:42:45 INFO - 'install', 12:42:45 INFO - 'run-tests'), 12:42:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:42:45 INFO - 'download_minidump_stackwalk': True, 12:42:45 INFO - 'download_symbols': 'ondemand', 12:42:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:42:45 INFO - 'tooltool.py': '/tools/tooltool.py', 12:42:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:42:45 INFO - '/tools/misc-python/virtualenv.py')}, 12:42:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:42:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:42:45 INFO - 'installer_path': 'installer.exe', 12:42:45 INFO - 'log_level': 'info', 12:42:45 INFO - 'log_name': 'talos', 12:42:45 INFO - 'log_to_console': True, 12:42:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:42:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:42:45 INFO - 'opt_config_files': (), 12:42:45 INFO - 'pip_index': False, 12:42:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:42:45 INFO - 'cmd': ('bash', 12:42:45 INFO - '-c', 12:42:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:42:45 INFO - 'enabled': True, 12:42:45 INFO - 'halt_on_failure': False, 12:42:45 INFO - 'name': 'check_screen_resolution'},), 12:42:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:42:45 INFO - 'cmd': ('bash', 12:42:45 INFO - '-c', 12:42:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:42:45 INFO - 'enabled': True, 12:42:45 INFO - 'halt_on_failure': False, 12:42:45 INFO - 'name': 'check_screen_resolution'},), 12:42:45 INFO - 'run_cmd_checks_enabled': True, 12:42:45 INFO - 'sps_profile': False, 12:42:45 INFO - 'sps_profile_interval': 0, 12:42:45 INFO - 'suite': 'dromaeojs', 12:42:45 INFO - 'system_bits': '32', 12:42:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:42:45 INFO - 'title': 't-yosemite-r7-0106', 12:42:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:42:45 INFO - 'use_talos_json': True, 12:42:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:42:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:42:45 INFO - 'work_dir': 'build'} 12:42:45 INFO - ##### 12:42:45 INFO - ##### Running clobber step. 12:42:45 INFO - ##### 12:42:45 INFO - Running pre-action listener: _resource_record_pre_action 12:42:45 INFO - Running main action method: clobber 12:42:45 INFO - rmtree: /builds/slave/test/build 12:42:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:42:47 INFO - Running post-action listener: _resource_record_post_action 12:42:47 INFO - ##### 12:42:47 INFO - ##### Running read-buildbot-config step. 12:42:47 INFO - ##### 12:42:47 INFO - Running pre-action listener: _resource_record_pre_action 12:42:47 INFO - Running main action method: read_buildbot_config 12:42:47 INFO - Using buildbot properties: 12:42:47 INFO - { 12:42:47 INFO - "project": "", 12:42:47 INFO - "product": "firefox", 12:42:47 INFO - "script_repo_revision": "production", 12:42:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:42:47 INFO - "repository": "", 12:42:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:42:47 INFO - "buildid": "20160303105838", 12:42:47 INFO - "pgo_build": "False", 12:42:47 INFO - "basedir": "/builds/slave/test", 12:42:47 INFO - "buildnumber": 453, 12:42:47 INFO - "slavename": "t-yosemite-r7-0106", 12:42:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:42:47 INFO - "platform": "yosemite_r7", 12:42:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:42:47 INFO - "branch": "fx-team", 12:42:47 INFO - "repo_path": "integration/fx-team", 12:42:47 INFO - "revision": "6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec", 12:42:47 INFO - "stage_platform": "macosx64", 12:42:47 INFO - "builduid": "e7940af702934d2187c49fe5ea0fb13e", 12:42:47 INFO - "slavebuilddir": "test" 12:42:47 INFO - } 12:42:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 12:42:47 INFO - Running post-action listener: _resource_record_post_action 12:42:47 INFO - ##### 12:42:47 INFO - ##### Running download-and-extract step. 12:42:47 INFO - ##### 12:42:47 INFO - Running pre-action listener: _resource_record_pre_action 12:42:47 INFO - Running main action method: download_and_extract 12:42:47 INFO - mkdir: /builds/slave/test/build/tests 12:42: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')]} 12:42:47 INFO - https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:42:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 12:42:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 12:42:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/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 12:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/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 12:42:51 INFO - Downloaded 1277 bytes. 12:42:51 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 12:42:51 INFO - Using the following test package requirements: 12:42:51 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:42:51 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 12:42:51 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 12:42:51 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'jsshell-mac.zip'], 12:42:51 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 12:42:51 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:42:51 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 12:42:51 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 12:42:51 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 12:42:51 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 12:42:51 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 12:42:51 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 12:42:51 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:42: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')]} 12:42:51 INFO - https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:42:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:42:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:42:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:42:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:43:04 INFO - Downloaded 17855029 bytes. 12:43:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:43:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:43:07 INFO - Return code: 0 12:43:07 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:07 INFO - https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:43:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:43:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:43:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 12:43:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:43:08 INFO - Downloaded 17855029 bytes. 12:43:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:43:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:43:12 INFO - Return code: 0 12:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:12 INFO - https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:43:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:43:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:43:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 12:43:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:43:13 INFO - Downloaded 10808282 bytes. 12:43:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:43:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 12:43:13 INFO - Return code: 0 12:43:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:13 INFO - https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:43:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:43:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:43:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 12:43:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 12:43:16 INFO - Downloaded 110953927 bytes. 12:43:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:43:16 INFO - mkdir: /builds/slave/test/properties 12:43:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:43:16 INFO - Writing to file /builds/slave/test/properties/build_url 12:43:16 INFO - Contents: 12:43:16 INFO - build_url:https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 12:43:18 INFO - Running post-action listener: _resource_record_post_action 12:43:18 INFO - Running post-action listener: set_extra_try_arguments 12:43:18 INFO - ##### 12:43:18 INFO - ##### Running populate-webroot step. 12:43:18 INFO - ##### 12:43:18 INFO - Running pre-action listener: _resource_record_pre_action 12:43:18 INFO - Running main action method: populate_webroot 12:43:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:43:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:43:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:43:18 INFO - '--tppagecycles', 12:43:18 INFO - '7'], 12:43:18 INFO - 'tests': ['tsvgm']}}, 12:43:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:43:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:43:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:43:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:43:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'tests': ['damp', 'tps']}, 12:43:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['damp', 'tps']}, 12:43:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:43:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:43:18 INFO - 'other': {'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore']}, 12:43:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore']}, 12:43:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore']}, 12:43:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore']}, 12:43:18 INFO - 'other_l64': {'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore']}, 12:43:18 INFO - 'other_nol64': {'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore']}, 12:43:18 INFO - 'svgr': {'tests': ['tsvgx', 12:43:18 INFO - 'tsvgr_opacity', 12:43:18 INFO - 'tart', 12:43:18 INFO - 'tscrollx', 12:43:18 INFO - 'cart']}, 12:43:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['tsvgx', 12:43:18 INFO - 'tsvgr_opacity', 12:43:18 INFO - 'tart', 12:43:18 INFO - 'tscrollx', 12:43:18 INFO - 'cart']}, 12:43:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'tests': ['tp5o']}, 12:43:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'talos_options': ['--e10s'], 12:43:18 INFO - 'tests': ['tp5o']}, 12:43:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'talos_options': ['--xperf_path', 12:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:18 INFO - 'tests': ['tp5n']}, 12:43:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:43:18 INFO - 'talos_options': ['--e10s', 12:43:18 INFO - '--xperf_path', 12:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:18 INFO - 'tests': ['tp5n']}}, 12:43:18 INFO - 'talos.zip': {'path': '', 12:43:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:43:18 INFO - Running post-action listener: _resource_record_post_action 12:43:18 INFO - ##### 12:43:18 INFO - ##### Running create-virtualenv step. 12:43:18 INFO - ##### 12:43:18 INFO - Running pre-action listener: _resource_record_pre_action 12:43:18 INFO - Running main action method: create_virtualenv 12:43:18 INFO - Creating virtualenv /builds/slave/test/build/venv 12:43:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:43:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:43:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:43:18 INFO - Using real prefix '/tools/python27' 12:43:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:22 INFO - Installing pip.................done. 12:43:22 INFO - Return code: 0 12:43:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:22 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:22 INFO - 'HOME': '/Users/cltbld', 12:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:22 INFO - 'LOGNAME': 'cltbld', 12:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:22 INFO - 'MOZ_NO_REMOTE': '1', 12:43:22 INFO - 'NO_EM_RESTART': '1', 12:43:22 INFO - 'PAGER': '/bin/cat', 12:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:22 INFO - 'PWD': '/builds/slave/test', 12:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:22 INFO - 'SHELL': '/bin/bash', 12:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:22 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:22 INFO - 'USER': 'cltbld', 12:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:22 INFO - 'XPC_FLAGS': '0x0', 12:43:22 INFO - 'XPC_SERVICE_NAME': '0', 12:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:43:22 INFO - Cleaning up... 12:43:22 INFO - Return code: 0 12:43:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:22 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:22 INFO - 'HOME': '/Users/cltbld', 12:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:22 INFO - 'LOGNAME': 'cltbld', 12:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:22 INFO - 'MOZ_NO_REMOTE': '1', 12:43:22 INFO - 'NO_EM_RESTART': '1', 12:43:22 INFO - 'PAGER': '/bin/cat', 12:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:22 INFO - 'PWD': '/builds/slave/test', 12:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:22 INFO - 'SHELL': '/bin/bash', 12:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:22 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:22 INFO - 'USER': 'cltbld', 12:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:22 INFO - 'XPC_FLAGS': '0x0', 12:43:22 INFO - 'XPC_SERVICE_NAME': '0', 12:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:22 INFO - Downloading/unpacking psutil>=0.7.1 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:25 INFO - Installing collected packages: psutil 12:43:25 INFO - Running setup.py install for psutil 12:43:25 INFO - building 'psutil._psutil_osx' extension 12:43:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:43:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:43:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:43:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:43:25 INFO - building 'psutil._psutil_posix' extension 12:43:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:43:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:43:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:43:26 INFO - ^ 12:43:26 INFO - 1 warning generated. 12:43:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:43:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:26 INFO - Successfully installed psutil 12:43:26 INFO - Cleaning up... 12:43:26 INFO - Return code: 0 12:43:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:26 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:43:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:26 INFO - 'HOME': '/Users/cltbld', 12:43:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:26 INFO - 'LOGNAME': 'cltbld', 12:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:26 INFO - 'MOZ_NO_REMOTE': '1', 12:43:26 INFO - 'NO_EM_RESTART': '1', 12:43:26 INFO - 'PAGER': '/bin/cat', 12:43:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:26 INFO - 'PWD': '/builds/slave/test', 12:43:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:26 INFO - 'SHELL': '/bin/bash', 12:43:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:26 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:26 INFO - 'USER': 'cltbld', 12:43:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:26 INFO - 'XPC_FLAGS': '0x0', 12:43:26 INFO - 'XPC_SERVICE_NAME': '0', 12:43:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:43:29 INFO - Installing collected packages: mozsystemmonitor 12:43:29 INFO - Running setup.py install for mozsystemmonitor 12:43:29 INFO - Successfully installed mozsystemmonitor 12:43:29 INFO - Cleaning up... 12:43:29 INFO - Return code: 0 12:43:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:29 INFO - 'HOME': '/Users/cltbld', 12:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:29 INFO - 'LOGNAME': 'cltbld', 12:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:29 INFO - 'MOZ_NO_REMOTE': '1', 12:43:29 INFO - 'NO_EM_RESTART': '1', 12:43:29 INFO - 'PAGER': '/bin/cat', 12:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:29 INFO - 'PWD': '/builds/slave/test', 12:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:29 INFO - 'SHELL': '/bin/bash', 12:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:29 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:29 INFO - 'USER': 'cltbld', 12:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:29 INFO - 'XPC_FLAGS': '0x0', 12:43:29 INFO - 'XPC_SERVICE_NAME': '0', 12:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:29 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:31 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:32 INFO - Downloading docopt-0.6.1.tar.gz 12:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:33 INFO - Running setup.py install for blobuploader 12:43:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:33 INFO - Running setup.py install for requests 12:43:33 INFO - Running setup.py install for docopt 12:43:33 INFO - Successfully installed blobuploader requests docopt 12:43:33 INFO - Cleaning up... 12:43:33 INFO - Return code: 0 12:43:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:34 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:34 INFO - 'HOME': '/Users/cltbld', 12:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:34 INFO - 'LOGNAME': 'cltbld', 12:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:34 INFO - 'MOZ_NO_REMOTE': '1', 12:43:34 INFO - 'NO_EM_RESTART': '1', 12:43:34 INFO - 'PAGER': '/bin/cat', 12:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:34 INFO - 'PWD': '/builds/slave/test', 12:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:34 INFO - 'SHELL': '/bin/bash', 12:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:34 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:34 INFO - 'USER': 'cltbld', 12:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:34 INFO - 'XPC_FLAGS': '0x0', 12:43:34 INFO - 'XPC_SERVICE_NAME': '0', 12:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:34 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Rz_f52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:34 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cXz7qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:34 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-0RxAiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:34 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kl5VDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-35o7cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-eLl17v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-28Drln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-FcQB0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-iBfhL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-48Phm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-zvvZ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-feLtf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LMyVgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:35 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-VwCR2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xL11wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-1VnBT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:36 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-DgklUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:36 INFO - Running setup.py install for manifestparser 12:43:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Running setup.py install for mozcrash 12:43:36 INFO - Running setup.py install for mozdebug 12:43:36 INFO - Running setup.py install for mozdevice 12:43:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Running setup.py install for mozfile 12:43:37 INFO - Running setup.py install for mozhttpd 12:43:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Running setup.py install for mozinfo 12:43:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Running setup.py install for mozInstall 12:43:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Running setup.py install for mozleak 12:43:37 INFO - Running setup.py install for mozlog 12:43:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Running setup.py install for moznetwork 12:43:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:37 INFO - Running setup.py install for mozprocess 12:43:38 INFO - Running setup.py install for mozprofile 12:43:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:38 INFO - Running setup.py install for mozrunner 12:43:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:38 INFO - Running setup.py install for mozscreenshot 12:43:38 INFO - Running setup.py install for moztest 12:43:38 INFO - Running setup.py install for mozversion 12:43:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:38 INFO - Cleaning up... 12:43:38 INFO - Return code: 0 12:43:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:38 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:38 INFO - 'HOME': '/Users/cltbld', 12:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:38 INFO - 'LOGNAME': 'cltbld', 12:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:38 INFO - 'MOZ_NO_REMOTE': '1', 12:43:38 INFO - 'NO_EM_RESTART': '1', 12:43:38 INFO - 'PAGER': '/bin/cat', 12:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:38 INFO - 'PWD': '/builds/slave/test', 12:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:38 INFO - 'SHELL': '/bin/bash', 12:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:38 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:38 INFO - 'USER': 'cltbld', 12:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:38 INFO - 'XPC_FLAGS': '0x0', 12:43:38 INFO - 'XPC_SERVICE_NAME': '0', 12:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-JH9Yrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kH2HiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-_nlEta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-r_ywcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-XfTarP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-8prtKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-UhojFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:39 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-UCxnSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-TPyLgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nma8OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-iNidl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-8o82Iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kkuLGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-KK8_NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9Ghl0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-T7HPMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:40 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2tiZe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:43:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:43 INFO - Downloading blessings-1.6.tar.gz 12:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:43 INFO - Installing collected packages: blessings 12:43:43 INFO - Running setup.py install for blessings 12:43:43 INFO - Successfully installed blessings 12:43:43 INFO - Cleaning up... 12:43:44 INFO - Return code: 0 12:43:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:44 INFO - Reading from file tmpfile_stdout 12:43:44 INFO - Current package versions: 12:43:44 INFO - blessings == 1.6 12:43:44 INFO - blobuploader == 1.2.4 12:43:44 INFO - docopt == 0.6.1 12:43:44 INFO - manifestparser == 1.1 12:43:44 INFO - mozInstall == 1.12 12:43:44 INFO - mozcrash == 0.16 12:43:44 INFO - mozdebug == 0.1 12:43:44 INFO - mozdevice == 0.48 12:43:44 INFO - mozfile == 1.2 12:43:44 INFO - mozhttpd == 0.7 12:43:44 INFO - mozinfo == 0.9 12:43:44 INFO - mozleak == 0.1 12:43:44 INFO - mozlog == 3.1 12:43:44 INFO - moznetwork == 0.27 12:43:44 INFO - mozprocess == 0.22 12:43:44 INFO - mozprofile == 0.28 12:43:44 INFO - mozrunner == 6.11 12:43:44 INFO - mozscreenshot == 0.1 12:43:44 INFO - mozsystemmonitor == 0.0 12:43:44 INFO - moztest == 0.7 12:43:44 INFO - mozversion == 1.4 12:43:44 INFO - psutil == 3.1.1 12:43:44 INFO - requests == 1.2.3 12:43:44 INFO - wsgiref == 0.1.2 12:43:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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')]} 12:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:44 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:44 INFO - 'HOME': '/Users/cltbld', 12:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:44 INFO - 'LOGNAME': 'cltbld', 12:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:44 INFO - 'MOZ_NO_REMOTE': '1', 12:43:44 INFO - 'NO_EM_RESTART': '1', 12:43:44 INFO - 'PAGER': '/bin/cat', 12:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:44 INFO - 'PWD': '/builds/slave/test', 12:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:44 INFO - 'SHELL': '/bin/bash', 12:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:44 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:44 INFO - 'USER': 'cltbld', 12:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:44 INFO - 'XPC_FLAGS': '0x0', 12:43:44 INFO - 'XPC_SERVICE_NAME': '0', 12:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:43:44 INFO - Cleaning up... 12:43:44 INFO - Return code: 0 12:43:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43: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')]} 12:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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')]} 12:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43: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', 'jsonschema'] in /builds/slave/test/build 12:43: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 jsonschema 12:43:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:44 INFO - 'HOME': '/Users/cltbld', 12:43:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:44 INFO - 'LOGNAME': 'cltbld', 12:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:44 INFO - 'MOZ_NO_REMOTE': '1', 12:43:44 INFO - 'NO_EM_RESTART': '1', 12:43:44 INFO - 'PAGER': '/bin/cat', 12:43:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:44 INFO - 'PWD': '/builds/slave/test', 12:43:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:44 INFO - 'SHELL': '/bin/bash', 12:43:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:44 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:44 INFO - 'USER': 'cltbld', 12:43:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:44 INFO - 'XPC_FLAGS': '0x0', 12:43:44 INFO - 'XPC_SERVICE_NAME': '0', 12:43:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:44 INFO - Downloading/unpacking jsonschema 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:43:47 INFO - Downloading/unpacking functools32 (from jsonschema) 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43: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 12:43:47 INFO - Downloading functools32-3.2.3-2.tar.gz 12:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:43:47 INFO - warning: no files found matching '*.txt' 12:43:47 INFO - no previously-included directories found matching 'build' 12:43:47 INFO - no previously-included directories found matching 'dist' 12:43:47 INFO - no previously-included directories found matching '.git*' 12:43:47 INFO - Installing collected packages: jsonschema, functools32 12:43:47 INFO - Running setup.py install for functools32 12:43:47 INFO - warning: no files found matching '*.txt' 12:43:47 INFO - no previously-included directories found matching 'build' 12:43:47 INFO - no previously-included directories found matching 'dist' 12:43:47 INFO - no previously-included directories found matching '.git*' 12:43:47 INFO - Successfully installed jsonschema functools32 12:43:47 INFO - Cleaning up... 12:43:48 INFO - Return code: 0 12:43:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:48 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 0x109e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb29d8cc40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, '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.kLRcridIie/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.HQSrd01iD4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:43:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:43:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:43:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:43:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:43:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:43:48 INFO - 'HOME': '/Users/cltbld', 12:43:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:43:48 INFO - 'LOGNAME': 'cltbld', 12:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:48 INFO - 'MOZ_NO_REMOTE': '1', 12:43:48 INFO - 'NO_EM_RESTART': '1', 12:43:48 INFO - 'PAGER': '/bin/cat', 12:43:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:48 INFO - 'PWD': '/builds/slave/test', 12:43:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:43:48 INFO - 'SHELL': '/bin/bash', 12:43:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:43:48 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:43:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:43:48 INFO - 'USER': 'cltbld', 12:43:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:43:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:48 INFO - 'XPC_FLAGS': '0x0', 12:43:48 INFO - 'XPC_SERVICE_NAME': '0', 12:43:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:48 INFO - Downloading/unpacking flake8 12:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:43:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:43:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:52 INFO - no previously-included directories found matching 'docs/_build' 12:43:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:43:52 INFO - Running setup.py install for pep8 12:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:43:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:43:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:43:52 INFO - no previously-included directories found matching 'docs/_build' 12:43:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:43:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:43:52 INFO - Cleaning up... 12:43:52 INFO - Return code: 0 12:43:52 INFO - Running post-action listener: _resource_record_post_action 12:43:52 INFO - Running post-action listener: _start_resource_monitoring 12:43:52 INFO - Starting resource monitoring. 12:43:52 INFO - ##### 12:43:52 INFO - ##### Running install step. 12:43:52 INFO - ##### 12:43:52 INFO - Running pre-action listener: _resource_record_pre_action 12:43:52 INFO - Running main action method: install 12:43:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:52 INFO - Reading from file tmpfile_stdout 12:43:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:53 INFO - Reading from file tmpfile_stdout 12:43:53 INFO - Output received: 12:43:53 INFO - Usage: mozinstall [options] installer 12:43:53 INFO - Options: 12:43:53 INFO - -h, --help show this help message and exit 12:43:53 INFO - -d DEST, --destination=DEST 12:43:53 INFO - Directory to install application into. [default: 12:43:53 INFO - "/builds/slave/test"] 12:43:53 INFO - --app=APP Application being installed. [default: firefox] 12:43:53 INFO - mkdir: /builds/slave/test/build/application 12:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:44:27 INFO - Reading from file tmpfile_stdout 12:44:27 INFO - Output received: 12:44:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:44:27 INFO - Running post-action listener: _resource_record_post_action 12:44:27 INFO - ##### 12:44:27 INFO - ##### Running run-tests step. 12:44:27 INFO - ##### 12:44:27 INFO - Running pre-action listener: _resource_record_pre_action 12:44:27 INFO - Running main action method: run_tests 12:44:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:44:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:44:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:44:27 INFO - 2016-03-03 12:44:27.338 screenresolution[1649:7603] starting screenresolution argv=screenresolution get 12:44:27 INFO - 2016-03-03 12:44:27.340 screenresolution[1649:7603] Display 0: 1600x1200x32@60 12:44:27 INFO - 2016-03-03 12:44:27.346 screenresolution[1650:7605] starting screenresolution argv=screenresolution list 12:44:27 INFO - Available Modes on Display 0 12:44:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:44:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:44:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:44:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:44:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:44:27 INFO - Intel Iris: 12:44:27 INFO - Chipset Model: Intel Iris 12:44:27 INFO - Type: GPU 12:44:27 INFO - Bus: Built-In 12:44:27 INFO - VRAM (Dynamic, Max): 1536 MB 12:44:27 INFO - Vendor: Intel (0x8086) 12:44:27 INFO - Device ID: 0x0a2e 12:44:27 INFO - Revision ID: 0x0009 12:44:27 INFO - Displays: 12:44:27 INFO - Display: 12:44:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:44:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:44:27 INFO - Display Serial Number: 1600x1200 60 12:44:27 INFO - Main Display: Yes 12:44:27 INFO - Mirror: Off 12:44:27 INFO - Online: Yes 12:44:27 INFO - Rotation: Supported 12:44:27 INFO - Return code: 0 12:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:44:27 INFO - Python 2.7.3 12:44:27 INFO - Return code: 0 12:44:27 INFO - grabbing minidump binary from tooltool 12:44: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')]} 12:44:27 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 0x109d32d30>, '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 0x109b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d29b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:44:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:44:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:44:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:27 INFO - Return code: 0 12:44:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:44:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:44:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:44:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:44:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:44:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:44:28 INFO - Return code: 0 12:44:28 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/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 12:44:28 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/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 12:44:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kLRcridIie/Render', 12:44:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:44:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:44:28 INFO - 'HOME': '/Users/cltbld', 12:44:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:44:28 INFO - 'LOGNAME': 'cltbld', 12:44:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:44:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:28 INFO - 'MOZ_NO_REMOTE': '1', 12:44:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:44:28 INFO - 'NO_EM_RESTART': '1', 12:44:28 INFO - 'PAGER': '/bin/cat', 12:44:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:44:28 INFO - 'PWD': '/builds/slave/test', 12:44:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:44:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:44:28 INFO - 'SHELL': '/bin/bash', 12:44:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HQSrd01iD4/Listeners', 12:44:28 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 12:44:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:44:28 INFO - 'USER': 'cltbld', 12:44:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:44:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:28 INFO - 'XPC_FLAGS': '0x0', 12:44:28 INFO - 'XPC_SERVICE_NAME': '0', 12:44:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:44:28 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/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 12:44:29 INFO - mozversion application_buildid: 20160303105838 12:44:29 INFO - mozversion application_changeset: 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec 12:44:29 INFO - mozversion application_display_name: Nightly 12:44:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:29 INFO - mozversion application_name: Firefox 12:44:29 INFO - mozversion application_remotingname: firefox 12:44:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:44:29 INFO - mozversion application_vendor: Mozilla 12:44:29 INFO - mozversion application_version: 47.0a1 12:44:29 INFO - mozversion platform_buildid: 20160303105838 12:44:29 INFO - mozversion platform_changeset: 6fe81a6dbaa8f2ffdfb64ff677af85128d0555ec 12:44:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:44:29 INFO - mozversion platform_version: 47.0a1 12:44:29 INFO - using testdate: 1457037869 12:44:29 INFO - actual date: 1457037869 12:44:29 INFO - starting webserver on 'localhost:49270' 12:44:29 INFO - SUITE-START | Running 2 tests 12:44:29 INFO - TEST-START | dromaeo_css 12:44:29 INFO - operating with platform_type : mac_ 12:44:29 INFO - Initialising browser for dromaeo_css test... 12:44:29 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpbispCE/profile http://localhost:49270/getInfo.html) 12:44:31 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 12:44:31 INFO - PROCESS | 1668 | colorDepth:24 12:44:31 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 12:44:31 INFO - PROCESS | 1668 | __metrics 12:44:31 INFO - PROCESS | 1668 | 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" 12:44:31 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:44:32 INFO - TEST-INFO | 1668: exit 0 12:44:32 INFO - Browser initialized. 12:44:32 INFO - Running cycle 1/1 for dromaeo_css test... 12:44:32 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpbispCE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:44 INFO - PROCESS | 1671 | RSS: Main: 243441664 12:44:44 INFO - PROCESS | 1671 | 12:45:35 INFO - PROCESS | 1671 | 1457037935990 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:47:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 12:47:46 INFO - PROCESS | 1671 | RSS: Main: 372748288 12:47:46 INFO - PROCESS | 1671 | 12:50:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 12:50:49 INFO - PROCESS | 1671 | RSS: Main: 372015104 12:50:49 INFO - PROCESS | 1671 | 12:53:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 12:53:52 INFO - PROCESS | 1671 | RSS: Main: 373018624 12:53:52 INFO - PROCESS | 1671 | 12:56:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 12:56:55 INFO - PROCESS | 1671 | RSS: Main: 329809920 12:56:55 INFO - PROCESS | 1671 | 12:59:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 12:59:58 INFO - PROCESS | 1671 | RSS: Main: 335458304 12:59:58 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 13:03:01 INFO - PROCESS | 1671 | RSS: Main: 386170880 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | __start_tp_report 13:03:01 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 13:03:01 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 13:03:01 INFO - PROCESS | 1671 | |i|pagename|runs| 13:03:01 INFO - PROCESS | 1671 | |0;dojo.html;3359.596848378195;3456.2914602506503;3483.8954831355054;3494.405950988332;3519.595246546648;5536.390996990338;5566.165075238716;5615.494605485505;5625.381208067114;5640.266765320503;5598.104303311471;5606.523445507127;5616.5787565932615;5749.281339832521;5757.165211044396;5000.824971126011;5003.524665156804;5024.196128619422;5068.670536415121;5127.000234954166;5124.5131712487255;5130.07658621448;5171.87070323243;5180.896382072357;5222.7649755760895;5028.5977121830165;5128.666636668605;5139.948600514003;5141.691498510064;5151.8196863109615;5049.2173713074535;5104.770285337168;5120.769565369567;5123.2827404163445;5126.871828204287;5083.974580127113;5084;5095.133827249377;5098.923516147261;5132.384113906318;5535.225068490415;5556.444355564452;5561.638493497951;5568.749406276727;5592.4407559244155;5952.375000624916;6094.6038507497315;6142.815715528542;6166.691665416712;6202.782902598433;5082.440931497532;6128.877422451526;6156.907646385308;6189.412005859436;6192.566520343577;5648.604597678123;5652.265205523256;5668.829935101953;5674.773009079632;5824.301083869963;5018.272350509155;6171.321154672983;6233;6293.811185664437;6312.053192021233;6030.819075427744;6040.577159598786;6072.240969878765;6081.5742897996715;6087.391260873877;6212.1303017577575;6230.501559875199;6240.188775459252;6241.375862413813;6247.656378899204;6023.698815059317;6089.786857459968;6109.586862300649;6141.056449558148;6159.384061593805;6121.540884433596;6143.296949342275;6145.064304743992;6167.290761562388;6191.380861913773;4805.567498925114;4823.03539292143;4825.396825396825;4829.348038014893;4869.245266983623;4313.590208930146;4342.6308763754805;4344.674149438804;4361.760103194355;4420.9336859947125;5343.973280133574;5445.863853403696;5570.944290557123;5642.887142257214;5754.74103665336;6232.781852635136;6251.3123556408755;6265.561410701207;6277.96861015692;6284.340144284784;5669.4047125051275;5671.950689122526;5675.801346952837;5687.459691329317;5734.483896449339;5229.6339256251695;5261.210818377198;5306.044911915892;5311.814086506954;5312.867178320573;6210.8136755898295;6234.064890266496;6288.717007734572;6296.496280297565;6299.464545513682;6243.750249990131;6266.561340706289;6281.623102613858;6282.403171698681;6287.96856015717;6193.1329613855;6264.404881536247;6264.68676566179;6282.089097080806;6283.2774230962195;6016.939830601638;6055.364186760326;6069.726862291296;6095.7708482108;6120.812855101138;5968.612040217372;6008.969955150196;6028.8794224116145;6046.12331211963;6072.939270607414;4654.48800631937;5772.884542309214;5793.623414478046;5798.652080875161;5805.187273781589;5049.469805670498;5855.473007429352;5958.672273025025;6020.789272375446;6120.908186377297;5866.50134738535;5869.853253668693;5874.060150375919;5877.177195192591;5879.323877754113;6014.977453832947;6035.6076855004285;6044.0933859919605;6062.030075187949;6084.239470066242;5760.510356619734;5879.794642098274;5887.470127688357;5974.40255974399;5982.312034116132 13:03:01 INFO - PROCESS | 1671 | |1;ext.html;458.3628756029118;533.1709192206118;565.0986676251378;632.1655414852394;633.9049142628605;29733.256668583297;30212.619170220332;30316.54525182124;38008.239835203276;38485.230295394074;41292.79353603228;41675.58324416755;41710.58289417105;41936.37095443563;42007.94980125498;9540.236781057516;9770.120689137977;9774.364666296668;9785.168260697848;9831.164351030171;9572.760680982961;9705.369151005198;9711.805763884719;9730;9749.805003899917;9648.372855764388;9720.951395243013;9751.853722194173;9862.358946668444;9863.30956833022;9788.36375635585;9850.704478865646;9850.999999999964;9870.161036311922;9874.40753554789;9653.986331435168;9807.215422766161;9818.509074546315;9819.165370943478;9869.407835529819;40190;40593.75249980024;40669.389959150634;40683.796581016904;40776.38835417471;3039.5440683897373;3235.272063785653;3385.4244778387488;3461.359648465042;3763.397856342999;27211.591826122625;27372;28191.57712634312;28195.85902070497;28246.293842653893;2716.606092116652;2779.986100069507;2783.9025634102914;2797.9020734274404;2836.1349788314556;491536.54231728613;492484;493645;493753.9999999964;495540;65310.34689653137;66230;66241.66879165573;66464;66508;68697.31302687009;69690.60618787596;69723;69783;69908;16288.755668664979;16483.093429861474;16502.33990640385;16533.256003479873;16548.089855057846;12652.936735316265;12677;12708.110432269652;12714.173578717353;12747.298898560482;20221.39335819928;20618.865962372212;20807.895960520404;20815.438842086904;20907.8954605226;7892.802679933047;8841.69054083104;8890.555472226362;8948;8974.641014359484;803.9799005024921;932.4871320773548;953.1802649721234;978.6085565773748;1089.2593036735095;27131.72868271292;27399.726002740117;27837.102805607232;27998;28254.85872570624;931.8788557487484;1073.672529878379;1104.5968221599057;1113.8551988241638;1114.6934592986831;14175.929120354333;14228.28858557068;14357.56927292183;14373.712525749426;14682.779758303634;652741;660599;664854;665314;665506;59431.702841485516;59862.70068649629;59928.70035649881;59946.40053599408;60183;1293.2369901758009;1402.2357814990855;1402.3408997771032;1416.3640994651194;1436.0522055443357;28417.005404810734;28905.176362803682;28969.420611588073;29021.564676529448;29759.404811904074;47317;47428.7628561855;47922.76038619784;47972;48103;363381;364040;364756;364854;365218;28286.575701364083;28648.85675571609;31776;32384.676153238164;33277.66722332746;39523.011924700964;40256.3961540583;40338;40360.3945940817;40364;33179.668203317655;33743.4938475928;33911.491327629614;34623.4806477898;34638.30723385468;33909.49135763015;34307.65692343045;34478;34602.788902388296;34815.477767833;33369.16577085592;34477.655223447444;34723.82638086793;35207.47188792119;35476.46785298171;31232.632988824487;31306.21734456657;31355.856080643294;31476.685233147375;31598.842005789826;23847.165349212693;23950.161744338864;24161.51676966486;24300.027998879847;24395.14616988397 13:03:01 INFO - PROCESS | 1671 | |2;jquery.html;353.2246718452995;354.638268965655;356.34254799894194;360.74567429961877;365.581409286367;19035.048247587616;19295.517612059688;19715.605687886233;19730.506737331572;19735.703964440545;19156.137973791178;19873.20507179711;20008.19967201314;20027.299044533444;20036.39890803278;5462.836114916549;5674.574406919477;5762.222100016486;5770.596058275923;5789.913151302712;4123.484564429446;4262.424572682679;4310.892227694317;5682.346530149044;5991.610545314563;6229.875402491947;6232.252129744415;6245.531585131111;6245.594036387621;6245.718942647592;6042.912275790356;6121.234845644294;6209.130721698965;6218.191635087455;6225.408586184328;3650.1787097903025;3829.5021647185686;3833.693304535658;5368.194770784375;5384.461553844623;23006;23743.406414839596;24014.759852401603;24299.514009719707;24310.756892431204;2247.3932038349717;2491.314888405685;2561.987190064038;2636.7890568754456;2703.91888243353;13793.931030344884;13882.305884705724;14490.855091449055;14502.1298722077;14742.70514589713;1669.8998060116432;1700.880938334317;1731.7835270591177;1753.2373417563274;1755.4733579926099;91429.76817939327;92284.53857730668;94552.52723736406;94784.05215947822;95141.52429237879;10103.444310562989;10543.630972916064;10565.313254638424;10659.4137322448;10661.147108231324;10788.676339709822;12692.048096392808;12792.488300468063;12793.424295906707;12796.10427270082;6027.487663548647;8361.707340243183;8371.246587807005;8447.113053129457;8469.491830490191;8577.828443431097;8581.399302048796;8593.484390936565;8679.956600217085;8714.477131372138;6041.667708275999;6129.2032035835055;6134.04922237054;6135.0797380392405;6199.721012554356;1447.862453066957;1571.6228105254886;1644.2025617575466;1752.3779058434327;1792.6773180827577;903.9231665308391;911.9708648257706;985.4235272365746;992.245893121233;1013.8732658417698;15127.243637818065;18742.437726868215;19039.809601904082;19979.60040799176;20907.37277881666;929.363386080537;933.0995589256264;968.9273304502191;978.7602037500858;1008.495752123938;10828;11167.888321116847;11188.720281993015;11203.887961120285;11250.437478126061;621647;626287;626866;631531;649981;95222;95568.9999999986;96585;97684.51157744166;98666;1040.095117247984;1051.9684409467882;1110.3171549497163;1126.189143816451;1129.9209055366046;14949.476768313058;17668.64662706713;18371.90814045921;18472.076396180408;18776.812231877506;49862.25206621831;52723.736381317845;52779;52964.73517632541;53942;69522;69730.65134674295;73512;74446.62776686082;75236.49527009539;7905.407094467823;8070.071941726542;8118.472299300763;8156.632951517315;8445.873311900203;9484.57319420614;12341.753164936472;12852.861851962765;13119.344032798132;13127.868721312665;11209.607663732057;11601.593944211912;11698.70753231176;11781.234219775688;11810.350430726392;9039.096090390909;11376.20366574365;11471.770564588829;11584.189106762446;11763.705907352385;11114.777044590952;11121.555137794398;11403.372814495282;11916;11949.522019119138;7948.244916732901;7953.5227886327;7998.648507644508;8055.83888322242;8164.346852251924;6177.81466556004;8457.149708735944;11474.024707899922;11574.479148438171;11787.646370608896 13:03:01 INFO - PROCESS | 1671 | |3;mootools.html;1352.3238380809596;1388.0630574362303;1512.7050225206085;1539.1996161995762;1895.365052707343;7938.563379014152;8521.829563408728;8605;8608.182222688834;8613.440126391795;8380.45527040742;8611.31109511239;8619.612117454713;8628.396012279143;8644.049154593005;2130.446084018151;2365.8698771567556;2406.3382569793357;2421.5883299838983;2432.282476669378;2102.412678427785;2436.2691192642224;2441.170002199252;2444.3766839455916;2444.9511009779794;2390.4262976885598;2403.531311394279;2451.852888826676;2453.877306134695;2455.1529722245796;2393.964090538643;2440.3533063738123;2440.9145679901208;2448.987755061231;2449.142800019979;2398.7481314461907;2410.2287268074224;2420.100221326268;2421.418859473731;2456.5086982603552;8668.133186681282;8736.213740763362;8737.344699147588;8739.082396348418;8752.474851508867;5281.234221037928;5471.316085489314;5474.616776825624;5477.780888764445;5541.362743284493;3516.6483351664883;3592.0481072515804;3661.761985470936;3664.6518580734787;3677.2461645362637;1022.601185537641;1034.4414016431117;1037.5901518899993;1057.3550134417999;1057.772578895541;11668.941655291754;11683.7079073023;11687.883121168765;11700.531978720926;11721.882781172164;4752.714837109785;4811.958194121445;4885.926711099336;4896.755162241873;4901.142300097468;10018.198544116452;10019.849702254473;10030.699079027641;10032;10041;5380.112281473513;5393.757280922289;5429.918551221735;5430.755615997289;5435.646682965595;4417.182821178092;4550.408446901948;4775.2359622460235;4898.657094003385;4922.483139270396;3798.3163030654196;3880.6119388061534;3895.558643301996;3914.080191155076;3936.2127574484643;1289.3166621690518;1292.6509842342514;1300.7918733002675;1305.8563558008611;1317.1833463252844;1011.9797604047877;1039.6465201831413;1057.799018186542;1060.0830281806182;1382.702718915438;7294.234105418961;7658.540487570764;8104.149064348158;8162.6734930602115;8193.50838949653;512.3134999101222;518.5592246590368;521.8486638874684;524.2660275614171;525.254139122447;6069.332373438918;6088;6180.721867515973;6231.688415579203;6256.124142620037;10085.041921017491;10199.694009179737;10353.585856565804;10529.473526323807;10566;10243.94878025605;10361.585536578452;10391.428471434143;10393.012663796928;10418.583256669648;6243.75024999004;7976.282134607914;7980.640871160812;8009.999999999884;8077.474964127313;7846.489978151631;7854.72508462201;7961.482503637245;7996.440249182734;8007.319377852948;9038.909610903807;9268.860967085364;9363.531823408939;9389.577469014048;9471.289653275893;8976.192142707188;9656.275779316438;9736.95131524338;9812.01879812013;9829.557669905014;6737.258901520927;6952.304769523007;6959.652017399008;7434;7582.203868593719;7572.697092116474;8011.3590912728005;8158.632861521127;8187.345012399113;8235.13531079228;7424.665890035069;7474.738384156529;7484.775456736306;7668.6165691716305;7689.50018248812;7422.777316680508;7451.664675089525;7461.701531938878;7590.582517961344;7662.578558179353;7439.293267139613;7495.662695178621;7496.62516874165;7502.324790768857;7506.1743208248145;6884.724611015503;6958;6997.1253593300835;6997.510174287751;7068.11648543932;7112.359887609933;7143.035690181759;7193.856122877618;7194.748183813542;7219.711211551479 13:03:01 INFO - PROCESS | 1671 | |4;prototype.html;319.5270998921596;322.2829205018833;325.42818188151233;329.2969510095945;330.1498640999427;6529.824631566316;6531.510136739746;6539.953607422814;6570.770023049195;6619.30497297784;6449.161608990837;6517.413432791048;6528.37980391862;6530.738770449188;6560.573562718432;4608.493065762764;4665.4168228971375;4714.080754252922;4758.928616070762;4842.273658951159;4765.713257420494;4771.236602143657;4788.209945359029;4793.544613261752;4797.7121372717575;3837.328467518187;3843.3082045231845;4722.055588882237;4729.006908549209;4768.380110585636;4540.432445944257;4625.074985002979;4756.571908528214;4757.238841785298;4760.785764640599;4070.61329173728;4083.203775263825;4085.3259212229946;4095.385692146172;4100.220958017997;6227.844303892393;6265.937340626581;6274.466670332981;6276.937230627681;6281.811545653638;5640.689762063085;5646.887062258732;5664.40523745005;5671.262735844355;5685.573581981368;6653.835578773744;6905.930940690579;6907.240203577602;6919.204291506491;6920.30796920309;3780.508533890604;4532.138893610237;4617.353570500132;4621.4685311189305;4634.748617873155;7245.963770181168;7328.7174744420045;7333.083364579427;7336.156342020682;7336.9266307336775;4711.623070154379;4718.197906355927;4726.598239149711;4727.763611819395;4735.12400205963;4775.904481910342;4781.976090119527;4782.426108866958;4807.399075115611;4810.374651295379;5610.831675049755;5611.831645050655;5617.21359009739;5630.465105814941;5648.830535083954;6623.403893649498;6945.826354341081;6962.930370696329;6978.232394436608;6990.091288132612;1455.6651970046737;1511.4029958166464;1591.2600640701899;1603.0622086079775;1622.6592415592859;973.1728031173446;1003.6487229469773;1024.2420608749471;1030.2891005206534;1050.1965996013057;5178.145605975047;6539.182602174728;6547.8363040923405;6562.967185164043;6565.21217453899;7251.1661158966335;7262.927370726331;7273.0908636420445;7275.381592564586;7279;6540.836479087966;6542.247641521286;6544.181977252843;6549.083128362033;6571.211454625475;3803.752756070902;3836.731428799957;3849.01850028241;3855.614438556122;3855.9228815424094;7391.408687305003;7711.768646940601;7744.728934487266;7747.186545412763;7747.690092396354;7481.476296659291;7547;7567.940488331638;7570.886436703454;7570.9242907570215;7694.4229182810395;7703.422243331885;7705.691772329156;7732.381409487228;7732.922670773332;6628.469722422291;6990.825229369307;7147.463940204401;7292.234315397019;7300.744473943387;7133.179684336368;7165.3551180394015;7185.928140718526;7202.351788338865;7232.710691572278;6783.966080169567;7211.963940180265;7478.962605187157;7686.654100565376;7691;3917.9020524487114;4622.422197225347;4641.512641172763;4645.837395691135;4646.65150113736;6546.901796473152;6754.223264324665;7003.894941575983;7280.453965952469;7310.926890731024;6999.755008574675;7005.159380874327;7034.859302814018;7043.823904402431;7055.082839230867;6966.12923384577;6997.790066298019;7019.613921234381;7030.964845175741;7048.154221493453;6882.659895635307;6887.793366199022;6893;6893.345132212432;6902.723891044302;6720.260771315054;7061.082059332254;7068.823279418056;7075.575465472089;7078.929210708033;6649.933500664932;6720.462363011045;6830.316968303328;6902.309769023058;6909.792706218822 13:03:01 INFO - PROCESS | 1671 | |5;yui.html;581.909803980383;705.7741522712732;713.671711012934;722.7398136670797;769.2576663519699;15046.172460514666;15223.695526089472;15235.542933711979;15247.771283430757;15272.541823745292;13766.518171863987;13822.308884555783;13833.723325533483;13852.584422467316;13855.307234638252;689.4932224814758;692.4183685704007;848.0078308379211;848.3213429256585;854.3805740837873;859.0121360435487;866.7443104284251;873.3231745397304;874.0865795243985;875.5184648443362;910.81328327693;912.0469109780263;912.7307444303913;915.4781774388601;916.1113719691888;725.8693435181665;887.0109827542309;902.499112992289;903.1916434790891;907.1382186922417;675.8749631318173;676.1784431915247;678.067656971664;678.2877978122951;680.45223595006;14687.926560367237;14697.485588004369;14726.779098313535;14740.041897276642;14857.508485505898;9900.455474948874;11246.700204213794;12381.133320667557;12639.747205055939;12874.16317939331;9980.451075190862;10055.748606284902;10058.295919285652;10092.798144037151;10327.380357178594;3456.4642480415578;3494.213801894579;3520.1903562180587;3541.769784963969;3604.098975256186;77539;77550;77699.66900992923;77829.22170778277;77927.61036194782;9192.95403522978;9328.626854925862;9492.430454172772;9622.711318660451;9727.756806079764;21530.56938861214;21616.35150945474;21633.35099947004;21657;21658;7171.533850299714;7177.6770045348085;7211;7368.263173682696;7387.7783666490095;3416.24842534642;4059.4316795648633;4094.3039683253323;4130.772807495617;4142.79286035697;3504.789712617251;3539.911502212414;3545.7163426925786;3552.467129930531;3552.804595747207;622.2999125983268;638.1990601794811;645.5287640022809;648.9972991727792;659.0378048049901;514.2697369734985;573.5096492498936;588.9499392551681;601.6149664214906;610.9480694140959;8094.635741391534;8120.269175774209;8176.427650064438;8250.587470626444;8421.789455263668;539.2531344088466;541.6641682157087;543.6058857328484;561.7752898840497;612.0849330251302;3628.3468975584647;3818.4272359145793;3863.7681739095183;3874.2832575973534;3915.9608403915595;93060.06939930649;94754;96290;96449;97888;75219.62390188014;77301;78392;79893;80318;68729;71206;71436.64281678558;71596.28403715896;72127.55744885073;8278.83442331162;8365.539895305574;8509.872351914602;8600.483970961763;8775.648974040967;42527.724168275;45461;46305.768471157426;46499.76750116228;50544;58552.12171817341;59312.70343648427;60385;60800;62358.37641623707;10599;10662.786744264917;10672.413017284123;10712.946435267773;11054.281471704313;11895.702607434883;11903.702407439883;12235.204711693712;12433.875661243634;12736.872631273569;10433.269671123253;10858.13134949218;10904.61833835812;11948.34284114382;12314.261144331369;10090.8486372703;10473.790524189626;10476.738081548023;10598.523066462181;11432.028277596164;10921.235513513977;10945.01494865466;11183.552657893593;11210.831837522606;11315.377654229096;9267.579926892551;9304.395214311047;9366.531673416166;9685.6610018649;9697.542533081229;8979.506127162807;9093.54532273397;9399.718008459757;9631.855522167314;9633 13:03:01 INFO - PROCESS | 1671 | __end_tp_report 13:03:01 INFO - PROCESS | 1671 | __start_cc_report 13:03:01 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1151 13:03:01 INFO - PROCESS | 1671 | __end_cc_report 13:03:01 INFO - PROCESS | 1671 | __startTimestamp1457038981746__endTimestamp 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | ------- Summary: start ------- 13:03:01 INFO - PROCESS | 1671 | Number of tests: 6 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5642.06 Median:5805.19 stddev:633.38 (10.9%) stddev-sans-first:609.49 13:03:01 INFO - PROCESS | 1671 | Values: 3359.6 3456.3 3483.9 3494.4 3519.6 5536.4 5566.2 5615.5 5625.4 5640.3 5598.1 5606.5 5616.6 5749.3 5757.2 5000.8 5003.5 5024.2 5068.7 5127.0 5124.5 5130.1 5171.9 5180.9 5222.8 5028.6 5128.7 5139.9 5141.7 5151.8 5049.2 5104.8 5120.8 5123.3 5126.9 5084.0 5084.0 5095.1 5098.9 5132.4 5535.2 5556.4 5561.6 5568.7 5592.4 5952.4 6094.6 6142.8 6166.7 6202.8 5082.4 6128.9 6156.9 6189.4 6192.6 5648.6 5652.3 5668.8 5674.8 5824.3 5018.3 6171.3 6233.0 6293.8 6312.1 6030.8 6040.6 6072.2 6081.6 6087.4 6212.1 6230.5 6240.2 6241.4 6247.7 6023.7 6089.8 6109.6 6141.1 6159.4 6121.5 6143.3 6145.1 6167.3 6191.4 4805.6 4823.0 4825.4 4829.3 4869.2 4313.6 4342.6 4344.7 4361.8 4420.9 5344.0 5445.9 5570.9 5642.9 5754.7 6232.8 6251.3 6265.6 6278.0 6284.3 5669.4 5672.0 5675.8 5687.5 5734.5 5229.6 5261.2 5306.0 5311.8 5312.9 6210.8 6234.1 6288.7 6296.5 6299.5 6243.8 6266.6 6281.6 6282.4 6288.0 6193.1 6264.4 6264.7 6282.1 6283.3 6016.9 6055.4 6069.7 6095.8 6120.8 5968.6 6009.0 6028.9 6046.1 6072.9 4654.5 5772.9 5793.6 5798.7 5805.2 5049.5 5855.5 5958.7 6020.8 6120.9 5866.5 5869.9 5874.1 5877.2 5879.3 6015.0 6035.6 6044.1 6062.0 6084.2 5760.5 5879.8 5887.5 5974.4 5982.3 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:64577.02 Median:365036.00 stddev:139377.04 (38.2%) stddev-sans-first:139684.89 13:03:01 INFO - PROCESS | 1671 | Values: 458.4 533.2 565.1 632.2 633.9 29733.3 30212.6 30316.5 38008.2 38485.2 41292.8 41675.6 41710.6 41936.4 42007.9 9540.2 9770.1 9774.4 9785.2 9831.2 9572.8 9705.4 9711.8 9730.0 9749.8 9648.4 9721.0 9751.9 9862.4 9863.3 9788.4 9850.7 9851.0 9870.2 9874.4 9654.0 9807.2 9818.5 9819.2 9869.4 40190.0 40593.8 40669.4 40683.8 40776.4 3039.5 3235.3 3385.4 3461.4 3763.4 27211.6 27372.0 28191.6 28195.9 28246.3 2716.6 2780.0 2783.9 2797.9 2836.1 491536.5 492484.0 493645.0 493754.0 495540.0 65310.3 66230.0 66241.7 66464.0 66508.0 68697.3 69690.6 69723.0 69783.0 69908.0 16288.8 16483.1 16502.3 16533.3 16548.1 12652.9 12677.0 12708.1 12714.2 12747.3 20221.4 20618.9 20807.9 20815.4 20907.9 7892.8 8841.7 8890.6 8948.0 8974.6 804.0 932.5 953.2 978.6 1089.3 27131.7 27399.7 27837.1 27998.0 28254.9 931.9 1073.7 1104.6 1113.9 1114.7 14175.9 14228.3 14357.6 14373.7 14682.8 652741.0 660599.0 664854.0 665314.0 665506.0 59431.7 59862.7 59928.7 59946.4 60183.0 1293.2 1402.2 1402.3 1416.4 1436.1 28417.0 28905.2 28969.4 29021.6 29759.4 47317.0 47428.8 47922.8 47972.0 48103.0 363381.0 364040.0 364756.0 364854.0 365218.0 28286.6 28648.9 31776.0 32384.7 33277.7 39523.0 40256.4 40338.0 40360.4 40364.0 33179.7 33743.5 33911.5 34623.5 34638.3 33909.5 34307.7 34478.0 34602.8 34815.5 33369.2 34477.7 34723.8 35207.5 35476.5 31232.6 31306.2 31355.9 31476.7 31598.8 23847.2 23950.2 24161.5 24300.0 24395.1 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:34062.17 Median:358.54 stddev:103929.93 (28986.7%) stddev-sans-first:104190.66 13:03:01 INFO - PROCESS | 1671 | Values: 353.2 354.6 356.3 360.7 365.6 19035.0 19295.5 19715.6 19730.5 19735.7 19156.1 19873.2 20008.2 20027.3 20036.4 5462.8 5674.6 5762.2 5770.6 5789.9 4123.5 4262.4 4310.9 5682.3 5991.6 6229.9 6232.3 6245.5 6245.6 6245.7 6042.9 6121.2 6209.1 6218.2 6225.4 3650.2 3829.5 3833.7 5368.2 5384.5 23006.0 23743.4 24014.8 24299.5 24310.8 2247.4 2491.3 2562.0 2636.8 2703.9 13793.9 13882.3 14490.9 14502.1 14742.7 1669.9 1700.9 1731.8 1753.2 1755.5 91429.8 92284.5 94552.5 94784.1 95141.5 10103.4 10543.6 10565.3 10659.4 10661.1 10788.7 12692.0 12792.5 12793.4 12796.1 6027.5 8361.7 8371.2 8447.1 8469.5 8577.8 8581.4 8593.5 8680.0 8714.5 6041.7 6129.2 6134.0 6135.1 6199.7 1447.9 1571.6 1644.2 1752.4 1792.7 903.9 912.0 985.4 992.2 1013.9 15127.2 18742.4 19039.8 19979.6 20907.4 929.4 933.1 968.9 978.8 1008.5 10828.0 11167.9 11188.7 11203.9 11250.4 621647.0 626287.0 626866.0 631531.0 649981.0 95222.0 95569.0 96585.0 97684.5 98666.0 1040.1 1052.0 1110.3 1126.2 1129.9 14949.5 17668.6 18371.9 18472.1 18776.8 49862.3 52723.7 52779.0 52964.7 53942.0 69522.0 69730.7 73512.0 74446.6 75236.5 7905.4 8070.1 8118.5 8156.6 8445.9 9484.6 12341.8 12852.9 13119.3 13127.9 11209.6 11601.6 11698.7 11781.2 11810.4 9039.1 11376.2 11471.8 11584.2 11763.7 11114.8 11121.6 11403.4 11916.0 11949.5 7948.2 7953.5 7998.6 8055.8 8164.3 6177.8 8457.1 11474.0 11574.5 11787.6 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5946.36 Median:5330.67 stddev:3150.71 (59.1%) stddev-sans-first:3140.63 13:03:01 INFO - PROCESS | 1671 | Values: 1352.3 1388.1 1512.7 1539.2 1895.4 7938.6 8521.8 8605.0 8608.2 8613.4 8380.5 8611.3 8619.6 8628.4 8644.0 2130.4 2365.9 2406.3 2421.6 2432.3 2102.4 2436.3 2441.2 2444.4 2445.0 2390.4 2403.5 2451.9 2453.9 2455.2 2394.0 2440.4 2440.9 2449.0 2449.1 2398.7 2410.2 2420.1 2421.4 2456.5 8668.1 8736.2 8737.3 8739.1 8752.5 5281.2 5471.3 5474.6 5477.8 5541.4 3516.6 3592.0 3661.8 3664.7 3677.2 1022.6 1034.4 1037.6 1057.4 1057.8 11668.9 11683.7 11687.9 11700.5 11721.9 4752.7 4812.0 4885.9 4896.8 4901.1 10018.2 10019.8 10030.7 10032.0 10041.0 5380.1 5393.8 5429.9 5430.8 5435.6 4417.2 4550.4 4775.2 4898.7 4922.5 3798.3 3880.6 3895.6 3914.1 3936.2 1289.3 1292.7 1300.8 1305.9 1317.2 1012.0 1039.6 1057.8 1060.1 1382.7 7294.2 7658.5 8104.1 8162.7 8193.5 512.3 518.6 521.8 524.3 525.3 6069.3 6088.0 6180.7 6231.7 6256.1 10085.0 10199.7 10353.6 10529.5 10566.0 10243.9 10361.6 10391.4 10393.0 10418.6 6243.8 7976.3 7980.6 8010.0 8077.5 7846.5 7854.7 7961.5 7996.4 8007.3 9038.9 9268.9 9363.5 9389.6 9471.3 8976.2 9656.3 9737.0 9812.0 9829.6 6737.3 6952.3 6959.7 7434.0 7582.2 7572.7 8011.4 8158.6 8187.3 8235.1 7424.7 7474.7 7484.8 7668.6 7689.5 7422.8 7451.7 7461.7 7590.6 7662.6 7439.3 7495.7 7496.6 7502.3 7506.2 6884.7 6958.0 6997.1 6997.5 7068.1 7112.4 7143.0 7193.9 7194.7 7219.7 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5719.84 Median:6545.54 stddev:1852.19 (28.3%) stddev-sans-first:1812.49 13:03:01 INFO - PROCESS | 1671 | Values: 319.5 322.3 325.4 329.3 330.1 6529.8 6531.5 6540.0 6570.8 6619.3 6449.2 6517.4 6528.4 6530.7 6560.6 4608.5 4665.4 4714.1 4758.9 4842.3 4765.7 4771.2 4788.2 4793.5 4797.7 3837.3 3843.3 4722.1 4729.0 4768.4 4540.4 4625.1 4756.6 4757.2 4760.8 4070.6 4083.2 4085.3 4095.4 4100.2 6227.8 6265.9 6274.5 6276.9 6281.8 5640.7 5646.9 5664.4 5671.3 5685.6 6653.8 6905.9 6907.2 6919.2 6920.3 3780.5 4532.1 4617.4 4621.5 4634.7 7246.0 7328.7 7333.1 7336.2 7336.9 4711.6 4718.2 4726.6 4727.8 4735.1 4775.9 4782.0 4782.4 4807.4 4810.4 5610.8 5611.8 5617.2 5630.5 5648.8 6623.4 6945.8 6962.9 6978.2 6990.1 1455.7 1511.4 1591.3 1603.1 1622.7 973.2 1003.6 1024.2 1030.3 1050.2 5178.1 6539.2 6547.8 6563.0 6565.2 7251.2 7262.9 7273.1 7275.4 7279.0 6540.8 6542.2 6544.2 6549.1 6571.2 3803.8 3836.7 3849.0 3855.6 3855.9 7391.4 7711.8 7744.7 7747.2 7747.7 7481.5 7547.0 7567.9 7570.9 7570.9 7694.4 7703.4 7705.7 7732.4 7732.9 6628.5 6990.8 7147.5 7292.2 7300.7 7133.2 7165.4 7185.9 7202.4 7232.7 6784.0 7212.0 7479.0 7686.7 7691.0 3917.9 4622.4 4641.5 4645.8 4646.7 6546.9 6754.2 7003.9 7280.5 7310.9 6999.8 7005.2 7034.9 7043.8 7055.1 6966.1 6997.8 7019.6 7031.0 7048.2 6882.7 6887.8 6893.0 6893.3 6902.7 6720.3 7061.1 7068.8 7075.6 7078.9 6649.9 6720.5 6830.3 6902.3 6909.8 13:03:01 INFO - PROCESS | 1671 | 13:03:01 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:17950.18 Median:30705.47 stddev:25373.22 (82.6%) stddev-sans-first:25410.89 13:03:01 INFO - PROCESS | 1671 | Values: 581.9 705.8 713.7 722.7 769.3 15046.2 15223.7 15235.5 15247.8 15272.5 13766.5 13822.3 13833.7 13852.6 13855.3 689.5 692.4 848.0 848.3 854.4 859.0 866.7 873.3 874.1 875.5 910.8 912.0 912.7 915.5 916.1 725.9 887.0 902.5 903.2 907.1 675.9 676.2 678.1 678.3 680.5 14687.9 14697.5 14726.8 14740.0 14857.5 9900.5 11246.7 12381.1 12639.7 12874.2 9980.5 10055.7 10058.3 10092.8 10327.4 3456.5 3494.2 3520.2 3541.8 3604.1 77539.0 77550.0 77699.7 77829.2 77927.6 9193.0 9328.6 9492.4 9622.7 9727.8 21530.6 21616.4 21633.4 21657.0 21658.0 7171.5 7177.7 7211.0 7368.3 7387.8 3416.2 4059.4 4094.3 4130.8 4142.8 3504.8 3539.9 3545.7 3552.5 3552.8 622.3 638.2 645.5 649.0 659.0 514.3 573.5 588.9 601.6 610.9 8094.6 8120.3 8176.4 8250.6 8421.8 539.3 541.7 543.6 561.8 612.1 3628.3 3818.4 3863.8 3874.3 3916.0 93060.1 94754.0 96290.0 96449.0 97888.0 75219.6 77301.0 78392.0 79893.0 80318.0 68729.0 71206.0 71436.6 71596.3 72127.6 8278.8 8365.5 8509.9 8600.5 8775.6 42527.7 45461.0 46305.8 46499.8 50544.0 58552.1 59312.7 60385.0 60800.0 62358.4 10599.0 10662.8 10672.4 10712.9 11054.3 11895.7 11903.7 12235.2 12433.9 12736.9 10433.3 10858.1 10904.6 11948.3 12314.3 10090.8 10473.8 10476.7 10598.5 11432.0 10921.2 10945.0 11183.6 11210.8 11315.4 9267.6 9304.4 9366.5 9685.7 9697.5 8979.5 9093.5 9399.7 9631.9 9633.0 13:03:01 INFO - PROCESS | 1671 | -------- Summary: end -------- 13:03:01 INFO - PROCESS | 1671 | 13:03:02 INFO - TEST-INFO | 1671: exit 0 13:03:02 INFO - TEST-OK | dromaeo_css | took 1112778ms 13:03:02 INFO - TEST-START | kraken 13:03:02 INFO - operating with platform_type : mac_ 13:03:02 INFO - Initialising browser for kraken test... 13:03:02 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpg2z2nb/profile http://localhost:49270/getInfo.html) 13:03:04 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 13:03:04 INFO - PROCESS | 1677 | colorDepth:24 13:03:04 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 13:03:04 INFO - PROCESS | 1677 | __metrics 13:03:04 INFO - PROCESS | 1677 | 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" 13:03:04 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:03:05 INFO - TEST-INFO | 1677: exit 0 13:03:05 INFO - Browser initialized. 13:03:05 INFO - Running cycle 1/1 for kraken test... 13:03:05 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpg2z2nb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:17 INFO - PROCESS | 1679 | RSS: Main: 243515392 13:03:17 INFO - PROCESS | 1679 | 13:03:19 INFO - PROCESS | 1679 | 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) 13:03:20 INFO - PROCESS | 1679 | RSS: Main: 289058816 13:03:20 INFO - PROCESS | 1679 | 13:03:23 INFO - PROCESS | 1679 | 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) 13:03:23 INFO - PROCESS | 1679 | RSS: Main: 298659840 13:03:23 INFO - PROCESS | 1679 | 13:03:26 INFO - PROCESS | 1679 | 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) 13:03:27 INFO - PROCESS | 1679 | RSS: Main: 283463680 13:03:27 INFO - PROCESS | 1679 | 13:03:29 INFO - PROCESS | 1679 | 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) 13:03:29 INFO - PROCESS | 1679 | RSS: Main: 286543872 13:03:29 INFO - PROCESS | 1679 | 13:03:32 INFO - PROCESS | 1679 | 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) 13:03:32 INFO - PROCESS | 1679 | RSS: Main: 286994432 13:03:32 INFO - PROCESS | 1679 | 13:03:35 INFO - PROCESS | 1679 | 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) 13:03:35 INFO - PROCESS | 1679 | RSS: Main: 288387072 13:03:35 INFO - PROCESS | 1679 | 13:03:38 INFO - PROCESS | 1679 | 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) 13:03:39 INFO - PROCESS | 1679 | RSS: Main: 288882688 13:03:39 INFO - PROCESS | 1679 | 13:03:42 INFO - PROCESS | 1679 | 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) 13:03:42 INFO - PROCESS | 1679 | RSS: Main: 287731712 13:03:42 INFO - PROCESS | 1679 | 13:03:44 INFO - PROCESS | 1679 | 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) 13:03:44 INFO - PROCESS | 1679 | RSS: Main: 323153920 13:03:44 INFO - PROCESS | 1679 | 13:03:46 INFO - PROCESS | 1679 | 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) 13:03:47 INFO - PROCESS | 1679 | RSS: Main: 321724416 13:03:47 INFO - PROCESS | 1679 | 13:03:49 INFO - PROCESS | 1679 | 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) 13:03:50 INFO - PROCESS | 1679 | RSS: Main: 331554816 13:03:50 INFO - PROCESS | 1679 | 13:03:52 INFO - PROCESS | 1679 | 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) 13:03:53 INFO - PROCESS | 1679 | RSS: Main: 333324288 13:03:53 INFO - PROCESS | 1679 | 13:03:55 INFO - PROCESS | 1679 | 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) 13:03:56 INFO - PROCESS | 1679 | RSS: Main: 332849152 13:03:56 INFO - PROCESS | 1679 | 13:03:57 INFO - PROCESS | 1679 | 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) 13:03:58 INFO - PROCESS | 1679 | RSS: Main: 393031680 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | __start_tp_report 13:03:58 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 13:03:58 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 13:03:58 INFO - PROCESS | 1679 | |i|pagename|runs| 13:03:58 INFO - PROCESS | 1679 | |0;ai-astar;110;107;110;111;110;111;116;110;111;110 13:03:58 INFO - PROCESS | 1679 | |1;audio-beat-detection;157;146;146;157;126;166;162;119;161;135 13:03:58 INFO - PROCESS | 1679 | |2;audio-dft;183;188;185;186;184;186;185;181;183;181 13:03:58 INFO - PROCESS | 1679 | |3;audio-fft;70;76;85;78;56;57;57;74;73;58 13:03:58 INFO - PROCESS | 1679 | |4;audio-oscillator;95;91;125;80;78;82;113;75;81;141 13:03:58 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;86;89;86;88;85;87;86;88;85 13:03:58 INFO - PROCESS | 1679 | |6;imaging-darkroom;92;94;93;94;92;92;114;148;93;93 13:03:58 INFO - PROCESS | 1679 | |7;imaging-desaturate;134;131;95;85;88;84;84;86;85;86 13:03:58 INFO - PROCESS | 1679 | |8;json-parse-financial;57;54;54;56;54;54;54;65;56;52 13:03:58 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;70;66;75;70;67;67;67;69;68 13:03:58 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;83;82;83;83;84;81;78;83;83;84 13:03:58 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;131;130;134;123;109;127;129;112;133;116 13:03:58 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;137;128;135;139;136;127;136;139;138;136 13:03:58 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;66;66;65;67;66;67;69;67;66;67 13:03:58 INFO - PROCESS | 1679 | __end_tp_report 13:03:58 INFO - PROCESS | 1679 | __start_cc_report 13:03:58 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1248 13:03:58 INFO - PROCESS | 1679 | __end_cc_report 13:03:58 INFO - PROCESS | 1679 | __startTimestamp1457039038184__endTimestamp 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | ------- Summary: start ------- 13:03:58 INFO - PROCESS | 1679 | Number of tests: 14 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:110.60 Median:110.50 stddev:2.22 (2.0%) stddev-sans-first:2.35 13:03:58 INFO - PROCESS | 1679 | Values: 110.0 107.0 110.0 111.0 110.0 111.0 116.0 110.0 111.0 110.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:157.00 stddev:16.16 (10.3%) stddev-sans-first:16.77 13:03:58 INFO - PROCESS | 1679 | Values: 157.0 146.0 146.0 157.0 126.0 166.0 162.0 119.0 161.0 135.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:2.25 (1.2%) stddev-sans-first:2.35 13:03:58 INFO - PROCESS | 1679 | Values: 183.0 188.0 185.0 186.0 184.0 186.0 185.0 181.0 183.0 181.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:68.40 Median:73.50 stddev:10.55 (14.4%) stddev-sans-first:11.18 13:03:58 INFO - PROCESS | 1679 | Values: 70.0 76.0 85.0 78.0 56.0 57.0 57.0 74.0 73.0 58.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:80.50 stddev:22.66 (28.2%) stddev-sans-first:24.04 13:03:58 INFO - PROCESS | 1679 | Values: 95.0 91.0 125.0 80.0 78.0 82.0 113.0 75.0 81.0 141.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.40 (1.6%) stddev-sans-first:1.41 13:03:58 INFO - PROCESS | 1679 | Values: 88.0 86.0 89.0 86.0 88.0 85.0 87.0 86.0 88.0 85.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:93.00 stddev:17.98 (19.3%) stddev-sans-first:18.80 13:03:58 INFO - PROCESS | 1679 | Values: 92.0 94.0 93.0 94.0 92.0 92.0 114.0 148.0 93.0 93.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:85.50 stddev:19.62 (22.9%) stddev-sans-first:15.17 13:03:58 INFO - PROCESS | 1679 | Values: 134.0 131.0 95.0 85.0 88.0 84.0 84.0 86.0 85.0 86.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.60 (6.5%) stddev-sans-first:3.78 13:03:58 INFO - PROCESS | 1679 | Values: 57.0 54.0 54.0 56.0 54.0 54.0 54.0 65.0 56.0 52.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:3.16 (4.6%) stddev-sans-first:2.73 13:03:58 INFO - PROCESS | 1679 | Values: 63.0 70.0 66.0 75.0 70.0 67.0 67.0 67.0 69.0 68.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.78 (2.1%) stddev-sans-first:1.87 13:03:58 INFO - PROCESS | 1679 | Values: 83.0 82.0 83.0 83.0 84.0 81.0 78.0 83.0 83.0 84.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:129.50 stddev:9.02 (7.0%) stddev-sans-first:9.25 13:03:58 INFO - PROCESS | 1679 | Values: 131.0 130.0 134.0 123.0 109.0 127.0 129.0 112.0 133.0 116.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.10 Median:136.50 stddev:4.23 (3.1%) stddev-sans-first:4.43 13:03:58 INFO - PROCESS | 1679 | Values: 137.0 128.0 135.0 139.0 136.0 127.0 136.0 139.0 138.0 136.0 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 13:03:58 INFO - PROCESS | 1679 | Values: 66.0 66.0 65.0 67.0 66.0 67.0 69.0 67.0 66.0 67.0 13:03:58 INFO - PROCESS | 1679 | -------- Summary: end -------- 13:03:58 INFO - PROCESS | 1679 | 13:03:58 INFO - TEST-INFO | 1679: exit 0 13:03:58 INFO - TEST-OK | kraken | took 56638ms 13:03:58 INFO - SUITE-END | took 1169s 13:03:59 INFO - Completed test suite (00:19:29) 13:03:59 INFO - Working with test: dromaeo_css 13:03:59 INFO - Generating results file: dromaeo_css 13:03:59 INFO - Working with test: kraken 13:03:59 INFO - Generating results file: kraken 13:03:59 INFO - javascript benchmark 13:03:59 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:03:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 13:03:59 INFO - process_Request line: dromaeo_css 7416.52 graph.html#tests=[[72,64,59]] 13:03:59 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:03:59 INFO - process_Request line: kraken 1422.20 graph.html#tests=[[232,64,59]] 13:03:59 INFO - RETURN: dromaeo_css: 7416.52 13:03:59 INFO - RETURN: kraken: 1422.20 13:03:59 INFO - javascript benchmark 13:03:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3359.596848378195, 3456.2914602506503, 3483.8954831355054, 3494.405950988332, 3519.595246546648, 5536.390996990338, 5566.165075238716, 5615.494605485505, 5625.381208067114, 5640.266765320503, 5598.104303311471, 5606.523445507127, 5616.5787565932615, 5749.281339832521, 5757.165211044396, 5000.824971126011, 5003.524665156804, 5024.196128619422, 5068.670536415121, 5127.000234954166, 5124.5131712487255, 5130.07658621448, 5171.87070323243, 5180.896382072357, 5222.7649755760895, 5028.5977121830165, 5128.666636668605, 5139.948600514003, 5141.691498510064, 5151.8196863109615, 5049.2173713074535, 5104.770285337168, 5120.769565369567, 5123.2827404163445, 5126.871828204287, 5083.974580127113, 5084.0, 5095.133827249377, 5098.923516147261, 5132.384113906318, 5535.225068490415, 5556.444355564452, 5561.638493497951, 5568.749406276727, 5592.4407559244155, 5952.375000624916, 6094.6038507497315, 6142.815715528542, 6166.691665416712, 6202.782902598433, 5082.440931497532, 6128.877422451526, 6156.907646385308, 6189.412005859436, 6192.566520343577, 5648.604597678123, 5652.265205523256, 5668.829935101953, 5674.773009079632, 5824.301083869963, 5018.272350509155, 6171.321154672983, 6233.0, 6293.811185664437, 6312.053192021233, 6030.819075427744, 6040.577159598786, 6072.240969878765, 6081.5742897996715, 6087.391260873877, 6212.1303017577575, 6230.501559875199, 6240.188775459252, 6241.375862413813, 6247.656378899204, 6023.698815059317, 6089.786857459968, 6109.586862300649, 6141.056449558148, 6159.384061593805, 6121.540884433596, 6143.296949342275, 6145.064304743992, 6167.290761562388, 6191.380861913773, 4805.567498925114, 4823.03539292143, 4825.396825396825, 4829.348038014893, 4869.245266983623, 4313.590208930146, 4342.6308763754805, 4344.674149438804, 4361.760103194355, 4420.9336859947125, 5343.973280133574, 5445.863853403696, 5570.944290557123, 5642.887142257214, 5754.74103665336, 6232.781852635136, 6251.3123556408755, 6265.561410701207, 6277.96861015692, 6284.340144284784, 5669.4047125051275, 5671.950689122526, 5675.801346952837, 5687.459691329317, 5734.483896449339, 5229.6339256251695, 5261.210818377198, 5306.044911915892, 5311.814086506954, 5312.867178320573, 6210.8136755898295, 6234.064890266496, 6288.717007734572, 6296.496280297565, 6299.464545513682, 6243.750249990131, 6266.561340706289, 6281.623102613858, 6282.403171698681, 6287.96856015717, 6193.1329613855, 6264.404881536247, 6264.68676566179, 6282.089097080806, 6283.2774230962195, 6016.939830601638, 6055.364186760326, 6069.726862291296, 6095.7708482108, 6120.812855101138, 5968.612040217372, 6008.969955150196, 6028.8794224116145, 6046.12331211963, 6072.939270607414, 4654.48800631937, 5772.884542309214, 5793.623414478046, 5798.652080875161, 5805.187273781589, 5049.469805670498, 5855.473007429352, 5958.672273025025, 6020.789272375446, 6120.908186377297, 5866.50134738535, 5869.853253668693, 5874.060150375919, 5877.177195192591, 5879.323877754113, 6014.977453832947, 6035.6076855004285, 6044.0933859919605, 6062.030075187949, 6084.239470066242, 5760.510356619734, 5879.794642098274, 5887.470127688357, 5974.40255974399, 5982.312034116132], "unit": "score", "name": "dojo.html", "value": 5603.7774447828315}, {"lowerIsBetter": false, "replicates": [458.3628756029118, 533.1709192206118, 565.0986676251378, 632.1655414852394, 633.9049142628605, 29733.256668583297, 30212.619170220332, 30316.54525182124, 38008.239835203276, 38485.230295394074, 41292.79353603228, 41675.58324416755, 41710.58289417105, 41936.37095443563, 42007.94980125498, 9540.236781057516, 9770.120689137977, 9774.364666296668, 9785.168260697848, 9831.164351030171, 9572.760680982961, 9705.369151005198, 9711.805763884719, 9730.0, 9749.805003899917, 9648.372855764388, 9720.951395243013, 9751.853722194173, 9862.358946668444, 9863.30956833022, 9788.36375635585, 9850.704478865646, 9850.999999999964, 9870.161036311922, 9874.40753554789, 9653.986331435168, 9807.215422766161, 9818.509074546315, 9819.165370943478, 9869.407835529819, 40190.0, 40593.75249980024, 40669.389959150634, 40683.796581016904, 40776.38835417471, 3039.5440683897373, 3235.272063785653, 3385.4244778387488, 3461.359648465042, 3763.397856342999, 27211.591826122625, 27372.0, 28191.57712634312, 28195.85902070497, 28246.293842653893, 2716.606092116652, 2779.986100069507, 2783.9025634102914, 2797.9020734274404, 2836.1349788314556, 491536.54231728613, 492484.0, 493645.0, 493753.9999999964, 495540.0, 65310.34689653137, 66230.0, 66241.66879165573, 66464.0, 66508.0, 68697.31302687009, 69690.60618787596, 69723.0, 69783.0, 69908.0, 16288.755668664979, 16483.093429861474, 16502.33990640385, 16533.256003479873, 16548.089855057846, 12652.936735316265, 12677.0, 12708.110432269652, 12714.173578717353, 12747.298898560482, 20221.39335819928, 20618.865962372212, 20807.895960520404, 20815.438842086904, 20907.8954605226, 7892.802679933047, 8841.69054083104, 8890.555472226362, 8948.0, 8974.641014359484, 803.9799005024921, 932.4871320773548, 953.1802649721234, 978.6085565773748, 1089.2593036735095, 27131.72868271292, 27399.726002740117, 27837.102805607232, 27998.0, 28254.85872570624, 931.8788557487484, 1073.672529878379, 1104.5968221599057, 1113.8551988241638, 1114.6934592986831, 14175.929120354333, 14228.28858557068, 14357.56927292183, 14373.712525749426, 14682.779758303634, 652741.0, 660599.0, 664854.0, 665314.0, 665506.0, 59431.702841485516, 59862.70068649629, 59928.70035649881, 59946.40053599408, 60183.0, 1293.2369901758009, 1402.2357814990855, 1402.3408997771032, 1416.3640994651194, 1436.0522055443357, 28417.005404810734, 28905.176362803682, 28969.420611588073, 29021.564676529448, 29759.404811904074, 47317.0, 47428.7628561855, 47922.76038619784, 47972.0, 48103.0, 363381.0, 364040.0, 364756.0, 364854.0, 365218.0, 28286.575701364083, 28648.85675571609, 31776.0, 32384.676153238164, 33277.66722332746, 39523.011924700964, 40256.3961540583, 40338.0, 40360.3945940817, 40364.0, 33179.668203317655, 33743.4938475928, 33911.491327629614, 34623.4806477898, 34638.30723385468, 33909.49135763015, 34307.65692343045, 34478.0, 34602.788902388296, 34815.477767833, 33369.16577085592, 34477.655223447444, 34723.82638086793, 35207.47188792119, 35476.46785298171, 31232.632988824487, 31306.21734456657, 31355.856080643294, 31476.685233147375, 31598.842005789826, 23847.165349212693, 23950.161744338864, 24161.51676966486, 24300.027998879847, 24395.14616988397], "unit": "score", "name": "ext.html", "value": 19494.58840076321}, {"lowerIsBetter": false, "replicates": [353.2246718452995, 354.638268965655, 356.34254799894194, 360.74567429961877, 365.581409286367, 19035.048247587616, 19295.517612059688, 19715.605687886233, 19730.506737331572, 19735.703964440545, 19156.137973791178, 19873.20507179711, 20008.19967201314, 20027.299044533444, 20036.39890803278, 5462.836114916549, 5674.574406919477, 5762.222100016486, 5770.596058275923, 5789.913151302712, 4123.484564429446, 4262.424572682679, 4310.892227694317, 5682.346530149044, 5991.610545314563, 6229.875402491947, 6232.252129744415, 6245.531585131111, 6245.594036387621, 6245.718942647592, 6042.912275790356, 6121.234845644294, 6209.130721698965, 6218.191635087455, 6225.408586184328, 3650.1787097903025, 3829.5021647185686, 3833.693304535658, 5368.194770784375, 5384.461553844623, 23006.0, 23743.406414839596, 24014.759852401603, 24299.514009719707, 24310.756892431204, 2247.3932038349717, 2491.314888405685, 2561.987190064038, 2636.7890568754456, 2703.91888243353, 13793.931030344884, 13882.305884705724, 14490.855091449055, 14502.1298722077, 14742.70514589713, 1669.8998060116432, 1700.880938334317, 1731.7835270591177, 1753.2373417563274, 1755.4733579926099, 91429.76817939327, 92284.53857730668, 94552.52723736406, 94784.05215947822, 95141.52429237879, 10103.444310562989, 10543.630972916064, 10565.313254638424, 10659.4137322448, 10661.147108231324, 10788.676339709822, 12692.048096392808, 12792.488300468063, 12793.424295906707, 12796.10427270082, 6027.487663548647, 8361.707340243183, 8371.246587807005, 8447.113053129457, 8469.491830490191, 8577.828443431097, 8581.399302048796, 8593.484390936565, 8679.956600217085, 8714.477131372138, 6041.667708275999, 6129.2032035835055, 6134.04922237054, 6135.0797380392405, 6199.721012554356, 1447.862453066957, 1571.6228105254886, 1644.2025617575466, 1752.3779058434327, 1792.6773180827577, 903.9231665308391, 911.9708648257706, 985.4235272365746, 992.245893121233, 1013.8732658417698, 15127.243637818065, 18742.437726868215, 19039.809601904082, 19979.60040799176, 20907.37277881666, 929.363386080537, 933.0995589256264, 968.9273304502191, 978.7602037500858, 1008.495752123938, 10828.0, 11167.888321116847, 11188.720281993015, 11203.887961120285, 11250.437478126061, 621647.0, 626287.0, 626866.0, 631531.0, 649981.0, 95222.0, 95568.9999999986, 96585.0, 97684.51157744166, 98666.0, 1040.095117247984, 1051.9684409467882, 1110.3171549497163, 1126.189143816451, 1129.9209055366046, 14949.476768313058, 17668.64662706713, 18371.90814045921, 18472.076396180408, 18776.812231877506, 49862.25206621831, 52723.736381317845, 52779.0, 52964.73517632541, 53942.0, 69522.0, 69730.65134674295, 73512.0, 74446.62776686082, 75236.49527009539, 7905.407094467823, 8070.071941726542, 8118.472299300763, 8156.632951517315, 8445.873311900203, 9484.57319420614, 12341.753164936472, 12852.861851962765, 13119.344032798132, 13127.868721312665, 11209.607663732057, 11601.593944211912, 11698.70753231176, 11781.234219775688, 11810.350430726392, 9039.096090390909, 11376.20366574365, 11471.770564588829, 11584.189106762446, 11763.705907352385, 11114.777044590952, 11121.555137794398, 11403.372814495282, 11916.0, 11949.522019119138, 7948.244916732901, 7953.5227886327, 7998.648507644508, 8055.83888322242, 8164.346852251924, 6177.81466556004, 8457.149708735944, 11474.024707899922, 11574.479148438171, 11787.646370608896], "unit": "score", "name": "jquery.html", "value": 9329.338656954134}, {"lowerIsBetter": false, "replicates": [1352.3238380809596, 1388.0630574362303, 1512.7050225206085, 1539.1996161995762, 1895.365052707343, 7938.563379014152, 8521.829563408728, 8605.0, 8608.182222688834, 8613.440126391795, 8380.45527040742, 8611.31109511239, 8619.612117454713, 8628.396012279143, 8644.049154593005, 2130.446084018151, 2365.8698771567556, 2406.3382569793357, 2421.5883299838983, 2432.282476669378, 2102.412678427785, 2436.2691192642224, 2441.170002199252, 2444.3766839455916, 2444.9511009779794, 2390.4262976885598, 2403.531311394279, 2451.852888826676, 2453.877306134695, 2455.1529722245796, 2393.964090538643, 2440.3533063738123, 2440.9145679901208, 2448.987755061231, 2449.142800019979, 2398.7481314461907, 2410.2287268074224, 2420.100221326268, 2421.418859473731, 2456.5086982603552, 8668.133186681282, 8736.213740763362, 8737.344699147588, 8739.082396348418, 8752.474851508867, 5281.234221037928, 5471.316085489314, 5474.616776825624, 5477.780888764445, 5541.362743284493, 3516.6483351664883, 3592.0481072515804, 3661.761985470936, 3664.6518580734787, 3677.2461645362637, 1022.601185537641, 1034.4414016431117, 1037.5901518899993, 1057.3550134417999, 1057.772578895541, 11668.941655291754, 11683.7079073023, 11687.883121168765, 11700.531978720926, 11721.882781172164, 4752.714837109785, 4811.958194121445, 4885.926711099336, 4896.755162241873, 4901.142300097468, 10018.198544116452, 10019.849702254473, 10030.699079027641, 10032.0, 10041.0, 5380.112281473513, 5393.757280922289, 5429.918551221735, 5430.755615997289, 5435.646682965595, 4417.182821178092, 4550.408446901948, 4775.2359622460235, 4898.657094003385, 4922.483139270396, 3798.3163030654196, 3880.6119388061534, 3895.558643301996, 3914.080191155076, 3936.2127574484643, 1289.3166621690518, 1292.6509842342514, 1300.7918733002675, 1305.8563558008611, 1317.1833463252844, 1011.9797604047877, 1039.6465201831413, 1057.799018186542, 1060.0830281806182, 1382.702718915438, 7294.234105418961, 7658.540487570764, 8104.149064348158, 8162.6734930602115, 8193.50838949653, 512.3134999101222, 518.5592246590368, 521.8486638874684, 524.2660275614171, 525.254139122447, 6069.332373438918, 6088.0, 6180.721867515973, 6231.688415579203, 6256.124142620037, 10085.041921017491, 10199.694009179737, 10353.585856565804, 10529.473526323807, 10566.0, 10243.94878025605, 10361.585536578452, 10391.428471434143, 10393.012663796928, 10418.583256669648, 6243.75024999004, 7976.282134607914, 7980.640871160812, 8009.999999999884, 8077.474964127313, 7846.489978151631, 7854.72508462201, 7961.482503637245, 7996.440249182734, 8007.319377852948, 9038.909610903807, 9268.860967085364, 9363.531823408939, 9389.577469014048, 9471.289653275893, 8976.192142707188, 9656.275779316438, 9736.95131524338, 9812.01879812013, 9829.557669905014, 6737.258901520927, 6952.304769523007, 6959.652017399008, 7434.0, 7582.203868593719, 7572.697092116474, 8011.3590912728005, 8158.632861521127, 8187.345012399113, 8235.13531079228, 7424.665890035069, 7474.738384156529, 7484.775456736306, 7668.6165691716305, 7689.50018248812, 7422.777316680508, 7451.664675089525, 7461.701531938878, 7590.582517961344, 7662.578558179353, 7439.293267139613, 7495.662695178621, 7496.62516874165, 7502.324790768857, 7506.1743208248145, 6884.724611015503, 6958.0, 6997.1253593300835, 6997.510174287751, 7068.11648543932, 7112.359887609933, 7143.035690181759, 7193.856122877618, 7194.748183813542, 7219.711211551479], "unit": "score", "name": "mootools.html", "value": 4753.003688641063}, {"lowerIsBetter": false, "replicates": [319.5270998921596, 322.2829205018833, 325.42818188151233, 329.2969510095945, 330.1498640999427, 6529.824631566316, 6531.510136739746, 6539.953607422814, 6570.770023049195, 6619.30497297784, 6449.161608990837, 6517.413432791048, 6528.37980391862, 6530.738770449188, 6560.573562718432, 4608.493065762764, 4665.4168228971375, 4714.080754252922, 4758.928616070762, 4842.273658951159, 4765.713257420494, 4771.236602143657, 4788.209945359029, 4793.544613261752, 4797.7121372717575, 3837.328467518187, 3843.3082045231845, 4722.055588882237, 4729.006908549209, 4768.380110585636, 4540.432445944257, 4625.074985002979, 4756.571908528214, 4757.238841785298, 4760.785764640599, 4070.61329173728, 4083.203775263825, 4085.3259212229946, 4095.385692146172, 4100.220958017997, 6227.844303892393, 6265.937340626581, 6274.466670332981, 6276.937230627681, 6281.811545653638, 5640.689762063085, 5646.887062258732, 5664.40523745005, 5671.262735844355, 5685.573581981368, 6653.835578773744, 6905.930940690579, 6907.240203577602, 6919.204291506491, 6920.30796920309, 3780.508533890604, 4532.138893610237, 4617.353570500132, 4621.4685311189305, 4634.748617873155, 7245.963770181168, 7328.7174744420045, 7333.083364579427, 7336.156342020682, 7336.9266307336775, 4711.623070154379, 4718.197906355927, 4726.598239149711, 4727.763611819395, 4735.12400205963, 4775.904481910342, 4781.976090119527, 4782.426108866958, 4807.399075115611, 4810.374651295379, 5610.831675049755, 5611.831645050655, 5617.21359009739, 5630.465105814941, 5648.830535083954, 6623.403893649498, 6945.826354341081, 6962.930370696329, 6978.232394436608, 6990.091288132612, 1455.6651970046737, 1511.4029958166464, 1591.2600640701899, 1603.0622086079775, 1622.6592415592859, 973.1728031173446, 1003.6487229469773, 1024.2420608749471, 1030.2891005206534, 1050.1965996013057, 5178.145605975047, 6539.182602174728, 6547.8363040923405, 6562.967185164043, 6565.21217453899, 7251.1661158966335, 7262.927370726331, 7273.0908636420445, 7275.381592564586, 7279.0, 6540.836479087966, 6542.247641521286, 6544.181977252843, 6549.083128362033, 6571.211454625475, 3803.752756070902, 3836.731428799957, 3849.01850028241, 3855.614438556122, 3855.9228815424094, 7391.408687305003, 7711.768646940601, 7744.728934487266, 7747.186545412763, 7747.690092396354, 7481.476296659291, 7547.0, 7567.940488331638, 7570.886436703454, 7570.9242907570215, 7694.4229182810395, 7703.422243331885, 7705.691772329156, 7732.381409487228, 7732.922670773332, 6628.469722422291, 6990.825229369307, 7147.463940204401, 7292.234315397019, 7300.744473943387, 7133.179684336368, 7165.3551180394015, 7185.928140718526, 7202.351788338865, 7232.710691572278, 6783.966080169567, 7211.963940180265, 7478.962605187157, 7686.654100565376, 7691.0, 3917.9020524487114, 4622.422197225347, 4641.512641172763, 4645.837395691135, 4646.65150113736, 6546.901796473152, 6754.223264324665, 7003.894941575983, 7280.453965952469, 7310.926890731024, 6999.755008574675, 7005.159380874327, 7034.859302814018, 7043.823904402431, 7055.082839230867, 6966.12923384577, 6997.790066298019, 7019.613921234381, 7030.964845175741, 7048.154221493453, 6882.659895635307, 6887.793366199022, 6893.0, 6893.345132212432, 6902.723891044302, 6720.260771315054, 7061.082059332254, 7068.823279418056, 7075.575465472089, 7078.929210708033, 6649.933500664932, 6720.462363011045, 6830.316968303328, 6902.309769023058, 6909.792706218822], "unit": "score", "name": "prototype.html", "value": 5092.981745132038}, {"lowerIsBetter": false, "replicates": [581.909803980383, 705.7741522712732, 713.671711012934, 722.7398136670797, 769.2576663519699, 15046.172460514666, 15223.695526089472, 15235.542933711979, 15247.771283430757, 15272.541823745292, 13766.518171863987, 13822.308884555783, 13833.723325533483, 13852.584422467316, 13855.307234638252, 689.4932224814758, 692.4183685704007, 848.0078308379211, 848.3213429256585, 854.3805740837873, 859.0121360435487, 866.7443104284251, 873.3231745397304, 874.0865795243985, 875.5184648443362, 910.81328327693, 912.0469109780263, 912.7307444303913, 915.4781774388601, 916.1113719691888, 725.8693435181665, 887.0109827542309, 902.499112992289, 903.1916434790891, 907.1382186922417, 675.8749631318173, 676.1784431915247, 678.067656971664, 678.2877978122951, 680.45223595006, 14687.926560367237, 14697.485588004369, 14726.779098313535, 14740.041897276642, 14857.508485505898, 9900.455474948874, 11246.700204213794, 12381.133320667557, 12639.747205055939, 12874.16317939331, 9980.451075190862, 10055.748606284902, 10058.295919285652, 10092.798144037151, 10327.380357178594, 3456.4642480415578, 3494.213801894579, 3520.1903562180587, 3541.769784963969, 3604.098975256186, 77539.0, 77550.0, 77699.66900992923, 77829.22170778277, 77927.61036194782, 9192.95403522978, 9328.626854925862, 9492.430454172772, 9622.711318660451, 9727.756806079764, 21530.56938861214, 21616.35150945474, 21633.35099947004, 21657.0, 21658.0, 7171.533850299714, 7177.6770045348085, 7211.0, 7368.263173682696, 7387.7783666490095, 3416.24842534642, 4059.4316795648633, 4094.3039683253323, 4130.772807495617, 4142.79286035697, 3504.789712617251, 3539.911502212414, 3545.7163426925786, 3552.467129930531, 3552.804595747207, 622.2999125983268, 638.1990601794811, 645.5287640022809, 648.9972991727792, 659.0378048049901, 514.2697369734985, 573.5096492498936, 588.9499392551681, 601.6149664214906, 610.9480694140959, 8094.635741391534, 8120.269175774209, 8176.427650064438, 8250.587470626444, 8421.789455263668, 539.2531344088466, 541.6641682157087, 543.6058857328484, 561.7752898840497, 612.0849330251302, 3628.3468975584647, 3818.4272359145793, 3863.7681739095183, 3874.2832575973534, 3915.9608403915595, 93060.06939930649, 94754.0, 96290.0, 96449.0, 97888.0, 75219.62390188014, 77301.0, 78392.0, 79893.0, 80318.0, 68729.0, 71206.0, 71436.64281678558, 71596.28403715896, 72127.55744885073, 8278.83442331162, 8365.539895305574, 8509.872351914602, 8600.483970961763, 8775.648974040967, 42527.724168275, 45461.0, 46305.768471157426, 46499.76750116228, 50544.0, 58552.12171817341, 59312.70343648427, 60385.0, 60800.0, 62358.37641623707, 10599.0, 10662.786744264917, 10672.413017284123, 10712.946435267773, 11054.281471704313, 11895.702607434883, 11903.702407439883, 12235.204711693712, 12433.875661243634, 12736.872631273569, 10433.269671123253, 10858.13134949218, 10904.61833835812, 11948.34284114382, 12314.261144331369, 10090.8486372703, 10473.790524189626, 10476.738081548023, 10598.523066462181, 11432.028277596164, 10921.235513513977, 10945.01494865466, 11183.552657893593, 11210.831837522606, 11315.377654229096, 9267.579926892551, 9304.395214311047, 9366.531673416166, 9685.6610018649, 9697.542533081229, 8979.506127162807, 9093.54532273397, 9399.718008459757, 9631.855522167314, 9633.0], "unit": "score", "name": "yui.html", "value": 6744.96693812242}], "name": "dromaeo_css", "value": 7416.5224991639125}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 110.0, 111.0, 110.0, 111.0, 116.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [157.0, 146.0, 146.0, 157.0, 126.0, 166.0, 162.0, 119.0, 161.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 147.5}, {"lowerIsBetter": true, "replicates": [183.0, 188.0, 185.0, 186.0, 184.0, 186.0, 185.0, 181.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.2}, {"lowerIsBetter": true, "replicates": [70.0, 76.0, 85.0, 78.0, 56.0, 57.0, 57.0, 74.0, 73.0, 58.0], "unit": "score", "name": "audio-fft", "value": 68.4}, {"lowerIsBetter": true, "replicates": [95.0, 91.0, 125.0, 80.0, 78.0, 82.0, 113.0, 75.0, 81.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 85.0, 87.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.8}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 93.0, 94.0, 92.0, 92.0, 114.0, 148.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 100.5}, {"lowerIsBetter": true, "replicates": [134.0, 131.0, 95.0, 85.0, 88.0, 84.0, 84.0, 86.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0, 65.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 66.0, 75.0, 70.0, 67.0, 67.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 83.0, 84.0, 81.0, 78.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [131.0, 130.0, 134.0, 123.0, 109.0, 127.0, 129.0, 112.0, 133.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [137.0, 128.0, 135.0, 139.0, 136.0, 127.0, 136.0, 139.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 67.0, 69.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1422.2}]} 13:03:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1422.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7416.52"}}} 13:03:59 INFO - Return code: 0 13:03:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:03:59 INFO - # TBPL SUCCESS # 13:03:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:03:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:03:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:03:59 INFO - 2016-03-03 13:03:59.937 screenresolution[1683:9692] starting screenresolution argv=screenresolution get 13:03:59 INFO - 2016-03-03 13:03:59.939 screenresolution[1683:9692] Display 0: 1600x1200x32@60 13:03:59 INFO - 2016-03-03 13:03:59.945 screenresolution[1684:9695] starting screenresolution argv=screenresolution list 13:03:59 INFO - Available Modes on Display 0 13:03:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:03:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:03:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:03:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:04:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:04:00 INFO - Intel Iris: 13:04:00 INFO - Chipset Model: Intel Iris 13:04:00 INFO - Type: GPU 13:04:00 INFO - Bus: Built-In 13:04:00 INFO - VRAM (Dynamic, Max): 1536 MB 13:04:00 INFO - Vendor: Intel (0x8086) 13:04:00 INFO - Device ID: 0x0a2e 13:04:00 INFO - Revision ID: 0x0009 13:04:00 INFO - Displays: 13:04:00 INFO - Display: 13:04:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:04:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:04:00 INFO - Display Serial Number: 1600x1200 60 13:04:00 INFO - Main Display: Yes 13:04:00 INFO - Mirror: Off 13:04:00 INFO - Online: Yes 13:04:00 INFO - Rotation: Supported 13:04:00 INFO - Return code: 0 13:04:00 INFO - Running post-action listener: _resource_record_post_action 13:04:00 INFO - Running post-run listener: _resource_record_post_run 13:04:01 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39347712; Write bytes: 705900032; Read time: 435; Write time: 1890 13:04:01 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395543040; Write bytes: 385488384; Read time: 29886; Write time: 702 13:04:01 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32308736; Write bytes: 298389504; Read time: 349; Write time: 1135 13:04:01 INFO - Running post-run listener: _upload_blobber_files 13:04:01 INFO - Blob upload gear active. 13:04:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:04:01 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 13:04:01 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'] 13:04:01 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 13:04:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:02 INFO - (blobuploader) - INFO - Done attempting. 13:04:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:04:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:04:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:04:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:04:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:04:04 INFO - (blobuploader) - INFO - Done attempting. 13:04:04 INFO - (blobuploader) - INFO - Iteration through files over. 13:04:04 INFO - Return code: 0 13:04:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:04:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:04:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/351f620922d523189312f6f4db3ab633e332275d7396b129f734454535832af4ed9a6a7c45f671b8a2937e4d4da426063baa40ba38b89d3e7735262f4531b8e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02f6286ede460fd77853ef02c377b8db97fd5193dc63f40145db1f80f0698a6aba7688ab11f3d5bf7794bdc8415fa3979d6a02f8edecf58c91967a56fecf71a3"} 13:04:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:04:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:04:04 INFO - Contents: 13:04:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/351f620922d523189312f6f4db3ab633e332275d7396b129f734454535832af4ed9a6a7c45f671b8a2937e4d4da426063baa40ba38b89d3e7735262f4531b8e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02f6286ede460fd77853ef02c377b8db97fd5193dc63f40145db1f80f0698a6aba7688ab11f3d5bf7794bdc8415fa3979d6a02f8edecf58c91967a56fecf71a3"} 13:04:04 INFO - Running post-run listener: copy_logs_to_upload_dir 13:04:04 INFO - Copying logs to upload dir... 13:04:04 INFO - mkdir: /builds/slave/test/build/upload/logs 13:04:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.917579 ========= master_lag: 8.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-03-03 13:04:12.633903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-03 13:04:12.637900) ========= 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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/351f620922d523189312f6f4db3ab633e332275d7396b129f734454535832af4ed9a6a7c45f671b8a2937e4d4da426063baa40ba38b89d3e7735262f4531b8e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02f6286ede460fd77853ef02c377b8db97fd5193dc63f40145db1f80f0698a6aba7688ab11f3d5bf7794bdc8415fa3979d6a02f8edecf58c91967a56fecf71a3"} build_url:https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011574 build_url: 'https://queue.taskcluster.net/v1/task/PEaobgXlRnmLSIfMhjQOwg/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/351f620922d523189312f6f4db3ab633e332275d7396b129f734454535832af4ed9a6a7c45f671b8a2937e4d4da426063baa40ba38b89d3e7735262f4531b8e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02f6286ede460fd77853ef02c377b8db97fd5193dc63f40145db1f80f0698a6aba7688ab11f3d5bf7794bdc8415fa3979d6a02f8edecf58c91967a56fecf71a3"}' ========= master_lag: 1.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-03 13:04:14.098097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 35 secs) (at 2016-03-03 13:04:14.098503) ========= 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.kLRcridIie/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.HQSrd01iD4/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005266 ========= master_lag: 35.19 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 35 secs) (at 2016-03-03 13:04:49.294153) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-03 13:04:49.294517) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-03 13:04:53.837810) ========= ========= Total master_lag: 45.06 =========