builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0148 starttime: 1458595778.95 results: success (0) buildid: 20160321115010 builduid: 6948140650c0488fa192c0237f57d58d revision: 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:38.954081) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:38.954599) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:38.954931) ========= 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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005557 basedir: '/builds/slave/test' ========= master_lag: 0.40 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:39.361878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-21 14:29:39.362202) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-03-21 14:29:40.756255) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:40.756643) ========= 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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005787 ========= master_lag: 0.45 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:41.209527) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:41.209831) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:41.214287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 14:29:41.214575) ========= 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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-21 14:29:41-- 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% 14.9M=0.001s 2016-03-21 14:29:42 (14.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.153061 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-21 14:29:42.579619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:42.579981) ========= 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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.027296 ========= master_lag: 0.40 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:43.011672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-21 14:29:43.012033) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 --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 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-21 14:29:43,190 truncating revision to first 12 chars 2016-03-21 14:29:43,190 Setting DEBUG logging. 2016-03-21 14:29:43,190 attempt 1/10 2016-03-21 14:29:43,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4eea3b603b0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 14:29:46,935 unpacking tar archive at: fx-team-4eea3b603b0a/testing/mozharness/ program finished with exit code 0 elapsedTime=8.575461 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-03-21 14:29:51.826067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:51.826518) ========= echo 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 program finished with exit code 0 elapsedTime=0.006268 script_repo_revision: '4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3' ========= master_lag: 0.54 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 14:29:52.372922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-03-21 14:29:52.373226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-03-21 14:29:57.054662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2016-03-21 14:29:57.055063) ========= /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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:29:57 INFO - MultiFileLogger online at 20160321 14:29:57 in /builds/slave/test 14:29:57 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 14:29:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:29:57 INFO - {'append_to_log': False, 14:29:57 INFO - 'base_work_dir': '/builds/slave/test', 14:29:57 INFO - 'blob_upload_branch': 'Fx-Team', 14:29:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:29:57 INFO - 'branch': 'Fx-Team', 14:29:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:29:57 INFO - 'config_files': ('talos/mac_config.py',), 14:29:57 INFO - 'default_actions': ('clobber', 14:29:57 INFO - 'read-buildbot-config', 14:29:57 INFO - 'download-and-extract', 14:29:57 INFO - 'populate-webroot', 14:29:57 INFO - 'create-virtualenv', 14:29:57 INFO - 'install', 14:29:57 INFO - 'run-tests'), 14:29:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:29:57 INFO - 'download_minidump_stackwalk': True, 14:29:57 INFO - 'download_symbols': 'ondemand', 14:29:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:29:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:29:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:29:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:29:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:29:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:29:57 INFO - 'installer_path': 'installer.exe', 14:29:57 INFO - 'log_level': 'info', 14:29:57 INFO - 'log_name': 'talos', 14:29:57 INFO - 'log_to_console': True, 14:29:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:29:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:29:57 INFO - 'opt_config_files': (), 14:29:57 INFO - 'pip_index': False, 14:29:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:29:57 INFO - 'cmd': ('bash', 14:29:57 INFO - '-c', 14:29:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:29:57 INFO - 'enabled': True, 14:29:57 INFO - 'halt_on_failure': False, 14:29:57 INFO - 'name': 'check_screen_resolution'},), 14:29:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:29:57 INFO - 'cmd': ('bash', 14:29:57 INFO - '-c', 14:29:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:29:57 INFO - 'enabled': True, 14:29:57 INFO - 'halt_on_failure': False, 14:29:57 INFO - 'name': 'check_screen_resolution'},), 14:29:57 INFO - 'run_cmd_checks_enabled': True, 14:29:57 INFO - 'sps_profile': False, 14:29:57 INFO - 'sps_profile_interval': 0, 14:29:57 INFO - 'suite': 'dromaeojs', 14:29:57 INFO - 'system_bits': '32', 14:29:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:29:57 INFO - 'title': 't-yosemite-r7-0148', 14:29:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:29:57 INFO - 'use_talos_json': True, 14:29:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:29:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:29:57 INFO - 'work_dir': 'build'} 14:29:57 INFO - ##### 14:29:57 INFO - ##### Running clobber step. 14:29:57 INFO - ##### 14:29:57 INFO - Running pre-action listener: _resource_record_pre_action 14:29:57 INFO - Running main action method: clobber 14:29:57 INFO - rmtree: /builds/slave/test/build 14:29:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:29:58 INFO - Running post-action listener: _resource_record_post_action 14:29:58 INFO - ##### 14:29:58 INFO - ##### Running read-buildbot-config step. 14:29:58 INFO - ##### 14:29:58 INFO - Running pre-action listener: _resource_record_pre_action 14:29:58 INFO - Running main action method: read_buildbot_config 14:29:58 INFO - Using buildbot properties: 14:29:58 INFO - { 14:29:58 INFO - "project": "", 14:29:58 INFO - "product": "firefox", 14:29:58 INFO - "script_repo_revision": "production", 14:29:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:29:58 INFO - "repository": "", 14:29:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:29:58 INFO - "buildid": "20160321115010", 14:29:58 INFO - "pgo_build": "False", 14:29:58 INFO - "basedir": "/builds/slave/test", 14:29:58 INFO - "buildnumber": 542, 14:29:58 INFO - "slavename": "t-yosemite-r7-0148", 14:29:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:29:58 INFO - "platform": "yosemite_r7", 14:29:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:29:58 INFO - "branch": "fx-team", 14:29:58 INFO - "repo_path": "integration/fx-team", 14:29:58 INFO - "revision": "4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3", 14:29:58 INFO - "stage_platform": "macosx64", 14:29:58 INFO - "builduid": "6948140650c0488fa192c0237f57d58d", 14:29:58 INFO - "slavebuilddir": "test" 14:29:58 INFO - } 14:29:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:29:58 INFO - Running post-action listener: _resource_record_post_action 14:29:58 INFO - ##### 14:29:58 INFO - ##### Running download-and-extract step. 14:29:58 INFO - ##### 14:29:58 INFO - Running pre-action listener: _resource_record_pre_action 14:29:58 INFO - Running main action method: download_and_extract 14:29:58 INFO - mkdir: /builds/slave/test/build/tests 14:29: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')]} 14:29:58 INFO - https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:29:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:29:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:29:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:02 INFO - Downloaded 1199 bytes. 14:30:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:30:02 INFO - Using the following test package requirements: 14:30:02 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:30:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:30:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:30:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'jsshell-mac.zip'], 14:30:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:30:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:30:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:30:02 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:30:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:30:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:30:02 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:30:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:02 INFO - https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:30:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:30:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:30:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:13 INFO - Downloaded 17858508 bytes. 14:30:13 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'] 14:30:13 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 14:30:16 INFO - Return code: 0 14:30:16 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 14:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:16 INFO - https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:35 INFO - Downloaded 17858508 bytes. 14:30:35 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'] 14:30:35 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 14:30:39 INFO - Return code: 0 14:30:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:30:39 INFO - https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:30:54 INFO - Downloaded 10847637 bytes. 14:30:54 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'] 14:30:54 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 14:30:55 INFO - Return code: 0 14:30:55 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')]} 14:30:55 INFO - https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:30:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:30:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:30:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNvPRZgmTHSevpAlp7x0gg/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 14:31:25 INFO - Downloaded 111267269 bytes. 14:31:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:31:25 INFO - mkdir: /builds/slave/test/properties 14:31:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:25 INFO - Contents: 14:31:25 INFO - build_url:https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:31:29 INFO - Running post-action listener: _resource_record_post_action 14:31:29 INFO - Running post-action listener: set_extra_try_arguments 14:31:29 INFO - ##### 14:31:29 INFO - ##### Running populate-webroot step. 14:31:29 INFO - ##### 14:31:29 INFO - Running pre-action listener: _resource_record_pre_action 14:31:29 INFO - Running main action method: populate_webroot 14:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:31:29 INFO - '--tppagecycles', 14:31:29 INFO - '7'], 14:31:29 INFO - 'tests': ['tsvgm']}}, 14:31:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:31:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:31:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:31:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:31:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:31:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'tests': ['damp', 'tps']}, 14:31:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['damp', 'tps']}, 14:31:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:31:29 INFO - 'other': {'tests': ['a11yr', 14:31:29 INFO - 'ts_paint', 14:31:29 INFO - 'tpaint', 14:31:29 INFO - 'sessionrestore', 14:31:29 INFO - 'sessionrestore_no_auto_restore', 14:31:29 INFO - 'tabpaint']}, 14:31:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['a11yr', 14:31:29 INFO - 'ts_paint', 14:31:29 INFO - 'tpaint', 14:31:29 INFO - 'sessionrestore', 14:31:29 INFO - 'sessionrestore_no_auto_restore', 14:31:29 INFO - 'tabpaint']}, 14:31:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['a11yr', 14:31:29 INFO - 'ts_paint', 14:31:29 INFO - 'tpaint', 14:31:29 INFO - 'sessionrestore', 14:31:29 INFO - 'sessionrestore_no_auto_restore', 14:31:29 INFO - 'tabpaint']}, 14:31:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['a11yr', 14:31:29 INFO - 'ts_paint', 14:31:29 INFO - 'tpaint', 14:31:29 INFO - 'sessionrestore', 14:31:29 INFO - 'sessionrestore_no_auto_restore', 14:31:29 INFO - 'tabpaint']}, 14:31:29 INFO - 'other_l64': {'tests': ['a11yr', 14:31:29 INFO - 'ts_paint', 14:31:29 INFO - 'tpaint', 14:31:29 INFO - 'sessionrestore', 14:31:29 INFO - 'sessionrestore_no_auto_restore', 14:31:29 INFO - 'tabpaint']}, 14:31:29 INFO - 'other_nol64': {'tests': ['a11yr', 14:31:29 INFO - 'ts_paint', 14:31:29 INFO - 'tpaint', 14:31:29 INFO - 'sessionrestore', 14:31:29 INFO - 'sessionrestore_no_auto_restore', 14:31:29 INFO - 'tabpaint']}, 14:31:29 INFO - 'svgr': {'tests': ['tsvgx', 14:31:29 INFO - 'tsvgr_opacity', 14:31:29 INFO - 'tart', 14:31:29 INFO - 'tscrollx', 14:31:29 INFO - 'cart']}, 14:31:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['tsvgx', 14:31:29 INFO - 'tsvgr_opacity', 14:31:29 INFO - 'tart', 14:31:29 INFO - 'tscrollx', 14:31:29 INFO - 'cart']}, 14:31:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'tests': ['tp5o']}, 14:31:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'talos_options': ['--e10s'], 14:31:29 INFO - 'tests': ['tp5o']}, 14:31:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'talos_options': ['--xperf_path', 14:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:29 INFO - 'tests': ['tp5n']}, 14:31:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:31:29 INFO - 'talos_options': ['--e10s', 14:31:29 INFO - '--xperf_path', 14:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:31:29 INFO - 'tests': ['tp5n']}}, 14:31:29 INFO - 'talos.zip': {'path': '', 14:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:31:29 INFO - Running post-action listener: _resource_record_post_action 14:31:29 INFO - ##### 14:31:29 INFO - ##### Running create-virtualenv step. 14:31:29 INFO - ##### 14:31:29 INFO - Running pre-action listener: _resource_record_pre_action 14:31:29 INFO - Running main action method: create_virtualenv 14:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:31:29 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 14:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:31:29 INFO - Using real prefix '/tools/python27' 14:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:31:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:31:33 INFO - Installing pip.................done. 14:31:33 INFO - Return code: 0 14:31:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:33 INFO - 'HOME': '/Users/cltbld', 14:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:33 INFO - 'LOGNAME': 'cltbld', 14:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:33 INFO - 'MOZ_NO_REMOTE': '1', 14:31:33 INFO - 'NO_EM_RESTART': '1', 14:31:33 INFO - 'PAGER': '/bin/cat', 14:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:33 INFO - 'PWD': '/builds/slave/test', 14:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:33 INFO - 'SHELL': '/bin/bash', 14:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:31:33 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:33 INFO - 'USER': 'cltbld', 14:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:33 INFO - 'XPC_FLAGS': '0x0', 14:31:33 INFO - 'XPC_SERVICE_NAME': '0', 14:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:33 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 14:31:33 INFO - Cleaning up... 14:31:33 INFO - Return code: 0 14:31:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:31:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:31:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:33 INFO - 'HOME': '/Users/cltbld', 14:31:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:33 INFO - 'LOGNAME': 'cltbld', 14:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:33 INFO - 'MOZ_NO_REMOTE': '1', 14:31:33 INFO - 'NO_EM_RESTART': '1', 14:31:33 INFO - 'PAGER': '/bin/cat', 14:31:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:33 INFO - 'PWD': '/builds/slave/test', 14:31:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:33 INFO - 'SHELL': '/bin/bash', 14:31:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:31:33 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:31:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:33 INFO - 'USER': 'cltbld', 14:31:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:33 INFO - 'XPC_FLAGS': '0x0', 14:31:33 INFO - 'XPC_SERVICE_NAME': '0', 14:31:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:33 INFO - Downloading/unpacking psutil>=0.7.1 14:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:31:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:44 INFO - Installing collected packages: psutil 14:31:44 INFO - Running setup.py install for psutil 14:31:44 INFO - building 'psutil._psutil_osx' extension 14:31:44 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 14:31:44 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 14:31:44 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 14:31:45 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 14:31:45 INFO - building 'psutil._psutil_posix' extension 14:31:45 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 14:31:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:31:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:31:45 INFO - ^ 14:31:45 INFO - 1 warning generated. 14:31:45 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 14:31:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:31:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:31:45 INFO - Successfully installed psutil 14:31:45 INFO - Cleaning up... 14:31:45 INFO - Return code: 0 14:31:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31: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')]} 14:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:46 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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:31:46 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 14:31:46 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 14:31:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:31:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:46 INFO - 'HOME': '/Users/cltbld', 14:31:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:46 INFO - 'LOGNAME': 'cltbld', 14:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:46 INFO - 'MOZ_NO_REMOTE': '1', 14:31:46 INFO - 'NO_EM_RESTART': '1', 14:31:46 INFO - 'PAGER': '/bin/cat', 14:31:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:46 INFO - 'PWD': '/builds/slave/test', 14:31:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:46 INFO - 'SHELL': '/bin/bash', 14:31:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:31:46 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:31:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:46 INFO - 'USER': 'cltbld', 14:31:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:46 INFO - 'XPC_FLAGS': '0x0', 14:31:46 INFO - 'XPC_SERVICE_NAME': '0', 14:31:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:31:46 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 14:31:46 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 14:31:46 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 14:31:46 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 14:31:46 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 14:31:46 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 14:31:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:31:55 INFO - Installing collected packages: mozsystemmonitor 14:31:55 INFO - Running setup.py install for mozsystemmonitor 14:31:55 INFO - Successfully installed mozsystemmonitor 14:31:55 INFO - Cleaning up... 14:31:55 INFO - Return code: 0 14:31:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:31:55 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')]} 14:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:55 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')]} 14:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:31:55 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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:31:55 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 14:31:55 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 14:31:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:31:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:31:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:31:55 INFO - 'HOME': '/Users/cltbld', 14:31:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:31:55 INFO - 'LOGNAME': 'cltbld', 14:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:31:55 INFO - 'MOZ_NO_REMOTE': '1', 14:31:55 INFO - 'NO_EM_RESTART': '1', 14:31:55 INFO - 'PAGER': '/bin/cat', 14:31:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:31:55 INFO - 'PWD': '/builds/slave/test', 14:31:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:31:55 INFO - 'SHELL': '/bin/bash', 14:31:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:31:55 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:31:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:31:55 INFO - 'USER': 'cltbld', 14:31:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:31:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:31:55 INFO - 'XPC_FLAGS': '0x0', 14:31:55 INFO - 'XPC_SERVICE_NAME': '0', 14:31:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:31:55 INFO - Downloading/unpacking blobuploader==1.2.4 14:31:55 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 14:31:55 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 14:31:55 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 14:31:55 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 14:31:55 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 14:31:55 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 14:32:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:08 INFO - Downloading docopt-0.6.1.tar.gz 14:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:08 INFO - Running setup.py install for blobuploader 14:32:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:08 INFO - Running setup.py install for requests 14:32:08 INFO - Running setup.py install for docopt 14:32:09 INFO - Successfully installed blobuploader requests docopt 14:32:09 INFO - Cleaning up... 14:32:09 INFO - Return code: 0 14:32:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:09 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')]} 14:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:09 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')]} 14:32:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:09 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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:32:09 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 14:32:09 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 14:32:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:32:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:09 INFO - 'HOME': '/Users/cltbld', 14:32:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:09 INFO - 'LOGNAME': 'cltbld', 14:32:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:09 INFO - 'MOZ_NO_REMOTE': '1', 14:32:09 INFO - 'NO_EM_RESTART': '1', 14:32:09 INFO - 'PAGER': '/bin/cat', 14:32:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:09 INFO - 'PWD': '/builds/slave/test', 14:32:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:09 INFO - 'SHELL': '/bin/bash', 14:32:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:32:09 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:32:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:09 INFO - 'USER': 'cltbld', 14:32:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:09 INFO - 'XPC_FLAGS': '0x0', 14:32:09 INFO - 'XPC_SERVICE_NAME': '0', 14:32:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:09 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-4DcatK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:09 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ARC25I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:09 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Vchv6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:09 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-P8W5Y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:09 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-PtWYMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:09 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-yP8Wfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-JmrdGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-AERgUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-jbWf8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-5Ae08A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-GRgyUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-snGneX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-I7yCkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-87VkdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-yaHlk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:10 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-5tqrsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:11 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-csFOrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:11 INFO - Running setup.py install for manifestparser 14:32:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:11 INFO - Running setup.py install for mozcrash 14:32:11 INFO - Running setup.py install for mozdebug 14:32:11 INFO - Running setup.py install for mozdevice 14:32:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:11 INFO - Running setup.py install for mozfile 14:32:11 INFO - Running setup.py install for mozhttpd 14:32:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Running setup.py install for mozinfo 14:32:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Running setup.py install for mozInstall 14:32:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Running setup.py install for mozleak 14:32:12 INFO - Running setup.py install for mozlog 14:32:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Running setup.py install for moznetwork 14:32:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:12 INFO - Running setup.py install for mozprocess 14:32:12 INFO - Running setup.py install for mozprofile 14:32:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Running setup.py install for mozrunner 14:32:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Running setup.py install for mozscreenshot 14:32:13 INFO - Running setup.py install for moztest 14:32:13 INFO - Running setup.py install for mozversion 14:32:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:13 INFO - Cleaning up... 14:32:13 INFO - Return code: 0 14:32:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:13 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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:32:13 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 14:32:13 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 14:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:13 INFO - 'HOME': '/Users/cltbld', 14:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:13 INFO - 'LOGNAME': 'cltbld', 14:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:13 INFO - 'MOZ_NO_REMOTE': '1', 14:32:13 INFO - 'NO_EM_RESTART': '1', 14:32:13 INFO - 'PAGER': '/bin/cat', 14:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:13 INFO - 'PWD': '/builds/slave/test', 14:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:13 INFO - 'SHELL': '/bin/bash', 14:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:32:13 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:13 INFO - 'USER': 'cltbld', 14:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:13 INFO - 'XPC_FLAGS': '0x0', 14:32:13 INFO - 'XPC_SERVICE_NAME': '0', 14:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-RATe0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-6btOrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-rEK8uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-bZyW0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-qZLpPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-HTYgid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ESpdm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-edXBvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:14 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-67e3i4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:14 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)) 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Yno6dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-U7JyYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-trCCBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-wLp03n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-jNxNky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-7i7xNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-nA5cgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:15 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)) 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:15 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ORYYDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:15 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)) 14:32:15 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)) 14:32:15 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)) 14:32:15 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)) 14:32:15 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)) 14:32:15 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)) 14:32:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:24 INFO - Downloading blessings-1.6.tar.gz 14:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:24 INFO - Installing collected packages: blessings 14:32:24 INFO - Running setup.py install for blessings 14:32:25 INFO - Successfully installed blessings 14:32:25 INFO - Cleaning up... 14:32:25 INFO - Return code: 0 14:32:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:25 INFO - Reading from file tmpfile_stdout 14:32:25 INFO - Current package versions: 14:32:25 INFO - blessings == 1.6 14:32:25 INFO - blobuploader == 1.2.4 14:32:25 INFO - docopt == 0.6.1 14:32:25 INFO - manifestparser == 1.1 14:32:25 INFO - mozInstall == 1.12 14:32:25 INFO - mozcrash == 0.17 14:32:25 INFO - mozdebug == 0.1 14:32:25 INFO - mozdevice == 0.48 14:32:25 INFO - mozfile == 1.2 14:32:25 INFO - mozhttpd == 0.7 14:32:25 INFO - mozinfo == 0.9 14:32:25 INFO - mozleak == 0.1 14:32:25 INFO - mozlog == 3.1 14:32:25 INFO - moznetwork == 0.27 14:32:25 INFO - mozprocess == 0.22 14:32:25 INFO - mozprofile == 0.28 14:32:25 INFO - mozrunner == 6.11 14:32:25 INFO - mozscreenshot == 0.1 14:32:25 INFO - mozsystemmonitor == 0.0 14:32:25 INFO - moztest == 0.7 14:32:25 INFO - mozversion == 1.4 14:32:25 INFO - psutil == 3.1.1 14:32:25 INFO - requests == 1.2.3 14:32:25 INFO - wsgiref == 0.1.2 14:32:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:25 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')]} 14:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:25 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')]} 14:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:25 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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:32:25 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 14:32:25 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 14:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:25 INFO - 'HOME': '/Users/cltbld', 14:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:25 INFO - 'LOGNAME': 'cltbld', 14:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:25 INFO - 'MOZ_NO_REMOTE': '1', 14:32:25 INFO - 'NO_EM_RESTART': '1', 14:32:25 INFO - 'PAGER': '/bin/cat', 14:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:25 INFO - 'PWD': '/builds/slave/test', 14:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:25 INFO - 'SHELL': '/bin/bash', 14:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:32:25 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:25 INFO - 'USER': 'cltbld', 14:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:25 INFO - 'XPC_FLAGS': '0x0', 14:32:25 INFO - 'XPC_SERVICE_NAME': '0', 14:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 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)) 14:32:25 INFO - Cleaning up... 14:32:25 INFO - Return code: 0 14:32:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32:25 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')]} 14:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:25 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')]} 14:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:25 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 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:32:25 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 14:32:25 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 14:32:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:32:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:25 INFO - 'HOME': '/Users/cltbld', 14:32:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:25 INFO - 'LOGNAME': 'cltbld', 14:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:25 INFO - 'MOZ_NO_REMOTE': '1', 14:32:25 INFO - 'NO_EM_RESTART': '1', 14:32:25 INFO - 'PAGER': '/bin/cat', 14:32:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:25 INFO - 'PWD': '/builds/slave/test', 14:32:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:25 INFO - 'SHELL': '/bin/bash', 14:32:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:32:25 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:32:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:25 INFO - 'USER': 'cltbld', 14:32:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:25 INFO - 'XPC_FLAGS': '0x0', 14:32:25 INFO - 'XPC_SERVICE_NAME': '0', 14:32:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:25 INFO - Downloading/unpacking jsonschema 14:32:25 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 14:32:25 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 14:32:25 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 14:32:25 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 14:32:25 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 14:32:25 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 14:32:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:32 INFO - Downloading/unpacking functools32 (from jsonschema) 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32: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 14:32:33 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:33 INFO - warning: no files found matching '*.txt' 14:32:33 INFO - no previously-included directories found matching 'build' 14:32:33 INFO - no previously-included directories found matching 'dist' 14:32:33 INFO - no previously-included directories found matching '.git*' 14:32:33 INFO - Installing collected packages: jsonschema, functools32 14:32:33 INFO - Running setup.py install for functools32 14:32:33 INFO - warning: no files found matching '*.txt' 14:32:33 INFO - no previously-included directories found matching 'build' 14:32:33 INFO - no previously-included directories found matching 'dist' 14:32:33 INFO - no previously-included directories found matching '.git*' 14:32:33 INFO - Successfully installed jsonschema functools32 14:32:33 INFO - Cleaning up... 14:32:33 INFO - Return code: 0 14:32:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1068c5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068d5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca3b5937c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, '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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 14:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:33 INFO - 'HOME': '/Users/cltbld', 14:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:33 INFO - 'LOGNAME': 'cltbld', 14:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:33 INFO - 'MOZ_NO_REMOTE': '1', 14:32:33 INFO - 'NO_EM_RESTART': '1', 14:32:33 INFO - 'PAGER': '/bin/cat', 14:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:33 INFO - 'PWD': '/builds/slave/test', 14:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:33 INFO - 'SHELL': '/bin/bash', 14:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:32:33 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:33 INFO - 'USER': 'cltbld', 14:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:33 INFO - 'XPC_FLAGS': '0x0', 14:32:33 INFO - 'XPC_SERVICE_NAME': '0', 14:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:33 INFO - Downloading/unpacking flake8 14:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:32:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:32:45 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 14:32:45 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 14:32:45 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 14:32:45 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 14:32:45 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 14:32:45 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 14:32:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:32:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:32:46 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 14:32:46 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 14:32:46 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 14:32:46 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 14:32:46 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 14:32:46 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 14:32:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:48 INFO - no previously-included directories found matching 'docs/_build' 14:32:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:32:48 INFO - Running setup.py install for pep8 14:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:48 INFO - no previously-included directories found matching 'docs/_build' 14:32:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:32:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:32:48 INFO - Cleaning up... 14:32:48 INFO - Return code: 0 14:32:48 INFO - Running post-action listener: _resource_record_post_action 14:32:48 INFO - Running post-action listener: _start_resource_monitoring 14:32:48 INFO - Starting resource monitoring. 14:32:48 INFO - ##### 14:32:48 INFO - ##### Running install step. 14:32:48 INFO - ##### 14:32:48 INFO - Running pre-action listener: _resource_record_pre_action 14:32:48 INFO - Running main action method: install 14:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:49 INFO - Reading from file tmpfile_stdout 14:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:49 INFO - Reading from file tmpfile_stdout 14:32:49 INFO - Output received: 14:32:49 INFO - Usage: mozinstall [options] installer 14:32:49 INFO - Options: 14:32:49 INFO - -h, --help show this help message and exit 14:32:49 INFO - -d DEST, --destination=DEST 14:32:49 INFO - Directory to install application into. [default: 14:32:49 INFO - "/builds/slave/test"] 14:32:49 INFO - --app=APP Application being installed. [default: firefox] 14:32:49 INFO - mkdir: /builds/slave/test/build/application 14:32:49 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'] 14:32:49 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 14:33:23 INFO - Reading from file tmpfile_stdout 14:33:23 INFO - Output received: 14:33:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:33:23 INFO - Running post-action listener: _resource_record_post_action 14:33:23 INFO - ##### 14:33:23 INFO - ##### Running run-tests step. 14:33:23 INFO - ##### 14:33:23 INFO - Running pre-action listener: _resource_record_pre_action 14:33:23 INFO - Running main action method: run_tests 14:33:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:23 INFO - 2016-03-21 14:33:23.229 screenresolution[1645:8036] starting screenresolution argv=screenresolution get 14:33:23 INFO - 2016-03-21 14:33:23.231 screenresolution[1645:8036] Display 0: 1600x1200x32@60 14:33:23 INFO - 2016-03-21 14:33:23.237 screenresolution[1646:8038] starting screenresolution argv=screenresolution list 14:33:23 INFO - Available Modes on Display 0 14:33:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:23 INFO - Intel Iris: 14:33:23 INFO - Chipset Model: Intel Iris 14:33:23 INFO - Type: GPU 14:33:23 INFO - Bus: Built-In 14:33:23 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:23 INFO - Vendor: Intel (0x8086) 14:33:23 INFO - Device ID: 0x0a2e 14:33:23 INFO - Revision ID: 0x0009 14:33:23 INFO - Displays: 14:33:23 INFO - Display: 14:33:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:23 INFO - Display Serial Number: 1600x1200 60 14:33:23 INFO - Main Display: Yes 14:33:23 INFO - Mirror: Off 14:33:23 INFO - Online: Yes 14:33:23 INFO - Rotation: Supported 14:33:23 INFO - Return code: 0 14:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:23 INFO - Python 2.7.3 14:33:23 INFO - Return code: 0 14:33:23 INFO - grabbing minidump binary from tooltool 14:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:33:23 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 0x106764e00>, '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 0x10658ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:23 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 14:33:23 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 14:33:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:23 INFO - Return code: 0 14:33:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:33:24 INFO - Return code: 0 14:33:24 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/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 14:33:24 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/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0148 --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 14:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r7QEIIO4Ws/Render', 14:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:24 INFO - 'HOME': '/Users/cltbld', 14:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:24 INFO - 'LOGNAME': 'cltbld', 14:33:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:24 INFO - 'MOZ_NO_REMOTE': '1', 14:33:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:24 INFO - 'NO_EM_RESTART': '1', 14:33:24 INFO - 'PAGER': '/bin/cat', 14:33:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:24 INFO - 'PWD': '/builds/slave/test', 14:33:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:24 INFO - 'SHELL': '/bin/bash', 14:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UW32g3UHOT/Listeners', 14:33:24 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 14:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:24 INFO - 'USER': 'cltbld', 14:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:24 INFO - 'XPC_FLAGS': '0x0', 14:33:24 INFO - 'XPC_SERVICE_NAME': '0', 14:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:24 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/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 14:33:24 INFO - mozversion application_buildid: 20160321115010 14:33:24 INFO - mozversion application_changeset: 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 14:33:24 INFO - mozversion application_display_name: Nightly 14:33:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:24 INFO - mozversion application_name: Firefox 14:33:24 INFO - mozversion application_remotingname: firefox 14:33:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:33:24 INFO - mozversion application_vendor: Mozilla 14:33:24 INFO - mozversion application_version: 48.0a1 14:33:24 INFO - mozversion platform_buildid: 20160321115010 14:33:24 INFO - mozversion platform_changeset: 4eea3b603b0aca9c157dc2e9f3bb3c0d9f23b1c3 14:33:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:33:24 INFO - mozversion platform_version: 48.0a1 14:33:24 INFO - using testdate: 1458596004 14:33:24 INFO - actual date: 1458596004 14:33:24 INFO - starting webserver on 'localhost:49271' 14:33:24 INFO - SUITE-START | Running 2 tests 14:33:24 INFO - TEST-START | dromaeo_css 14:33:24 INFO - operating with platform_type : mac_ 14:33:24 INFO - Initialising browser for dromaeo_css test... 14:33:24 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpTrXGyd/profile http://localhost:49271/getInfo.html) 14:33:27 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:33:27 INFO - PROCESS | 1664 | colorDepth:24 14:33:27 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:33:27 INFO - PROCESS | 1664 | __metrics 14:33:27 INFO - PROCESS | 1664 | 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" 14:33:27 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:33:28 INFO - TEST-INFO | 1664: exit 0 14:33:28 INFO - Browser initialized. 14:33:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:28 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpTrXGyd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:40 INFO - PROCESS | 1668 | RSS: Main: 246759424 14:33:40 INFO - PROCESS | 1668 | 14:34:31 INFO - PROCESS | 1668 | 1458596071442 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] 14:36:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 14:36:43 INFO - PROCESS | 1668 | RSS: Main: 384999424 14:36:43 INFO - PROCESS | 1668 | 14:39:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 14:39:46 INFO - PROCESS | 1668 | RSS: Main: 377122816 14:39:46 INFO - PROCESS | 1668 | 14:42:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 14:42:48 INFO - PROCESS | 1668 | RSS: Main: 376041472 14:42:48 INFO - PROCESS | 1668 | 14:45:51 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 14:45:51 INFO - PROCESS | 1668 | RSS: Main: 336076800 14:45:51 INFO - PROCESS | 1668 | 14:48:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 14:48:55 INFO - PROCESS | 1668 | RSS: Main: 338505728 14:48:55 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 14:51:58 INFO - PROCESS | 1668 | RSS: Main: 383787008 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | __start_tp_report 14:51:58 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 14:51:58 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 14:51:58 INFO - PROCESS | 1668 | |i|pagename|runs| 14:51:58 INFO - PROCESS | 1668 | |0;dojo.html;3387.3733359328526;3499.8250087495617;3518.173229291116;3526.418141006734;3575.785452872828;5528.55771538277;5577.163425486179;5637.9718101409535;5663;5677.545796336293;5548.140038294071;5652.06740887753;5653.745581448834;5657.801976930808;5665.688387138705;5094.46508116648;5121.846344609658;5145.176771716526;5161.993411284801;5195.818146364878;5207.140821764404;5214.869628259305;5223.869403264911;5229.450907654698;5234.26720259164;4136.255474014676;5192.8701782455555;5211.088059589576;5215.4523775003645;5216.165413533835;5171.870703232412;5211.062008838408;5226.346706661668;5230.973845130788;5295.099833028395;5076.263941728429;5118.10433174193;5135.512126347991;5135.871603209912;5144.4083930348115;5561.221428999943;5561.972190139023;5579.804706835282;5583.8604034899045;5675.460831221028;6209.658468784215;6233.470155036827;6238;6242.594231374991;6250.343713910065;5022.874428139289;6141.938580614182;6242.157308763304;6253.562250642457;6270.561060725751;5773.451522105393;5776.393478684761;5776.624519406225;5789.2763404574425;5789.565782566325;6236.688165591702;6245.250569931546;6248.968755156195;6259.217597800275;6269.8746025079245;4922.286268491049;5968.46283834457;6088.756449742049;6123.173371594867;6145.432914606747;5204.5576126028955;6192.938070619326;6215.471684906834;6223.875522489525;6245.656488893063;6104.542159338067;6134.938650613437;6172.660503672341;6184.752609895554;6193.566450348522;6062.272527296753;6121.209103132296;6159.722812473449;6236.158118654014;6245.812625621239;4901.044296362246;4902.852914412573;4910.6987690978485;4913.508649135058;4919.803207871717;4410.1400226956075;4421.9336709949375;4438.378626992224;4452.398926144993;4480.820767169342;5624.493795558419;5706.686132262683;5723.141528770634;5724;5782.017057100303;6152.692365381713;6163.260408750889;6170.876582468325;6176.66028368435;6198.659073750987;5619.719014049281;5622.493975542221;5636.746346414421;5638.436156384329;5638.746256418471;4915.0415668944215;5210.609204309692;5226.529612334832;5288.365396152486;5327.334083239595;6271.4669253114;6319.557630965788;6346.873062538631;6360.236771587347;6362.172917520786;6243.625382477066;6252.874942501034;6273.71768270438;6284.057391391328;6295.244570651551;6148.631082135086;6271.184745982993;6295.087212354275;6325.652089135142;6356.841078972878;6129.141920131096;6181.165542651865;6195.876082478415;6197.070439434121;6212.658303793335;6143.017117261216;6232.09634602971;6256.718447669775;6265.216847894013;6266.592671476339;4558.726476411426;5966.910496342645;6081.118237855575;6134.344744984565;6156.476699480415;6109.070667812992;6117.900468191327;6132.569672417391;6138.51101655979;6142.560166306883;5937.3468918418075;5953.613015154001;5954.434328738763;5957.76168953237;5995.820125396245;5816.185733997159;5902.822915312548;5943.138244954371;6018.879622407615;6127.84680382994;5836.270466191726;5879.882402352015;5903.114532820111;5938.257717785277;5963.582549221686 14:51:58 INFO - PROCESS | 1668 | |1;ext.html;526.0741095671617;578.2569398323155;580.5906835680844;605.4762630324767;627.0969803482984;30668.233294167658;39206.01984950378;39567.604323956824;39611.40582891259;39625;41294.79352603233;41928;42042.369364459555;42102;42208.82449983503;9419.29355298352;9638.710838674815;9641.13229809317;9662.32363734539;9695.854562181574;9562.0916012979;9711.12599866012;9713.70858874235;9720.902790972106;9730.756731081745;9679.419234845896;9745.122938935494;9745.171660408874;9746.756331091745;9750.609975600968;9621.855672164924;9710.563024663907;9712.951435242849;9714.757131071708;9718.028197180296;9569.425834449956;9730.756731081708;9740.220782337467;9740.805183896282;9755.414675119444;40695.59304406948;41231.96920076992;41297.96755081117;41409.1718165638;41418;3240.3519296140867;3259.9185020374443;3398.150462384404;3428.879989200391;3490.4415293553166;28807.423851522854;29067;29695.5545666813;29718.108456746115;29825.25436864074;2700.2709268497397;2727.8499682517454;2734.6991830898783;2847.373577812878;2888.581155732407;482874.58562707313;483545;485633;485836;487262.99999999645;45036;63804.68097659482;63983.6800815993;64023;64197.67901160558;45196.57641083091;45343.31985020227;45405;45441.31838022432;45455;15153.848461515465;15366.615834604225;15380.692386152214;15391.384344626313;15410.383584656489;12288.324142172267;12344.074194435454;12361.381930903599;12375.6906077347;12385.876141238652;14451.566453006426;14519;14669.33987970544;14796.926015370069;14854;5490.835274941758;6396.328385519547;6534.967325163344;6575.506836987245;6598.076269322299;1005.8985410974971;1057.6932689519954;1138.6584024792694;1148.2134737704698;1192.1059205595802;28944.85527572391;29085.41829163405;29604.40791184164;29775.10674679763;29790.702092979227;1070.6092276319243;1091.5688303120382;1182.7930112230497;1194.6619785839741;1214.2957084890743;14582.30227407933;14718.705625887636;14804.991499693408;14821.92589037048;15001.774973375408;516359;522900;523490;525181;528276;58155.41844581585;58884.82230355369;58985.705071475226;59042.70478647579;59069;1399.783033629789;1475.1886462445611;1478.3495262084648;1490.0835985868612;1510.4864346122151;28219.71780282253;28325.291867703472;28907.56638650464;28955.13134605965;28956.131316060553;44973.77513112414;45294.54705452903;45788.084238315714;45798.31302530398;45985.77007114943;312037;318898;319247;319311;319363;28914.27714307159;32410.675893240765;33093.67625294961;33531.83234083814;33778.3244335107;42679.146417070864;46027.07945840997;47177.764111179225;47503.762481187376;47911.520884790705;36036.27927441489;36072;36079;37062;37354;35397.82301088478;35505.64494355127;35838.820805896845;36200.45699314565;36302.636973629924;35373.64626353807;35589.46615800713;36464.635353646125;37182.705718271005;38197.427038595;31357.8432107838;32783.83608081944;32794.016179514656;32837.83581082079;32838.179045523095;24126.638100428157;24457.143999959917;24530.75469245356;25001.624975625018;25167.37081572975 14:51:58 INFO - PROCESS | 1668 | |2;jquery.html;368.2689860626657;369.6543731610943;372.3130823630403;379.37213910977323;382.10777833758175;19039.904800475997;19615.11731972061;20595;20795.792042079574;20804.687929681066;17493.338132877387;19462.90268548655;20330.08514616842;21315.57368852622;21370.57258854822;5613.129964855444;5835.912461313083;5862.413758624146;5870.97064514679;5933.88132237355;4138.937915931264;4166.770827604496;5786.479216870481;6392.808215753512;6415.518836087289;6319.862424763541;6350.714217860207;6358.650274234915;6367;6367.458766004872;5251.894962100756;6120.724567394478;6325.715342809584;6334.651594162319;6336.52476064297;5489.258950041733;5490.752916118784;5492.450754924515;5502.9174562381595;5525.11598144299;24519.509609807883;25704.871475642503;26015.21954341373;26024.219273421826;26041.609375859378;2107.451167601537;2112.746470423559;2144.281665642012;2543.9364015899564;2857.6142220800134;14049.71900561983;14140.15159090458;14349.641258968504;14671.119732816065;14717.632059198499;1489.2851431312922;1576.7004269188817;1669.8079720832018;1767.2135899524717;1772.7872655281449;95268.57097143549;97589.0241097587;97977.5101124497;98023;98292;8774.956125219333;10319.690409287734;10552.736181595368;10880.183986201067;11022.393768342657;12967.481300747864;13003.674908127183;13013.674658133623;13051.543195988284;13062.673433164247;8338.458000229966;8557.871631925525;8559.443636163629;8648.481091134552;8650.697225597074;8738.563071846509;8758.47449153053;8772.95613521941;8881.156290152425;8932.508712020901;6069.787557435468;6282.340354262828;6294.496440284766;6313.368663133741;6369.617822930639;1524.5578782153273;1682.512071499276;1778.813224611423;1809.9185536650882;1816.3188804198426;835.9582020898931;958.1951161024773;992.6178421307849;1067.5889782433665;1069.6363236499471;19906.701399479018;20876.851773152317;21040.894795525925;21105.68341474879;21159.153633854472;953.4327075390132;980.6763767956558;984.7144328144758;1010.434156872154;1021.5403068619152;9418.10527999839;10988;11592.130590205768;11698.181127321175;11709.590164344378;618087;623545;639146;641326;642763;87057;102579.46130808044;104644;106255.46872265743;108702;989.3322007644811;1032.2464600841429;1049.4175732468552;1050.7425680708275;1051.731808388856;18597.628047439244;18954.147063381904;19029.429117126507;19175.137118829407;19180.808191917902;50706;50897.745511273686;51016.34236582286;51211.74394128005;51214.74392628013;63044.36955630385;65119.96096725509;66224.33775662375;70183.94724079041;72678;7326.853462930605;7424.628768561658;7651.846963060819;7659.693612255447;7855.882161767692;10020.298579099393;11815.527378904748;11975.940120299343;11984.880151198726;12200.511979521074;9793.412395256308;9943.850842237227;10561.049505544537;10621.309614875008;10685;9383;10100.090991810772;10174.643887463903;10244.282900196915;10407.739806504898;10269.743256418351;10333.070023697903;10734.946325268324;10780.892191077988;10893.400862952614;7353.963230183815;7505.662245199088;7553.471257011956;7613.885791713239;7679.347255483123;8080.111187769458;8323.83352332962;9928.950355248466;10406.710523684776;10676.306040107369 14:51:58 INFO - PROCESS | 1668 | |3;mootools.html;1386.542440994472;1439.4170361003796;1567.835377285385;1805.3500739733693;2008.4878356019221;7840.0983886852955;8441.493510389373;8600.483970961746;8644.265237454816;8654.697085602005;6853.383195512403;8563.314934805216;8574.828503429928;8578.056413794493;8580.356473264499;2053.1889903488113;2174.749903761072;2417.3714834143075;2459.643351714005;2481.813863960201;2510.874456277188;2513.648089267504;2515.220281712666;2519.395345117177;2520.9243722688257;2416.709994800626;2466.90132394704;2483.4039830440656;2483.515714435686;2483.540544999181;2382.892769825362;2392.7248366437734;2397.1729753235104;2421.9394515137087;2462.22439931421;2387.212219967407;2404.158544509425;2406.843555168926;2475.183189547445;2501.8123640726835;8618.482891026495;8699.739007829776;8706.347023973227;8709.651613935435;8725.38922275441;5263.578913686896;5428.945710542884;5467.289252397202;5468.015757163709;5470.480304371078;3547;3681.668649821529;3736.2340720152574;3741.251749650081;3754.249150169977;1037.2583602724012;1052.2213561964168;1061.0344586426315;1066.4667666166918;1070.64668659343;11673.824892626617;11700.888415600504;11708.658268346364;11735.354555499443;11776.293422394683;4803.135435621552;4829.227323628273;4901.877453063702;4923.08922849274;4925.236588328815;9935.65225217114;9972.900270997343;9976.600935962626;9992.050755178247;10000.649977250907;5457.317835270591;5463.781448742086;5473.370562385297;5498.230247765316;5502.202180683858;4399.274119770266;4553.248713962225;4830.879228019257;4919.114559379274;4935.8519244422005;3844.961550384516;3910.413437984325;3932.3511620582285;3967.8412863485137;3991.341428664296;1304.2630913533824;1307.2222027893388;1310.6592286005707;1316.1445060710423;1318.6769241535885;1306.758249723804;1343.5700575815645;1371.7736573465265;1386.3068465767117;1399.1884706869992;8085.636146373427;8091.271785539329;8142;8142.633581488729;8154.38842086834;514.4264145477765;531.8590573498026;534.0733826810481;535.1223992652053;537.0226188337189;5129.487051294841;6125.019996800491;6154.584445577542;6169.9383006170265;6217;10225.284230103822;10534.841977370346;10673.679789606324;10686.946565267279;10687.465626718633;9862.55618497155;10479.476026198812;10539.63111291101;10558.208134389952;10567.260291779501;8025.23760242776;8151.1441298662785;8214.671413143407;8256;8259.710910118118;7883.251091146332;7908.485948413335;7963.601819908866;8007.239312265326;8018.997625296838;7958.442908996546;8910.331725120772;8945.016048234818;9258.398204116711;9376.67181648639;9177.862332065159;9345.252379809735;9478.715638530855;9515.429074255568;9566.808663826545;6737.494687898526;6949.652517374212;7152.499325047197;7273.927260727325;7420.703171873065;8020.719274825353;8094.028716554051;8103.797405064684;8108.635111420118;8123.6750529978135;7107.538010029331;7213.891791623025;7215.350618444365;7339.74310899116;7397.889031664637;7003.7548685795755;7040.542364746275;7102.857942841011;7175.21072682015;7176.605286709281;7413.962045313552;7568.470207085451;7598.696052157852;7607.657655405409;7615.923840761521;6827.146606674166;6854.794356169323;6882.724691012303;6888;6889.173299203927;6861.828454288683;6956.756513522205;6980.685869136003;6983.336583024605;6991.126109236346 14:51:58 INFO - PROCESS | 1668 | |4;prototype.html;320.898916841195;326.08695652173907;333.00929734041245;334.1495892952436;337.6033161035784;6586.967065164679;6603.273639899613;6625.403713665769;6637.40263376296;6649.8005059848165;6526.641034743087;6608.735650573984;6614.338566143383;6634.668266586676;6649;3609.981950090246;4678.181318269306;4799.448063472711;4800.855974320759;4953.801847926087;4503.819847206108;4893.730844803535;4898.632602554805;4909.582685471739;4917.459079501252;4752.120857641347;4806.7356295403915;4830.541098595628;4835.685680430778;4853.053654537367;4223.36649502574;4634.884127896829;4721.598664113554;4821.421429428456;4842.1042107210105;3366.8148251846137;4160.292750232437;4173.499180098408;4175.812088455997;4189.476315460567;6301.590396624205;6379.36206379363;6384.042393640944;6390.520710946697;6405.903911441285;5709.172170035322;5725.942740572583;5737.713114344266;5765.769369225226;5786.913196302059;6972.047826608557;6978.616176110312;6981.197162326347;6996.230414654384;7005.719771209146;4321.7406955582765;4494.303382975644;4515.254982927813;4522.140793249305;4690.742009189493;7272.563646181246;7341.192468828424;7352.264773522658;7388.704451821921;7395.297446742605;4586.380838586748;4602.585767280961;4610.216263235258;4616.746078965689;4618.67669263155;4178.561251068594;4352.955290730265;4640.350350950802;4667.719936803803;4672.696274742131;5548.001359755202;5573.247611572386;5576.247206627135;5594;5597.692126932976;6827;6941.583504989717;7047.154341479055;7060.682269297791;7105.396041336544;1591.5145880506325;1611.4118346803332;1630.4293497276096;1632.0289427790447;1635.0598405916646;1028.3315844701003;1041.7864337810731;1050.9159267258601;1059.5496913811753;1062.6440142552176;6322.33615470369;6542.051402546604;6569.704363303663;6580.703868325937;6588;7143.107111611049;7249.565026098451;7267.709291628382;7361.1166660001145;7368.521046131984;6009.36901625323;6171.506279497629;6645.800625981228;6662.133922590032;6671;3831.2529056834205;3879.1271963807917;3880.553736320303;3882.650561449483;3891.280113179071;7410.814729631695;7644.923550764533;7704.922950770532;7708.344790692742;7726.613669316512;7539.585322807188;7588.696452141963;7592.278733520307;7605.847883042308;7630.351420129351;7679.308862202429;7689.846203076019;7697.422693297913;7699.4610377274175;7702.3453006493955;7011.404030657247;7323.523970941872;7332.523385979895;7348;7359.006534117825;7215.639218038972;7257.310555497219;7258.673359698932;7260.237675044255;7264.164621068645;7222.819429514094;7510.79827227641;7638.732644357421;7698.384129269757;7740.535567865946;3789.81050947446;4624.930626040679;4645.976770116128;4646.83736069236;4650.651201159859;5914.556408269311;7028.9297107030325;7301.707931682673;7311.232320606472;7319;7057.929420705727;7099.07711997437;7117.715291388494;7121.145462544528;7123.038389817516;7021.789346319619;7077.115360579927;7094.361507464353;7103;7104.715811367488;6925.480588955747;6932.029515867884;6940.895886561605;6949.200841903245;6978.720851165896;5500.367457742411;7056.50604457683;7092;7106.7157313706875;7109.253528379446;5616.382197958303;5753;6639.2696803352555;6877.415419689382;6938.5836849789175 14:51:58 INFO - PROCESS | 1668 | |5;yui.html;695.4540685561834;739.6634531288261;752.5635131623659;767.2365995834144;779.6179871862789;14901.627459313522;15113.848861511382;15148.545543633694;15148.62128446788;15164.014339067953;12456.439460224288;12842.52310984237;13781.379837907292;13848.792268115962;13861.653458663539;725.4160400877291;904.7059705595691;920.9079092090805;922.077922077922;922.1608336413865;739.0244876762675;910.899801021887;927.4342650982895;928.5682157796623;930.2186163622556;960.817444685511;971.8007808399296;972.6060945317158;976.1507488485028;987.3138168972567;780.2626517940548;954.9856752148723;976.345848281653;978.8238117138912;984.1732944326764;728.4682182007111;729.2998721227627;730.8647900138438;730.9232530584319;732.1068296678044;15312.310946007456;15355;15364.385424583003;15380.615484612974;15382.230888455533;12667;12669.936650316782;12775.552855650008;12806.743865122646;13150.671233219151;9873.802523949553;10195.847062294071;10291.382517048925;10650.946745266301;11111;3561.0919215600115;3644.7084233261276;3646.7264955128207;3689.335919534483;3702.2780557791243;84445.7955009822;85310.45482043647;85970.57014714886;86210;86381.13618863793;9002.50486223264;9346.53267336644;9562.474063926411;9598.760030999281;9883.604655813688;21660.675089873665;21694.891525542273;21932.89033554822;21961.121555137615;21972.560548788933;7642.312191902755;7710.691572337156;7721.691132354756;7728.459007869507;7770.844583108419;4026.154507553388;4111.773852438145;4116.4648595682365;4129.648979836687;4132.586741325904;3647.7993710345654;3698.2973235085246;3699.112213068844;3706.721995850322;3709.0356507307756;676.827409010709;684.5003147702205;691.1498856406547;692.5290802254415;704.0214102397568;575.1315513574533;595.8778450417655;600.1987346891948;609.7225762278152;614.6937757265811;8067;8078.434509584273;8182.118112833962;8187.590620468953;8274.669013239523;572.3904042195132;585.3590318601125;606.5875204860649;618.5670030978333;645.4803882874331;3701.3892707702926;3749.3626083565314;3804.6766024887643;3911.119998000427;3916.3929590913453;85665.14334856572;88462.55768721244;88890.55554722185;89824.5508772452;91042;75950;76171;76364.61817690876;77243;77778.2222177771;67349.3265067343;68488.31511684919;68511.62976740536;68870;69311;7537.2462753724185;7592.658330375036;7676.462647614613;7914.920850791418;8020.117787043304;34896.65103348934;45012.32481512715;46045;46893.06213875635;47175.52824471849;57860.71069644793;58285.708571456875;61520.76958460716;62117.757644847756;62452.68773656103;9882.703518894445;10573.2598718089;10668.946655266674;10850.945745271223;11144.052755515548;11875.406229688653;11938.64184074479;11939.283642981449;12459.12786104964;12759.681007974876;11447.828282575934;11537.48081336325;11734.002609778265;11755.529778808752;11766.647000589654;9144;10466.581336746749;10705.89294107049;11320.433978301216;11653.47559359814;11149.237499813678;11378.374189419661;11383.943080284545;11513.366764828015;11631.127665424958;9633.518324083909;9791.167750740982;10013.098821106136;10022.198224142197;10087.243456740627;9519.857202142111;9573.569189386633;9604.567794449127;9628.32601717873;9642.132208101304 14:51:58 INFO - PROCESS | 1668 | __end_tp_report 14:51:58 INFO - PROCESS | 1668 | __start_cc_report 14:51:58 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1415 14:51:58 INFO - PROCESS | 1668 | __end_cc_report 14:51:58 INFO - PROCESS | 1668 | __startTimestamp1458597118494__endTimestamp 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | ------- Summary: start ------- 14:51:58 INFO - PROCESS | 1668 | Number of tests: 6 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5684.52 Median:5902.82 stddev:642.89 (10.9%) stddev-sans-first:619.09 14:51:58 INFO - PROCESS | 1668 | Values: 3387.4 3499.8 3518.2 3526.4 3575.8 5528.6 5577.2 5638.0 5663.0 5677.5 5548.1 5652.1 5653.7 5657.8 5665.7 5094.5 5121.8 5145.2 5162.0 5195.8 5207.1 5214.9 5223.9 5229.5 5234.3 4136.3 5192.9 5211.1 5215.5 5216.2 5171.9 5211.1 5226.3 5231.0 5295.1 5076.3 5118.1 5135.5 5135.9 5144.4 5561.2 5562.0 5579.8 5583.9 5675.5 6209.7 6233.5 6238.0 6242.6 6250.3 5022.9 6141.9 6242.2 6253.6 6270.6 5773.5 5776.4 5776.6 5789.3 5789.6 6236.7 6245.3 6249.0 6259.2 6269.9 4922.3 5968.5 6088.8 6123.2 6145.4 5204.6 6192.9 6215.5 6223.9 6245.7 6104.5 6134.9 6172.7 6184.8 6193.6 6062.3 6121.2 6159.7 6236.2 6245.8 4901.0 4902.9 4910.7 4913.5 4919.8 4410.1 4421.9 4438.4 4452.4 4480.8 5624.5 5706.7 5723.1 5724.0 5782.0 6152.7 6163.3 6170.9 6176.7 6198.7 5619.7 5622.5 5636.7 5638.4 5638.7 4915.0 5210.6 5226.5 5288.4 5327.3 6271.5 6319.6 6346.9 6360.2 6362.2 6243.6 6252.9 6273.7 6284.1 6295.2 6148.6 6271.2 6295.1 6325.7 6356.8 6129.1 6181.2 6195.9 6197.1 6212.7 6143.0 6232.1 6256.7 6265.2 6266.6 4558.7 5966.9 6081.1 6134.3 6156.5 6109.1 6117.9 6132.6 6138.5 6142.6 5937.3 5953.6 5954.4 5957.8 5995.8 5816.2 5902.8 5943.1 6018.9 6127.8 5836.3 5879.9 5903.1 5938.3 5963.6 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:58652.11 Median:36383.64 stddev:119950.45 (329.7%) stddev-sans-first:120207.55 14:51:58 INFO - PROCESS | 1668 | Values: 526.1 578.3 580.6 605.5 627.1 30668.2 39206.0 39567.6 39611.4 39625.0 41294.8 41928.0 42042.4 42102.0 42208.8 9419.3 9638.7 9641.1 9662.3 9695.9 9562.1 9711.1 9713.7 9720.9 9730.8 9679.4 9745.1 9745.2 9746.8 9750.6 9621.9 9710.6 9713.0 9714.8 9718.0 9569.4 9730.8 9740.2 9740.8 9755.4 40695.6 41232.0 41298.0 41409.2 41418.0 3240.4 3259.9 3398.2 3428.9 3490.4 28807.4 29067.0 29695.6 29718.1 29825.3 2700.3 2727.8 2734.7 2847.4 2888.6 482874.6 483545.0 485633.0 485836.0 487263.0 45036.0 63804.7 63983.7 64023.0 64197.7 45196.6 45343.3 45405.0 45441.3 45455.0 15153.8 15366.6 15380.7 15391.4 15410.4 12288.3 12344.1 12361.4 12375.7 12385.9 14451.6 14519.0 14669.3 14796.9 14854.0 5490.8 6396.3 6535.0 6575.5 6598.1 1005.9 1057.7 1138.7 1148.2 1192.1 28944.9 29085.4 29604.4 29775.1 29790.7 1070.6 1091.6 1182.8 1194.7 1214.3 14582.3 14718.7 14805.0 14821.9 15001.8 516359.0 522900.0 523490.0 525181.0 528276.0 58155.4 58884.8 58985.7 59042.7 59069.0 1399.8 1475.2 1478.3 1490.1 1510.5 28219.7 28325.3 28907.6 28955.1 28956.1 44973.8 45294.5 45788.1 45798.3 45985.8 312037.0 318898.0 319247.0 319311.0 319363.0 28914.3 32410.7 33093.7 33531.8 33778.3 42679.1 46027.1 47177.8 47503.8 47911.5 36036.3 36072.0 36079.0 37062.0 37354.0 35397.8 35505.6 35838.8 36200.5 36302.6 35373.6 35589.5 36464.6 37182.7 38197.4 31357.8 32783.8 32794.0 32837.8 32838.2 24126.6 24457.1 24530.8 25001.6 25167.4 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34283.60 Median:370.98 stddev:104298.79 (28114.1%) stddev-sans-first:104560.29 14:51:58 INFO - PROCESS | 1668 | Values: 368.3 369.7 372.3 379.4 382.1 19039.9 19615.1 20595.0 20795.8 20804.7 17493.3 19462.9 20330.1 21315.6 21370.6 5613.1 5835.9 5862.4 5871.0 5933.9 4138.9 4166.8 5786.5 6392.8 6415.5 6319.9 6350.7 6358.7 6367.0 6367.5 5251.9 6120.7 6325.7 6334.7 6336.5 5489.3 5490.8 5492.5 5502.9 5525.1 24519.5 25704.9 26015.2 26024.2 26041.6 2107.5 2112.7 2144.3 2543.9 2857.6 14049.7 14140.2 14349.6 14671.1 14717.6 1489.3 1576.7 1669.8 1767.2 1772.8 95268.6 97589.0 97977.5 98023.0 98292.0 8775.0 10319.7 10552.7 10880.2 11022.4 12967.5 13003.7 13013.7 13051.5 13062.7 8338.5 8557.9 8559.4 8648.5 8650.7 8738.6 8758.5 8773.0 8881.2 8932.5 6069.8 6282.3 6294.5 6313.4 6369.6 1524.6 1682.5 1778.8 1809.9 1816.3 836.0 958.2 992.6 1067.6 1069.6 19906.7 20876.9 21040.9 21105.7 21159.2 953.4 980.7 984.7 1010.4 1021.5 9418.1 10988.0 11592.1 11698.2 11709.6 618087.0 623545.0 639146.0 641326.0 642763.0 87057.0 102579.5 104644.0 106255.5 108702.0 989.3 1032.2 1049.4 1050.7 1051.7 18597.6 18954.1 19029.4 19175.1 19180.8 50706.0 50897.7 51016.3 51211.7 51214.7 63044.4 65120.0 66224.3 70183.9 72678.0 7326.9 7424.6 7651.8 7659.7 7855.9 10020.3 11815.5 11975.9 11984.9 12200.5 9793.4 9943.9 10561.0 10621.3 10685.0 9383.0 10100.1 10174.6 10244.3 10407.7 10269.7 10333.1 10734.9 10780.9 10893.4 7354.0 7505.7 7553.5 7613.9 7679.3 8080.1 8323.8 9929.0 10406.7 10676.3 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5934.76 Median:5467.65 stddev:3114.99 (57.0%) stddev-sans-first:3104.96 14:51:58 INFO - PROCESS | 1668 | Values: 1386.5 1439.4 1567.8 1805.4 2008.5 7840.1 8441.5 8600.5 8644.3 8654.7 6853.4 8563.3 8574.8 8578.1 8580.4 2053.2 2174.7 2417.4 2459.6 2481.8 2510.9 2513.6 2515.2 2519.4 2520.9 2416.7 2466.9 2483.4 2483.5 2483.5 2382.9 2392.7 2397.2 2421.9 2462.2 2387.2 2404.2 2406.8 2475.2 2501.8 8618.5 8699.7 8706.3 8709.7 8725.4 5263.6 5428.9 5467.3 5468.0 5470.5 3547.0 3681.7 3736.2 3741.3 3754.2 1037.3 1052.2 1061.0 1066.5 1070.6 11673.8 11700.9 11708.7 11735.4 11776.3 4803.1 4829.2 4901.9 4923.1 4925.2 9935.7 9972.9 9976.6 9992.1 10000.6 5457.3 5463.8 5473.4 5498.2 5502.2 4399.3 4553.2 4830.9 4919.1 4935.9 3845.0 3910.4 3932.4 3967.8 3991.3 1304.3 1307.2 1310.7 1316.1 1318.7 1306.8 1343.6 1371.8 1386.3 1399.2 8085.6 8091.3 8142.0 8142.6 8154.4 514.4 531.9 534.1 535.1 537.0 5129.5 6125.0 6154.6 6169.9 6217.0 10225.3 10534.8 10673.7 10686.9 10687.5 9862.6 10479.5 10539.6 10558.2 10567.3 8025.2 8151.1 8214.7 8256.0 8259.7 7883.3 7908.5 7963.6 8007.2 8019.0 7958.4 8910.3 8945.0 9258.4 9376.7 9177.9 9345.3 9478.7 9515.4 9566.8 6737.5 6949.7 7152.5 7273.9 7420.7 8020.7 8094.0 8103.8 8108.6 8123.7 7107.5 7213.9 7215.4 7339.7 7397.9 7003.8 7040.5 7102.9 7175.2 7176.6 7414.0 7568.5 7598.7 7607.7 7615.9 6827.1 6854.8 6882.7 6888.0 6889.2 6861.8 6956.8 6980.7 6983.3 6991.1 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5738.15 Median:6583.84 stddev:1866.63 (28.4%) stddev-sans-first:1827.04 14:51:58 INFO - PROCESS | 1668 | Values: 320.9 326.1 333.0 334.1 337.6 6587.0 6603.3 6625.4 6637.4 6649.8 6526.6 6608.7 6614.3 6634.7 6649.0 3610.0 4678.2 4799.4 4800.9 4953.8 4503.8 4893.7 4898.6 4909.6 4917.5 4752.1 4806.7 4830.5 4835.7 4853.1 4223.4 4634.9 4721.6 4821.4 4842.1 3366.8 4160.3 4173.5 4175.8 4189.5 6301.6 6379.4 6384.0 6390.5 6405.9 5709.2 5725.9 5737.7 5765.8 5786.9 6972.0 6978.6 6981.2 6996.2 7005.7 4321.7 4494.3 4515.3 4522.1 4690.7 7272.6 7341.2 7352.3 7388.7 7395.3 4586.4 4602.6 4610.2 4616.7 4618.7 4178.6 4353.0 4640.4 4667.7 4672.7 5548.0 5573.2 5576.2 5594.0 5597.7 6827.0 6941.6 7047.2 7060.7 7105.4 1591.5 1611.4 1630.4 1632.0 1635.1 1028.3 1041.8 1050.9 1059.5 1062.6 6322.3 6542.1 6569.7 6580.7 6588.0 7143.1 7249.6 7267.7 7361.1 7368.5 6009.4 6171.5 6645.8 6662.1 6671.0 3831.3 3879.1 3880.6 3882.7 3891.3 7410.8 7644.9 7704.9 7708.3 7726.6 7539.6 7588.7 7592.3 7605.8 7630.4 7679.3 7689.8 7697.4 7699.5 7702.3 7011.4 7323.5 7332.5 7348.0 7359.0 7215.6 7257.3 7258.7 7260.2 7264.2 7222.8 7510.8 7638.7 7698.4 7740.5 3789.8 4624.9 4646.0 4646.8 4650.7 5914.6 7028.9 7301.7 7311.2 7319.0 7057.9 7099.1 7117.7 7121.1 7123.0 7021.8 7077.1 7094.4 7103.0 7104.7 6925.5 6932.0 6940.9 6949.2 6978.7 5500.4 7056.5 7092.0 7106.7 7109.3 5616.4 5753.0 6639.3 6877.4 6938.6 14:51:58 INFO - PROCESS | 1668 | 14:51:58 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:17901.17 Median:31069.67 stddev:25039.08 (80.6%) stddev-sans-first:25075.99 14:51:58 INFO - PROCESS | 1668 | Values: 695.5 739.7 752.6 767.2 779.6 14901.6 15113.8 15148.5 15148.6 15164.0 12456.4 12842.5 13781.4 13848.8 13861.7 725.4 904.7 920.9 922.1 922.2 739.0 910.9 927.4 928.6 930.2 960.8 971.8 972.6 976.2 987.3 780.3 955.0 976.3 978.8 984.2 728.5 729.3 730.9 730.9 732.1 15312.3 15355.0 15364.4 15380.6 15382.2 12667.0 12669.9 12775.6 12806.7 13150.7 9873.8 10195.8 10291.4 10650.9 11111.0 3561.1 3644.7 3646.7 3689.3 3702.3 84445.8 85310.5 85970.6 86210.0 86381.1 9002.5 9346.5 9562.5 9598.8 9883.6 21660.7 21694.9 21932.9 21961.1 21972.6 7642.3 7710.7 7721.7 7728.5 7770.8 4026.2 4111.8 4116.5 4129.6 4132.6 3647.8 3698.3 3699.1 3706.7 3709.0 676.8 684.5 691.1 692.5 704.0 575.1 595.9 600.2 609.7 614.7 8067.0 8078.4 8182.1 8187.6 8274.7 572.4 585.4 606.6 618.6 645.5 3701.4 3749.4 3804.7 3911.1 3916.4 85665.1 88462.6 88890.6 89824.6 91042.0 75950.0 76171.0 76364.6 77243.0 77778.2 67349.3 68488.3 68511.6 68870.0 69311.0 7537.2 7592.7 7676.5 7914.9 8020.1 34896.7 45012.3 46045.0 46893.1 47175.5 57860.7 58285.7 61520.8 62117.8 62452.7 9882.7 10573.3 10668.9 10850.9 11144.1 11875.4 11938.6 11939.3 12459.1 12759.7 11447.8 11537.5 11734.0 11755.5 11766.6 9144.0 10466.6 10705.9 11320.4 11653.5 11149.2 11378.4 11383.9 11513.4 11631.1 9633.5 9791.2 10013.1 10022.2 10087.2 9519.9 9573.6 9604.6 9628.3 9642.1 14:51:58 INFO - PROCESS | 1668 | -------- Summary: end -------- 14:51:58 INFO - PROCESS | 1668 | 14:51:59 INFO - TEST-INFO | 1668: exit 0 14:51:59 INFO - TEST-OK | dromaeo_css | took 1114078ms 14:51:59 INFO - TEST-START | kraken 14:51:59 INFO - operating with platform_type : mac_ 14:51:59 INFO - Initialising browser for kraken test... 14:51:59 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpCLBLNh/profile http://localhost:49271/getInfo.html) 14:52:01 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 14:52:01 INFO - PROCESS | 1673 | colorDepth:24 14:52:01 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 14:52:01 INFO - PROCESS | 1673 | __metrics 14:52:01 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:52:01 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:52:02 INFO - TEST-INFO | 1673: exit 0 14:52:02 INFO - Browser initialized. 14:52:02 INFO - Running cycle 1/1 for kraken test... 14:52:02 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpCLBLNh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:13 INFO - PROCESS | 1675 | RSS: Main: 245194752 14:52:13 INFO - PROCESS | 1675 | 14:52:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:17 INFO - PROCESS | 1675 | RSS: Main: 292458496 14:52:17 INFO - PROCESS | 1675 | 14:52:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 14:52:20 INFO - PROCESS | 1675 | RSS: Main: 301789184 14:52:20 INFO - PROCESS | 1675 | 14:52:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 14:52:24 INFO - PROCESS | 1675 | RSS: Main: 289857536 14:52:24 INFO - PROCESS | 1675 | 14:52:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 14:52:26 INFO - PROCESS | 1675 | RSS: Main: 292868096 14:52:26 INFO - PROCESS | 1675 | 14:52:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:52:29 INFO - PROCESS | 1675 | RSS: Main: 291119104 14:52:29 INFO - PROCESS | 1675 | 14:52:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 14:52:32 INFO - PROCESS | 1675 | RSS: Main: 291860480 14:52:32 INFO - PROCESS | 1675 | 14:52:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 14:52:36 INFO - PROCESS | 1675 | RSS: Main: 292618240 14:52:36 INFO - PROCESS | 1675 | 14:52:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 14:52:39 INFO - PROCESS | 1675 | RSS: Main: 294232064 14:52:39 INFO - PROCESS | 1675 | 14:52:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:41 INFO - PROCESS | 1675 | RSS: Main: 327462912 14:52:41 INFO - PROCESS | 1675 | 14:52:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:44 INFO - PROCESS | 1675 | RSS: Main: 327217152 14:52:44 INFO - PROCESS | 1675 | 14:52:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:46 INFO - PROCESS | 1675 | RSS: Main: 333316096 14:52:46 INFO - PROCESS | 1675 | 14:52:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:50 INFO - PROCESS | 1675 | RSS: Main: 334782464 14:52:50 INFO - PROCESS | 1675 | 14:52:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:53 INFO - PROCESS | 1675 | RSS: Main: 335122432 14:52:53 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 14:52:55 INFO - PROCESS | 1675 | RSS: Main: 395079680 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | __start_tp_report 14:52:55 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 14:52:55 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 14:52:55 INFO - PROCESS | 1675 | |i|pagename|runs| 14:52:55 INFO - PROCESS | 1675 | |0;ai-astar;110;106;110;112;110;110;113;111;109;112 14:52:55 INFO - PROCESS | 1675 | |1;audio-beat-detection;157;120;142;156;119;141;138;117;159;131 14:52:55 INFO - PROCESS | 1675 | |2;audio-dft;184;186;186;191;185;183;184;185;181;180 14:52:55 INFO - PROCESS | 1675 | |3;audio-fft;77;75;85;78;58;58;57;79;76;54 14:52:55 INFO - PROCESS | 1675 | |4;audio-oscillator;93;97;130;80;80;87;114;79;79;119 14:52:55 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;86;102;86;84;86;97;126;84;86;84 14:52:55 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;93;94;94;92;109;150;93;92;93 14:52:55 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;100;133;134;85;84;84;85;84;86 14:52:55 INFO - PROCESS | 1675 | |8;json-parse-financial;58;55;55;55;55;56;55;66;55;53 14:52:55 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;70;69;71;71;68;66;66;67;67 14:52:55 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;84;83;83;84;84;83;83;84;84;82 14:52:55 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;125;134;131;137;129;132;122;120;126;128 14:52:55 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;141;127;139;138;136;134;137;138;134;137 14:52:55 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;56;82;93;96;67;68;68;65;67;65 14:52:55 INFO - PROCESS | 1675 | __end_tp_report 14:52:55 INFO - PROCESS | 1675 | __start_cc_report 14:52:55 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1297 14:52:55 INFO - PROCESS | 1675 | __end_cc_report 14:52:55 INFO - PROCESS | 1675 | __startTimestamp1458597175294__endTimestamp 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | ------- Summary: start ------- 14:52:55 INFO - PROCESS | 1675 | Number of tests: 14 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:1.95 (1.8%) stddev-sans-first:2.06 14:52:55 INFO - PROCESS | 1675 | Values: 110.0 106.0 110.0 112.0 110.0 110.0 113.0 111.0 109.0 112.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:141.50 stddev:16.08 (11.4%) stddev-sans-first:15.51 14:52:55 INFO - PROCESS | 1675 | Values: 157.0 120.0 142.0 156.0 119.0 141.0 138.0 117.0 159.0 131.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:3.03 (1.6%) stddev-sans-first:3.21 14:52:55 INFO - PROCESS | 1675 | Values: 184.0 186.0 186.0 191.0 185.0 183.0 184.0 185.0 181.0 180.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:69.70 Median:76.50 stddev:11.51 (15.0%) stddev-sans-first:11.90 14:52:55 INFO - PROCESS | 1675 | Values: 77.0 75.0 85.0 78.0 58.0 58.0 57.0 79.0 76.0 54.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:80.00 stddev:18.83 (23.5%) stddev-sans-first:19.94 14:52:55 INFO - PROCESS | 1675 | Values: 93.0 97.0 130.0 80.0 80.0 87.0 114.0 79.0 79.0 119.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:86.00 stddev:13.40 (15.6%) stddev-sans-first:14.03 14:52:55 INFO - PROCESS | 1675 | Values: 86.0 102.0 86.0 84.0 86.0 97.0 126.0 84.0 86.0 84.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:100.20 Median:93.00 stddev:18.23 (19.6%) stddev-sans-first:19.09 14:52:55 INFO - PROCESS | 1675 | Values: 92.0 93.0 94.0 94.0 92.0 109.0 150.0 93.0 92.0 93.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:84.50 stddev:20.34 (24.1%) stddev-sans-first:21.18 14:52:55 INFO - PROCESS | 1675 | Values: 85.0 100.0 133.0 134.0 85.0 84.0 84.0 85.0 84.0 86.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:55.00 stddev:3.62 (6.6%) stddev-sans-first:3.79 14:52:55 INFO - PROCESS | 1675 | Values: 58.0 55.0 55.0 55.0 55.0 56.0 55.0 66.0 55.0 53.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.50 stddev:2.53 (3.7%) stddev-sans-first:2.00 14:52:55 INFO - PROCESS | 1675 | Values: 63.0 70.0 69.0 71.0 71.0 68.0 66.0 66.0 67.0 67.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 14:52:55 INFO - PROCESS | 1675 | Values: 84.0 83.0 83.0 84.0 84.0 83.0 83.0 84.0 84.0 82.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:130.00 stddev:5.32 (4.1%) stddev-sans-first:5.49 14:52:55 INFO - PROCESS | 1675 | Values: 125.0 134.0 131.0 137.0 129.0 132.0 122.0 120.0 126.0 128.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:137.50 stddev:3.84 (2.8%) stddev-sans-first:3.64 14:52:55 INFO - PROCESS | 1675 | Values: 141.0 127.0 139.0 138.0 136.0 134.0 137.0 138.0 134.0 137.0 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:68.00 stddev:13.12 (19.3%) stddev-sans-first:12.44 14:52:55 INFO - PROCESS | 1675 | Values: 56.0 82.0 93.0 96.0 67.0 68.0 68.0 65.0 67.0 65.0 14:52:55 INFO - PROCESS | 1675 | -------- Summary: end -------- 14:52:55 INFO - PROCESS | 1675 | 14:52:55 INFO - TEST-INFO | 1675: exit 0 14:52:56 INFO - TEST-OK | kraken | took 56954ms 14:52:56 INFO - SUITE-END | took 1171s 14:52:56 INFO - Completed test suite (00:19:31) 14:52:56 INFO - javascript benchmark 14:52:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3387.3733359328526, 3499.8250087495617, 3518.173229291116, 3526.418141006734, 3575.785452872828, 5528.55771538277, 5577.163425486179, 5637.9718101409535, 5663.0, 5677.545796336293, 5548.140038294071, 5652.06740887753, 5653.745581448834, 5657.801976930808, 5665.688387138705, 5094.46508116648, 5121.846344609658, 5145.176771716526, 5161.993411284801, 5195.818146364878, 5207.140821764404, 5214.869628259305, 5223.869403264911, 5229.450907654698, 5234.26720259164, 4136.255474014676, 5192.8701782455555, 5211.088059589576, 5215.4523775003645, 5216.165413533835, 5171.870703232412, 5211.062008838408, 5226.346706661668, 5230.973845130788, 5295.099833028395, 5076.263941728429, 5118.10433174193, 5135.512126347991, 5135.871603209912, 5144.4083930348115, 5561.221428999943, 5561.972190139023, 5579.804706835282, 5583.8604034899045, 5675.460831221028, 6209.658468784215, 6233.470155036827, 6238.0, 6242.594231374991, 6250.343713910065, 5022.874428139289, 6141.938580614182, 6242.157308763304, 6253.562250642457, 6270.561060725751, 5773.451522105393, 5776.393478684761, 5776.624519406225, 5789.2763404574425, 5789.565782566325, 6236.688165591702, 6245.250569931546, 6248.968755156195, 6259.217597800275, 6269.8746025079245, 4922.286268491049, 5968.46283834457, 6088.756449742049, 6123.173371594867, 6145.432914606747, 5204.5576126028955, 6192.938070619326, 6215.471684906834, 6223.875522489525, 6245.656488893063, 6104.542159338067, 6134.938650613437, 6172.660503672341, 6184.752609895554, 6193.566450348522, 6062.272527296753, 6121.209103132296, 6159.722812473449, 6236.158118654014, 6245.812625621239, 4901.044296362246, 4902.852914412573, 4910.6987690978485, 4913.508649135058, 4919.803207871717, 4410.1400226956075, 4421.9336709949375, 4438.378626992224, 4452.398926144993, 4480.820767169342, 5624.493795558419, 5706.686132262683, 5723.141528770634, 5724.0, 5782.017057100303, 6152.692365381713, 6163.260408750889, 6170.876582468325, 6176.66028368435, 6198.659073750987, 5619.719014049281, 5622.493975542221, 5636.746346414421, 5638.436156384329, 5638.746256418471, 4915.0415668944215, 5210.609204309692, 5226.529612334832, 5288.365396152486, 5327.334083239595, 6271.4669253114, 6319.557630965788, 6346.873062538631, 6360.236771587347, 6362.172917520786, 6243.625382477066, 6252.874942501034, 6273.71768270438, 6284.057391391328, 6295.244570651551, 6148.631082135086, 6271.184745982993, 6295.087212354275, 6325.652089135142, 6356.841078972878, 6129.141920131096, 6181.165542651865, 6195.876082478415, 6197.070439434121, 6212.658303793335, 6143.017117261216, 6232.09634602971, 6256.718447669775, 6265.216847894013, 6266.592671476339, 4558.726476411426, 5966.910496342645, 6081.118237855575, 6134.344744984565, 6156.476699480415, 6109.070667812992, 6117.900468191327, 6132.569672417391, 6138.51101655979, 6142.560166306883, 5937.3468918418075, 5953.613015154001, 5954.434328738763, 5957.76168953237, 5995.820125396245, 5816.185733997159, 5902.822915312548, 5943.138244954371, 6018.879622407615, 6127.84680382994, 5836.270466191726, 5879.882402352015, 5903.114532820111, 5938.257717785277, 5963.582549221686], "unit": "score", "name": "dojo.html", "value": 5646.566504433898}, {"lowerIsBetter": false, "replicates": [526.0741095671617, 578.2569398323155, 580.5906835680844, 605.4762630324767, 627.0969803482984, 30668.233294167658, 39206.01984950378, 39567.604323956824, 39611.40582891259, 39625.0, 41294.79352603233, 41928.0, 42042.369364459555, 42102.0, 42208.82449983503, 9419.29355298352, 9638.710838674815, 9641.13229809317, 9662.32363734539, 9695.854562181574, 9562.0916012979, 9711.12599866012, 9713.70858874235, 9720.902790972106, 9730.756731081745, 9679.419234845896, 9745.122938935494, 9745.171660408874, 9746.756331091745, 9750.609975600968, 9621.855672164924, 9710.563024663907, 9712.951435242849, 9714.757131071708, 9718.028197180296, 9569.425834449956, 9730.756731081708, 9740.220782337467, 9740.805183896282, 9755.414675119444, 40695.59304406948, 41231.96920076992, 41297.96755081117, 41409.1718165638, 41418.0, 3240.3519296140867, 3259.9185020374443, 3398.150462384404, 3428.879989200391, 3490.4415293553166, 28807.423851522854, 29067.0, 29695.5545666813, 29718.108456746115, 29825.25436864074, 2700.2709268497397, 2727.8499682517454, 2734.6991830898783, 2847.373577812878, 2888.581155732407, 482874.58562707313, 483545.0, 485633.0, 485836.0, 487262.99999999645, 45036.0, 63804.68097659482, 63983.6800815993, 64023.0, 64197.67901160558, 45196.57641083091, 45343.31985020227, 45405.0, 45441.31838022432, 45455.0, 15153.848461515465, 15366.615834604225, 15380.692386152214, 15391.384344626313, 15410.383584656489, 12288.324142172267, 12344.074194435454, 12361.381930903599, 12375.6906077347, 12385.876141238652, 14451.566453006426, 14519.0, 14669.33987970544, 14796.926015370069, 14854.0, 5490.835274941758, 6396.328385519547, 6534.967325163344, 6575.506836987245, 6598.076269322299, 1005.8985410974971, 1057.6932689519954, 1138.6584024792694, 1148.2134737704698, 1192.1059205595802, 28944.85527572391, 29085.41829163405, 29604.40791184164, 29775.10674679763, 29790.702092979227, 1070.6092276319243, 1091.5688303120382, 1182.7930112230497, 1194.6619785839741, 1214.2957084890743, 14582.30227407933, 14718.705625887636, 14804.991499693408, 14821.92589037048, 15001.774973375408, 516359.0, 522900.0, 523490.0, 525181.0, 528276.0, 58155.41844581585, 58884.82230355369, 58985.705071475226, 59042.70478647579, 59069.0, 1399.783033629789, 1475.1886462445611, 1478.3495262084648, 1490.0835985868612, 1510.4864346122151, 28219.71780282253, 28325.291867703472, 28907.56638650464, 28955.13134605965, 28956.131316060553, 44973.77513112414, 45294.54705452903, 45788.084238315714, 45798.31302530398, 45985.77007114943, 312037.0, 318898.0, 319247.0, 319311.0, 319363.0, 28914.27714307159, 32410.675893240765, 33093.67625294961, 33531.83234083814, 33778.3244335107, 42679.146417070864, 46027.07945840997, 47177.764111179225, 47503.762481187376, 47911.520884790705, 36036.27927441489, 36072.0, 36079.0, 37062.0, 37354.0, 35397.82301088478, 35505.64494355127, 35838.820805896845, 36200.45699314565, 36302.636973629924, 35373.64626353807, 35589.46615800713, 36464.635353646125, 37182.705718271005, 38197.427038595, 31357.8432107838, 32783.83608081944, 32794.016179514656, 32837.83581082079, 32838.179045523095, 24126.638100428157, 24457.143999959917, 24530.75469245356, 25001.624975625018, 25167.37081572975], "unit": "score", "name": "ext.html", "value": 19075.02883467719}, {"lowerIsBetter": false, "replicates": [368.2689860626657, 369.6543731610943, 372.3130823630403, 379.37213910977323, 382.10777833758175, 19039.904800475997, 19615.11731972061, 20595.0, 20795.792042079574, 20804.687929681066, 17493.338132877387, 19462.90268548655, 20330.08514616842, 21315.57368852622, 21370.57258854822, 5613.129964855444, 5835.912461313083, 5862.413758624146, 5870.97064514679, 5933.88132237355, 4138.937915931264, 4166.770827604496, 5786.479216870481, 6392.808215753512, 6415.518836087289, 6319.862424763541, 6350.714217860207, 6358.650274234915, 6367.0, 6367.458766004872, 5251.894962100756, 6120.724567394478, 6325.715342809584, 6334.651594162319, 6336.52476064297, 5489.258950041733, 5490.752916118784, 5492.450754924515, 5502.9174562381595, 5525.11598144299, 24519.509609807883, 25704.871475642503, 26015.21954341373, 26024.219273421826, 26041.609375859378, 2107.451167601537, 2112.746470423559, 2144.281665642012, 2543.9364015899564, 2857.6142220800134, 14049.71900561983, 14140.15159090458, 14349.641258968504, 14671.119732816065, 14717.632059198499, 1489.2851431312922, 1576.7004269188817, 1669.8079720832018, 1767.2135899524717, 1772.7872655281449, 95268.57097143549, 97589.0241097587, 97977.5101124497, 98023.0, 98292.0, 8774.956125219333, 10319.690409287734, 10552.736181595368, 10880.183986201067, 11022.393768342657, 12967.481300747864, 13003.674908127183, 13013.674658133623, 13051.543195988284, 13062.673433164247, 8338.458000229966, 8557.871631925525, 8559.443636163629, 8648.481091134552, 8650.697225597074, 8738.563071846509, 8758.47449153053, 8772.95613521941, 8881.156290152425, 8932.508712020901, 6069.787557435468, 6282.340354262828, 6294.496440284766, 6313.368663133741, 6369.617822930639, 1524.5578782153273, 1682.512071499276, 1778.813224611423, 1809.9185536650882, 1816.3188804198426, 835.9582020898931, 958.1951161024773, 992.6178421307849, 1067.5889782433665, 1069.6363236499471, 19906.701399479018, 20876.851773152317, 21040.894795525925, 21105.68341474879, 21159.153633854472, 953.4327075390132, 980.6763767956558, 984.7144328144758, 1010.434156872154, 1021.5403068619152, 9418.10527999839, 10988.0, 11592.130590205768, 11698.181127321175, 11709.590164344378, 618087.0, 623545.0, 639146.0, 641326.0, 642763.0, 87057.0, 102579.46130808044, 104644.0, 106255.46872265743, 108702.0, 989.3322007644811, 1032.2464600841429, 1049.4175732468552, 1050.7425680708275, 1051.731808388856, 18597.628047439244, 18954.147063381904, 19029.429117126507, 19175.137118829407, 19180.808191917902, 50706.0, 50897.745511273686, 51016.34236582286, 51211.74394128005, 51214.74392628013, 63044.36955630385, 65119.96096725509, 66224.33775662375, 70183.94724079041, 72678.0, 7326.853462930605, 7424.628768561658, 7651.846963060819, 7659.693612255447, 7855.882161767692, 10020.298579099393, 11815.527378904748, 11975.940120299343, 11984.880151198726, 12200.511979521074, 9793.412395256308, 9943.850842237227, 10561.049505544537, 10621.309614875008, 10685.0, 9383.0, 10100.090991810772, 10174.643887463903, 10244.282900196915, 10407.739806504898, 10269.743256418351, 10333.070023697903, 10734.946325268324, 10780.892191077988, 10893.400862952614, 7353.963230183815, 7505.662245199088, 7553.471257011956, 7613.885791713239, 7679.347255483123, 8080.111187769458, 8323.83352332962, 9928.950355248466, 10406.710523684776, 10676.306040107369], "unit": "score", "name": "jquery.html", "value": 9392.927575656695}, {"lowerIsBetter": false, "replicates": [1386.542440994472, 1439.4170361003796, 1567.835377285385, 1805.3500739733693, 2008.4878356019221, 7840.0983886852955, 8441.493510389373, 8600.483970961746, 8644.265237454816, 8654.697085602005, 6853.383195512403, 8563.314934805216, 8574.828503429928, 8578.056413794493, 8580.356473264499, 2053.1889903488113, 2174.749903761072, 2417.3714834143075, 2459.643351714005, 2481.813863960201, 2510.874456277188, 2513.648089267504, 2515.220281712666, 2519.395345117177, 2520.9243722688257, 2416.709994800626, 2466.90132394704, 2483.4039830440656, 2483.515714435686, 2483.540544999181, 2382.892769825362, 2392.7248366437734, 2397.1729753235104, 2421.9394515137087, 2462.22439931421, 2387.212219967407, 2404.158544509425, 2406.843555168926, 2475.183189547445, 2501.8123640726835, 8618.482891026495, 8699.739007829776, 8706.347023973227, 8709.651613935435, 8725.38922275441, 5263.578913686896, 5428.945710542884, 5467.289252397202, 5468.015757163709, 5470.480304371078, 3547.0, 3681.668649821529, 3736.2340720152574, 3741.251749650081, 3754.249150169977, 1037.2583602724012, 1052.2213561964168, 1061.0344586426315, 1066.4667666166918, 1070.64668659343, 11673.824892626617, 11700.888415600504, 11708.658268346364, 11735.354555499443, 11776.293422394683, 4803.135435621552, 4829.227323628273, 4901.877453063702, 4923.08922849274, 4925.236588328815, 9935.65225217114, 9972.900270997343, 9976.600935962626, 9992.050755178247, 10000.649977250907, 5457.317835270591, 5463.781448742086, 5473.370562385297, 5498.230247765316, 5502.202180683858, 4399.274119770266, 4553.248713962225, 4830.879228019257, 4919.114559379274, 4935.8519244422005, 3844.961550384516, 3910.413437984325, 3932.3511620582285, 3967.8412863485137, 3991.341428664296, 1304.2630913533824, 1307.2222027893388, 1310.6592286005707, 1316.1445060710423, 1318.6769241535885, 1306.758249723804, 1343.5700575815645, 1371.7736573465265, 1386.3068465767117, 1399.1884706869992, 8085.636146373427, 8091.271785539329, 8142.0, 8142.633581488729, 8154.38842086834, 514.4264145477765, 531.8590573498026, 534.0733826810481, 535.1223992652053, 537.0226188337189, 5129.487051294841, 6125.019996800491, 6154.584445577542, 6169.9383006170265, 6217.0, 10225.284230103822, 10534.841977370346, 10673.679789606324, 10686.946565267279, 10687.465626718633, 9862.55618497155, 10479.476026198812, 10539.63111291101, 10558.208134389952, 10567.260291779501, 8025.23760242776, 8151.1441298662785, 8214.671413143407, 8256.0, 8259.710910118118, 7883.251091146332, 7908.485948413335, 7963.601819908866, 8007.239312265326, 8018.997625296838, 7958.442908996546, 8910.331725120772, 8945.016048234818, 9258.398204116711, 9376.67181648639, 9177.862332065159, 9345.252379809735, 9478.715638530855, 9515.429074255568, 9566.808663826545, 6737.494687898526, 6949.652517374212, 7152.499325047197, 7273.927260727325, 7420.703171873065, 8020.719274825353, 8094.028716554051, 8103.797405064684, 8108.635111420118, 8123.6750529978135, 7107.538010029331, 7213.891791623025, 7215.350618444365, 7339.74310899116, 7397.889031664637, 7003.7548685795755, 7040.542364746275, 7102.857942841011, 7175.21072682015, 7176.605286709281, 7413.962045313552, 7568.470207085451, 7598.696052157852, 7607.657655405409, 7615.923840761521, 6827.146606674166, 6854.794356169323, 6882.724691012303, 6888.0, 6889.173299203927, 6861.828454288683, 6956.756513522205, 6980.685869136003, 6983.336583024605, 6991.126109236346], "unit": "score", "name": "mootools.html", "value": 4786.548960826519}, {"lowerIsBetter": false, "replicates": [320.898916841195, 326.08695652173907, 333.00929734041245, 334.1495892952436, 337.6033161035784, 6586.967065164679, 6603.273639899613, 6625.403713665769, 6637.40263376296, 6649.8005059848165, 6526.641034743087, 6608.735650573984, 6614.338566143383, 6634.668266586676, 6649.0, 3609.981950090246, 4678.181318269306, 4799.448063472711, 4800.855974320759, 4953.801847926087, 4503.819847206108, 4893.730844803535, 4898.632602554805, 4909.582685471739, 4917.459079501252, 4752.120857641347, 4806.7356295403915, 4830.541098595628, 4835.685680430778, 4853.053654537367, 4223.36649502574, 4634.884127896829, 4721.598664113554, 4821.421429428456, 4842.1042107210105, 3366.8148251846137, 4160.292750232437, 4173.499180098408, 4175.812088455997, 4189.476315460567, 6301.590396624205, 6379.36206379363, 6384.042393640944, 6390.520710946697, 6405.903911441285, 5709.172170035322, 5725.942740572583, 5737.713114344266, 5765.769369225226, 5786.913196302059, 6972.047826608557, 6978.616176110312, 6981.197162326347, 6996.230414654384, 7005.719771209146, 4321.7406955582765, 4494.303382975644, 4515.254982927813, 4522.140793249305, 4690.742009189493, 7272.563646181246, 7341.192468828424, 7352.264773522658, 7388.704451821921, 7395.297446742605, 4586.380838586748, 4602.585767280961, 4610.216263235258, 4616.746078965689, 4618.67669263155, 4178.561251068594, 4352.955290730265, 4640.350350950802, 4667.719936803803, 4672.696274742131, 5548.001359755202, 5573.247611572386, 5576.247206627135, 5594.0, 5597.692126932976, 6827.0, 6941.583504989717, 7047.154341479055, 7060.682269297791, 7105.396041336544, 1591.5145880506325, 1611.4118346803332, 1630.4293497276096, 1632.0289427790447, 1635.0598405916646, 1028.3315844701003, 1041.7864337810731, 1050.9159267258601, 1059.5496913811753, 1062.6440142552176, 6322.33615470369, 6542.051402546604, 6569.704363303663, 6580.703868325937, 6588.0, 7143.107111611049, 7249.565026098451, 7267.709291628382, 7361.1166660001145, 7368.521046131984, 6009.36901625323, 6171.506279497629, 6645.800625981228, 6662.133922590032, 6671.0, 3831.2529056834205, 3879.1271963807917, 3880.553736320303, 3882.650561449483, 3891.280113179071, 7410.814729631695, 7644.923550764533, 7704.922950770532, 7708.344790692742, 7726.613669316512, 7539.585322807188, 7588.696452141963, 7592.278733520307, 7605.847883042308, 7630.351420129351, 7679.308862202429, 7689.846203076019, 7697.422693297913, 7699.4610377274175, 7702.3453006493955, 7011.404030657247, 7323.523970941872, 7332.523385979895, 7348.0, 7359.006534117825, 7215.639218038972, 7257.310555497219, 7258.673359698932, 7260.237675044255, 7264.164621068645, 7222.819429514094, 7510.79827227641, 7638.732644357421, 7698.384129269757, 7740.535567865946, 3789.81050947446, 4624.930626040679, 4645.976770116128, 4646.83736069236, 4650.651201159859, 5914.556408269311, 7028.9297107030325, 7301.707931682673, 7311.232320606472, 7319.0, 7057.929420705727, 7099.07711997437, 7117.715291388494, 7121.145462544528, 7123.038389817516, 7021.789346319619, 7077.115360579927, 7094.361507464353, 7103.0, 7104.715811367488, 6925.480588955747, 6932.029515867884, 6940.895886561605, 6949.200841903245, 6978.720851165896, 5500.367457742411, 7056.50604457683, 7092.0, 7106.7157313706875, 7109.253528379446, 5616.382197958303, 5753.0, 6639.2696803352555, 6877.415419689382, 6938.5836849789175], "unit": "score", "name": "prototype.html", "value": 5115.311688067535}, {"lowerIsBetter": false, "replicates": [695.4540685561834, 739.6634531288261, 752.5635131623659, 767.2365995834144, 779.6179871862789, 14901.627459313522, 15113.848861511382, 15148.545543633694, 15148.62128446788, 15164.014339067953, 12456.439460224288, 12842.52310984237, 13781.379837907292, 13848.792268115962, 13861.653458663539, 725.4160400877291, 904.7059705595691, 920.9079092090805, 922.077922077922, 922.1608336413865, 739.0244876762675, 910.899801021887, 927.4342650982895, 928.5682157796623, 930.2186163622556, 960.817444685511, 971.8007808399296, 972.6060945317158, 976.1507488485028, 987.3138168972567, 780.2626517940548, 954.9856752148723, 976.345848281653, 978.8238117138912, 984.1732944326764, 728.4682182007111, 729.2998721227627, 730.8647900138438, 730.9232530584319, 732.1068296678044, 15312.310946007456, 15355.0, 15364.385424583003, 15380.615484612974, 15382.230888455533, 12667.0, 12669.936650316782, 12775.552855650008, 12806.743865122646, 13150.671233219151, 9873.802523949553, 10195.847062294071, 10291.382517048925, 10650.946745266301, 11111.0, 3561.0919215600115, 3644.7084233261276, 3646.7264955128207, 3689.335919534483, 3702.2780557791243, 84445.7955009822, 85310.45482043647, 85970.57014714886, 86210.0, 86381.13618863793, 9002.50486223264, 9346.53267336644, 9562.474063926411, 9598.760030999281, 9883.604655813688, 21660.675089873665, 21694.891525542273, 21932.89033554822, 21961.121555137615, 21972.560548788933, 7642.312191902755, 7710.691572337156, 7721.691132354756, 7728.459007869507, 7770.844583108419, 4026.154507553388, 4111.773852438145, 4116.4648595682365, 4129.648979836687, 4132.586741325904, 3647.7993710345654, 3698.2973235085246, 3699.112213068844, 3706.721995850322, 3709.0356507307756, 676.827409010709, 684.5003147702205, 691.1498856406547, 692.5290802254415, 704.0214102397568, 575.1315513574533, 595.8778450417655, 600.1987346891948, 609.7225762278152, 614.6937757265811, 8067.0, 8078.434509584273, 8182.118112833962, 8187.590620468953, 8274.669013239523, 572.3904042195132, 585.3590318601125, 606.5875204860649, 618.5670030978333, 645.4803882874331, 3701.3892707702926, 3749.3626083565314, 3804.6766024887643, 3911.119998000427, 3916.3929590913453, 85665.14334856572, 88462.55768721244, 88890.55554722185, 89824.5508772452, 91042.0, 75950.0, 76171.0, 76364.61817690876, 77243.0, 77778.2222177771, 67349.3265067343, 68488.31511684919, 68511.62976740536, 68870.0, 69311.0, 7537.2462753724185, 7592.658330375036, 7676.462647614613, 7914.920850791418, 8020.117787043304, 34896.65103348934, 45012.32481512715, 46045.0, 46893.06213875635, 47175.52824471849, 57860.71069644793, 58285.708571456875, 61520.76958460716, 62117.757644847756, 62452.68773656103, 9882.703518894445, 10573.2598718089, 10668.946655266674, 10850.945745271223, 11144.052755515548, 11875.406229688653, 11938.64184074479, 11939.283642981449, 12459.12786104964, 12759.681007974876, 11447.828282575934, 11537.48081336325, 11734.002609778265, 11755.529778808752, 11766.647000589654, 9144.0, 10466.581336746749, 10705.89294107049, 11320.433978301216, 11653.47559359814, 11149.237499813678, 11378.374189419661, 11383.943080284545, 11513.366764828015, 11631.127665424958, 9633.518324083909, 9791.167750740982, 10013.098821106136, 10022.198224142197, 10087.243456740627, 9519.857202142111, 9573.569189386633, 9604.567794449127, 9628.32601717873, 9642.132208101304], "unit": "score", "name": "yui.html", "value": 6902.395213561789}], "name": "dromaeo_css", "value": 7450.120413501969}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 110.0, 112.0, 110.0, 110.0, 113.0, 111.0, 109.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 142.0, 156.0, 119.0, 141.0, 138.0, 117.0, 159.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 138.0}, {"lowerIsBetter": true, "replicates": [184.0, 186.0, 186.0, 191.0, 185.0, 183.0, 184.0, 185.0, 181.0, 180.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 85.0, 78.0, 58.0, 58.0, 57.0, 79.0, 76.0, 54.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [93.0, 97.0, 130.0, 80.0, 80.0, 87.0, 114.0, 79.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 95.8}, {"lowerIsBetter": true, "replicates": [86.0, 102.0, 86.0, 84.0, 86.0, 97.0, 126.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 94.0, 94.0, 92.0, 109.0, 150.0, 93.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 100.2}, {"lowerIsBetter": true, "replicates": [85.0, 100.0, 133.0, 134.0, 85.0, 84.0, 84.0, 85.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 66.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 69.0, 71.0, 71.0, 68.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 84.0, 84.0, 83.0, 83.0, 84.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [125.0, 134.0, 131.0, 137.0, 129.0, 132.0, 122.0, 120.0, 126.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [141.0, 127.0, 139.0, 138.0, 136.0, 134.0, 137.0, 138.0, 134.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [56.0, 82.0, 93.0, 96.0, 67.0, 68.0, 68.0, 65.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.7}], "name": "kraken", "value": 1431.3}]} 14:52:56 INFO - Return code: 0 14:52:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:52:56 ERROR - # TBPL SUCCESS # 14:52:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:52:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:52:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:52:56 INFO - 2016-03-21 14:52:56.596 screenresolution[1679:10222] starting screenresolution argv=screenresolution get 14:52:56 INFO - 2016-03-21 14:52:56.599 screenresolution[1679:10222] Display 0: 1600x1200x32@60 14:52:56 INFO - 2016-03-21 14:52:56.605 screenresolution[1680:10225] starting screenresolution argv=screenresolution list 14:52:56 INFO - Available Modes on Display 0 14:52:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:52:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:52:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:52:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:52:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:52:56 INFO - Intel Iris: 14:52:56 INFO - Chipset Model: Intel Iris 14:52:56 INFO - Type: GPU 14:52:56 INFO - Bus: Built-In 14:52:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:52:56 INFO - Vendor: Intel (0x8086) 14:52:56 INFO - Device ID: 0x0a2e 14:52:56 INFO - Revision ID: 0x0009 14:52:56 INFO - Displays: 14:52:56 INFO - Display: 14:52:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:52:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:52:56 INFO - Display Serial Number: 1600x1200 60 14:52:56 INFO - Main Display: Yes 14:52:56 INFO - Mirror: Off 14:52:56 INFO - Online: Yes 14:52:56 INFO - Rotation: Supported 14:52:56 INFO - Return code: 0 14:52:56 INFO - Running post-action listener: _resource_record_post_action 14:52:56 INFO - Running post-run listener: _resource_record_post_run 14:52:57 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34020864; Write bytes: 706113024; Read time: 360; Write time: 1848 14:52:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400132608; Write bytes: 394898944; Read time: 30340; Write time: 701 14:52:57 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32218624; Write bytes: 300212224; Read time: 340; Write time: 1099 14:52:57 INFO - Running post-run listener: _upload_blobber_files 14:52:57 INFO - Blob upload gear active. 14:52:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:57 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 14:52:57 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'] 14:52:57 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 14:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:00 INFO - (blobuploader) - INFO - Done attempting. 14:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:01 INFO - (blobuploader) - INFO - Done attempting. 14:53:01 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:01 INFO - Return code: 0 14:53:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22a5508b519e55195d4092d0a7b59489b57845a61b4c09b1922e82018d3c367a916a33381301909e4d72fb4773314ad6a436b0606dfb79321c122153b66eab16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ee8d6bc9dea1496f98455ff8dd4fbdd5540cc5c4ca0760aa830f7f17b4ab6915bbcd7af0ed375a1ad28faa0070ab071d4ced9faaabd9005deb5f4185bcb403"} 14:53:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:01 INFO - Contents: 14:53:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/22a5508b519e55195d4092d0a7b59489b57845a61b4c09b1922e82018d3c367a916a33381301909e4d72fb4773314ad6a436b0606dfb79321c122153b66eab16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ee8d6bc9dea1496f98455ff8dd4fbdd5540cc5c4ca0760aa830f7f17b4ab6915bbcd7af0ed375a1ad28faa0070ab071d4ced9faaabd9005deb5f4185bcb403"} 14:53:01 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:01 INFO - Copying logs to upload dir... 14:53:01 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1384.369164 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2016-03-21 14:53:01.629102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 14:53:01.632330) ========= 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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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/22a5508b519e55195d4092d0a7b59489b57845a61b4c09b1922e82018d3c367a916a33381301909e4d72fb4773314ad6a436b0606dfb79321c122153b66eab16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ee8d6bc9dea1496f98455ff8dd4fbdd5540cc5c4ca0760aa830f7f17b4ab6915bbcd7af0ed375a1ad28faa0070ab071d4ced9faaabd9005deb5f4185bcb403"} build_url:https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011066 build_url: 'https://queue.taskcluster.net/v1/task/HNvPRZgmTHSevpAlp7x0gg/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/22a5508b519e55195d4092d0a7b59489b57845a61b4c09b1922e82018d3c367a916a33381301909e4d72fb4773314ad6a436b0606dfb79321c122153b66eab16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93ee8d6bc9dea1496f98455ff8dd4fbdd5540cc5c4ca0760aa830f7f17b4ab6915bbcd7af0ed375a1ad28faa0070ab071d4ced9faaabd9005deb5f4185bcb403"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 14:53:01.701628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 14:53:01.701977) ========= 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.r7QEIIO4Ws/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.UW32g3UHOT/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.004393 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 14:53:01.812646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 14:53:01.813441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 14:53:01.813971) ========= ========= Total master_lag: 2.61 =========