builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1459033102.28 results: success (0) buildid: 20160326141442 builduid: 37954366833548ab9c93a29909ad93ba revision: 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.278684) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.279551) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.279832) ========= 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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005573 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.317295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.317595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.363335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.363643) ========= 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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005865 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.416964) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.417252) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.420623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:22.420904) ========= 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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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-26 15:58:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-03-26 15:58:23 (15.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.741256 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:23.181882) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:23.182217) ========= 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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.026148 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:23.242531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-26 15:58:23.242885) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 --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 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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-26 15:58:23,323 truncating revision to first 12 chars 2016-03-26 15:58:23,323 Setting DEBUG logging. 2016-03-26 15:58:23,323 attempt 1/10 2016-03-26 15:58:23,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/678ddeb8eb84?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-26 15:58:25,336 unpacking tar archive at: fx-team-678ddeb8eb84/testing/mozharness/ program finished with exit code 0 elapsedTime=2.260134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-26 15:58:25.525746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:25.526117) ========= echo 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'678ddeb8eb8483540c58ce4ad54248a2429cb6b7'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 program finished with exit code 0 elapsedTime=0.005792 script_repo_revision: '678ddeb8eb8483540c58ce4ad54248a2429cb6b7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:25.580925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:25.581235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-26 15:58:25.599640) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-03-26 15:58:25.599956) ========= /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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:58:25 INFO - MultiFileLogger online at 20160326 15:58:25 in /builds/slave/test 15:58:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:58:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:25 INFO - {'append_to_log': False, 15:58:25 INFO - 'base_work_dir': '/builds/slave/test', 15:58:25 INFO - 'blob_upload_branch': 'Fx-Team', 15:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:25 INFO - 'branch': 'Fx-Team', 15:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:25 INFO - 'config_files': ('talos/mac_config.py',), 15:58:25 INFO - 'default_actions': ('clobber', 15:58:25 INFO - 'read-buildbot-config', 15:58:25 INFO - 'download-and-extract', 15:58:25 INFO - 'populate-webroot', 15:58:25 INFO - 'create-virtualenv', 15:58:25 INFO - 'install', 15:58:25 INFO - 'run-tests'), 15:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:25 INFO - 'download_minidump_stackwalk': True, 15:58:25 INFO - 'download_symbols': 'ondemand', 15:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:25 INFO - 'installer_path': 'installer.exe', 15:58:25 INFO - 'log_level': 'info', 15:58:25 INFO - 'log_name': 'talos', 15:58:25 INFO - 'log_to_console': True, 15:58:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:58:25 INFO - 'opt_config_files': (), 15:58:25 INFO - 'pip_index': False, 15:58:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:58:25 INFO - 'cmd': ('bash', 15:58:25 INFO - '-c', 15:58:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:58:25 INFO - 'enabled': True, 15:58:25 INFO - 'halt_on_failure': False, 15:58:25 INFO - 'name': 'check_screen_resolution'},), 15:58:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:58:25 INFO - 'cmd': ('bash', 15:58:25 INFO - '-c', 15:58:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:58:25 INFO - 'enabled': True, 15:58:25 INFO - 'halt_on_failure': False, 15:58:25 INFO - 'name': 'check_screen_resolution'},), 15:58:25 INFO - 'run_cmd_checks_enabled': True, 15:58:25 INFO - 'sps_profile': False, 15:58:25 INFO - 'sps_profile_interval': 0, 15:58:25 INFO - 'suite': 'dromaeojs', 15:58:25 INFO - 'system_bits': '32', 15:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:25 INFO - 'title': 't-yosemite-r7-0138', 15:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:25 INFO - 'use_talos_json': True, 15:58:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:25 INFO - 'work_dir': 'build'} 15:58:25 INFO - ##### 15:58:25 INFO - ##### Running clobber step. 15:58:25 INFO - ##### 15:58:25 INFO - Running pre-action listener: _resource_record_pre_action 15:58:25 INFO - Running main action method: clobber 15:58:25 INFO - rmtree: /builds/slave/test/build 15:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:27 INFO - Running post-action listener: _resource_record_post_action 15:58:27 INFO - ##### 15:58:27 INFO - ##### Running read-buildbot-config step. 15:58:27 INFO - ##### 15:58:27 INFO - Running pre-action listener: _resource_record_pre_action 15:58:27 INFO - Running main action method: read_buildbot_config 15:58:27 INFO - Using buildbot properties: 15:58:27 INFO - { 15:58:27 INFO - "project": "", 15:58:27 INFO - "product": "firefox", 15:58:27 INFO - "script_repo_revision": "production", 15:58:27 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:58:27 INFO - "repository": "", 15:58:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:58:27 INFO - "buildid": "20160326141442", 15:58:27 INFO - "pgo_build": "False", 15:58:27 INFO - "basedir": "/builds/slave/test", 15:58:27 INFO - "buildnumber": 634, 15:58:27 INFO - "slavename": "t-yosemite-r7-0138", 15:58:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:58:27 INFO - "platform": "yosemite_r7", 15:58:27 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:58:27 INFO - "branch": "fx-team", 15:58:27 INFO - "repo_path": "integration/fx-team", 15:58:27 INFO - "revision": "678ddeb8eb8483540c58ce4ad54248a2429cb6b7", 15:58:27 INFO - "stage_platform": "macosx64", 15:58:27 INFO - "builduid": "37954366833548ab9c93a29909ad93ba", 15:58:27 INFO - "slavebuilddir": "test" 15:58:27 INFO - } 15:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:58:27 INFO - Running post-action listener: _resource_record_post_action 15:58:27 INFO - ##### 15:58:27 INFO - ##### Running download-and-extract step. 15:58:27 INFO - ##### 15:58:27 INFO - Running pre-action listener: _resource_record_pre_action 15:58:27 INFO - Running main action method: download_and_extract 15:58:27 INFO - mkdir: /builds/slave/test/build/tests 15:58: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')]} 15:58:27 INFO - https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 15:58:46 INFO - Downloaded 1199 bytes. 15:58:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:58:46 INFO - Using the following test package requirements: 15:58:46 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:58:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:58:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:58:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'jsshell-mac.zip'], 15:58:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:58:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:58:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:58:46 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:58:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:58:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:58:46 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:58:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:46 INFO - https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:58:48 INFO - Downloaded 17943872 bytes. 15:58:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:58:51 INFO - Return code: 0 15:58:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:58: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')]} 15:58:51 INFO - https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:58:53 INFO - Downloaded 17943872 bytes. 15:58:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:58:57 INFO - Return code: 0 15:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:57 INFO - https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:58:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:58:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:58:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:58:58 INFO - Downloaded 10847531 bytes. 15:58:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:58:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:58:58 INFO - Return code: 0 15:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:58 INFO - https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:58:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:58:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:58:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:58:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 15:59:04 INFO - Downloaded 111382511 bytes. 15:59:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:59:04 INFO - mkdir: /builds/slave/test/properties 15:59:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:59:04 INFO - Writing to file /builds/slave/test/properties/build_url 15:59:04 INFO - Contents: 15:59:04 INFO - build_url:https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:59:06 INFO - Running post-action listener: _resource_record_post_action 15:59:06 INFO - Running post-action listener: set_extra_try_arguments 15:59:06 INFO - ##### 15:59:06 INFO - ##### Running populate-webroot step. 15:59:06 INFO - ##### 15:59:06 INFO - Running pre-action listener: _resource_record_pre_action 15:59:06 INFO - Running main action method: populate_webroot 15:59:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:06 INFO - '--tppagecycles', 15:59:06 INFO - '7'], 15:59:06 INFO - 'tests': ['tsvgm']}}, 15:59:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:59:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:59:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'tests': ['damp', 'tps']}, 15:59:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['damp', 'tps']}, 15:59:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:59:06 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['dromaeo_dom']}, 15:59:06 INFO - 'other': {'tests': ['a11yr', 15:59:06 INFO - 'ts_paint', 15:59:06 INFO - 'tpaint', 15:59:06 INFO - 'sessionrestore', 15:59:06 INFO - 'sessionrestore_no_auto_restore', 15:59:06 INFO - 'tabpaint']}, 15:59:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['a11yr', 15:59:06 INFO - 'ts_paint', 15:59:06 INFO - 'tpaint', 15:59:06 INFO - 'sessionrestore', 15:59:06 INFO - 'sessionrestore_no_auto_restore', 15:59:06 INFO - 'tabpaint']}, 15:59:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['a11yr', 15:59:06 INFO - 'ts_paint', 15:59:06 INFO - 'tpaint', 15:59:06 INFO - 'sessionrestore', 15:59:06 INFO - 'sessionrestore_no_auto_restore', 15:59:06 INFO - 'tabpaint']}, 15:59:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['a11yr', 15:59:06 INFO - 'ts_paint', 15:59:06 INFO - 'tpaint', 15:59:06 INFO - 'sessionrestore', 15:59:06 INFO - 'sessionrestore_no_auto_restore', 15:59:06 INFO - 'tabpaint']}, 15:59:06 INFO - 'other_l64': {'tests': ['a11yr', 15:59:06 INFO - 'ts_paint', 15:59:06 INFO - 'tpaint', 15:59:06 INFO - 'sessionrestore', 15:59:06 INFO - 'sessionrestore_no_auto_restore', 15:59:06 INFO - 'tabpaint']}, 15:59:06 INFO - 'other_nol64': {'tests': ['a11yr', 15:59:06 INFO - 'ts_paint', 15:59:06 INFO - 'tpaint', 15:59:06 INFO - 'sessionrestore', 15:59:06 INFO - 'sessionrestore_no_auto_restore', 15:59:06 INFO - 'tabpaint']}, 15:59:06 INFO - 'svgr': {'tests': ['tsvgx', 15:59:06 INFO - 'tsvgr_opacity', 15:59:06 INFO - 'tart', 15:59:06 INFO - 'tscrollx', 15:59:06 INFO - 'cart']}, 15:59:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['tsvgx', 15:59:06 INFO - 'tsvgr_opacity', 15:59:06 INFO - 'tart', 15:59:06 INFO - 'tscrollx', 15:59:06 INFO - 'cart']}, 15:59:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'tests': ['tp5o']}, 15:59:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'talos_options': ['--e10s'], 15:59:06 INFO - 'tests': ['tp5o']}, 15:59:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'talos_options': ['--xperf_path', 15:59:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:06 INFO - 'tests': ['tp5n']}, 15:59:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:06 INFO - 'talos_options': ['--e10s', 15:59:06 INFO - '--xperf_path', 15:59:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:06 INFO - 'tests': ['tp5n']}}, 15:59:06 INFO - 'talos.zip': {'path': '', 15:59:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:06 INFO - Running post-action listener: _resource_record_post_action 15:59:06 INFO - ##### 15:59:06 INFO - ##### Running create-virtualenv step. 15:59:06 INFO - ##### 15:59:06 INFO - Running pre-action listener: _resource_record_pre_action 15:59:06 INFO - Running main action method: create_virtualenv 15:59:06 INFO - Creating virtualenv /builds/slave/test/build/venv 15:59:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:59:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:59:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:06 INFO - Using real prefix '/tools/python27' 15:59:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:59:07 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:10 INFO - Installing pip.................done. 15:59:10 INFO - Return code: 0 15:59:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:10 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:10 INFO - 'HOME': '/Users/cltbld', 15:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PAGER': '/bin/cat', 15:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:10 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - 'XPC_FLAGS': '0x0', 15:59:10 INFO - 'XPC_SERVICE_NAME': '0', 15:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:59:10 INFO - Cleaning up... 15:59:10 INFO - Return code: 0 15:59:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:10 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:10 INFO - 'HOME': '/Users/cltbld', 15:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:10 INFO - 'LOGNAME': 'cltbld', 15:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:10 INFO - 'MOZ_NO_REMOTE': '1', 15:59:10 INFO - 'NO_EM_RESTART': '1', 15:59:10 INFO - 'PAGER': '/bin/cat', 15:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:10 INFO - 'PWD': '/builds/slave/test', 15:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:10 INFO - 'SHELL': '/bin/bash', 15:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:10 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:10 INFO - 'USER': 'cltbld', 15:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:10 INFO - 'XPC_FLAGS': '0x0', 15:59:10 INFO - 'XPC_SERVICE_NAME': '0', 15:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:10 INFO - Downloading/unpacking psutil>=0.7.1 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:13 INFO - Installing collected packages: psutil 15:59:13 INFO - Running setup.py install for psutil 15:59:14 INFO - building 'psutil._psutil_osx' extension 15:59:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:59:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:59:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:59:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:59:14 INFO - building 'psutil._psutil_posix' extension 15:59:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:59:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:59:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:59:14 INFO - ^ 15:59:14 INFO - 1 warning generated. 15:59:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:59:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:15 INFO - Successfully installed psutil 15:59:15 INFO - Cleaning up... 15:59:15 INFO - Return code: 0 15:59:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:15 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:15 INFO - 'HOME': '/Users/cltbld', 15:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:15 INFO - 'LOGNAME': 'cltbld', 15:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:15 INFO - 'MOZ_NO_REMOTE': '1', 15:59:15 INFO - 'NO_EM_RESTART': '1', 15:59:15 INFO - 'PAGER': '/bin/cat', 15:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:15 INFO - 'PWD': '/builds/slave/test', 15:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:15 INFO - 'SHELL': '/bin/bash', 15:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:15 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:15 INFO - 'USER': 'cltbld', 15:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:15 INFO - 'XPC_FLAGS': '0x0', 15:59:15 INFO - 'XPC_SERVICE_NAME': '0', 15:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:17 INFO - Installing collected packages: mozsystemmonitor 15:59:17 INFO - Running setup.py install for mozsystemmonitor 15:59:17 INFO - Successfully installed mozsystemmonitor 15:59:17 INFO - Cleaning up... 15:59:18 INFO - Return code: 0 15:59:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:18 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:18 INFO - 'HOME': '/Users/cltbld', 15:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:18 INFO - 'LOGNAME': 'cltbld', 15:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:18 INFO - 'MOZ_NO_REMOTE': '1', 15:59:18 INFO - 'NO_EM_RESTART': '1', 15:59:18 INFO - 'PAGER': '/bin/cat', 15:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:18 INFO - 'PWD': '/builds/slave/test', 15:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:18 INFO - 'SHELL': '/bin/bash', 15:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:18 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:18 INFO - 'USER': 'cltbld', 15:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:18 INFO - 'XPC_FLAGS': '0x0', 15:59:18 INFO - 'XPC_SERVICE_NAME': '0', 15:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:18 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:20 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:21 INFO - Downloading docopt-0.6.1.tar.gz 15:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:21 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:21 INFO - Running setup.py install for blobuploader 15:59:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:22 INFO - Running setup.py install for requests 15:59:22 INFO - Running setup.py install for docopt 15:59:22 INFO - Successfully installed blobuploader requests docopt 15:59:22 INFO - Cleaning up... 15:59:22 INFO - Return code: 0 15:59:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:22 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:22 INFO - 'HOME': '/Users/cltbld', 15:59:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:22 INFO - 'LOGNAME': 'cltbld', 15:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:22 INFO - 'MOZ_NO_REMOTE': '1', 15:59:22 INFO - 'NO_EM_RESTART': '1', 15:59:22 INFO - 'PAGER': '/bin/cat', 15:59:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:22 INFO - 'PWD': '/builds/slave/test', 15:59:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:22 INFO - 'SHELL': '/bin/bash', 15:59:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:22 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:22 INFO - 'USER': 'cltbld', 15:59:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:22 INFO - 'XPC_FLAGS': '0x0', 15:59:22 INFO - 'XPC_SERVICE_NAME': '0', 15:59:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-woHO_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8xoYnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-cnqBpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-bV59Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-3641gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-NYrztZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-XBtJEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-VdfcY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-uh3WSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-OqUeXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8ZkBvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-fzB2BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-79FivW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-e5BdYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-NiGQzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-aYMTQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-NO8gLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:24 INFO - Running setup.py install for manifestparser 15:59:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:24 INFO - Running setup.py install for mozcrash 15:59:25 INFO - Running setup.py install for mozdebug 15:59:25 INFO - Running setup.py install for mozdevice 15:59:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Running setup.py install for mozfile 15:59:25 INFO - Running setup.py install for mozhttpd 15:59:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Running setup.py install for mozinfo 15:59:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Running setup.py install for mozInstall 15:59:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:25 INFO - Running setup.py install for mozleak 15:59:26 INFO - Running setup.py install for mozlog 15:59:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:26 INFO - Running setup.py install for moznetwork 15:59:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:26 INFO - Running setup.py install for mozprocess 15:59:26 INFO - Running setup.py install for mozprofile 15:59:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:26 INFO - Running setup.py install for mozrunner 15:59:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:26 INFO - Running setup.py install for mozscreenshot 15:59:27 INFO - Running setup.py install for moztest 15:59:27 INFO - Running setup.py install for mozversion 15:59:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:27 INFO - Cleaning up... 15:59:27 INFO - Return code: 0 15:59:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:27 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:27 INFO - 'HOME': '/Users/cltbld', 15:59:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:27 INFO - 'LOGNAME': 'cltbld', 15:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:27 INFO - 'MOZ_NO_REMOTE': '1', 15:59:27 INFO - 'NO_EM_RESTART': '1', 15:59:27 INFO - 'PAGER': '/bin/cat', 15:59:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:27 INFO - 'PWD': '/builds/slave/test', 15:59:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:27 INFO - 'SHELL': '/bin/bash', 15:59:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:27 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:27 INFO - 'USER': 'cltbld', 15:59:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:27 INFO - 'XPC_FLAGS': '0x0', 15:59:27 INFO - 'XPC_SERVICE_NAME': '0', 15:59:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:27 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-gi7Q9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:27 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-BvebZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:27 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-mI1G4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:27 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-k3m5hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-SChFe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-k93clM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-hWFugC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-QO1MGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-wwPLFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-VSbARX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-goUFSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-_cjYRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:28 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-3PaLnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-sZmluU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-VjSb0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-aY6zKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:29 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-9smjUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:59:29 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:29 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:31 INFO - Downloading blessings-1.6.tar.gz 15:59:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:31 INFO - Installing collected packages: blessings 15:59:31 INFO - Running setup.py install for blessings 15:59:32 INFO - Successfully installed blessings 15:59:32 INFO - Cleaning up... 15:59:32 INFO - Return code: 0 15:59:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:32 INFO - Reading from file tmpfile_stdout 15:59:32 INFO - Current package versions: 15:59:32 INFO - blessings == 1.6 15:59:32 INFO - blobuploader == 1.2.4 15:59:32 INFO - docopt == 0.6.1 15:59:32 INFO - manifestparser == 1.1 15:59:32 INFO - mozInstall == 1.12 15:59:32 INFO - mozcrash == 0.17 15:59:32 INFO - mozdebug == 0.1 15:59:32 INFO - mozdevice == 0.48 15:59:32 INFO - mozfile == 1.2 15:59:32 INFO - mozhttpd == 0.7 15:59:32 INFO - mozinfo == 0.9 15:59:32 INFO - mozleak == 0.1 15:59:32 INFO - mozlog == 3.1 15:59:32 INFO - moznetwork == 0.27 15:59:32 INFO - mozprocess == 0.22 15:59:32 INFO - mozprofile == 0.28 15:59:32 INFO - mozrunner == 6.11 15:59:32 INFO - mozscreenshot == 0.1 15:59:32 INFO - mozsystemmonitor == 0.0 15:59:32 INFO - moztest == 0.7 15:59:32 INFO - mozversion == 1.4 15:59:32 INFO - psutil == 3.1.1 15:59:32 INFO - requests == 1.2.3 15:59:32 INFO - wsgiref == 0.1.2 15:59:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:32 INFO - 'HOME': '/Users/cltbld', 15:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PAGER': '/bin/cat', 15:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:32 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - 'XPC_FLAGS': '0x0', 15:59:32 INFO - 'XPC_SERVICE_NAME': '0', 15:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:32 INFO - Cleaning up... 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:32 INFO - 'HOME': '/Users/cltbld', 15:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PAGER': '/bin/cat', 15:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:32 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - 'XPC_FLAGS': '0x0', 15:59:32 INFO - 'XPC_SERVICE_NAME': '0', 15:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:32 INFO - Downloading/unpacking jsonschema 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:35 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:35 INFO - warning: no files found matching '*.txt' 15:59:35 INFO - no previously-included directories found matching 'build' 15:59:35 INFO - no previously-included directories found matching 'dist' 15:59:35 INFO - no previously-included directories found matching '.git*' 15:59:35 INFO - Installing collected packages: jsonschema, functools32 15:59:35 INFO - Running setup.py install for functools32 15:59:35 INFO - warning: no files found matching '*.txt' 15:59:35 INFO - no previously-included directories found matching 'build' 15:59:35 INFO - no previously-included directories found matching 'dist' 15:59:35 INFO - no previously-included directories found matching '.git*' 15:59:35 INFO - Successfully installed jsonschema functools32 15:59:35 INFO - Cleaning up... 15:59:36 INFO - Return code: 0 15:59:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:36 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 0x102219a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102229420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f801b5984d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, '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.nWhPRdb7kp/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.v5o8y28CKD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 15:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:59:36 INFO - 'HOME': '/Users/cltbld', 15:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:59:36 INFO - 'LOGNAME': 'cltbld', 15:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:36 INFO - 'MOZ_NO_REMOTE': '1', 15:59:36 INFO - 'NO_EM_RESTART': '1', 15:59:36 INFO - 'PAGER': '/bin/cat', 15:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:36 INFO - 'PWD': '/builds/slave/test', 15:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:59:36 INFO - 'SHELL': '/bin/bash', 15:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 15:59:36 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 15:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:59:36 INFO - 'USER': 'cltbld', 15:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:36 INFO - 'XPC_FLAGS': '0x0', 15:59:36 INFO - 'XPC_SERVICE_NAME': '0', 15:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:36 INFO - Downloading/unpacking flake8 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:39 INFO - no previously-included directories found matching 'docs/_build' 15:59:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:40 INFO - Running setup.py install for pep8 15:59:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:40 INFO - no previously-included directories found matching 'docs/_build' 15:59:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:59:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:40 INFO - Cleaning up... 15:59:40 INFO - Return code: 0 15:59:40 INFO - Running post-action listener: _resource_record_post_action 15:59:40 INFO - Running post-action listener: _start_resource_monitoring 15:59:40 INFO - Starting resource monitoring. 15:59:40 INFO - ##### 15:59:40 INFO - ##### Running install step. 15:59:40 INFO - ##### 15:59:40 INFO - Running pre-action listener: _resource_record_pre_action 15:59:40 INFO - Running main action method: install 15:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:40 INFO - Reading from file tmpfile_stdout 15:59:40 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:40 INFO - Reading from file tmpfile_stdout 15:59:40 INFO - Output received: 15:59:40 INFO - Usage: mozinstall [options] installer 15:59:40 INFO - Options: 15:59:40 INFO - -h, --help show this help message and exit 15:59:40 INFO - -d DEST, --destination=DEST 15:59:40 INFO - Directory to install application into. [default: 15:59:40 INFO - "/builds/slave/test"] 15:59:40 INFO - --app=APP Application being installed. [default: firefox] 15:59:40 INFO - mkdir: /builds/slave/test/build/application 15:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:00:15 INFO - Reading from file tmpfile_stdout 16:00:15 INFO - Output received: 16:00:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:00:15 INFO - Running post-action listener: _resource_record_post_action 16:00:15 INFO - ##### 16:00:15 INFO - ##### Running run-tests step. 16:00:15 INFO - ##### 16:00:15 INFO - Running pre-action listener: _resource_record_pre_action 16:00:15 INFO - Running main action method: run_tests 16:00:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:00:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:00:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:00:15 INFO - 2016-03-26 16:00:15.151 screenresolution[1650:8450] starting screenresolution argv=screenresolution get 16:00:15 INFO - 2016-03-26 16:00:15.153 screenresolution[1650:8450] Display 0: 1600x1200x32@60 16:00:15 INFO - 2016-03-26 16:00:15.159 screenresolution[1651:8453] starting screenresolution argv=screenresolution list 16:00:15 INFO - Available Modes on Display 0 16:00:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:00:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:00:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:00:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:00:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:00:15 INFO - Intel Iris: 16:00:15 INFO - Chipset Model: Intel Iris 16:00:15 INFO - Type: GPU 16:00:15 INFO - Bus: Built-In 16:00:15 INFO - VRAM (Dynamic, Max): 1536 MB 16:00:15 INFO - Vendor: Intel (0x8086) 16:00:15 INFO - Device ID: 0x0a2e 16:00:15 INFO - Revision ID: 0x0009 16:00:15 INFO - Displays: 16:00:15 INFO - Display: 16:00:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:00:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:00:15 INFO - Display Serial Number: 1600x1200 60 16:00:15 INFO - Main Display: Yes 16:00:15 INFO - Mirror: Off 16:00:15 INFO - Online: Yes 16:00:15 INFO - Rotation: Supported 16:00:15 INFO - Return code: 0 16:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:00:15 INFO - Python 2.7.3 16:00:15 INFO - Return code: 0 16:00:15 INFO - grabbing minidump binary from tooltool 16:00:15 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')]} 16:00:15 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 0x1020b8e00>, '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 0x101ee1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1020b3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:00:15 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 16:00:15 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 16:00:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:15 INFO - Return code: 0 16:00:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:00:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:00:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:00:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:00:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:00:16 INFO - Return code: 0 16:00:16 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/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 16:00:16 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/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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 16:00:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nWhPRdb7kp/Render', 16:00:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:00:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:00:16 INFO - 'HOME': '/Users/cltbld', 16:00:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:00:16 INFO - 'LOGNAME': 'cltbld', 16:00:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:00:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:16 INFO - 'MOZ_NO_REMOTE': '1', 16:00:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:00:16 INFO - 'NO_EM_RESTART': '1', 16:00:16 INFO - 'PAGER': '/bin/cat', 16:00:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:16 INFO - 'PWD': '/builds/slave/test', 16:00:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:00:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:00:16 INFO - 'SHELL': '/bin/bash', 16:00:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5o8y28CKD/Listeners', 16:00:16 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 16:00:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:00:16 INFO - 'USER': 'cltbld', 16:00:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:00:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:16 INFO - 'XPC_FLAGS': '0x0', 16:00:16 INFO - 'XPC_SERVICE_NAME': '0', 16:00:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:00:16 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/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 16:00:16 INFO - mozversion application_buildid: 20160326141442 16:00:16 INFO - mozversion application_changeset: 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 16:00:16 INFO - mozversion application_display_name: Nightly 16:00:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:16 INFO - mozversion application_name: Firefox 16:00:16 INFO - mozversion application_remotingname: firefox 16:00:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:00:16 INFO - mozversion application_vendor: Mozilla 16:00:16 INFO - mozversion application_version: 48.0a1 16:00:16 INFO - mozversion platform_buildid: 20160326141442 16:00:16 INFO - mozversion platform_changeset: 678ddeb8eb8483540c58ce4ad54248a2429cb6b7 16:00:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:00:16 INFO - mozversion platform_version: 48.0a1 16:00:16 INFO - using testdate: 1459033216 16:00:16 INFO - actual date: 1459033216 16:00:16 INFO - starting webserver on 'localhost:49272' 16:00:16 INFO - SUITE-START | Running 2 tests 16:00:16 INFO - TEST-START | dromaeo_css 16:00:16 INFO - operating with platform_type : mac_ 16:00:16 INFO - Initialising browser for dromaeo_css test... 16:00:16 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpCdW91m/profile http://localhost:49272/getInfo.html) 16:00:19 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 16:00:19 INFO - PROCESS | 1669 | colorDepth:24 16:00:19 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 16:00:19 INFO - PROCESS | 1669 | __metrics 16:00:19 INFO - PROCESS | 1669 | 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" 16:00:19 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:00:19 INFO - TEST-INFO | 1669: exit 0 16:00:19 INFO - Browser initialized. 16:00:19 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:19 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpCdW91m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:31 INFO - PROCESS | 1673 | RSS: Main: 244330496 16:00:31 INFO - PROCESS | 1673 | 16:01:22 INFO - PROCESS | 1673 | 1459033282656 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] 16:03:33 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 16:03:34 INFO - PROCESS | 1673 | RSS: Main: 380735488 16:03:34 INFO - PROCESS | 1673 | 16:06:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 16:06:38 INFO - PROCESS | 1673 | RSS: Main: 375214080 16:06:38 INFO - PROCESS | 1673 | 16:09:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 16:09:40 INFO - PROCESS | 1673 | RSS: Main: 374796288 16:09:40 INFO - PROCESS | 1673 | 16:12:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 16:12:43 INFO - PROCESS | 1673 | RSS: Main: 333840384 16:12:43 INFO - PROCESS | 1673 | 16:15:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 16:15:47 INFO - PROCESS | 1673 | RSS: Main: 333832192 16:15:47 INFO - PROCESS | 1673 | 16:18:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 16:18:50 INFO - PROCESS | 1673 | RSS: Main: 443555840 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | __start_tp_report 16:18:50 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 16:18:50 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 16:18:50 INFO - PROCESS | 1673 | |i|pagename|runs| 16:18:50 INFO - PROCESS | 1673 | |0;dojo.html;3369.6967272945435;3487.7384196185294;3496.1609213788697;3522.771019883707;3571.428571428572;5609.635373700707;5662.688552129631;5715.257016587848;5726.656400615955;5734.971325143374;5683.5169010634145;5795.768169273224;5805.970970145143;5814.854628634286;5867.178594996693;5185.974070129663;5217.426083130853;5242.737863106849;5249.763760630772;5258.1849813279005;5128.333316668828;5268.209768534713;5293.550048245904;5352.330958630171;5366.195070739382;5293.602979776513;5295.4704529546925;5307.73461326934;5314.787408503656;5369.382521010075;5143.614228932845;5235.790568377299;5245.082110630625;5245.501677340685;5268.236105764681;5142.9228561571235;5186.273921650934;5195.428502864682;5199.402068762103;5204.479552044803;5598.608097433182;5634.464725851038;5636.436356364372;5640.520555752766;5655.632383895034;6124.938750612526;6141.50867930569;6164.445199931983;6232.594881332699;6282.78010269643;4738.597219236334;6271.43557079865;6293.402126797947;6298.6535740534255;6304.117423560705;5729.942700573024;5791.189233507313;5803.129530570363;5812.476877081083;5854.853628659275;6180.66006369645;6211.409916057967;6228.190335256388;6248.968755156195;6255.71849266775;6111.755529778848;6124.785632502841;6149.13912052313;6149.538784591174;6164.845878853064;6133.693315334215;6272.435480806749;6272.749090036347;6278.466330361879;6305.558610897285;6141.271221159771;6144.600600960924;6159.969200153971;6198.907016394758;6273.498120150377;6252.062190671345;6257.749690012349;6273.96863015682;6274.592151510137;6275.780347687809;4860.854174374775;4873.122837889143;4877.244027175793;4881.365422495053;4903.33804936329;4269.615734583902;4418.469783625986;4421.137878113801;4449.466064072332;4481.887952801206;5604.047311956977;5617.662940223599;5630.183623374588;5641.464060914206;5644.943550564524;6184.288806787187;6220.595661282002;6242.969909964805;6272.341404152498;6286.8428289292215;5614.2701448811395;5634.267545219095;5650.434956504317;5658.490735833795;5681.772729090872;5336.493033161843;5341.893162136813;5363.356397232357;5364.195370694427;5392.514673679388;5415.972920135374;6176.907346389808;6273.717682704198;6287.056941458818;6313.43179113882;6244.1570387997035;6281.371862813682;6291.779787707408;6305.8108256752375;6314.336994615499;6207.503399727921;6260.593061450991;6287.497000240061;6295.961166407492;6316.431521163117;6141.84645383869;6153.2616086068165;6183.258009038944;6193.287771906288;6196.628202307876;6269.49844012487;6270.843228919131;6274.466670333073;6289.371062893674;6291.779787707408;5971.343152253336;6045.335013148638;6066.3023752269055;6067.787627433018;6068.362821903636;6051.515878729779;6109.465396926494;6110.680268050674;6115.818436018264;6126.724297406538;5888.205092312483;5931.673757943355;5944;5946.643201407929;6003.459688628044;5207.583393328448;5677.97796396636;6112.694365281807;6126.846828829315;6140.017597184429;5406.675599463887;5891.086881533369;5911.527077833849;6006.069059295816;6021 16:18:50 INFO - PROCESS | 1673 | |1;ext.html;501.2631431795264;550.0237079184444;581.9621724587904;627.9466245369143;642.6690254518923;38998.220035599305;40114;40182.79908600453;40217;40249.79875100624;42496.15007699844;43111.70664880059;43135.78432107843;43209.35185972213;43303.56696433035;8237.135100814417;9656.662016829412;9657.179139773129;9658.227341812639;9688.75778105546;9498.240140788756;9642.951785241099;9655;9664.178544823662;9667.95166024169;9738.853917191247;9812.852807207897;9814.411135331868;9815.558299876522;9816.705498835046;9706.902930970671;9771.853422198672;9784.315097943147;9790.510474476248;9801.019898010141;9666.323357364987;9784.51077446132;9793.853092203623;9802.950985245028;9806;41770.58229417697;42236.15527689429;42298.78850605758;42310.57689423128;42311.57688423138;3264.7388208943225;3294.456414691573;3367;3428.9314213715834;3462.79223246606;29228.41543169146;29328.8533557333;29942.55086173709;30318;30518.389632207454;2727.4545090981683;2732.2486316263185;2751.3534319434916;2840.1195629354966;2879.928001799951;378641;379491;379884;381214;382495.1750482515;45997.77001114973;53451.73274133605;65881.67059164673;67733.66133169303;67871.98192027124;45690.060292161805;46054.53945460569;46075.53924460713;46148.30777538339;46192.53807461949;15586.844131558766;15771.29029193689;15776.290066947015;15787.368505259661;15803.920980395254;12673.98608111349;12699.873001269869;12703.301318427575;12724.236545807282;12747.490100396066;14727.631809204855;14742.041767285093;15041.172735499435;15059.698806024036;15173.013754105948;6224.62652240867;6266.373362663697;6303.077561343743;6310.810675679737;6320.4311611955145;978.6183388478499;988.2736188901152;1050.8318669012922;1090.6618948125947;1099.115212254127;29301;29305;29879.40241195164;30120.84939575288;30209.546856797166;1074.8280275155937;1088.7822435512928;1099.1536516881956;1108.7449886526144;1284.5760898903338;14894.776578351333;14959.551213463614;15096.39614415433;15343.616409589626;15351.769723454157;479519;547200;551069;552876;553753;60712.69643651754;61112;61225;61534.769304613656;61661.07508387378;1310.1549500572269;1325.6420766393019;1424.7435461617008;1430.8926830487756;1471.9705605888037;29574.556381653863;29698.851505742332;29806.403871922008;30370.785168593007;30387.544186836774;50405.991880162925;50778.74610626923;51000.489995099575;51079;51199;374115;376636;377278;377333;377573;33243;33932;34605.30789384148;34668.47997279993;34791.13022174466;45973.54026459826;46121.53878461172;46353.53646463492;46803.765981169876;47756;37767.62232377641;38033.61966380301;38601.6139838598;38612.80693596626;38780.41829372618;37097.44353834641;37330.44004339991;37849.81075094607;37997.43003854889;38013.80993095017;31745;32363.029109126765;35872.4619130708;37617.68338108263;37779.81110094432;31262.53106203363;32406.67593324131;32450.513242300913;32472.83763581167;32482;24042.63936040926;24093.550996907998;24637;24642.01431942702;24717.134900278405 16:18:50 INFO - PROCESS | 1673 | |2;jquery.html;323.6633900743227;360.61594401961906;364.755613738795;367.9724020698448;373.5013756634892;19511.512212194702;19686.507837304056;21019.894900525476;21031.369058928256;21049;19929;20467.874266915314;20631.381058568266;20665.070071846767;21378.46553836155;5578.44215578443;5835.503982161521;5895.764169433218;5901.970490147543;5918;4152.730072545275;4243.915121697564;4281.957180428187;5733.913991290134;6428.132202152719;6327.525435592349;6373;6381.106645069671;6388.64862432566;6410.423061924426;6350.523710721668;6353.714082866282;6358.3641635836275;6363.236411630611;6364.49084073273;3755.1926335837925;3919.3729003359613;3923.1369098798505;3926.0773718176206;5492;23751.931163097703;24589;24611.13861014856;25186.24441266765;25223.24330270095;2155.698202251686;2184.945376365588;2277.487565297811;2331.3588763090115;2752.8073034887566;14189.574312770634;14414.783778243334;14444.277786110653;14652.70694586113;14738.778918316233;1674.6148385871195;1713.374618264337;1721.3975108711975;1763.7795275590552;1780.8931464112195;96122.51938740262;98032.50983745036;98135;98161.5275770864;98413;9906.20750339971;10164.847527287096;10409.68770936873;10472.057514823702;10510.264281500375;10916.727081822859;12823.871761282455;12871.905887999437;12925.418356173996;12959.481620735254;7528.51064680794;8013.7996550085545;8093.826395172667;8262.793430164174;8525.44584601999;7152.678129484186;7561.924380756122;8645.524496152646;8652.264557512555;8672.523011234316;5181.792728290901;5992.970035149883;6040.586594548246;6047.002244629675;6060.454559089703;1531.7855500229978;1810.614879617094;1816.536783120296;1822.9453116406528;1857.1178690122083;410.43360162974903;411.0197179726374;423.6314406466394;431.34866351808995;1025.9025392587691;11248.043916267045;11654.941725291319;11848.881511184778;11873.643790686294;11949.701257468632;449.95275496073094;452.16801086001914;456.05141306083266;456.0992040719552;472.43308030363016;5983.192269043623;6049.364816694272;6143.201383820075;6143.56995010345;6156.07658851167;594668;634310.8284458548;641515;642866;655185;97245;108056;110656.34015489774;116680;118567.2214916777;1021.6883850425692;1058.5342449322275;1075.596651255779;1076.1014552848303;1077.477423449642;17832.732509012636;17899.463016109537;18178.636427271114;18399;18470;51052.48947510626;51298.48701512937;51845.70385740236;53953;54190.72904635609;72724;75105.62447187948;75349.62325188339;77223.61388193023;78226;7372.705091796268;7583.355414789805;7650.923490765021;7685.577293248925;7705.730299439493;10323.896761032294;11923.344216068199;12059.698507537381;12068.879311207127;12206.389680515762;9613.423194608346;9706.902930970882;10339.853557007404;10606.522706478072;10826.512806923865;7362.785140451765;10067.69796906094;10223;10302.536385862804;10711.678649640524;9410.670626528039;10386.324888882198;10767.228612885534;10922.672319830417;10926.016658500774;7408.814779630552;7464.962675186589;7506.099268087864;7547.0943486781935;7746.845063098819;10296.845547316647;10464.215183861394;10673;10708.89291107079;10740.409277489813 16:18:50 INFO - PROCESS | 1673 | |3;mootools.html;1449.869511743943;1610.3075677458692;1637.50056232849;1906.3994841624888;2017.3947815655308;7967.721129760453;8622.870656940151;8806.20744133028;8808.251298639623;8849.247813935806;8449.197326254012;8719.694810681627;8726.47641141532;8733.781655458617;8774.473531588093;2175.249538909082;2404.4589967257402;2447.755224477547;2466.482038771851;2472.9629055564183;2154.9892250538724;2444.401121725171;2448.816338774599;2449.191766716979;2456.385903524119;2415.311636183688;2445.3397582652674;2480.1443501991876;2481.0323973650293;2492.763187497185;2416.3838221253554;2461.4707837814867;2463.051725085837;2467.3091534370405;2473.282748003077;2454.840435371713;2455.3002394317714;2471.641611966255;2477.2444404456633;2500.1249562653106;8799.472031678055;8874.423162494417;8876.822463550692;8885.733427997171;8899.955500222522;5437.401885792559;5529.640573362719;5567.415421380737;5575.498205161514;5579;3495.667911548399;3593.2633810068874;3621.257642183346;3714.145746478298;3717.7769333840056;1046.2832959422744;1063.6968463987803;1071.608862765093;1077.7844431113808;1080.9189310801721;11885.643430697006;11907.047436205083;11914.523419063227;11915.582954596548;11934.641960741104;4741.976290118528;4831.227003679394;4906.533879281463;4912.189488734391;4914.631402644816;10142.543585538668;10145.137663298703;10150.289479736348;10165.593376264867;10169.491525423698;5511.200875872976;5522.282103326542;5534.833954981357;5540.335159780771;5556.888862222814;4468.620167285817;4621.653375996813;4844.709317440965;4997.100521906092;4999.225120106389;3762.887113386603;3858.1704933439446;3870.8838734838;3907.9804600976813;3930.5479869814767;1128.480898786551;1304.3869381390732;1305.4386613755987;1314.0998416085013;1318.6110097521255;1206.4812130783848;1381.2196109198471;1381.8272715910512;1386.4107754204422;1416.2493878244547;8156.306713929263;8364.247217750431;8364.37267204962;8371.37214708887;8372.455790373606;519.0737439301839;526.631358049367;534.2120372450682;534.895695339405;535.4163961282221;6163.260408750889;6169.722362493699;6205.410486003822;6208.596441231305;6223.782167624111;10504.264701470976;10890.292131011618;10893.782124357469;11049.779004420026;11064.502097405637;10353.896461035294;10772.838407423895;10780.622678206382;10883.455827208609;10896.346219226873;8467.153284671607;8469.661213551512;8524.8721269181;8540.274076703425;8543;6731.798046058626;7782.338501227459;8040.597970101355;8055.355571554379;8070.071941726542;9402.811943761224;9629.711108666752;9738.853917191389;9756.219502439646;9838.950805245928;9777.41335519871;9871.802563948537;10084.042016008467;10102.494875256354;10109.39343639384;6529.575577587441;6800.115984921928;7061.364477196871;7369.18938916708;7659.042619672541;8230.547319897223;8294.626741796514;8319.334453243848;8320.292775114183;8347.373946953881;6189.442950134509;7243.963780181065;7366.263373662591;7381;7510.324070833652;7271.2365201653065;7334.96332518334;7341.610542307301;7425.220351862977;7434.888476672746;7726.536407815549;7803.765887023398;7809.023872015998;7827.139014708264;7863.606819658879;6972.755953541602;6995.510314277952;7099.645017748989;7104.893426598502;7107.395871350993;7123.967024781274;7184.604846733271;7186.10173728284;7205.099362579677;7212.963935180291 16:18:50 INFO - PROCESS | 1673 | |4;prototype.html;325.2405632847301;329.57155697593123;334.2079272125064;335.5051299333483;340.22598588211815;6618.271990081099;6686.097376854129;6689.030090636861;6711.731530738764;6721.3950744433;6628.668566571676;6655.733770649168;6659.234188068373;6670.96664516678;6682.899756503644;3873.4383514390397;4795.856124316276;4853.199222128363;4921.384826896638;4957.776900039498;4892.094962431944;4894.902101957977;4906.092372911023;4906.435759887623;4909.361782968209;4874.683145595543;4894.119058569456;4900.191468407708;4900.705957642535;4916.262560615918;4708.5526874947;4776.522347765231;4904.558589726942;4924.581410580105;4939.086269040203;4187.979060104711;4196.895077623053;4200.306949353353;4203.243416185085;4223.535411104776;6375.362463753588;6453.354664533556;6479.384458476485;6488.740450381979;6504.772332968323;5806.59353845231;5815.040518314473;5816.505597024258;5819.359870414251;5843.094320380348;6708.228553716336;7063.258357872401;7080.114985626797;7092.255313192092;7150.5352152109945;4578.793954272032;4591.920898588829;4597.9654577720075;4607.032523170138;4609.723416594981;6378.93621063788;7293.4529910256415;7404.592747398891;7430.554166750012;7518.849623007564;3901.6878649707955;4636;4642.837500687459;4646.907061858744;4658.7204767713365;4101.384792281182;4477.910441791146;4580.473245576802;4695.295705644113;4723.126221649006;5604.243427137366;5608.46719561641;5618.213450116987;5624.437556244343;5636.2954630671165;5163.922541161885;5953.434423729739;6052.455279024909;6322.747090116344;6327.715252813635;1601.6956778212102;1631.4942367865763;1635.5502236884713;1640.4832477769464;1641.048192048609;823.8434697407473;1010.6361709784471;1029.2692188546216;1039.781645854364;1058.3702696895334;6489.513286503531;6633.170853643294;6642.86714265712;6644.169478815148;6644.634545099969;7441.441891858132;7456.440766942393;7467.439942004263;7476.476646634792;7477.140128885139;6589.242237142694;6609.173853268341;6633.535652504375;6635;6637.46900247979;3367.696907278357;3827.3110840048503;3880.9223815523533;3927.626875446828;3929.5677475477673;7361.852762944711;7627.283861131312;7730.420218483524;7739.61301934901;7781.8832717509285;7569.772906812805;7631.3131818136635;7634.580098094547;7639.427042971799;7660.961695191489;5610.046292130348;7731.188225236382;7734.4585878989055;7773.989381380385;7775.883361749465;7167.820804479721;7352.669129889061;7453.888191677021;7469.626518674153;7484.476086673881;7264.128304603481;7326.853462930605;7331.340179383881;7337.633118344168;7349.412047036331;7743.341815945708;7744.961275193813;7755.302022817974;7758.68965241384;7762.184970578234;3915.275674000319;4673.9298910517045;4679.3448917150945;4682.063587282625;4692.882677933079;7087.192765844677;7407.444441666788;7426.071741032371;7434.7769566913075;7448.1807001228735;7157.391621712213;7170.354668079689;7180.676869540779;7199.568025918462;7203.675834587351;7137.072180616487;7152.892706609509;7161.4986950912935;7169.677364518505;7173.748918787817;7012.7545535906;7018.157821061505;7026.789196324118;7029.61337126463;7035;5563.193336966036;7071.045408869943;7077.469189810682;7157.105361829771;7165.319294666998;6655.767048153291;6802.795916122524;6831.9316806833285;6893.7931862042215;6905.205901321211 16:18:50 INFO - PROCESS | 1673 | |5;yui.html;628.7767842415946;679.8606285711429;744.7207297263525;762.7368557847541;796.0169191049054;15305.234738263098;15517.767233491506;15518.767218491732;15525.068495890255;15547.61130971725;12976.675583110427;14173.43306267748;14179.858201417983;14229.146251224935;14243.216623085726;728.264452902567;728.5701436152669;873.52829472085;901.9864702029474;904.263025634106;894.2622336572322;894.432035657359;907.9863802042942;908.3596064774318;908.695586978363;965.6813251626982;967.809594199132;968.2834702320267;968.4479846487505;971.4414211828228;697.0728930522394;760.1714131596531;761.3376362564549;768.2394429514796;937.6390089815402;715.6421789105448;718.2207305074;718.4862823081522;718.8095154783987;719.2663483247059;13946.721065578631;15077.321520531603;15090.622734431727;15142.015768974981;15158;11514.481848316846;12614.053945953998;12631.684207894785;12728.681782955407;12964.87035129646;10049.736906175642;10075.798484030352;10146.543405546769;10443.791124177475;10492.003259690317;3334.983325083359;3360.495925611178;3387.661233876617;3454.084667563098;3501.19472521319;82729.58635206845;83026.58486707589;83776;88930;89374.5531272346;9530.666426675032;9721.979192184861;9813.067758562926;9887.703368898945;10032.247581431422;22297.777022229893;22299.104576110887;22312.442188945406;22314.55370892573;22353;7379.335859772539;7580.9620951894885;7664.34853037498;7761.844763104819;7784.727534536264;4054.39184122384;4070.633642972147;4073.246449406869;4125.216208920296;4195.056112374691;3588.748787584844;3634.4184930411006;3638.7634803737674;3638.799866007342;3657.743957922973;643.7392855893371;663.9701213445406;666.3236814633151;670.9765158219438;678.2098854834162;543.4809756682359;569.8489900176456;599.7750843433712;610.185402487675;614.8217017065001;7852.475301893471;8035.517868927883;8188.631511581993;8191.713290034821;8583.65665373378;572.3046498504337;594.3580932592789;596.379765044349;605.459106573762;643.1285608001184;3758.3422900992764;3780.319542482325;3849.1531862990096;3910.7066969976795;3944.4280579315837;93609;96004;96159.51920240354;96414;96859;80556.59721701471;81000.78498822522;81229;81347;81577.59211203906;70576.94134587985;71102.64448677724;71279.2872071283;72652;72791;7488.5506869588;7682.270184332479;7692.7692169235015;7880.17258187882;8076.555789431402;48980.75509622429;49067;49914.750426247636;50079.74960125176;51894;60076.69961650164;70355;70723.23191920243;70840.22899427556;73295;10238.385696858213;11083.889161108285;11130.833037504606;11420.657380278604;11500.712482187677;11283;11934.940325298317;12078.75842483163;12381.195222310522;12471.688207794878;11604.709882252673;11900.107491938312;11950.103742219195;12048.75902481963;12094.697632559257;11636;11669.183157178915;11904.940475297915;12050.276983381025;12081.033517318769;11181.552737890719;11282.153838461983;11302;11595.420228988685;12205.69485762863;8084.878726818984;9468.431894086378;9565.426074435556;9626.711198664052;9723.611055557698;8761.693340733043;9145.143073225838;9205.539723013688;9526;9745.074217949283 16:18:50 INFO - PROCESS | 1673 | __end_tp_report 16:18:50 INFO - PROCESS | 1673 | __start_cc_report 16:18:50 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1308 16:18:50 INFO - PROCESS | 1673 | __end_cc_report 16:18:50 INFO - PROCESS | 1673 | __startTimestamp1459034330086__endTimestamp 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | ------- Summary: start ------- 16:18:50 INFO - PROCESS | 1673 | Number of tests: 6 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5725.64 Median:5911.53 stddev:625.55 (10.6%) stddev-sans-first:599.55 16:18:50 INFO - PROCESS | 1673 | Values: 3369.7 3487.7 3496.2 3522.8 3571.4 5609.6 5662.7 5715.3 5726.7 5735.0 5683.5 5795.8 5806.0 5814.9 5867.2 5186.0 5217.4 5242.7 5249.8 5258.2 5128.3 5268.2 5293.6 5352.3 5366.2 5293.6 5295.5 5307.7 5314.8 5369.4 5143.6 5235.8 5245.1 5245.5 5268.2 5142.9 5186.3 5195.4 5199.4 5204.5 5598.6 5634.5 5636.4 5640.5 5655.6 6124.9 6141.5 6164.4 6232.6 6282.8 4738.6 6271.4 6293.4 6298.7 6304.1 5729.9 5791.2 5803.1 5812.5 5854.9 6180.7 6211.4 6228.2 6249.0 6255.7 6111.8 6124.8 6149.1 6149.5 6164.8 6133.7 6272.4 6272.7 6278.5 6305.6 6141.3 6144.6 6160.0 6198.9 6273.5 6252.1 6257.7 6274.0 6274.6 6275.8 4860.9 4873.1 4877.2 4881.4 4903.3 4269.6 4418.5 4421.1 4449.5 4481.9 5604.0 5617.7 5630.2 5641.5 5644.9 6184.3 6220.6 6243.0 6272.3 6286.8 5614.3 5634.3 5650.4 5658.5 5681.8 5336.5 5341.9 5363.4 5364.2 5392.5 5416.0 6176.9 6273.7 6287.1 6313.4 6244.2 6281.4 6291.8 6305.8 6314.3 6207.5 6260.6 6287.5 6296.0 6316.4 6141.8 6153.3 6183.3 6193.3 6196.6 6269.5 6270.8 6274.5 6289.4 6291.8 5971.3 6045.3 6066.3 6067.8 6068.4 6051.5 6109.5 6110.7 6115.8 6126.7 5888.2 5931.7 5944.0 5946.6 6003.5 5207.6 5678.0 6112.7 6126.8 6140.0 5406.7 5891.1 5911.5 6006.1 6021.0 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:58305.78 Median:38005.62 stddev:116242.26 (305.9%) stddev-sans-first:116487.33 16:18:50 INFO - PROCESS | 1673 | Values: 501.3 550.0 582.0 627.9 642.7 38998.2 40114.0 40182.8 40217.0 40249.8 42496.2 43111.7 43135.8 43209.4 43303.6 8237.1 9656.7 9657.2 9658.2 9688.8 9498.2 9643.0 9655.0 9664.2 9668.0 9738.9 9812.9 9814.4 9815.6 9816.7 9706.9 9771.9 9784.3 9790.5 9801.0 9666.3 9784.5 9793.9 9803.0 9806.0 41770.6 42236.2 42298.8 42310.6 42311.6 3264.7 3294.5 3367.0 3428.9 3462.8 29228.4 29328.9 29942.6 30318.0 30518.4 2727.5 2732.2 2751.4 2840.1 2879.9 378641.0 379491.0 379884.0 381214.0 382495.2 45997.8 53451.7 65881.7 67733.7 67872.0 45690.1 46054.5 46075.5 46148.3 46192.5 15586.8 15771.3 15776.3 15787.4 15803.9 12674.0 12699.9 12703.3 12724.2 12747.5 14727.6 14742.0 15041.2 15059.7 15173.0 6224.6 6266.4 6303.1 6310.8 6320.4 978.6 988.3 1050.8 1090.7 1099.1 29301.0 29305.0 29879.4 30120.8 30209.5 1074.8 1088.8 1099.2 1108.7 1284.6 14894.8 14959.6 15096.4 15343.6 15351.8 479519.0 547200.0 551069.0 552876.0 553753.0 60712.7 61112.0 61225.0 61534.8 61661.1 1310.2 1325.6 1424.7 1430.9 1472.0 29574.6 29698.9 29806.4 30370.8 30387.5 50406.0 50778.7 51000.5 51079.0 51199.0 374115.0 376636.0 377278.0 377333.0 377573.0 33243.0 33932.0 34605.3 34668.5 34791.1 45973.5 46121.5 46353.5 46803.8 47756.0 37767.6 38033.6 38601.6 38612.8 38780.4 37097.4 37330.4 37849.8 37997.4 38013.8 31745.0 32363.0 35872.5 37617.7 37779.8 31262.5 32406.7 32450.5 32472.8 32482.0 24042.6 24093.6 24637.0 24642.0 24717.1 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:34301.28 Median:3837.28 stddev:104822.75 (2731.7%) stddev-sans-first:105085.75 16:18:50 INFO - PROCESS | 1673 | Values: 323.7 360.6 364.8 368.0 373.5 19511.5 19686.5 21019.9 21031.4 21049.0 19929.0 20467.9 20631.4 20665.1 21378.5 5578.4 5835.5 5895.8 5902.0 5918.0 4152.7 4243.9 4282.0 5733.9 6428.1 6327.5 6373.0 6381.1 6388.6 6410.4 6350.5 6353.7 6358.4 6363.2 6364.5 3755.2 3919.4 3923.1 3926.1 5492.0 23751.9 24589.0 24611.1 25186.2 25223.2 2155.7 2184.9 2277.5 2331.4 2752.8 14189.6 14414.8 14444.3 14652.7 14738.8 1674.6 1713.4 1721.4 1763.8 1780.9 96122.5 98032.5 98135.0 98161.5 98413.0 9906.2 10164.8 10409.7 10472.1 10510.3 10916.7 12823.9 12871.9 12925.4 12959.5 7528.5 8013.8 8093.8 8262.8 8525.4 7152.7 7561.9 8645.5 8652.3 8672.5 5181.8 5993.0 6040.6 6047.0 6060.5 1531.8 1810.6 1816.5 1822.9 1857.1 410.4 411.0 423.6 431.3 1025.9 11248.0 11654.9 11848.9 11873.6 11949.7 450.0 452.2 456.1 456.1 472.4 5983.2 6049.4 6143.2 6143.6 6156.1 594668.0 634310.8 641515.0 642866.0 655185.0 97245.0 108056.0 110656.3 116680.0 118567.2 1021.7 1058.5 1075.6 1076.1 1077.5 17832.7 17899.5 18178.6 18399.0 18470.0 51052.5 51298.5 51845.7 53953.0 54190.7 72724.0 75105.6 75349.6 77223.6 78226.0 7372.7 7583.4 7650.9 7685.6 7705.7 10323.9 11923.3 12059.7 12068.9 12206.4 9613.4 9706.9 10339.9 10606.5 10826.5 7362.8 10067.7 10223.0 10302.5 10711.7 9410.7 10386.3 10767.2 10922.7 10926.0 7408.8 7465.0 7506.1 7547.1 7746.8 10296.8 10464.2 10673.0 10708.9 10740.4 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6070.56 Median:534.55 stddev:3234.39 (605.1%) stddev-sans-first:3224.82 16:18:50 INFO - PROCESS | 1673 | Values: 1449.9 1610.3 1637.5 1906.4 2017.4 7967.7 8622.9 8806.2 8808.3 8849.2 8449.2 8719.7 8726.5 8733.8 8774.5 2175.2 2404.5 2447.8 2466.5 2473.0 2155.0 2444.4 2448.8 2449.2 2456.4 2415.3 2445.3 2480.1 2481.0 2492.8 2416.4 2461.5 2463.1 2467.3 2473.3 2454.8 2455.3 2471.6 2477.2 2500.1 8799.5 8874.4 8876.8 8885.7 8900.0 5437.4 5529.6 5567.4 5575.5 5579.0 3495.7 3593.3 3621.3 3714.1 3717.8 1046.3 1063.7 1071.6 1077.8 1080.9 11885.6 11907.0 11914.5 11915.6 11934.6 4742.0 4831.2 4906.5 4912.2 4914.6 10142.5 10145.1 10150.3 10165.6 10169.5 5511.2 5522.3 5534.8 5540.3 5556.9 4468.6 4621.7 4844.7 4997.1 4999.2 3762.9 3858.2 3870.9 3908.0 3930.5 1128.5 1304.4 1305.4 1314.1 1318.6 1206.5 1381.2 1381.8 1386.4 1416.2 8156.3 8364.2 8364.4 8371.4 8372.5 519.1 526.6 534.2 534.9 535.4 6163.3 6169.7 6205.4 6208.6 6223.8 10504.3 10890.3 10893.8 11049.8 11064.5 10353.9 10772.8 10780.6 10883.5 10896.3 8467.2 8469.7 8524.9 8540.3 8543.0 6731.8 7782.3 8040.6 8055.4 8070.1 9402.8 9629.7 9738.9 9756.2 9839.0 9777.4 9871.8 10084.0 10102.5 10109.4 6529.6 6800.1 7061.4 7369.2 7659.0 8230.5 8294.6 8319.3 8320.3 8347.4 6189.4 7244.0 7366.3 7381.0 7510.3 7271.2 7335.0 7341.6 7425.2 7434.9 7726.5 7803.8 7809.0 7827.1 7863.6 6972.8 6995.5 7099.6 7104.9 7107.4 7124.0 7184.6 7186.1 7205.1 7213.0 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5776.46 Median:6623.47 stddev:1877.92 (28.4%) stddev-sans-first:1838.08 16:18:50 INFO - PROCESS | 1673 | Values: 325.2 329.6 334.2 335.5 340.2 6618.3 6686.1 6689.0 6711.7 6721.4 6628.7 6655.7 6659.2 6671.0 6682.9 3873.4 4795.9 4853.2 4921.4 4957.8 4892.1 4894.9 4906.1 4906.4 4909.4 4874.7 4894.1 4900.2 4900.7 4916.3 4708.6 4776.5 4904.6 4924.6 4939.1 4188.0 4196.9 4200.3 4203.2 4223.5 6375.4 6453.4 6479.4 6488.7 6504.8 5806.6 5815.0 5816.5 5819.4 5843.1 6708.2 7063.3 7080.1 7092.3 7150.5 4578.8 4591.9 4598.0 4607.0 4609.7 6378.9 7293.5 7404.6 7430.6 7518.8 3901.7 4636.0 4642.8 4646.9 4658.7 4101.4 4477.9 4580.5 4695.3 4723.1 5604.2 5608.5 5618.2 5624.4 5636.3 5163.9 5953.4 6052.5 6322.7 6327.7 1601.7 1631.5 1635.6 1640.5 1641.0 823.8 1010.6 1029.3 1039.8 1058.4 6489.5 6633.2 6642.9 6644.2 6644.6 7441.4 7456.4 7467.4 7476.5 7477.1 6589.2 6609.2 6633.5 6635.0 6637.5 3367.7 3827.3 3880.9 3927.6 3929.6 7361.9 7627.3 7730.4 7739.6 7781.9 7569.8 7631.3 7634.6 7639.4 7661.0 5610.0 7731.2 7734.5 7774.0 7775.9 7167.8 7352.7 7453.9 7469.6 7484.5 7264.1 7326.9 7331.3 7337.6 7349.4 7743.3 7745.0 7755.3 7758.7 7762.2 3915.3 4673.9 4679.3 4682.1 4692.9 7087.2 7407.4 7426.1 7434.8 7448.2 7157.4 7170.4 7180.7 7199.6 7203.7 7137.1 7152.9 7161.5 7169.7 7173.7 7012.8 7018.2 7026.8 7029.6 7035.0 5563.2 7071.0 7077.5 7157.1 7165.3 6655.8 6802.8 6831.9 6893.8 6905.2 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18742.52 Median:621.80 stddev:26685.32 (4291.6%) stddev-sans-first:26725.52 16:18:50 INFO - PROCESS | 1673 | Values: 628.8 679.9 744.7 762.7 796.0 15305.2 15517.8 15518.8 15525.1 15547.6 12976.7 14173.4 14179.9 14229.1 14243.2 728.3 728.6 873.5 902.0 904.3 894.3 894.4 908.0 908.4 908.7 965.7 967.8 968.3 968.4 971.4 697.1 760.2 761.3 768.2 937.6 715.6 718.2 718.5 718.8 719.3 13946.7 15077.3 15090.6 15142.0 15158.0 11514.5 12614.1 12631.7 12728.7 12964.9 10049.7 10075.8 10146.5 10443.8 10492.0 3335.0 3360.5 3387.7 3454.1 3501.2 82729.6 83026.6 83776.0 88930.0 89374.6 9530.7 9722.0 9813.1 9887.7 10032.2 22297.8 22299.1 22312.4 22314.6 22353.0 7379.3 7581.0 7664.3 7761.8 7784.7 4054.4 4070.6 4073.2 4125.2 4195.1 3588.7 3634.4 3638.8 3638.8 3657.7 643.7 664.0 666.3 671.0 678.2 543.5 569.8 599.8 610.2 614.8 7852.5 8035.5 8188.6 8191.7 8583.7 572.3 594.4 596.4 605.5 643.1 3758.3 3780.3 3849.2 3910.7 3944.4 93609.0 96004.0 96159.5 96414.0 96859.0 80556.6 81000.8 81229.0 81347.0 81577.6 70576.9 71102.6 71279.3 72652.0 72791.0 7488.6 7682.3 7692.8 7880.2 8076.6 48980.8 49067.0 49914.8 50079.7 51894.0 60076.7 70355.0 70723.2 70840.2 73295.0 10238.4 11083.9 11130.8 11420.7 11500.7 11283.0 11934.9 12078.8 12381.2 12471.7 11604.7 11900.1 11950.1 12048.8 12094.7 11636.0 11669.2 11904.9 12050.3 12081.0 11181.6 11282.2 11302.0 11595.4 12205.7 8084.9 9468.4 9565.4 9626.7 9723.6 8761.7 9145.1 9205.5 9526.0 9745.1 16:18:50 INFO - PROCESS | 1673 | -------- Summary: end -------- 16:18:50 INFO - PROCESS | 1673 | 16:18:50 INFO - TEST-INFO | 1673: exit 0 16:18:50 INFO - TEST-OK | dromaeo_css | took 1113742ms 16:18:50 INFO - TEST-START | kraken 16:18:50 INFO - operating with platform_type : mac_ 16:18:50 INFO - Initialising browser for kraken test... 16:18:50 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpicKPFl/profile http://localhost:49272/getInfo.html) 16:18:52 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 16:18:52 INFO - PROCESS | 1679 | colorDepth:24 16:18:52 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 16:18:52 INFO - PROCESS | 1679 | __metrics 16:18:52 INFO - PROCESS | 1679 | 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" 16:18:52 ERROR - PROCESS | 1679 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:18:53 INFO - TEST-INFO | 1679: exit 0 16:18:53 INFO - Browser initialized. 16:18:53 INFO - Running cycle 1/1 for kraken test... 16:18:53 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpicKPFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:05 INFO - PROCESS | 1681 | RSS: Main: 244330496 16:19:05 INFO - PROCESS | 1681 | 16:19:08 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:08 INFO - PROCESS | 1681 | RSS: Main: 290308096 16:19:08 INFO - PROCESS | 1681 | 16:19:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 16:19:12 INFO - PROCESS | 1681 | RSS: Main: 300953600 16:19:12 INFO - PROCESS | 1681 | 16:19:15 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 16:19:16 INFO - PROCESS | 1681 | RSS: Main: 289284096 16:19:16 INFO - PROCESS | 1681 | 16:19:17 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 16:19:18 INFO - PROCESS | 1681 | RSS: Main: 292806656 16:19:18 INFO - PROCESS | 1681 | 16:19:20 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:21 INFO - PROCESS | 1681 | RSS: Main: 292749312 16:19:21 INFO - PROCESS | 1681 | 16:19:24 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:24 INFO - PROCESS | 1681 | RSS: Main: 293408768 16:19:24 INFO - PROCESS | 1681 | 16:19:27 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:28 INFO - PROCESS | 1681 | RSS: Main: 293388288 16:19:28 INFO - PROCESS | 1681 | 16:19:30 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 16:19:31 INFO - PROCESS | 1681 | RSS: Main: 293531648 16:19:31 INFO - PROCESS | 1681 | 16:19:33 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:33 INFO - PROCESS | 1681 | RSS: Main: 325300224 16:19:33 INFO - PROCESS | 1681 | 16:19:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:36 INFO - PROCESS | 1681 | RSS: Main: 326135808 16:19:36 INFO - PROCESS | 1681 | 16:19:38 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:38 INFO - PROCESS | 1681 | RSS: Main: 330960896 16:19:38 INFO - PROCESS | 1681 | 16:19:41 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:42 INFO - PROCESS | 1681 | RSS: Main: 332013568 16:19:42 INFO - PROCESS | 1681 | 16:19:44 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:45 INFO - PROCESS | 1681 | RSS: Main: 332169216 16:19:45 INFO - PROCESS | 1681 | 16:19:46 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 16:19:47 INFO - PROCESS | 1681 | RSS: Main: 394727424 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | __start_tp_report 16:19:47 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 16:19:47 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 16:19:47 INFO - PROCESS | 1681 | |i|pagename|runs| 16:19:47 INFO - PROCESS | 1681 | |0;ai-astar;112;111;114;112;112;116;163;161;113;111 16:19:47 INFO - PROCESS | 1681 | |1;audio-beat-detection;158;127;142;160;122;143;142;118;164;121 16:19:47 INFO - PROCESS | 1681 | |2;audio-dft;185;184;187;188;184;185;182;183;184;182 16:19:47 INFO - PROCESS | 1681 | |3;audio-fft;72;85;73;117;56;59;57;58;120;56 16:19:47 INFO - PROCESS | 1681 | |4;audio-oscillator;91;95;127;81;77;85;115;109;110;148 16:19:47 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;90;84;125;88;88;85;89;86;90;85 16:19:47 INFO - PROCESS | 1681 | |6;imaging-darkroom;94;95;95;93;93;93;94;95;93;93 16:19:47 INFO - PROCESS | 1681 | |7;imaging-desaturate;86;88;88;87;85;85;85;87;86;85 16:19:47 INFO - PROCESS | 1681 | |8;json-parse-financial;55;55;53;54;54;53;54;64;55;52 16:19:47 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;67;93;78;79;74;71;69;70;69;68 16:19:47 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;83;83;84;82;84;83;83;84;84;85 16:19:47 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;136;117;129;120;126;123;120;134;126;133 16:19:47 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;140;130;140;140;135;130;145;141;141;139 16:19:47 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;70;67;67;67;68;67;67;67;66;67 16:19:47 INFO - PROCESS | 1681 | __end_tp_report 16:19:47 INFO - PROCESS | 1681 | __start_cc_report 16:19:47 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1244 16:19:47 INFO - PROCESS | 1681 | __end_cc_report 16:19:47 INFO - PROCESS | 1681 | __startTimestamp1459034387075__endTimestamp 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | ------- Summary: start ------- 16:19:47 INFO - PROCESS | 1681 | Number of tests: 14 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:122.50 Median:113.50 stddev:20.88 (18.4%) stddev-sans-first:21.79 16:19:47 INFO - PROCESS | 1681 | Values: 112.0 111.0 114.0 112.0 112.0 116.0 163.0 161.0 113.0 111.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:142.50 stddev:17.17 (12.1%) stddev-sans-first:16.89 16:19:47 INFO - PROCESS | 1681 | Values: 158.0 127.0 142.0 160.0 122.0 143.0 142.0 118.0 164.0 121.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:1.96 (1.1%) stddev-sans-first:2.06 16:19:47 INFO - PROCESS | 1681 | Values: 185.0 184.0 187.0 188.0 184.0 185.0 182.0 183.0 184.0 182.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:75.30 Median:58.50 stddev:24.70 (42.2%) stddev-sans-first:26.17 16:19:47 INFO - PROCESS | 1681 | Values: 72.0 85.0 73.0 117.0 56.0 59.0 57.0 58.0 120.0 56.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:79.00 stddev:22.40 (28.4%) stddev-sans-first:23.27 16:19:47 INFO - PROCESS | 1681 | Values: 91.0 95.0 127.0 81.0 77.0 85.0 115.0 109.0 110.0 148.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:88.00 stddev:12.14 (13.8%) stddev-sans-first:12.87 16:19:47 INFO - PROCESS | 1681 | Values: 90.0 84.0 125.0 88.0 88.0 85.0 89.0 86.0 90.0 85.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 16:19:47 INFO - PROCESS | 1681 | Values: 94.0 95.0 95.0 93.0 93.0 93.0 94.0 95.0 93.0 93.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.23 (1.4%) stddev-sans-first:1.30 16:19:47 INFO - PROCESS | 1681 | Values: 86.0 88.0 88.0 87.0 85.0 85.0 85.0 87.0 86.0 85.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.35 (6.1%) stddev-sans-first:3.55 16:19:47 INFO - PROCESS | 1681 | Values: 55.0 55.0 53.0 54.0 54.0 53.0 54.0 64.0 55.0 52.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:72.50 stddev:7.90 (10.9%) stddev-sans-first:7.99 16:19:47 INFO - PROCESS | 1681 | Values: 67.0 93.0 78.0 79.0 74.0 71.0 69.0 70.0 69.0 68.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 16:19:47 INFO - PROCESS | 1681 | Values: 83.0 83.0 84.0 82.0 84.0 83.0 83.0 84.0 84.0 85.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:127.50 stddev:6.52 (5.1%) stddev-sans-first:5.92 16:19:47 INFO - PROCESS | 1681 | Values: 136.0 117.0 129.0 120.0 126.0 123.0 120.0 134.0 126.0 133.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.10 Median:140.00 stddev:4.91 (3.5%) stddev-sans-first:5.16 16:19:47 INFO - PROCESS | 1681 | Values: 140.0 130.0 140.0 140.0 135.0 130.0 145.0 141.0 141.0 139.0 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:0.50 16:19:47 INFO - PROCESS | 1681 | Values: 70.0 67.0 67.0 67.0 68.0 67.0 67.0 67.0 66.0 67.0 16:19:47 INFO - PROCESS | 1681 | -------- Summary: end -------- 16:19:47 INFO - PROCESS | 1681 | 16:19:47 INFO - TEST-INFO | 1681: exit 0 16:19:47 INFO - TEST-OK | kraken | took 57162ms 16:19:47 INFO - SUITE-END | took 1170s 16:19:48 INFO - Completed test suite (00:19:31) 16:19:48 INFO - javascript benchmark 16:19:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3369.6967272945435, 3487.7384196185294, 3496.1609213788697, 3522.771019883707, 3571.428571428572, 5609.635373700707, 5662.688552129631, 5715.257016587848, 5726.656400615955, 5734.971325143374, 5683.5169010634145, 5795.768169273224, 5805.970970145143, 5814.854628634286, 5867.178594996693, 5185.974070129663, 5217.426083130853, 5242.737863106849, 5249.763760630772, 5258.1849813279005, 5128.333316668828, 5268.209768534713, 5293.550048245904, 5352.330958630171, 5366.195070739382, 5293.602979776513, 5295.4704529546925, 5307.73461326934, 5314.787408503656, 5369.382521010075, 5143.614228932845, 5235.790568377299, 5245.082110630625, 5245.501677340685, 5268.236105764681, 5142.9228561571235, 5186.273921650934, 5195.428502864682, 5199.402068762103, 5204.479552044803, 5598.608097433182, 5634.464725851038, 5636.436356364372, 5640.520555752766, 5655.632383895034, 6124.938750612526, 6141.50867930569, 6164.445199931983, 6232.594881332699, 6282.78010269643, 4738.597219236334, 6271.43557079865, 6293.402126797947, 6298.6535740534255, 6304.117423560705, 5729.942700573024, 5791.189233507313, 5803.129530570363, 5812.476877081083, 5854.853628659275, 6180.66006369645, 6211.409916057967, 6228.190335256388, 6248.968755156195, 6255.71849266775, 6111.755529778848, 6124.785632502841, 6149.13912052313, 6149.538784591174, 6164.845878853064, 6133.693315334215, 6272.435480806749, 6272.749090036347, 6278.466330361879, 6305.558610897285, 6141.271221159771, 6144.600600960924, 6159.969200153971, 6198.907016394758, 6273.498120150377, 6252.062190671345, 6257.749690012349, 6273.96863015682, 6274.592151510137, 6275.780347687809, 4860.854174374775, 4873.122837889143, 4877.244027175793, 4881.365422495053, 4903.33804936329, 4269.615734583902, 4418.469783625986, 4421.137878113801, 4449.466064072332, 4481.887952801206, 5604.047311956977, 5617.662940223599, 5630.183623374588, 5641.464060914206, 5644.943550564524, 6184.288806787187, 6220.595661282002, 6242.969909964805, 6272.341404152498, 6286.8428289292215, 5614.2701448811395, 5634.267545219095, 5650.434956504317, 5658.490735833795, 5681.772729090872, 5336.493033161843, 5341.893162136813, 5363.356397232357, 5364.195370694427, 5392.514673679388, 5415.972920135374, 6176.907346389808, 6273.717682704198, 6287.056941458818, 6313.43179113882, 6244.1570387997035, 6281.371862813682, 6291.779787707408, 6305.8108256752375, 6314.336994615499, 6207.503399727921, 6260.593061450991, 6287.497000240061, 6295.961166407492, 6316.431521163117, 6141.84645383869, 6153.2616086068165, 6183.258009038944, 6193.287771906288, 6196.628202307876, 6269.49844012487, 6270.843228919131, 6274.466670333073, 6289.371062893674, 6291.779787707408, 5971.343152253336, 6045.335013148638, 6066.3023752269055, 6067.787627433018, 6068.362821903636, 6051.515878729779, 6109.465396926494, 6110.680268050674, 6115.818436018264, 6126.724297406538, 5888.205092312483, 5931.673757943355, 5944.0, 5946.643201407929, 6003.459688628044, 5207.583393328448, 5677.97796396636, 6112.694365281807, 6126.846828829315, 6140.017597184429, 5406.675599463887, 5891.086881533369, 5911.527077833849, 6006.069059295816, 6021.0], "unit": "score", "name": "dojo.html", "value": 5688.026409931724}, {"lowerIsBetter": false, "replicates": [501.2631431795264, 550.0237079184444, 581.9621724587904, 627.9466245369143, 642.6690254518923, 38998.220035599305, 40114.0, 40182.79908600453, 40217.0, 40249.79875100624, 42496.15007699844, 43111.70664880059, 43135.78432107843, 43209.35185972213, 43303.56696433035, 8237.135100814417, 9656.662016829412, 9657.179139773129, 9658.227341812639, 9688.75778105546, 9498.240140788756, 9642.951785241099, 9655.0, 9664.178544823662, 9667.95166024169, 9738.853917191247, 9812.852807207897, 9814.411135331868, 9815.558299876522, 9816.705498835046, 9706.902930970671, 9771.853422198672, 9784.315097943147, 9790.510474476248, 9801.019898010141, 9666.323357364987, 9784.51077446132, 9793.853092203623, 9802.950985245028, 9806.0, 41770.58229417697, 42236.15527689429, 42298.78850605758, 42310.57689423128, 42311.57688423138, 3264.7388208943225, 3294.456414691573, 3367.0, 3428.9314213715834, 3462.79223246606, 29228.41543169146, 29328.8533557333, 29942.55086173709, 30318.0, 30518.389632207454, 2727.4545090981683, 2732.2486316263185, 2751.3534319434916, 2840.1195629354966, 2879.928001799951, 378641.0, 379491.0, 379884.0, 381214.0, 382495.1750482515, 45997.77001114973, 53451.73274133605, 65881.67059164673, 67733.66133169303, 67871.98192027124, 45690.060292161805, 46054.53945460569, 46075.53924460713, 46148.30777538339, 46192.53807461949, 15586.844131558766, 15771.29029193689, 15776.290066947015, 15787.368505259661, 15803.920980395254, 12673.98608111349, 12699.873001269869, 12703.301318427575, 12724.236545807282, 12747.490100396066, 14727.631809204855, 14742.041767285093, 15041.172735499435, 15059.698806024036, 15173.013754105948, 6224.62652240867, 6266.373362663697, 6303.077561343743, 6310.810675679737, 6320.4311611955145, 978.6183388478499, 988.2736188901152, 1050.8318669012922, 1090.6618948125947, 1099.115212254127, 29301.0, 29305.0, 29879.40241195164, 30120.84939575288, 30209.546856797166, 1074.8280275155937, 1088.7822435512928, 1099.1536516881956, 1108.7449886526144, 1284.5760898903338, 14894.776578351333, 14959.551213463614, 15096.39614415433, 15343.616409589626, 15351.769723454157, 479519.0, 547200.0, 551069.0, 552876.0, 553753.0, 60712.69643651754, 61112.0, 61225.0, 61534.769304613656, 61661.07508387378, 1310.1549500572269, 1325.6420766393019, 1424.7435461617008, 1430.8926830487756, 1471.9705605888037, 29574.556381653863, 29698.851505742332, 29806.403871922008, 30370.785168593007, 30387.544186836774, 50405.991880162925, 50778.74610626923, 51000.489995099575, 51079.0, 51199.0, 374115.0, 376636.0, 377278.0, 377333.0, 377573.0, 33243.0, 33932.0, 34605.30789384148, 34668.47997279993, 34791.13022174466, 45973.54026459826, 46121.53878461172, 46353.53646463492, 46803.765981169876, 47756.0, 37767.62232377641, 38033.61966380301, 38601.6139838598, 38612.80693596626, 38780.41829372618, 37097.44353834641, 37330.44004339991, 37849.81075094607, 37997.43003854889, 38013.80993095017, 31745.0, 32363.029109126765, 35872.4619130708, 37617.68338108263, 37779.81110094432, 31262.53106203363, 32406.67593324131, 32450.513242300913, 32472.83763581167, 32482.0, 24042.63936040926, 24093.550996907998, 24637.0, 24642.01431942702, 24717.134900278405], "unit": "score", "name": "ext.html", "value": 19257.598334786566}, {"lowerIsBetter": false, "replicates": [323.6633900743227, 360.61594401961906, 364.755613738795, 367.9724020698448, 373.5013756634892, 19511.512212194702, 19686.507837304056, 21019.894900525476, 21031.369058928256, 21049.0, 19929.0, 20467.874266915314, 20631.381058568266, 20665.070071846767, 21378.46553836155, 5578.44215578443, 5835.503982161521, 5895.764169433218, 5901.970490147543, 5918.0, 4152.730072545275, 4243.915121697564, 4281.957180428187, 5733.913991290134, 6428.132202152719, 6327.525435592349, 6373.0, 6381.106645069671, 6388.64862432566, 6410.423061924426, 6350.523710721668, 6353.714082866282, 6358.3641635836275, 6363.236411630611, 6364.49084073273, 3755.1926335837925, 3919.3729003359613, 3923.1369098798505, 3926.0773718176206, 5492.0, 23751.931163097703, 24589.0, 24611.13861014856, 25186.24441266765, 25223.24330270095, 2155.698202251686, 2184.945376365588, 2277.487565297811, 2331.3588763090115, 2752.8073034887566, 14189.574312770634, 14414.783778243334, 14444.277786110653, 14652.70694586113, 14738.778918316233, 1674.6148385871195, 1713.374618264337, 1721.3975108711975, 1763.7795275590552, 1780.8931464112195, 96122.51938740262, 98032.50983745036, 98135.0, 98161.5275770864, 98413.0, 9906.20750339971, 10164.847527287096, 10409.68770936873, 10472.057514823702, 10510.264281500375, 10916.727081822859, 12823.871761282455, 12871.905887999437, 12925.418356173996, 12959.481620735254, 7528.51064680794, 8013.7996550085545, 8093.826395172667, 8262.793430164174, 8525.44584601999, 7152.678129484186, 7561.924380756122, 8645.524496152646, 8652.264557512555, 8672.523011234316, 5181.792728290901, 5992.970035149883, 6040.586594548246, 6047.002244629675, 6060.454559089703, 1531.7855500229978, 1810.614879617094, 1816.536783120296, 1822.9453116406528, 1857.1178690122083, 410.43360162974903, 411.0197179726374, 423.6314406466394, 431.34866351808995, 1025.9025392587691, 11248.043916267045, 11654.941725291319, 11848.881511184778, 11873.643790686294, 11949.701257468632, 449.95275496073094, 452.16801086001914, 456.05141306083266, 456.0992040719552, 472.43308030363016, 5983.192269043623, 6049.364816694272, 6143.201383820075, 6143.56995010345, 6156.07658851167, 594668.0, 634310.8284458548, 641515.0, 642866.0, 655185.0, 97245.0, 108056.0, 110656.34015489774, 116680.0, 118567.2214916777, 1021.6883850425692, 1058.5342449322275, 1075.596651255779, 1076.1014552848303, 1077.477423449642, 17832.732509012636, 17899.463016109537, 18178.636427271114, 18399.0, 18470.0, 51052.48947510626, 51298.48701512937, 51845.70385740236, 53953.0, 54190.72904635609, 72724.0, 75105.62447187948, 75349.62325188339, 77223.61388193023, 78226.0, 7372.705091796268, 7583.355414789805, 7650.923490765021, 7685.577293248925, 7705.730299439493, 10323.896761032294, 11923.344216068199, 12059.698507537381, 12068.879311207127, 12206.389680515762, 9613.423194608346, 9706.902930970882, 10339.853557007404, 10606.522706478072, 10826.512806923865, 7362.785140451765, 10067.69796906094, 10223.0, 10302.536385862804, 10711.678649640524, 9410.670626528039, 10386.324888882198, 10767.228612885534, 10922.672319830417, 10926.016658500774, 7408.814779630552, 7464.962675186589, 7506.099268087864, 7547.0943486781935, 7746.845063098819, 10296.845547316647, 10464.215183861394, 10673.0, 10708.89291107079, 10740.409277489813], "unit": "score", "name": "jquery.html", "value": 8695.233295764921}, {"lowerIsBetter": false, "replicates": [1449.869511743943, 1610.3075677458692, 1637.50056232849, 1906.3994841624888, 2017.3947815655308, 7967.721129760453, 8622.870656940151, 8806.20744133028, 8808.251298639623, 8849.247813935806, 8449.197326254012, 8719.694810681627, 8726.47641141532, 8733.781655458617, 8774.473531588093, 2175.249538909082, 2404.4589967257402, 2447.755224477547, 2466.482038771851, 2472.9629055564183, 2154.9892250538724, 2444.401121725171, 2448.816338774599, 2449.191766716979, 2456.385903524119, 2415.311636183688, 2445.3397582652674, 2480.1443501991876, 2481.0323973650293, 2492.763187497185, 2416.3838221253554, 2461.4707837814867, 2463.051725085837, 2467.3091534370405, 2473.282748003077, 2454.840435371713, 2455.3002394317714, 2471.641611966255, 2477.2444404456633, 2500.1249562653106, 8799.472031678055, 8874.423162494417, 8876.822463550692, 8885.733427997171, 8899.955500222522, 5437.401885792559, 5529.640573362719, 5567.415421380737, 5575.498205161514, 5579.0, 3495.667911548399, 3593.2633810068874, 3621.257642183346, 3714.145746478298, 3717.7769333840056, 1046.2832959422744, 1063.6968463987803, 1071.608862765093, 1077.7844431113808, 1080.9189310801721, 11885.643430697006, 11907.047436205083, 11914.523419063227, 11915.582954596548, 11934.641960741104, 4741.976290118528, 4831.227003679394, 4906.533879281463, 4912.189488734391, 4914.631402644816, 10142.543585538668, 10145.137663298703, 10150.289479736348, 10165.593376264867, 10169.491525423698, 5511.200875872976, 5522.282103326542, 5534.833954981357, 5540.335159780771, 5556.888862222814, 4468.620167285817, 4621.653375996813, 4844.709317440965, 4997.100521906092, 4999.225120106389, 3762.887113386603, 3858.1704933439446, 3870.8838734838, 3907.9804600976813, 3930.5479869814767, 1128.480898786551, 1304.3869381390732, 1305.4386613755987, 1314.0998416085013, 1318.6110097521255, 1206.4812130783848, 1381.2196109198471, 1381.8272715910512, 1386.4107754204422, 1416.2493878244547, 8156.306713929263, 8364.247217750431, 8364.37267204962, 8371.37214708887, 8372.455790373606, 519.0737439301839, 526.631358049367, 534.2120372450682, 534.895695339405, 535.4163961282221, 6163.260408750889, 6169.722362493699, 6205.410486003822, 6208.596441231305, 6223.782167624111, 10504.264701470976, 10890.292131011618, 10893.782124357469, 11049.779004420026, 11064.502097405637, 10353.896461035294, 10772.838407423895, 10780.622678206382, 10883.455827208609, 10896.346219226873, 8467.153284671607, 8469.661213551512, 8524.8721269181, 8540.274076703425, 8543.0, 6731.798046058626, 7782.338501227459, 8040.597970101355, 8055.355571554379, 8070.071941726542, 9402.811943761224, 9629.711108666752, 9738.853917191389, 9756.219502439646, 9838.950805245928, 9777.41335519871, 9871.802563948537, 10084.042016008467, 10102.494875256354, 10109.39343639384, 6529.575577587441, 6800.115984921928, 7061.364477196871, 7369.18938916708, 7659.042619672541, 8230.547319897223, 8294.626741796514, 8319.334453243848, 8320.292775114183, 8347.373946953881, 6189.442950134509, 7243.963780181065, 7366.263373662591, 7381.0, 7510.324070833652, 7271.2365201653065, 7334.96332518334, 7341.610542307301, 7425.220351862977, 7434.888476672746, 7726.536407815549, 7803.765887023398, 7809.023872015998, 7827.139014708264, 7863.606819658879, 6972.755953541602, 6995.510314277952, 7099.645017748989, 7104.893426598502, 7107.395871350993, 7123.967024781274, 7184.604846733271, 7186.10173728284, 7205.099362579677, 7212.963935180291], "unit": "score", "name": "mootools.html", "value": 4865.024486855189}, {"lowerIsBetter": false, "replicates": [325.2405632847301, 329.57155697593123, 334.2079272125064, 335.5051299333483, 340.22598588211815, 6618.271990081099, 6686.097376854129, 6689.030090636861, 6711.731530738764, 6721.3950744433, 6628.668566571676, 6655.733770649168, 6659.234188068373, 6670.96664516678, 6682.899756503644, 3873.4383514390397, 4795.856124316276, 4853.199222128363, 4921.384826896638, 4957.776900039498, 4892.094962431944, 4894.902101957977, 4906.092372911023, 4906.435759887623, 4909.361782968209, 4874.683145595543, 4894.119058569456, 4900.191468407708, 4900.705957642535, 4916.262560615918, 4708.5526874947, 4776.522347765231, 4904.558589726942, 4924.581410580105, 4939.086269040203, 4187.979060104711, 4196.895077623053, 4200.306949353353, 4203.243416185085, 4223.535411104776, 6375.362463753588, 6453.354664533556, 6479.384458476485, 6488.740450381979, 6504.772332968323, 5806.59353845231, 5815.040518314473, 5816.505597024258, 5819.359870414251, 5843.094320380348, 6708.228553716336, 7063.258357872401, 7080.114985626797, 7092.255313192092, 7150.5352152109945, 4578.793954272032, 4591.920898588829, 4597.9654577720075, 4607.032523170138, 4609.723416594981, 6378.93621063788, 7293.4529910256415, 7404.592747398891, 7430.554166750012, 7518.849623007564, 3901.6878649707955, 4636.0, 4642.837500687459, 4646.907061858744, 4658.7204767713365, 4101.384792281182, 4477.910441791146, 4580.473245576802, 4695.295705644113, 4723.126221649006, 5604.243427137366, 5608.46719561641, 5618.213450116987, 5624.437556244343, 5636.2954630671165, 5163.922541161885, 5953.434423729739, 6052.455279024909, 6322.747090116344, 6327.715252813635, 1601.6956778212102, 1631.4942367865763, 1635.5502236884713, 1640.4832477769464, 1641.048192048609, 823.8434697407473, 1010.6361709784471, 1029.2692188546216, 1039.781645854364, 1058.3702696895334, 6489.513286503531, 6633.170853643294, 6642.86714265712, 6644.169478815148, 6644.634545099969, 7441.441891858132, 7456.440766942393, 7467.439942004263, 7476.476646634792, 7477.140128885139, 6589.242237142694, 6609.173853268341, 6633.535652504375, 6635.0, 6637.46900247979, 3367.696907278357, 3827.3110840048503, 3880.9223815523533, 3927.626875446828, 3929.5677475477673, 7361.852762944711, 7627.283861131312, 7730.420218483524, 7739.61301934901, 7781.8832717509285, 7569.772906812805, 7631.3131818136635, 7634.580098094547, 7639.427042971799, 7660.961695191489, 5610.046292130348, 7731.188225236382, 7734.4585878989055, 7773.989381380385, 7775.883361749465, 7167.820804479721, 7352.669129889061, 7453.888191677021, 7469.626518674153, 7484.476086673881, 7264.128304603481, 7326.853462930605, 7331.340179383881, 7337.633118344168, 7349.412047036331, 7743.341815945708, 7744.961275193813, 7755.302022817974, 7758.68965241384, 7762.184970578234, 3915.275674000319, 4673.9298910517045, 4679.3448917150945, 4682.063587282625, 4692.882677933079, 7087.192765844677, 7407.444441666788, 7426.071741032371, 7434.7769566913075, 7448.1807001228735, 7157.391621712213, 7170.354668079689, 7180.676869540779, 7199.568025918462, 7203.675834587351, 7137.072180616487, 7152.892706609509, 7161.4986950912935, 7169.677364518505, 7173.748918787817, 7012.7545535906, 7018.157821061505, 7026.789196324118, 7029.61337126463, 7035.0, 5563.193336966036, 7071.045408869943, 7077.469189810682, 7157.105361829771, 7165.319294666998, 6655.767048153291, 6802.795916122524, 6831.9316806833285, 6893.7931862042215, 6905.205901321211], "unit": "score", "name": "prototype.html", "value": 5144.481923788069}, {"lowerIsBetter": false, "replicates": [628.7767842415946, 679.8606285711429, 744.7207297263525, 762.7368557847541, 796.0169191049054, 15305.234738263098, 15517.767233491506, 15518.767218491732, 15525.068495890255, 15547.61130971725, 12976.675583110427, 14173.43306267748, 14179.858201417983, 14229.146251224935, 14243.216623085726, 728.264452902567, 728.5701436152669, 873.52829472085, 901.9864702029474, 904.263025634106, 894.2622336572322, 894.432035657359, 907.9863802042942, 908.3596064774318, 908.695586978363, 965.6813251626982, 967.809594199132, 968.2834702320267, 968.4479846487505, 971.4414211828228, 697.0728930522394, 760.1714131596531, 761.3376362564549, 768.2394429514796, 937.6390089815402, 715.6421789105448, 718.2207305074, 718.4862823081522, 718.8095154783987, 719.2663483247059, 13946.721065578631, 15077.321520531603, 15090.622734431727, 15142.015768974981, 15158.0, 11514.481848316846, 12614.053945953998, 12631.684207894785, 12728.681782955407, 12964.87035129646, 10049.736906175642, 10075.798484030352, 10146.543405546769, 10443.791124177475, 10492.003259690317, 3334.983325083359, 3360.495925611178, 3387.661233876617, 3454.084667563098, 3501.19472521319, 82729.58635206845, 83026.58486707589, 83776.0, 88930.0, 89374.5531272346, 9530.666426675032, 9721.979192184861, 9813.067758562926, 9887.703368898945, 10032.247581431422, 22297.777022229893, 22299.104576110887, 22312.442188945406, 22314.55370892573, 22353.0, 7379.335859772539, 7580.9620951894885, 7664.34853037498, 7761.844763104819, 7784.727534536264, 4054.39184122384, 4070.633642972147, 4073.246449406869, 4125.216208920296, 4195.056112374691, 3588.748787584844, 3634.4184930411006, 3638.7634803737674, 3638.799866007342, 3657.743957922973, 643.7392855893371, 663.9701213445406, 666.3236814633151, 670.9765158219438, 678.2098854834162, 543.4809756682359, 569.8489900176456, 599.7750843433712, 610.185402487675, 614.8217017065001, 7852.475301893471, 8035.517868927883, 8188.631511581993, 8191.713290034821, 8583.65665373378, 572.3046498504337, 594.3580932592789, 596.379765044349, 605.459106573762, 643.1285608001184, 3758.3422900992764, 3780.319542482325, 3849.1531862990096, 3910.7066969976795, 3944.4280579315837, 93609.0, 96004.0, 96159.51920240354, 96414.0, 96859.0, 80556.59721701471, 81000.78498822522, 81229.0, 81347.0, 81577.59211203906, 70576.94134587985, 71102.64448677724, 71279.2872071283, 72652.0, 72791.0, 7488.5506869588, 7682.270184332479, 7692.7692169235015, 7880.17258187882, 8076.555789431402, 48980.75509622429, 49067.0, 49914.750426247636, 50079.74960125176, 51894.0, 60076.69961650164, 70355.0, 70723.23191920243, 70840.22899427556, 73295.0, 10238.385696858213, 11083.889161108285, 11130.833037504606, 11420.657380278604, 11500.712482187677, 11283.0, 11934.940325298317, 12078.75842483163, 12381.195222310522, 12471.688207794878, 11604.709882252673, 11900.107491938312, 11950.103742219195, 12048.75902481963, 12094.697632559257, 11636.0, 11669.183157178915, 11904.940475297915, 12050.276983381025, 12081.033517318769, 11181.552737890719, 11282.153838461983, 11302.0, 11595.420228988685, 12205.69485762863, 8084.878726818984, 9468.431894086378, 9565.426074435556, 9626.711198664052, 9723.611055557698, 8761.693340733043, 9145.143073225838, 9205.539723013688, 9526.0, 9745.074217949283], "unit": "score", "name": "yui.html", "value": 6928.729106984445}], "name": "dromaeo_css", "value": 7407.2972908791935}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 114.0, 112.0, 112.0, 116.0, 163.0, 161.0, 113.0, 111.0], "unit": "score", "name": "ai-astar", "value": 122.5}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 142.0, 160.0, 122.0, 143.0, 142.0, 118.0, 164.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 139.7}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 187.0, 188.0, 184.0, 185.0, 182.0, 183.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [72.0, 85.0, 73.0, 117.0, 56.0, 59.0, 57.0, 58.0, 120.0, 56.0], "unit": "score", "name": "audio-fft", "value": 75.3}, {"lowerIsBetter": true, "replicates": [91.0, 95.0, 127.0, 81.0, 77.0, 85.0, 115.0, 109.0, 110.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 103.8}, {"lowerIsBetter": true, "replicates": [90.0, 84.0, 125.0, 88.0, 88.0, 85.0, 89.0, 86.0, 90.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 93.0, 93.0, 93.0, 94.0, 95.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.8}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 88.0, 87.0, 85.0, 85.0, 85.0, 87.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 53.0, 54.0, 54.0, 53.0, 54.0, 64.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [67.0, 93.0, 78.0, 79.0, 74.0, 71.0, 69.0, 70.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 82.0, 84.0, 83.0, 83.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [136.0, 117.0, 129.0, 120.0, 126.0, 123.0, 120.0, 134.0, 126.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [140.0, 130.0, 140.0, 140.0, 135.0, 130.0, 145.0, 141.0, 141.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.1}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1440.6999999999998}]} 16:19:48 INFO - Return code: 0 16:19:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:48 ERROR - # TBPL SUCCESS # 16:19:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:48 INFO - 2016-03-26 16:19:48.391 screenresolution[1685:10615] starting screenresolution argv=screenresolution get 16:19:48 INFO - 2016-03-26 16:19:48.393 screenresolution[1685:10615] Display 0: 1600x1200x32@60 16:19:48 INFO - 2016-03-26 16:19:48.399 screenresolution[1686:10619] starting screenresolution argv=screenresolution list 16:19:48 INFO - Available Modes on Display 0 16:19:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:48 INFO - Intel Iris: 16:19:48 INFO - Chipset Model: Intel Iris 16:19:48 INFO - Type: GPU 16:19:48 INFO - Bus: Built-In 16:19:48 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:48 INFO - Vendor: Intel (0x8086) 16:19:48 INFO - Device ID: 0x0a2e 16:19:48 INFO - Revision ID: 0x0009 16:19:48 INFO - Displays: 16:19:48 INFO - Display: 16:19:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:48 INFO - Display Serial Number: 1600x1200 60 16:19:48 INFO - Main Display: Yes 16:19:48 INFO - Mirror: Off 16:19:48 INFO - Online: Yes 16:19:48 INFO - Rotation: Supported 16:19:48 INFO - Return code: 0 16:19:48 INFO - Running post-action listener: _resource_record_post_action 16:19:48 INFO - Running post-run listener: _resource_record_post_run 16:19:49 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34225664; Write bytes: 705335808; Read time: 361; Write time: 2125 16:19:49 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 385782272; Write bytes: 380020736; Read time: 29671; Write time: 688 16:19:49 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33299968; Write bytes: 300427776; Read time: 348; Write time: 1385 16:19:49 INFO - Running post-run listener: _upload_blobber_files 16:19:49 INFO - Blob upload gear active. 16:19:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:49 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 16:19:49 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'] 16:19:49 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 16:19:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:19:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:51 INFO - (blobuploader) - INFO - Done attempting. 16:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:52 INFO - (blobuploader) - INFO - Done attempting. 16:19:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:52 INFO - Return code: 0 16:19:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b55907467a6aea605a36e1efe591f25a7a07ccf284d95cda8dceb0fccac1bd25d05b48ac817852e90f4481a4e9ff806aa7fde7f3c6ee4cca68e6c5119a3862ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1702aaad7252f48136932f87a79fb5df4518f767f2968fbcb9c676e0c98b56ef2d64b14cdfc48a8794af14f3ac578a816b633ec8f7d563046f92ba0682e3ad01"} 16:19:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:52 INFO - Contents: 16:19:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b55907467a6aea605a36e1efe591f25a7a07ccf284d95cda8dceb0fccac1bd25d05b48ac817852e90f4481a4e9ff806aa7fde7f3c6ee4cca68e6c5119a3862ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1702aaad7252f48136932f87a79fb5df4518f767f2968fbcb9c676e0c98b56ef2d64b14cdfc48a8794af14f3ac578a816b633ec8f7d563046f92ba0682e3ad01"} 16:19:52 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:52 INFO - Copying logs to upload dir... 16:19:52 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.743917 ========= master_lag: 6.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-03-26 16:19:59.216357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-26 16:19:59.217491) ========= 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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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/b55907467a6aea605a36e1efe591f25a7a07ccf284d95cda8dceb0fccac1bd25d05b48ac817852e90f4481a4e9ff806aa7fde7f3c6ee4cca68e6c5119a3862ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1702aaad7252f48136932f87a79fb5df4518f767f2968fbcb9c676e0c98b56ef2d64b14cdfc48a8794af14f3ac578a816b633ec8f7d563046f92ba0682e3ad01"} build_url:https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011198 build_url: 'https://queue.taskcluster.net/v1/task/aK0MaGEWTR--_8kaEABlAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b55907467a6aea605a36e1efe591f25a7a07ccf284d95cda8dceb0fccac1bd25d05b48ac817852e90f4481a4e9ff806aa7fde7f3c6ee4cca68e6c5119a3862ab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1702aaad7252f48136932f87a79fb5df4518f767f2968fbcb9c676e0c98b56ef2d64b14cdfc48a8794af14f3ac578a816b633ec8f7d563046f92ba0682e3ad01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-26 16:19:59.252682) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 16:19:59.252999) ========= 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.nWhPRdb7kp/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.v5o8y28CKD/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005111 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 16:19:59.305530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-26 16:19:59.305869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-26 16:19:59.306205) ========= ========= Total master_lag: 7.15 =========