builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0003 starttime: 1459473660.71 results: success (0) buildid: 20160331161533 builduid: af112e4ca795467c8d9337e1ba12467a revision: 27104628616c5550fc56b060e727248c5f3a1c2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:00.713363) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:00.713737) ========= ========= Started set props: basedir (results: 0, elapsed: 15 secs) (at 2016-03-31 18:21:00.714040) ========= 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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005539 basedir: '/builds/slave/test' ========= master_lag: 15.46 ========= ========= Finished set props: basedir (results: 0, elapsed: 15 secs) (at 2016-03-31 18:21:16.181354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-31 18:21:16.181764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-03-31 18:21:18.225959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.226300) ========= 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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005071 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.314419) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.314745) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.319309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.319614) ========= 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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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-31 18:21:18-- 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% 152M=0s 2016-03-31 18:21:19 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.597454 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.950044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:18.950337) ========= 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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.026816 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:19.001055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 18:21:19.001378) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27104628616c5550fc56b060e727248c5f3a1c2c --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 27104628616c5550fc56b060e727248c5f3a1c2c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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-31 18:21:19,587 truncating revision to first 12 chars 2016-03-31 18:21:19,587 Setting DEBUG logging. 2016-03-31 18:21:19,587 attempt 1/10 2016-03-31 18:21:19,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27104628616c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-31 18:21:20,689 unpacking tar archive at: fx-team-27104628616c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.350105 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 18:21:20.370921) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:20.373470) ========= echo 27104628616c5550fc56b060e727248c5f3a1c2c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'27104628616c5550fc56b060e727248c5f3a1c2c'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 27104628616c5550fc56b060e727248c5f3a1c2c program finished with exit code 0 elapsedTime=0.005377 script_repo_revision: '27104628616c5550fc56b060e727248c5f3a1c2c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:20.424359) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:20.424682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 18:21:20.441505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-03-31 18:21:20.441875) ========= /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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:21:21 INFO - MultiFileLogger online at 20160331 18:21:21 in /builds/slave/test 18:21:21 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 18:21:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:21:21 INFO - {'append_to_log': False, 18:21:21 INFO - 'base_work_dir': '/builds/slave/test', 18:21:21 INFO - 'blob_upload_branch': 'Fx-Team', 18:21:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:21:21 INFO - 'branch': 'Fx-Team', 18:21:21 INFO - 'buildbot_json_path': 'buildprops.json', 18:21:21 INFO - 'config_files': ('talos/mac_config.py',), 18:21:21 INFO - 'default_actions': ('clobber', 18:21:21 INFO - 'read-buildbot-config', 18:21:21 INFO - 'download-and-extract', 18:21:21 INFO - 'populate-webroot', 18:21:21 INFO - 'create-virtualenv', 18:21:21 INFO - 'install', 18:21:21 INFO - 'run-tests'), 18:21:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:21:21 INFO - 'download_minidump_stackwalk': True, 18:21:21 INFO - 'download_symbols': 'ondemand', 18:21:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:21:21 INFO - 'tooltool.py': '/tools/tooltool.py', 18:21:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:21:21 INFO - '/tools/misc-python/virtualenv.py')}, 18:21:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:21:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:21:21 INFO - 'installer_path': 'installer.exe', 18:21:21 INFO - 'log_level': 'info', 18:21:21 INFO - 'log_name': 'talos', 18:21:21 INFO - 'log_to_console': True, 18:21:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:21:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:21:21 INFO - 'opt_config_files': (), 18:21:21 INFO - 'pip_index': False, 18:21:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:21:21 INFO - 'cmd': ('bash', 18:21:21 INFO - '-c', 18:21:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:21:21 INFO - 'enabled': True, 18:21:21 INFO - 'halt_on_failure': False, 18:21:21 INFO - 'name': 'check_screen_resolution'},), 18:21:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:21:21 INFO - 'cmd': ('bash', 18:21:21 INFO - '-c', 18:21:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:21:21 INFO - 'enabled': True, 18:21:21 INFO - 'halt_on_failure': False, 18:21:21 INFO - 'name': 'check_screen_resolution'},), 18:21:21 INFO - 'run_cmd_checks_enabled': True, 18:21:21 INFO - 'sps_profile': False, 18:21:21 INFO - 'sps_profile_interval': 0, 18:21:21 INFO - 'suite': 'dromaeojs', 18:21:21 INFO - 'system_bits': '32', 18:21:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:21:21 INFO - 'title': 't-yosemite-r7-0003', 18:21:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:21:21 INFO - 'use_talos_json': True, 18:21:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:21:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:21:21 INFO - 'work_dir': 'build'} 18:21:21 INFO - ##### 18:21:21 INFO - ##### Running clobber step. 18:21:21 INFO - ##### 18:21:21 INFO - Running pre-action listener: _resource_record_pre_action 18:21:21 INFO - Running main action method: clobber 18:21:21 INFO - rmtree: /builds/slave/test/build 18:21:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:21:22 INFO - Running post-action listener: _resource_record_post_action 18:21:22 INFO - ##### 18:21:22 INFO - ##### Running read-buildbot-config step. 18:21:22 INFO - ##### 18:21:22 INFO - Running pre-action listener: _resource_record_pre_action 18:21:22 INFO - Running main action method: read_buildbot_config 18:21:22 INFO - Using buildbot properties: 18:21:22 INFO - { 18:21:22 INFO - "project": "", 18:21:22 INFO - "product": "firefox", 18:21:22 INFO - "script_repo_revision": "production", 18:21:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:21:22 INFO - "repository": "", 18:21:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:21:22 INFO - "buildid": "20160331161533", 18:21:22 INFO - "pgo_build": "False", 18:21:22 INFO - "basedir": "/builds/slave/test", 18:21:22 INFO - "buildnumber": 651, 18:21:22 INFO - "slavename": "t-yosemite-r7-0003", 18:21:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:21:22 INFO - "platform": "yosemite_r7", 18:21:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:21:22 INFO - "branch": "fx-team", 18:21:22 INFO - "repo_path": "integration/fx-team", 18:21:22 INFO - "revision": "27104628616c5550fc56b060e727248c5f3a1c2c", 18:21:22 INFO - "stage_platform": "macosx64", 18:21:22 INFO - "builduid": "af112e4ca795467c8d9337e1ba12467a", 18:21:22 INFO - "slavebuilddir": "test" 18:21:22 INFO - } 18:21:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:21:22 INFO - Running post-action listener: _resource_record_post_action 18:21:22 INFO - ##### 18:21:22 INFO - ##### Running download-and-extract step. 18:21:22 INFO - ##### 18:21:22 INFO - Running pre-action listener: _resource_record_pre_action 18:21:22 INFO - Running main action method: download_and_extract 18:21:22 INFO - mkdir: /builds/slave/test/build/tests 18:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:22 INFO - https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:21:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:21:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:21:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:25 INFO - Downloaded 1199 bytes. 18:21:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:21:25 INFO - Using the following test package requirements: 18:21:25 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:21:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:21:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:21:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'jsshell-mac.zip'], 18:21:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:21:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:21:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:21:25 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:21:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:21:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:21:25 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:21:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:21: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')]} 18:21:25 INFO - https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:35 INFO - Downloaded 17955628 bytes. 18:21: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'] 18:21: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 18:21:38 INFO - Return code: 0 18:21:38 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 18:21:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:38 INFO - https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:39 INFO - Downloaded 17955628 bytes. 18:21:39 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'] 18:21:39 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 18:21:43 INFO - Return code: 0 18:21:43 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')]} 18:21:43 INFO - https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:21:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:21:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:21:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:21:44 INFO - Downloaded 10847534 bytes. 18:21:44 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'] 18:21:44 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 18:21:44 INFO - Return code: 0 18:21:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:44 INFO - https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:21:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:21:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:21:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:21:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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 18:22:03 INFO - Downloaded 111469896 bytes. 18:22:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:22:03 INFO - mkdir: /builds/slave/test/properties 18:22:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:22:03 INFO - Writing to file /builds/slave/test/properties/build_url 18:22:03 INFO - Contents: 18:22:03 INFO - build_url:https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:22:06 INFO - Running post-action listener: _resource_record_post_action 18:22:06 INFO - Running post-action listener: set_extra_try_arguments 18:22:06 INFO - ##### 18:22:06 INFO - ##### Running populate-webroot step. 18:22:06 INFO - ##### 18:22:06 INFO - Running pre-action listener: _resource_record_pre_action 18:22:06 INFO - Running main action method: populate_webroot 18:22:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:22:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:22:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:22:06 INFO - '--tppagecycles', 18:22:06 INFO - '7'], 18:22:06 INFO - 'tests': ['tsvgm']}}, 18:22:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:22:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:22:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:22:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:22:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:22:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'tests': ['damp', 'tps']}, 18:22:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['damp', 'tps']}, 18:22:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:22:06 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['dromaeo_dom']}, 18:22:06 INFO - 'other': {'tests': ['a11yr', 18:22:06 INFO - 'ts_paint', 18:22:06 INFO - 'tpaint', 18:22:06 INFO - 'sessionrestore', 18:22:06 INFO - 'sessionrestore_no_auto_restore', 18:22:06 INFO - 'tabpaint']}, 18:22:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['a11yr', 18:22:06 INFO - 'ts_paint', 18:22:06 INFO - 'tpaint', 18:22:06 INFO - 'sessionrestore', 18:22:06 INFO - 'sessionrestore_no_auto_restore', 18:22:06 INFO - 'tabpaint']}, 18:22:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['a11yr', 18:22:06 INFO - 'ts_paint', 18:22:06 INFO - 'tpaint', 18:22:06 INFO - 'sessionrestore', 18:22:06 INFO - 'sessionrestore_no_auto_restore', 18:22:06 INFO - 'tabpaint']}, 18:22:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['a11yr', 18:22:06 INFO - 'ts_paint', 18:22:06 INFO - 'tpaint', 18:22:06 INFO - 'sessionrestore', 18:22:06 INFO - 'sessionrestore_no_auto_restore', 18:22:06 INFO - 'tabpaint']}, 18:22:06 INFO - 'other_l64': {'tests': ['a11yr', 18:22:06 INFO - 'ts_paint', 18:22:06 INFO - 'tpaint', 18:22:06 INFO - 'sessionrestore', 18:22:06 INFO - 'sessionrestore_no_auto_restore', 18:22:06 INFO - 'tabpaint']}, 18:22:06 INFO - 'other_nol64': {'tests': ['a11yr', 18:22:06 INFO - 'ts_paint', 18:22:06 INFO - 'tpaint', 18:22:06 INFO - 'sessionrestore', 18:22:06 INFO - 'sessionrestore_no_auto_restore', 18:22:06 INFO - 'tabpaint']}, 18:22:06 INFO - 'svgr': {'tests': ['tsvgx', 18:22:06 INFO - 'tsvgr_opacity', 18:22:06 INFO - 'tart', 18:22:06 INFO - 'tscrollx', 18:22:06 INFO - 'cart']}, 18:22:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['tsvgx', 18:22:06 INFO - 'tsvgr_opacity', 18:22:06 INFO - 'tart', 18:22:06 INFO - 'tscrollx', 18:22:06 INFO - 'cart']}, 18:22:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'tests': ['tp5o']}, 18:22:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'talos_options': ['--e10s'], 18:22:06 INFO - 'tests': ['tp5o']}, 18:22:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'talos_options': ['--xperf_path', 18:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:06 INFO - 'tests': ['tp5n']}, 18:22:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:22:06 INFO - 'talos_options': ['--e10s', 18:22:06 INFO - '--xperf_path', 18:22:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:22:06 INFO - 'tests': ['tp5n']}}, 18:22:06 INFO - 'talos.zip': {'path': '', 18:22:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:22:06 INFO - Running post-action listener: _resource_record_post_action 18:22:06 INFO - ##### 18:22:06 INFO - ##### Running create-virtualenv step. 18:22:06 INFO - ##### 18:22:06 INFO - Running pre-action listener: _resource_record_pre_action 18:22:06 INFO - Running main action method: create_virtualenv 18:22:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:22:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:22:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:22:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:22:06 INFO - Using real prefix '/tools/python27' 18:22:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:22:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:22:09 INFO - Installing pip.................done. 18:22:09 INFO - Return code: 0 18:22:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:22: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')]} 18:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22: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')]} 18:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:09 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 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:09 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 18:22:09 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 18:22:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:09 INFO - 'HOME': '/Users/cltbld', 18:22:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:09 INFO - 'LOGNAME': 'cltbld', 18:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:09 INFO - 'MOZ_NO_REMOTE': '1', 18:22:09 INFO - 'NO_EM_RESTART': '1', 18:22:09 INFO - 'PAGER': '/bin/cat', 18:22:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:09 INFO - 'PWD': '/builds/slave/test', 18:22:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:09 INFO - 'SHELL': '/bin/bash', 18:22:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:09 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:09 INFO - 'USER': 'cltbld', 18:22:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:09 INFO - 'XPC_FLAGS': '0x0', 18:22:09 INFO - 'XPC_SERVICE_NAME': '0', 18:22:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:22:10 INFO - Cleaning up... 18:22:10 INFO - Return code: 0 18:22:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:22:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:10 INFO - 'HOME': '/Users/cltbld', 18:22:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:10 INFO - 'LOGNAME': 'cltbld', 18:22:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:10 INFO - 'MOZ_NO_REMOTE': '1', 18:22:10 INFO - 'NO_EM_RESTART': '1', 18:22:10 INFO - 'PAGER': '/bin/cat', 18:22:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:10 INFO - 'PWD': '/builds/slave/test', 18:22:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:10 INFO - 'SHELL': '/bin/bash', 18:22:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:10 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:10 INFO - 'USER': 'cltbld', 18:22:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:10 INFO - 'XPC_FLAGS': '0x0', 18:22:10 INFO - 'XPC_SERVICE_NAME': '0', 18:22:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:10 INFO - Downloading/unpacking psutil>=0.7.1 18:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:22:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:13 INFO - Installing collected packages: psutil 18:22:13 INFO - Running setup.py install for psutil 18:22:13 INFO - building 'psutil._psutil_osx' extension 18:22:13 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 18:22:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:22:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:22:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:22:14 INFO - building 'psutil._psutil_posix' extension 18:22:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:22:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:22:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:22:14 INFO - ^ 18:22:14 INFO - 1 warning generated. 18:22:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:22:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:22:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:22:14 INFO - Successfully installed psutil 18:22:14 INFO - Cleaning up... 18:22:14 INFO - Return code: 0 18:22:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:22:14 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')]} 18:22:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:14 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')]} 18:22:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:14 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 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:14 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 18:22:14 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 18:22:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:14 INFO - 'HOME': '/Users/cltbld', 18:22:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:14 INFO - 'LOGNAME': 'cltbld', 18:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:14 INFO - 'MOZ_NO_REMOTE': '1', 18:22:14 INFO - 'NO_EM_RESTART': '1', 18:22:14 INFO - 'PAGER': '/bin/cat', 18:22:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:14 INFO - 'PWD': '/builds/slave/test', 18:22:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:14 INFO - 'SHELL': '/bin/bash', 18:22:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:14 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:14 INFO - 'USER': 'cltbld', 18:22:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:14 INFO - 'XPC_FLAGS': '0x0', 18:22:14 INFO - 'XPC_SERVICE_NAME': '0', 18:22:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:22:14 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 18:22:14 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 18:22:14 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 18:22:14 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 18:22:14 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 18:22:14 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 18:22:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:22:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:22:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:22:17 INFO - Installing collected packages: mozsystemmonitor 18:22:17 INFO - Running setup.py install for mozsystemmonitor 18:22:17 INFO - Successfully installed mozsystemmonitor 18:22:17 INFO - Cleaning up... 18:22:17 INFO - Return code: 0 18:22:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:22:17 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')]} 18:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:17 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')]} 18:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:17 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 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:17 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 18:22:17 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 18:22:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:17 INFO - 'HOME': '/Users/cltbld', 18:22:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:17 INFO - 'LOGNAME': 'cltbld', 18:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:17 INFO - 'MOZ_NO_REMOTE': '1', 18:22:17 INFO - 'NO_EM_RESTART': '1', 18:22:17 INFO - 'PAGER': '/bin/cat', 18:22:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:17 INFO - 'PWD': '/builds/slave/test', 18:22:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:17 INFO - 'SHELL': '/bin/bash', 18:22:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:17 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:17 INFO - 'USER': 'cltbld', 18:22:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:17 INFO - 'XPC_FLAGS': '0x0', 18:22:17 INFO - 'XPC_SERVICE_NAME': '0', 18:22:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:17 INFO - Downloading/unpacking blobuploader==1.2.4 18:22:17 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 18:22:17 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 18:22:17 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 18:22:17 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 18:22:17 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 18:22:17 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 18:22:20 INFO - Downloading blobuploader-1.2.4.tar.gz 18:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:22:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:22:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:21 INFO - Downloading docopt-0.6.1.tar.gz 18:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:22:21 INFO - Installing collected packages: blobuploader, requests, docopt 18:22:21 INFO - Running setup.py install for blobuploader 18:22:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:22:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:22:21 INFO - Running setup.py install for requests 18:22:22 INFO - Running setup.py install for docopt 18:22:22 INFO - Successfully installed blobuploader requests docopt 18:22:22 INFO - Cleaning up... 18:22:22 INFO - Return code: 0 18:22:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:22 INFO - 'HOME': '/Users/cltbld', 18:22:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:22 INFO - 'LOGNAME': 'cltbld', 18:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:22 INFO - 'MOZ_NO_REMOTE': '1', 18:22:22 INFO - 'NO_EM_RESTART': '1', 18:22:22 INFO - 'PAGER': '/bin/cat', 18:22:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:22 INFO - 'PWD': '/builds/slave/test', 18:22:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:22 INFO - 'SHELL': '/bin/bash', 18:22:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:22 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:22 INFO - 'USER': 'cltbld', 18:22:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:22 INFO - 'XPC_FLAGS': '0x0', 18:22:22 INFO - 'XPC_SERVICE_NAME': '0', 18:22:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:22 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ruOSlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:22 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-TNbMXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:22 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-WdjDlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-1M61xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-PdcfQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-OApTJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-y6_mup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ynu0vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-ZppW6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-wqK4JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-fX1n7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Jce376-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:23 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Az1O1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:24 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-XgsBmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:24 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-vkfCtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:24 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-Q6js_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:24 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-hj8voe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:22:24 INFO - Running setup.py install for manifestparser 18:22:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:22:24 INFO - Running setup.py install for mozcrash 18:22:24 INFO - Running setup.py install for mozdebug 18:22:24 INFO - Running setup.py install for mozdevice 18:22:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Running setup.py install for mozfile 18:22:25 INFO - Running setup.py install for mozhttpd 18:22:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Running setup.py install for mozinfo 18:22:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Running setup.py install for mozInstall 18:22:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:22:25 INFO - Running setup.py install for mozleak 18:22:25 INFO - Running setup.py install for mozlog 18:22:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:22:26 INFO - Running setup.py install for moznetwork 18:22:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:22:26 INFO - Running setup.py install for mozprocess 18:22:26 INFO - Running setup.py install for mozprofile 18:22:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:22:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:22:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:22:26 INFO - Running setup.py install for mozrunner 18:22:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:22:26 INFO - Running setup.py install for mozscreenshot 18:22:26 INFO - Running setup.py install for moztest 18:22:26 INFO - Running setup.py install for mozversion 18:22:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:22:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:22:27 INFO - Cleaning up... 18:22:27 INFO - Return code: 0 18:22:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:27 INFO - 'HOME': '/Users/cltbld', 18:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:27 INFO - 'LOGNAME': 'cltbld', 18:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:27 INFO - 'MOZ_NO_REMOTE': '1', 18:22:27 INFO - 'NO_EM_RESTART': '1', 18:22:27 INFO - 'PAGER': '/bin/cat', 18:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:27 INFO - 'PWD': '/builds/slave/test', 18:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:27 INFO - 'SHELL': '/bin/bash', 18:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:27 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:27 INFO - 'USER': 'cltbld', 18:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:27 INFO - 'XPC_FLAGS': '0x0', 18:22:27 INFO - 'XPC_SERVICE_NAME': '0', 18:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-yvB3P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-HDDit5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-gWM_lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:22:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-dmubIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:22:27 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)) 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-E4MoMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:22:27 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)) 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-yclTLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:22:27 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)) 18:22:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:22:27 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-DFlvzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-N91HJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-9VT7J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-IcRMAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-On2qve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-VSWUio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-rMT2Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:22:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-t6lpCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:22:28 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)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-R3as19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:22:28 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)) 18:22:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:22:28 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-NQcqXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:22:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:22:29 INFO - Running setup.py (path:/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/pip-4sAsdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:22:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:31 INFO - Downloading blessings-1.6.tar.gz 18:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:22:32 INFO - Installing collected packages: blessings 18:22:32 INFO - Running setup.py install for blessings 18:22:32 INFO - Successfully installed blessings 18:22:32 INFO - Cleaning up... 18:22:32 INFO - Return code: 0 18:22:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:22:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:32 INFO - Reading from file tmpfile_stdout 18:22:32 INFO - Current package versions: 18:22:32 INFO - blessings == 1.6 18:22:32 INFO - blobuploader == 1.2.4 18:22:32 INFO - docopt == 0.6.1 18:22:32 INFO - manifestparser == 1.1 18:22:32 INFO - mozInstall == 1.12 18:22:32 INFO - mozcrash == 0.17 18:22:32 INFO - mozdebug == 0.1 18:22:32 INFO - mozdevice == 0.48 18:22:32 INFO - mozfile == 1.2 18:22:32 INFO - mozhttpd == 0.7 18:22:32 INFO - mozinfo == 0.9 18:22:32 INFO - mozleak == 0.1 18:22:32 INFO - mozlog == 3.1 18:22:32 INFO - moznetwork == 0.27 18:22:32 INFO - mozprocess == 0.22 18:22:32 INFO - mozprofile == 0.28 18:22:32 INFO - mozrunner == 6.11 18:22:32 INFO - mozscreenshot == 0.1 18:22:32 INFO - mozsystemmonitor == 0.0 18:22:32 INFO - moztest == 0.7 18:22:32 INFO - mozversion == 1.4 18:22:32 INFO - psutil == 3.1.1 18:22:32 INFO - requests == 1.2.3 18:22:32 INFO - wsgiref == 0.1.2 18:22:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:22:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:32 INFO - 'HOME': '/Users/cltbld', 18:22:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:32 INFO - 'LOGNAME': 'cltbld', 18:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:32 INFO - 'MOZ_NO_REMOTE': '1', 18:22:32 INFO - 'NO_EM_RESTART': '1', 18:22:32 INFO - 'PAGER': '/bin/cat', 18:22:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:32 INFO - 'PWD': '/builds/slave/test', 18:22:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:32 INFO - 'SHELL': '/bin/bash', 18:22:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:32 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:32 INFO - 'USER': 'cltbld', 18:22:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:32 INFO - 'XPC_FLAGS': '0x0', 18:22:32 INFO - 'XPC_SERVICE_NAME': '0', 18:22:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:22:32 INFO - Cleaning up... 18:22:32 INFO - Return code: 0 18:22:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:22:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:22:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:32 INFO - 'HOME': '/Users/cltbld', 18:22:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:32 INFO - 'LOGNAME': 'cltbld', 18:22:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:32 INFO - 'MOZ_NO_REMOTE': '1', 18:22:32 INFO - 'NO_EM_RESTART': '1', 18:22:32 INFO - 'PAGER': '/bin/cat', 18:22:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:32 INFO - 'PWD': '/builds/slave/test', 18:22:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:32 INFO - 'SHELL': '/bin/bash', 18:22:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:32 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:32 INFO - 'USER': 'cltbld', 18:22:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:32 INFO - 'XPC_FLAGS': '0x0', 18:22:32 INFO - 'XPC_SERVICE_NAME': '0', 18:22:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:33 INFO - Downloading/unpacking jsonschema 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22: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 18:22:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:22:35 INFO - Downloading/unpacking functools32 (from jsonschema) 18:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:35 INFO - Downloading functools32-3.2.3-2.tar.gz 18:22:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:22:35 INFO - warning: no files found matching '*.txt' 18:22:35 INFO - no previously-included directories found matching 'build' 18:22:35 INFO - no previously-included directories found matching 'dist' 18:22:35 INFO - no previously-included directories found matching '.git*' 18:22:35 INFO - Installing collected packages: jsonschema, functools32 18:22:35 INFO - Running setup.py install for functools32 18:22:36 INFO - warning: no files found matching '*.txt' 18:22:36 INFO - no previously-included directories found matching 'build' 18:22:36 INFO - no previously-included directories found matching 'dist' 18:22:36 INFO - no previously-included directories found matching '.git*' 18:22:36 INFO - Successfully installed jsonschema functools32 18:22:36 INFO - Cleaning up... 18:22:36 INFO - Return code: 0 18:22:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:22:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:22:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:22:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107317a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107327420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95e34cc710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, '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.A0bVYme0jw/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.w6PA2tTf08/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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 18:22:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:22:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:22:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:22:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:36 INFO - 'HOME': '/Users/cltbld', 18:22:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:36 INFO - 'LOGNAME': 'cltbld', 18:22:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:36 INFO - 'MOZ_NO_REMOTE': '1', 18:22:36 INFO - 'NO_EM_RESTART': '1', 18:22:36 INFO - 'PAGER': '/bin/cat', 18:22:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:36 INFO - 'PWD': '/builds/slave/test', 18:22:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:36 INFO - 'SHELL': '/bin/bash', 18:22:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:22:36 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:22:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:36 INFO - 'USER': 'cltbld', 18:22:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:36 INFO - 'XPC_FLAGS': '0x0', 18:22:36 INFO - 'XPC_SERVICE_NAME': '0', 18:22:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:22:36 INFO - Downloading/unpacking flake8 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:22:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:22:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:22:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:40 INFO - no previously-included directories found matching 'docs/_build' 18:22:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:22:40 INFO - Running setup.py install for pep8 18:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:40 INFO - no previously-included directories found matching 'docs/_build' 18:22:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:22:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:22:40 INFO - Cleaning up... 18:22:40 INFO - Return code: 0 18:22:40 INFO - Running post-action listener: _resource_record_post_action 18:22:40 INFO - Running post-action listener: _start_resource_monitoring 18:22:40 INFO - Starting resource monitoring. 18:22:40 INFO - ##### 18:22:40 INFO - ##### Running install step. 18:22:40 INFO - ##### 18:22:40 INFO - Running pre-action listener: _resource_record_pre_action 18:22:40 INFO - Running main action method: install 18:22:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:40 INFO - Reading from file tmpfile_stdout 18:22:40 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:41 INFO - Reading from file tmpfile_stdout 18:22:41 INFO - Output received: 18:22:41 INFO - Usage: mozinstall [options] installer 18:22:41 INFO - Options: 18:22:41 INFO - -h, --help show this help message and exit 18:22:41 INFO - -d DEST, --destination=DEST 18:22:41 INFO - Directory to install application into. [default: 18:22:41 INFO - "/builds/slave/test"] 18:22:41 INFO - --app=APP Application being installed. [default: firefox] 18:22:41 INFO - mkdir: /builds/slave/test/build/application 18:22:41 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'] 18:22:41 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 18:23:15 INFO - Reading from file tmpfile_stdout 18:23:15 INFO - Output received: 18:23:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:23:15 INFO - Running post-action listener: _resource_record_post_action 18:23:15 INFO - ##### 18:23:15 INFO - ##### Running run-tests step. 18:23:15 INFO - ##### 18:23:15 INFO - Running pre-action listener: _resource_record_pre_action 18:23:15 INFO - Running main action method: run_tests 18:23:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:23:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:23:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:23:15 INFO - 2016-03-31 18:23:15.086 screenresolution[1645:7493] starting screenresolution argv=screenresolution get 18:23:15 INFO - 2016-03-31 18:23:15.088 screenresolution[1645:7493] Display 0: 1600x1200x32@60 18:23:15 INFO - 2016-03-31 18:23:15.096 screenresolution[1646:7495] starting screenresolution argv=screenresolution list 18:23:15 INFO - Available Modes on Display 0 18:23:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:23:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:23:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:23:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:23:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:23:15 INFO - Intel Iris: 18:23:15 INFO - Chipset Model: Intel Iris 18:23:15 INFO - Type: GPU 18:23:15 INFO - Bus: Built-In 18:23:15 INFO - VRAM (Dynamic, Max): 1536 MB 18:23:15 INFO - Vendor: Intel (0x8086) 18:23:15 INFO - Device ID: 0x0a2e 18:23:15 INFO - Revision ID: 0x0009 18:23:15 INFO - Displays: 18:23:15 INFO - Display: 18:23:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:23:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:23:15 INFO - Display Serial Number: 1600x1200 60 18:23:15 INFO - Main Display: Yes 18:23:15 INFO - Mirror: Off 18:23:15 INFO - Online: Yes 18:23:15 INFO - Rotation: Supported 18:23:15 INFO - Return code: 0 18:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:15 INFO - Python 2.7.3 18:23:15 INFO - Return code: 0 18:23:15 INFO - grabbing minidump binary from tooltool 18:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1071b6e00>, '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 0x106fdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1071b1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:23:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:23:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:15 INFO - Return code: 0 18:23:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:23:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:23:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:23:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:23:16 INFO - Return code: 0 18:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 18:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0003 --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 18:23:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A0bVYme0jw/Render', 18:23:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:23:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:23:16 INFO - 'HOME': '/Users/cltbld', 18:23:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:23:16 INFO - 'LOGNAME': 'cltbld', 18:23:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:16 INFO - 'MOZ_NO_REMOTE': '1', 18:23:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:16 INFO - 'NO_EM_RESTART': '1', 18:23:16 INFO - 'PAGER': '/bin/cat', 18:23:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:16 INFO - 'PWD': '/builds/slave/test', 18:23:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:23:16 INFO - 'SHELL': '/bin/bash', 18:23:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w6PA2tTf08/Listeners', 18:23:16 INFO - 'TMPDIR': '/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/', 18:23:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:23:16 INFO - 'USER': 'cltbld', 18:23:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:23:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:16 INFO - 'XPC_FLAGS': '0x0', 18:23:16 INFO - 'XPC_SERVICE_NAME': '0', 18:23:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:23:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 18:23:16 INFO - mozversion application_buildid: 20160331161533 18:23:16 INFO - mozversion application_changeset: 27104628616c5550fc56b060e727248c5f3a1c2c 18:23:16 INFO - mozversion application_display_name: Nightly 18:23:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:16 INFO - mozversion application_name: Firefox 18:23:16 INFO - mozversion application_remotingname: firefox 18:23:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:23:16 INFO - mozversion application_vendor: Mozilla 18:23:16 INFO - mozversion application_version: 48.0a1 18:23:16 INFO - mozversion platform_buildid: 20160331161533 18:23:16 INFO - mozversion platform_changeset: 27104628616c5550fc56b060e727248c5f3a1c2c 18:23:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:23:16 INFO - mozversion platform_version: 48.0a1 18:23:16 INFO - using testdate: 1459473796 18:23:16 INFO - actual date: 1459473796 18:23:16 INFO - starting webserver on 'localhost:49270' 18:23:16 INFO - SUITE-START | Running 2 tests 18:23:16 INFO - TEST-START | dromaeo_css 18:23:16 INFO - operating with platform_type : mac_ 18:23:16 INFO - Initialising browser for dromaeo_css test... 18:23:16 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmp70l2YM/profile http://localhost:49270/getInfo.html) 18:23:19 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 18:23:19 INFO - PROCESS | 1664 | colorDepth:24 18:23:19 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 18:23:19 INFO - PROCESS | 1664 | __metrics 18:23:19 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" 18:23:19 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:23:20 INFO - TEST-INFO | 1664: exit 0 18:23:20 INFO - Browser initialized. 18:23:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:23:20 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmp70l2YM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:32 INFO - PROCESS | 1667 | RSS: Main: 244092928 18:23:32 INFO - PROCESS | 1667 | 18:24:23 INFO - PROCESS | 1667 | 1459473863787 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] 18:26:34 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 18:26:35 INFO - PROCESS | 1667 | RSS: Main: 332218368 18:26:35 INFO - PROCESS | 1667 | 18:29:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 18:29:38 INFO - PROCESS | 1667 | RSS: Main: 373559296 18:29:38 INFO - PROCESS | 1667 | 18:32:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 18:32:41 INFO - PROCESS | 1667 | RSS: Main: 378433536 18:32:41 INFO - PROCESS | 1667 | 18:35:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 18:35:43 INFO - PROCESS | 1667 | RSS: Main: 334413824 18:35:43 INFO - PROCESS | 1667 | 18:38:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 18:38:47 INFO - PROCESS | 1667 | RSS: Main: 336191488 18:38:47 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 18:41:50 INFO - PROCESS | 1667 | RSS: Main: 383860736 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | __start_tp_report 18:41:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 18:41:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 18:41:50 INFO - PROCESS | 1667 | |i|pagename|runs| 18:41:50 INFO - PROCESS | 1667 | |0;dojo.html;3383.7649258020824;3426.7601267911255;3464.549608550888;3467.3412051710156;3511.192425742079;5472.671639701611;5561.443855614437;5617.859553511159;5629.971850140749;5647.774089036438;5581;5638.605297629158;5646.943530564703;5656.208130861683;5662.5753068519925;5065.341505604276;5081.84754457365;5084.415292241384;5115.437301896788;5173.068847607429;5164.586833053347;5167.224916262553;5168.9224661630105;5172.870678233036;5176.120059589879;5063.139266324715;5117.078925793356;5138.177891537355;5148.716820574867;5153.098207813637;5140.434552199236;5165.251038599419;5188.014277287341;5188.481151884819;5257.1588545832865;5001.824936127255;5012.674176178537;5047.394312682465;5108.64239503235;5119.590432765407;5483.369412517572;5515.669059856422;5526.336839579276;5553.944460555384;5620.606557540974;6181.196444462236;6221.688915554249;6225.719842607094;6237.09562113491;6250.624962502219;6073.279660637198;6088.543359248074;6194.4115309045565;6245.910891138545;6297.905531417033;5763.164341170507;5787.392323806024;5804.448577385142;5824.359320474744;5839.211706419579;6232.875342493216;6251.718672659741;6265.122882796412;6265.216847894013;6300.338464461257;5962.105684147413;6056;6129.14485165794;6143.170671959318;6198.132261483396;6141.877162456815;6217.409346112112;6228.906566401508;6229;6232.0963460298;6125.877482450326;6164.075388691643;6184.010558310649;6184.412480814315;6203.96898015516;6103.450689437972;6121.755129794848;6174.722137503823;6207.720652570645;6237.625742455467;4846.321514987904;4854.247591623304;4856.538628830255;4889.193283108248;4900.044491324157;4381.846635367747;4392.472903251566;4407.559244075567;4410.42664453619;4449.755263460476;5535.750891209906;5620.353659329147;5622.550195984311;5629.549636029108;5706;5202.869928251824;6189;6222.439980401786;6229.626222426669;6237.376262373817;5612.831615051555;5626.606137570331;5658.943410565924;5678.630888992202;5685.175649530877;5232.712200828915;5271.156614941668;5343.5457986071615;5361.490658387447;5409.864753381197;6220.471259942956;6239.688015599293;6261.749530018839;6265.0602409637095;6271.3728627136925;6121.788327166137;6209.813705588659;6236.282827474898;6245.219347581552;6259.843503912257;6205.348438413902;6233.532485063548;6242.750289988531;6255.31191568918;6267.905981410374;6076.574639775174;6110.938890611037;6138.263408391022;6153.630782153085;6159.23009623797;6105.702364394958;6114.969425152845;6222.844428889314;6224.688765561613;6231.688415579112;6098.069176274391;6105.945000794801;6110.663913484801;6111.0752052021135;6138.048602466625;6070.757169713339;6079.908801368071;6088.665123418255;6099.420555047263;6100.572959892765;5700.5154561861045;5826.912596310974;5885.823425297248;5915.763369465173;5924.851878702894;5838.065909454467;5980.19267398913;6019;6122.093225952662;6142.600730952474;5855.151003104441;5910.379410161871;5912.201852749996;5916.112583112567;5920.200772895604 18:41:50 INFO - PROCESS | 1667 | |1;ext.html;435.59054488780527;511.41443047710374;515.4355980201681;607.4381197392412;641.95506314558;38132.809335953316;38497;38548;38564.22871542568;38590;41626.16747665045;41950.16099678005;41976;42141.36787948175;42179;9441.81116377672;9657.758556036086;9666.420014799134;9671.323007389485;9698.90301096987;9450.33847630666;9559.80880382392;9577;9682.661106861262;9736.51317434129;9594.952025239863;9661.71014869555;9680;9681.70954871355;9699.224062075016;9633.855492167622;9720.854187187198;9727.610895564168;9729.173020293283;9740.561674724619;9376.296777741696;9497.857532137023;9529.047095290485;9540.475273859935;9543.618255269781;32087.518687219475;32695;39875.20249595021;40291.99270018244;40452.797736011424;3141.528770684393;3250.983745081283;3323.9169020774675;3393.915152121192;3636.381815091441;23295.767042329528;25766.87116564424;26876.92492300306;27562;27718.02986895449;2659.9335016624545;2723.6867760207433;2734.8359098453957;2794.2176190666646;2862.670792858827;408231;412117;414476.92761536303;414651;416599;45429;64449.355506444335;68918.31081689219;69003;69015.96476052863;44643.10713785706;44902;44903.55096449059;44904;45027.77486112549;15586.220688965734;15836.841631583537;15868.365265389486;15872.841271587367;15875.52373428799;12691.746165076647;12742.554010609585;12777.361131943366;12789.680257993625;12798.936005319914;14274.571762847132;14274.643133921734;14533.128012319296;14533.491327803476;14614.196219208046;5309.3894202166475;6223.595466294676;6290.339514351019;6313.526485513605;6314.6113451151;915.7619019055094;918.169057003413;980.9117179453883;1034.6016783538391;1146.8394424780538;28979.56530652042;29014.27464313409;29595.26011849678;29693.703062969093;29725.851370743007;983.6360546597662;1019.6023550815188;1119.6696974392412;1144.8282757586262;1196.9281843089443;14637.121772693672;14744.299755525706;14868;14996.325165367367;15053;526380;527419;533122;534364;534896;58210.70894645499;58647;58741;58785.706071470224;58925.70537147287;1338.4846833968797;1348.9730205396033;1449.39125567262;1455.5051282563768;1489.7616381378928;26041.609375859756;28373.148805535868;28599.28501787472;28923;29122.417551649272;45320.546794531634;45798.77100614476;45800.54199457963;45865.54134458613;45872;325167;335577;336573;336711.632883668;337860;29176.7082329174;32368.514472282463;32479.35041299208;32855;33206.16984575405;40537.59462405338;41117.383239252034;41683;41889.58110418857;42273.15453690848;34309.48535771915;36241.27517449689;36516;36948.89153325404;37871.24257514889;35151.82424087863;35294.64705353016;35335.82332088323;36110;36202.45696314505;36479.817600911825;36683;37601.43597846089;37895;38017.2396552073;29844.253893652833;31136;31227.375452491277;31237.531437028916;31371.686283136878;23568;23597.75240456734;23685.52628947446;23949;24118.276451706475 18:41:50 INFO - PROCESS | 1667 | |2;jquery.html;355.90034790258727;358.12259963090435;364.686369722039;370.4184430444202;371.6450789496028;19646.410607681773;20348.389548313557;20595.2791652292;21087.68368474474;21097.94510274484;19362.419127426165;19523.219071237134;20064.996750162507;20100.39196864251;20554.280600178958;5151.922721159186;5345.118055520835;5392.379876314215;5399.244105825188;5405.540529055035;3908;4036.1120553478336;4711.505291944348;5288.365396152448;5967.910481342762;5939.227900372945;5944;5953.226080609515;5957.582969192158;5964.433378829026;5700.942990570083;5837.854053648651;5886.6173698709445;5913.940860591403;5934.228550288456;5596.524295434893;5618.438156184389;5624.21261023457;5624.240727501776;5624.915626265569;13065.673358166121;13485.932570337085;13518.459261629523;13519;13542.390592423364;2082.3648787119923;2334.8599084055013;2454.840435371695;2605.8534244932357;2798.328401183722;7586.62066896653;9964.551595178234;10823.621173258976;11130;14492;1675.7989041314997;1699.7110491216522;1743.555393374694;1758.4900378890106;1790.9641807163914;90124.5493772527;92773.53613231958;93730.59404108944;94847.52576237144;95410.52294738551;10782.4069676167;10805.83791243132;10807.83788243177;10828.458577071115;10887.346759194474;13540.458381664623;13591.52429664957;13604.863951360558;13620.523281685093;13692.178469291874;8258.958705206436;8410.831783364298;8434.493930364199;8496.490210587384;8502.574871256413;8453.535055572003;8471.534065626327;8481.363897707697;8546.102659220693;8562.529060901586;4289.356596510486;4359.891002724894;4368.191884501377;4412.779361031936;4418.337249412614;1688.3331084221663;1765.64687062588;1768.8673349498838;1778.4753497718204;1834.5872178759673;789.2226157235119;912.7672443526858;945.6595625574788;971.7464470832688;1011.8735158105237;19069.904650476936;19439.708404373945;19545.902270488557;19900.70148947767;19914.800851991586;869.6564856881496;915.9221466175317;919.1819280840058;970.6990832841842;971.9854202186973;10495.632652857113;10629.681109566725;10640.35074563444;10653.786924261627;10759.677209683721;528752;539073;555065;564351;628282;59500.45494995547;86036;87887;89101;109664;996.6960077176386;999.8551658351147;1013.3160116921196;1018.5365658625308;1018.6383833738915;14031.859681403055;17560.209790559198;17654.293828246726;18103;18264.634707306046;48172;48821.511784883114;49381;50151.98176218877;50361.244581332045;69112.54437278016;69589.60820783657;69905.65047174731;70209.89370318898;70424.64787676028;7600.399600399601;7670.654820532978;7753.534787912743;7838.764837054898;7954.681812727657;8561.657533698582;11636.12729045308;12335.198212116184;12343.382830858602;12612.936935315265;10648.254622176373;10689.9465502672;10829.783404331713;10954.671359859218;10990;10383.844242336521;10428.165746740091;10530.789384212427;10578.365298082139;10808.189385796253;10781.784364312512;10795.19036072282;10915.23593348458;11099.889001109885;11182.888171118184;7549.358304544176;7688.192739762245;7748.883766743616;7905.549279723305;8046.517208967481;10477.804269697815;10551.419671918118;10587.629432969808;10772.461376931278;10778.083862871743 18:41:50 INFO - PROCESS | 1667 | |3;mootools.html;1441.8846492280618;1580.1546172797553;1613.0644226348718;1881.670707626165;2019.4850313170148;7994.080680721719;8552.230299273064;8724.47653140812;8737.12628737126;8740.344474164447;8468.576571171448;8716.91283087169;8724.73825785226;8726.345524085687;8738.563071846398;2189.5511420158828;2430.9756902430927;2475.4430253193023;2494.102123235643;2505.223380751973;2505.2108585795418;2508.611165269386;2514.09492582671;2517.332906779696;2519.2694118705554;2036.2465887621602;2423.6485709572103;2484.1305543059875;2487.6766020417413;2494.5135698538793;2457.8893949772123;2460.052879641333;2483.689538807649;2484.354067942339;2485.142625794098;2437.025189924027;2451.742567030472;2469.2839076667747;2479.417336925821;2497.2383423055962;8716.215540601313;8795.956020219923;8808.603612837374;8813.42712723671;8815.20663140314;5436.456354364572;5554.555635549146;5591.692456914868;5592.049351610236;5593.52455041322;3457.2048428861253;3537;3592.0660628236847;3659.469376940329;3659.8170091495585;903.9186473217442;983.6360546597805;989.6635144051057;990.5047476261869;994.4977786217986;12272.018238540895;12282.201656892363;12293.200941938745;12293.446794894251;12309.322987235699;4870.391201099863;4929.852104436873;4969.801207951641;4985.700857948535;4997.325361076281;10251.743706407251;10308.072273495422;10310.07209351162;10321.535530901128;10331.896681033093;5553.250311208016;5562.499375056264;5577.661361273265;5578.2748242728185;5592.636478628876;4443.400140980991;4605.562471565196;4777.641676874248;5005;5006.874828129253;3825.5218097737784;3932.46911666927;3950.20995800841;3964.900877478086;4000.239954408653;1288.2335010668637;1297.47452281826;1297.8702129786946;1305.2364366845502;1326.8009798530104;1052.8894466081103;1071.8959471744115;1096.6161843354762;1366.3373263966969;1369.5275130080106;7213.350798428167;8117.350611951029;8246.38152138592;8309.626066826886;8348.707795227137;506.8758154252158;511.4144304771091;521.8643152780229;523.7826302084592;524.1063985904025;6227.408396202353;6249.1563638908165;6300.527460440485;6312.652804095819;6315.305316415191;10381.896181038244;10715.571377144826;10849.403282819363;10852.077573406192;10882.129429645609;10499.160067194605;10685.732856678645;10711.303765255234;10762.24664273509;10773.946130269298;8242.052164001216;8342.833143337099;8413.284870786052;8421.578921053922;8435.240828325357;7720.459567830198;7943.483673561431;7950.16523265072;7961.40289478303;7995.040595128622;9378.062193780568;9607.231421486404;9697.321187516805;9812;9853.408795472295;9732.610695572097;9842.163416109712;9955.20358371343;10021.298509104292;10058.949705251427;6486.740530378732;6875.1749790025515;7043.225245222919;7445.218252083453;7532.246775322643;8268.586570671321;8359.08050114499;8359.874601880854;8360.623771930399;8385.161483851565;7288.125424948828;7402.814929626802;7421.777346679608;7544.6227688616445;7579.924200757921;5943.227380440515;7176.21061683204;7273.854522909618;7335.193128755939;7339.77980660581;7603.125640551186;7819.296263336099;7879.606019698877;7881.881771773543;7886.921130788848;7117.7152913882865;7131.465140114616;7155.534890232118;7157.892631610426;7193.820154496179;7094.964525177341;7111;7123.25205853378;7148.821279468055;7229.457790665826 18:41:50 INFO - PROCESS | 1667 | |4;prototype.html;325.0540925905614;327.386150966937;330.50259359663704;331.2662452667342;336.4532634468989;6512.153420055392;6551.443127334176;6561.9015714764255;6562.179727534059;6567.901481477782;6467.805965821021;6546.3126371731;6556.934430655692;6556.967215163918;6565.409113179813;3949.6247856453665;4611.4005179326805;4722.834700785474;4731.148393289207;4791.305260737191;4777.498362671921;4778.880527986794;4789.832355867546;4812.085703716282;4821.710697358152;3959.2675355059405;4666.4400271967415;4755.64332675049;4762.214234651278;4762.761861906908;4562.292844609091;4660.953390466086;4762.904741905159;4763.261694437368;4775.594074503671;3438.4670376091744;3867.3425517662067;4098.282800509899;4118.217538667644;4118.608732170439;5054.393472783289;6156.199694039791;6248.4064013918605;6302.747890084391;6310.33741457145;5743.4256574342235;5744.396838331999;5752.165935939307;5764.962306784777;5767.711614419304;6941.930580694179;6994.930050699479;6998.650067496605;7003.5797852129035;7010.684519196649;4373.650107991353;4550.385697930803;4559.17934771741;4598.724076555417;4685.390899183119;7254.093238345207;7277.599732014737;7339;7350.926490735131;7392.075990501187;4602.125596136723;4602.4477062752685;4617.168909596305;4624.1445332613575;4633.72197668141;4322.3516472528745;4671.159191345522;4671.182543054952;4680.625549956064;4690.81236750533;5141;5575.0522411190195;5577.358603760538;5578.748956296977;5587.161925711094;6759.194528503863;6897.862042759217;6988.720451181895;6991.056207411934;7016.5088443808445;1366.549038817188;1609.3643011010586;1615.135902292268;1631.7144499712504;1633.3956436118713;905.0677801864091;969.3117886300664;995.6664517386756;1022.4274406332329;1051.0225490293947;5157.484251574812;6459.063435801782;6521.413072823469;6562.179727534059;6566.3105373936005;7259.963700181465;7298;7301.08736407949;7308.853822923512;7310;6513.478921686254;6540.182477190351;6580.901286480706;6588.209414870246;6591.307912669196;3841.961580384216;3889.922201555953;3897.3569361055675;3899.771571954825;3900.2199560088097;7313.853722925512;7635.198304177981;7644.961775191088;7669.654865531064;7677.385809135256;7537.510061845963;7585.0139481867;7588.62056897153;7604.619769011527;7614.238576142452;7626.161122276434;7634.770956871303;7647.08235011791;7653.081630204411;7656.234376562299;6933.791986240421;7315.707371705073;7328.450366222448;7338.706451742084;7340.743073992385;6591.077249185214;7198.6040767756185;7205.675744591401;7209.990601315925;7213.963930180315;6800.31996800316;7618;7628.694852205849;7642.006539149875;7646;4792.501473923985;4837.467878533429;4846.612271018381;4846.854594362175;4850.805967761391;6147.262328520606;6987.161540615159;7037.824054398681;7241.855162896818;7253.963730181315;5573.913086948006;6974.302569742985;6988.755393561201;6989.33601307875;6990.510664253454;6904.861902762017;6947.756828510978;6948.756793512202;6972.755953541602;6980.267071957574;6808.965955170391;6814.965925170342;6823.761168359282;6831.555948863308;6842.828929276808;6710.83222919431;6990.021397004525;6996;7006.439484841098;7026.578405295699;6599.670016499252;6724.29394913527;6726.865462690621;6844.28135045813;6853.109095817512 18:41:50 INFO - PROCESS | 1667 | |5;yui.html;711.4166383565475;728.4427413029032;731.9231480694527;741.6625435426881;763.2443880558249;14895.478658246964;14931.178785166812;15068.246587670628;15084.396624135035;15093.6981260375;11737;12157.696057598543;12246.0815438842;12381.56664516742;12467.501299948013;725.0176011504415;898.0211569389364;914.4330515080659;914.9980771055716;916.2166347772659;736.6095969136367;899.8110396816676;923.4274749655223;927.5918595817852;928.2944961829024;972.6741541583579;972.9902700973006;978.5205249427801;980.9950950245238;983.4197823284261;751.5002523321984;955.5222388805597;969.6557722008691;973.4500007495777;975.3903810118641;725.354434553248;726.0887586079489;727.4689476681999;727.9381252593536;728.2098922668911;14808.703825923421;14824.3329050193;14894.180820054893;14925.25373731309;14979.026363286352;12494;12512.436940337615;12562.434690438951;12780.680482987907;12969.092163548461;9849.21206303494;10131.08820206185;10814.459277036116;10962.451877406098;11579.884201157965;3606.855725770966;3964.603539646041;4311.719738217006;4314.82740690372;4436.755978421185;68745.65627171882;75877.22145378865;76794.23205767927;76856.61571692106;76989.23010769933;9265.490398028038;9833.115019648267;10017.39895606266;10034.24743144267;10050.095491405662;22457.32628021162;22474.98862551189;22477.100915963507;22507.212247571584;22536.098556057903;7540.660670269851;7618.657160427683;7655.540667559964;7699.576523291273;7738.148803631596;3017.7434918032213;3885.611438856092;3933.6853051755793;4033.495813023372;4033.838646454109;3469.739769517246;3523.6300188480354;3524.647535246455;3532.646735326447;3537.6816086552335;657.8914479110989;671.2549070531705;671.5232185148599;673.7636437137809;691.2948792231996;480.2436163043221;540.3272925208141;551.7461967494917;595.2440400691185;604.1722839709538;8074.677012919417;8125.1062383137805;8267.586620668942;8290.585470726439;8417.70538031166;588.7203578300273;602.1690067706625;606.6299557270062;607.6323824086453;615.6952308607268;3545.4859045438266;3774.8678796241998;3813.3517302058717;3896.532416110085;3996.4005399189773;84443.57778211069;85531;85625.71561426584;85783.14216857876;86768.56615716881;72878;75911;77076.61461692768;79380;79445.80831287535;68460;74601;75128.4974300511;75916.24083759202;76691.61654191805;8265.793355166168;8283.668653253802;8461.06928237881;8592.65629374843;8616.827663446571;32925.34149317048;39912.20175596414;50886.71009804642;51582.48417515777;51796.741016294676;59164;65363.34636653573;67908;69999.65000174966;71502.64248678723;11075.113990880871;11367.261128026652;11453.312801231952;11507.539698411969;11688.298702077902;11888.108391870472;11908.821367679666;12150.392480376122;12468.002559795375;12525.185862918881;10974.890251097388;11122.165837562054;11179.329240245612;11502.42487875586;11625.953664170265;10996.505157267782;11065.280756750786;11420.885791142315;11514.481848316678;11653.242539234923;10254.077133058061;10498.842517362398;11049.834252486058;11272.66182014541;11496.31022138641;9498.905010950079;9539.952300238732;9581.904180958101;9604.423734575948;9783.9021609783;9374.906250937676;9579.521023948635;9604.75988100303;9614.134727874525;9822.901770982198 18:41:50 INFO - PROCESS | 1667 | __end_tp_report 18:41:50 INFO - PROCESS | 1667 | __start_cc_report 18:41:50 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1162 18:41:50 INFO - PROCESS | 1667 | __end_cc_report 18:41:50 INFO - PROCESS | 1667 | __startTimestamp1459474910782__endTimestamp 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | ------- Summary: start ------- 18:41:50 INFO - PROCESS | 1667 | Number of tests: 6 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5692.71 Median:5912.20 stddev:630.61 (10.7%) stddev-sans-first:605.97 18:41:50 INFO - PROCESS | 1667 | Values: 3383.8 3426.8 3464.5 3467.3 3511.2 5472.7 5561.4 5617.9 5630.0 5647.8 5581.0 5638.6 5646.9 5656.2 5662.6 5065.3 5081.8 5084.4 5115.4 5173.1 5164.6 5167.2 5168.9 5172.9 5176.1 5063.1 5117.1 5138.2 5148.7 5153.1 5140.4 5165.3 5188.0 5188.5 5257.2 5001.8 5012.7 5047.4 5108.6 5119.6 5483.4 5515.7 5526.3 5553.9 5620.6 6181.2 6221.7 6225.7 6237.1 6250.6 6073.3 6088.5 6194.4 6245.9 6297.9 5763.2 5787.4 5804.4 5824.4 5839.2 6232.9 6251.7 6265.1 6265.2 6300.3 5962.1 6056.0 6129.1 6143.2 6198.1 6141.9 6217.4 6228.9 6229.0 6232.1 6125.9 6164.1 6184.0 6184.4 6204.0 6103.5 6121.8 6174.7 6207.7 6237.6 4846.3 4854.2 4856.5 4889.2 4900.0 4381.8 4392.5 4407.6 4410.4 4449.8 5535.8 5620.4 5622.6 5629.5 5706.0 5202.9 6189.0 6222.4 6229.6 6237.4 5612.8 5626.6 5658.9 5678.6 5685.2 5232.7 5271.2 5343.5 5361.5 5409.9 6220.5 6239.7 6261.7 6265.1 6271.4 6121.8 6209.8 6236.3 6245.2 6259.8 6205.3 6233.5 6242.8 6255.3 6267.9 6076.6 6110.9 6138.3 6153.6 6159.2 6105.7 6115.0 6222.8 6224.7 6231.7 6098.1 6105.9 6110.7 6111.1 6138.0 6070.8 6079.9 6088.7 6099.4 6100.6 5700.5 5826.9 5885.8 5915.8 5924.9 5838.1 5980.2 6019.0 6122.1 6142.6 5855.2 5910.4 5912.2 5916.1 5920.2 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:57018.22 Median:37883.12 stddev:115312.14 (304.4%) stddev-sans-first:115557.36 18:41:50 INFO - PROCESS | 1667 | Values: 435.6 511.4 515.4 607.4 642.0 38132.8 38497.0 38548.0 38564.2 38590.0 41626.2 41950.2 41976.0 42141.4 42179.0 9441.8 9657.8 9666.4 9671.3 9698.9 9450.3 9559.8 9577.0 9682.7 9736.5 9595.0 9661.7 9680.0 9681.7 9699.2 9633.9 9720.9 9727.6 9729.2 9740.6 9376.3 9497.9 9529.0 9540.5 9543.6 32087.5 32695.0 39875.2 40292.0 40452.8 3141.5 3251.0 3323.9 3393.9 3636.4 23295.8 25766.9 26876.9 27562.0 27718.0 2659.9 2723.7 2734.8 2794.2 2862.7 408231.0 412117.0 414476.9 414651.0 416599.0 45429.0 64449.4 68918.3 69003.0 69016.0 44643.1 44902.0 44903.6 44904.0 45027.8 15586.2 15836.8 15868.4 15872.8 15875.5 12691.7 12742.6 12777.4 12789.7 12798.9 14274.6 14274.6 14533.1 14533.5 14614.2 5309.4 6223.6 6290.3 6313.5 6314.6 915.8 918.2 980.9 1034.6 1146.8 28979.6 29014.3 29595.3 29693.7 29725.9 983.6 1019.6 1119.7 1144.8 1196.9 14637.1 14744.3 14868.0 14996.3 15053.0 526380.0 527419.0 533122.0 534364.0 534896.0 58210.7 58647.0 58741.0 58785.7 58925.7 1338.5 1349.0 1449.4 1455.5 1489.8 26041.6 28373.1 28599.3 28923.0 29122.4 45320.5 45798.8 45800.5 45865.5 45872.0 325167.0 335577.0 336573.0 336711.6 337860.0 29176.7 32368.5 32479.4 32855.0 33206.2 40537.6 41117.4 41683.0 41889.6 42273.2 34309.5 36241.3 36516.0 36948.9 37871.2 35151.8 35294.6 35335.8 36110.0 36202.5 36479.8 36683.0 37601.4 37895.0 38017.2 29844.3 31136.0 31227.4 31237.5 31371.7 23568.0 23597.8 23685.5 23949.0 24118.3 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:31295.63 Median:371.03 stddev:93065.85 (25083.0%) stddev-sans-first:93297.93 18:41:50 INFO - PROCESS | 1667 | Values: 355.9 358.1 364.7 370.4 371.6 19646.4 20348.4 20595.3 21087.7 21097.9 19362.4 19523.2 20065.0 20100.4 20554.3 5151.9 5345.1 5392.4 5399.2 5405.5 3908.0 4036.1 4711.5 5288.4 5967.9 5939.2 5944.0 5953.2 5957.6 5964.4 5700.9 5837.9 5886.6 5913.9 5934.2 5596.5 5618.4 5624.2 5624.2 5624.9 13065.7 13485.9 13518.5 13519.0 13542.4 2082.4 2334.9 2454.8 2605.9 2798.3 7586.6 9964.6 10823.6 11130.0 14492.0 1675.8 1699.7 1743.6 1758.5 1791.0 90124.5 92773.5 93730.6 94847.5 95410.5 10782.4 10805.8 10807.8 10828.5 10887.3 13540.5 13591.5 13604.9 13620.5 13692.2 8259.0 8410.8 8434.5 8496.5 8502.6 8453.5 8471.5 8481.4 8546.1 8562.5 4289.4 4359.9 4368.2 4412.8 4418.3 1688.3 1765.6 1768.9 1778.5 1834.6 789.2 912.8 945.7 971.7 1011.9 19069.9 19439.7 19545.9 19900.7 19914.8 869.7 915.9 919.2 970.7 972.0 10495.6 10629.7 10640.4 10653.8 10759.7 528752.0 539073.0 555065.0 564351.0 628282.0 59500.5 86036.0 87887.0 89101.0 109664.0 996.7 999.9 1013.3 1018.5 1018.6 14031.9 17560.2 17654.3 18103.0 18264.6 48172.0 48821.5 49381.0 50152.0 50361.2 69112.5 69589.6 69905.7 70209.9 70424.6 7600.4 7670.7 7753.5 7838.8 7954.7 8561.7 11636.1 12335.2 12343.4 12612.9 10648.3 10689.9 10829.8 10954.7 10990.0 10383.8 10428.2 10530.8 10578.4 10808.2 10781.8 10795.2 10915.2 11099.9 11182.9 7549.4 7688.2 7748.9 7905.5 8046.5 10477.8 10551.4 10587.6 10772.5 10778.1 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6070.53 Median:5570.08 stddev:3249.01 (58.3%) stddev-sans-first:3239.49 18:41:50 INFO - PROCESS | 1667 | Values: 1441.9 1580.2 1613.1 1881.7 2019.5 7994.1 8552.2 8724.5 8737.1 8740.3 8468.6 8716.9 8724.7 8726.3 8738.6 2189.6 2431.0 2475.4 2494.1 2505.2 2505.2 2508.6 2514.1 2517.3 2519.3 2036.2 2423.6 2484.1 2487.7 2494.5 2457.9 2460.1 2483.7 2484.4 2485.1 2437.0 2451.7 2469.3 2479.4 2497.2 8716.2 8796.0 8808.6 8813.4 8815.2 5436.5 5554.6 5591.7 5592.0 5593.5 3457.2 3537.0 3592.1 3659.5 3659.8 903.9 983.6 989.7 990.5 994.5 12272.0 12282.2 12293.2 12293.4 12309.3 4870.4 4929.9 4969.8 4985.7 4997.3 10251.7 10308.1 10310.1 10321.5 10331.9 5553.3 5562.5 5577.7 5578.3 5592.6 4443.4 4605.6 4777.6 5005.0 5006.9 3825.5 3932.5 3950.2 3964.9 4000.2 1288.2 1297.5 1297.9 1305.2 1326.8 1052.9 1071.9 1096.6 1366.3 1369.5 7213.4 8117.4 8246.4 8309.6 8348.7 506.9 511.4 521.9 523.8 524.1 6227.4 6249.2 6300.5 6312.7 6315.3 10381.9 10715.6 10849.4 10852.1 10882.1 10499.2 10685.7 10711.3 10762.2 10773.9 8242.1 8342.8 8413.3 8421.6 8435.2 7720.5 7943.5 7950.2 7961.4 7995.0 9378.1 9607.2 9697.3 9812.0 9853.4 9732.6 9842.2 9955.2 10021.3 10058.9 6486.7 6875.2 7043.2 7445.2 7532.2 8268.6 8359.1 8359.9 8360.6 8385.2 7288.1 7402.8 7421.8 7544.6 7579.9 5943.2 7176.2 7273.9 7335.2 7339.8 7603.1 7819.3 7879.6 7881.9 7886.9 7117.7 7131.5 7155.5 7157.9 7193.8 7095.0 7111.0 7123.3 7148.8 7229.5 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5705.35 Median:6562.04 stddev:1847.96 (28.2%) stddev-sans-first:1808.48 18:41:50 INFO - PROCESS | 1667 | Values: 325.1 327.4 330.5 331.3 336.5 6512.2 6551.4 6561.9 6562.2 6567.9 6467.8 6546.3 6556.9 6557.0 6565.4 3949.6 4611.4 4722.8 4731.1 4791.3 4777.5 4778.9 4789.8 4812.1 4821.7 3959.3 4666.4 4755.6 4762.2 4762.8 4562.3 4661.0 4762.9 4763.3 4775.6 3438.5 3867.3 4098.3 4118.2 4118.6 5054.4 6156.2 6248.4 6302.7 6310.3 5743.4 5744.4 5752.2 5765.0 5767.7 6941.9 6994.9 6998.7 7003.6 7010.7 4373.7 4550.4 4559.2 4598.7 4685.4 7254.1 7277.6 7339.0 7350.9 7392.1 4602.1 4602.4 4617.2 4624.1 4633.7 4322.4 4671.2 4671.2 4680.6 4690.8 5141.0 5575.1 5577.4 5578.7 5587.2 6759.2 6897.9 6988.7 6991.1 7016.5 1366.5 1609.4 1615.1 1631.7 1633.4 905.1 969.3 995.7 1022.4 1051.0 5157.5 6459.1 6521.4 6562.2 6566.3 7260.0 7298.0 7301.1 7308.9 7310.0 6513.5 6540.2 6580.9 6588.2 6591.3 3842.0 3889.9 3897.4 3899.8 3900.2 7313.9 7635.2 7645.0 7669.7 7677.4 7537.5 7585.0 7588.6 7604.6 7614.2 7626.2 7634.8 7647.1 7653.1 7656.2 6933.8 7315.7 7328.5 7338.7 7340.7 6591.1 7198.6 7205.7 7210.0 7214.0 6800.3 7618.0 7628.7 7642.0 7646.0 4792.5 4837.5 4846.6 4846.9 4850.8 6147.3 6987.2 7037.8 7241.9 7254.0 5573.9 6974.3 6988.8 6989.3 6990.5 6904.9 6947.8 6948.8 6972.8 6980.3 6809.0 6815.0 6823.8 6831.6 6842.8 6710.8 6990.0 6996.0 7006.4 7026.6 6599.7 6724.3 6726.9 6844.3 6853.1 18:41:50 INFO - PROCESS | 1667 | 18:41:50 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17905.46 Median:607.13 stddev:24813.75 (4087.0%) stddev-sans-first:24849.77 18:41:50 INFO - PROCESS | 1667 | Values: 711.4 728.4 731.9 741.7 763.2 14895.5 14931.2 15068.2 15084.4 15093.7 11737.0 12157.7 12246.1 12381.6 12467.5 725.0 898.0 914.4 915.0 916.2 736.6 899.8 923.4 927.6 928.3 972.7 973.0 978.5 981.0 983.4 751.5 955.5 969.7 973.5 975.4 725.4 726.1 727.5 727.9 728.2 14808.7 14824.3 14894.2 14925.3 14979.0 12494.0 12512.4 12562.4 12780.7 12969.1 9849.2 10131.1 10814.5 10962.5 11579.9 3606.9 3964.6 4311.7 4314.8 4436.8 68745.7 75877.2 76794.2 76856.6 76989.2 9265.5 9833.1 10017.4 10034.2 10050.1 22457.3 22475.0 22477.1 22507.2 22536.1 7540.7 7618.7 7655.5 7699.6 7738.1 3017.7 3885.6 3933.7 4033.5 4033.8 3469.7 3523.6 3524.6 3532.6 3537.7 657.9 671.3 671.5 673.8 691.3 480.2 540.3 551.7 595.2 604.2 8074.7 8125.1 8267.6 8290.6 8417.7 588.7 602.2 606.6 607.6 615.7 3545.5 3774.9 3813.4 3896.5 3996.4 84443.6 85531.0 85625.7 85783.1 86768.6 72878.0 75911.0 77076.6 79380.0 79445.8 68460.0 74601.0 75128.5 75916.2 76691.6 8265.8 8283.7 8461.1 8592.7 8616.8 32925.3 39912.2 50886.7 51582.5 51796.7 59164.0 65363.3 67908.0 69999.7 71502.6 11075.1 11367.3 11453.3 11507.5 11688.3 11888.1 11908.8 12150.4 12468.0 12525.2 10974.9 11122.2 11179.3 11502.4 11626.0 10996.5 11065.3 11420.9 11514.5 11653.2 10254.1 10498.8 11049.8 11272.7 11496.3 9498.9 9540.0 9581.9 9604.4 9783.9 9374.9 9579.5 9604.8 9614.1 9822.9 18:41:50 INFO - PROCESS | 1667 | -------- Summary: end -------- 18:41:50 INFO - PROCESS | 1667 | 18:41:51 INFO - TEST-INFO | 1667: exit 0 18:41:51 INFO - TEST-OK | dromaeo_css | took 1114513ms 18:41:51 INFO - TEST-START | kraken 18:41:51 INFO - operating with platform_type : mac_ 18:41:51 INFO - Initialising browser for kraken test... 18:41:51 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpgGbFvh/profile http://localhost:49270/getInfo.html) 18:41:53 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 18:41:53 INFO - PROCESS | 1675 | colorDepth:24 18:41:53 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 18:41:53 INFO - PROCESS | 1675 | __metrics 18:41:53 INFO - PROCESS | 1675 | 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" 18:41:53 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:41:54 INFO - TEST-INFO | 1675: exit 0 18:41:54 INFO - Browser initialized. 18:41:54 INFO - Running cycle 1/1 for kraken test... 18:41:54 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/T/tmpgGbFvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:06 INFO - PROCESS | 1677 | RSS: Main: 244219904 18:42:06 INFO - PROCESS | 1677 | 18:42:08 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 18:42:09 INFO - PROCESS | 1677 | RSS: Main: 290217984 18:42:09 INFO - PROCESS | 1677 | 18:42:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 18:42:12 INFO - PROCESS | 1677 | RSS: Main: 300576768 18:42:12 INFO - PROCESS | 1677 | 18:42:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 18:42:16 INFO - PROCESS | 1677 | RSS: Main: 287039488 18:42:16 INFO - PROCESS | 1677 | 18:42:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 18:42:19 INFO - PROCESS | 1677 | RSS: Main: 288342016 18:42:19 INFO - PROCESS | 1677 | 18:42:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:42:21 INFO - PROCESS | 1677 | RSS: Main: 289849344 18:42:21 INFO - PROCESS | 1677 | 18:42:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 18:42:25 INFO - PROCESS | 1677 | RSS: Main: 289705984 18:42:25 INFO - PROCESS | 1677 | 18:42:28 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 18:42:28 INFO - PROCESS | 1677 | RSS: Main: 289873920 18:42:28 INFO - PROCESS | 1677 | 18:42:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 18:42:32 INFO - PROCESS | 1677 | RSS: Main: 290009088 18:42:32 INFO - PROCESS | 1677 | 18:42:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:42:34 INFO - PROCESS | 1677 | RSS: Main: 323641344 18:42:34 INFO - PROCESS | 1677 | 18:42:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:42:36 INFO - PROCESS | 1677 | RSS: Main: 323432448 18:42:36 INFO - PROCESS | 1677 | 18:42:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:42:39 INFO - PROCESS | 1677 | RSS: Main: 330481664 18:42:39 INFO - PROCESS | 1677 | 18:42:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:42 INFO - PROCESS | 1677 | RSS: Main: 331571200 18:42:42 INFO - PROCESS | 1677 | 18:42:45 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:45 INFO - PROCESS | 1677 | RSS: Main: 331530240 18:42:45 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 18:42:47 INFO - PROCESS | 1677 | RSS: Main: 394502144 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | __start_tp_report 18:42:47 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 18:42:47 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 18:42:47 INFO - PROCESS | 1677 | |i|pagename|runs| 18:42:47 INFO - PROCESS | 1677 | |0;ai-astar;111;109;108;111;111;110;116;110;112;110 18:42:47 INFO - PROCESS | 1677 | |1;audio-beat-detection;155;122;145;158;110;128;159;150;196;130 18:42:47 INFO - PROCESS | 1677 | |2;audio-dft;184;184;184;189;187;186;185;185;185;184 18:42:47 INFO - PROCESS | 1677 | |3;audio-fft;75;78;84;80;57;57;59;83;104;83 18:42:47 INFO - PROCESS | 1677 | |4;audio-oscillator;92;93;124;78;78;79;113;79;75;118 18:42:47 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;86;93;87;88;84;88;130;134;86 18:42:47 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;92;94;95;94;92;97;119;92;94 18:42:47 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;88;88;87;88;87;85;87;86;85 18:42:47 INFO - PROCESS | 1677 | |8;json-parse-financial;53;55;53;53;54;55;52;63;54;52 18:42:47 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;65;67;75;79;71;70;68;65;66;68 18:42:47 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;84;84;84;83;84;81;84;83;86;84 18:42:47 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;124;134;133;112;129;131;135;133;122;120 18:42:47 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;144;130;140;139;135;129;141;139;138;140 18:42:47 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;70;67;68;67;67;67;68;67;66;65 18:42:47 INFO - PROCESS | 1677 | __end_tp_report 18:42:47 INFO - PROCESS | 1677 | __start_cc_report 18:42:47 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1302 18:42:47 INFO - PROCESS | 1677 | __end_cc_report 18:42:47 INFO - PROCESS | 1677 | __startTimestamp1459474967655__endTimestamp 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | ------- Summary: start ------- 18:42:47 INFO - PROCESS | 1677 | Number of tests: 14 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.15 (1.9%) stddev-sans-first:2.28 18:42:47 INFO - PROCESS | 1677 | Values: 111.0 109.0 108.0 111.0 111.0 110.0 116.0 110.0 112.0 110.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:152.50 stddev:24.40 (16.0%) stddev-sans-first:25.63 18:42:47 INFO - PROCESS | 1677 | Values: 155.0 122.0 145.0 158.0 110.0 128.0 159.0 150.0 196.0 130.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:185.30 Median:185.00 stddev:1.64 (0.9%) stddev-sans-first:1.67 18:42:47 INFO - PROCESS | 1677 | Values: 184.0 184.0 184.0 189.0 187.0 186.0 185.0 185.0 185.0 184.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:76.00 Median:79.00 stddev:14.82 (18.8%) stddev-sans-first:15.72 18:42:47 INFO - PROCESS | 1677 | Values: 75.0 78.0 84.0 80.0 57.0 57.0 59.0 83.0 104.0 83.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:78.50 stddev:18.72 (23.8%) stddev-sans-first:19.85 18:42:47 INFO - PROCESS | 1677 | Values: 92.0 93.0 124.0 78.0 78.0 79.0 113.0 79.0 75.0 118.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:87.50 stddev:18.93 (21.6%) stddev-sans-first:19.83 18:42:47 INFO - PROCESS | 1677 | Values: 88.0 86.0 93.0 87.0 88.0 84.0 88.0 130.0 134.0 86.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:94.00 stddev:8.16 (8.7%) stddev-sans-first:8.57 18:42:47 INFO - PROCESS | 1677 | Values: 93.0 92.0 94.0 95.0 94.0 92.0 97.0 119.0 92.0 94.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.26 (1.5%) stddev-sans-first:1.20 18:42:47 INFO - PROCESS | 1677 | Values: 85.0 88.0 88.0 87.0 88.0 87.0 85.0 87.0 86.0 85.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.20 (5.9%) stddev-sans-first:3.36 18:42:47 INFO - PROCESS | 1677 | Values: 53.0 55.0 53.0 53.0 54.0 55.0 52.0 63.0 54.0 52.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:4.55 (6.6%) stddev-sans-first:4.54 18:42:47 INFO - PROCESS | 1677 | Values: 65.0 67.0 75.0 79.0 71.0 70.0 68.0 65.0 66.0 68.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.25 (1.5%) stddev-sans-first:1.32 18:42:47 INFO - PROCESS | 1677 | Values: 84.0 84.0 84.0 83.0 84.0 81.0 84.0 83.0 86.0 84.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:132.00 stddev:7.54 (5.7%) stddev-sans-first:7.91 18:42:47 INFO - PROCESS | 1677 | Values: 124.0 134.0 133.0 112.0 129.0 131.0 135.0 133.0 122.0 120.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:139.50 stddev:4.79 (3.4%) stddev-sans-first:4.47 18:42:47 INFO - PROCESS | 1677 | Values: 144.0 130.0 140.0 139.0 135.0 129.0 141.0 139.0 138.0 140.0 18:42:47 INFO - PROCESS | 1677 | 18:42:47 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.32 (2.0%) stddev-sans-first:0.93 18:42:47 INFO - PROCESS | 1677 | Values: 70.0 67.0 68.0 67.0 67.0 67.0 68.0 67.0 66.0 65.0 18:42:47 INFO - PROCESS | 1677 | -------- Summary: end -------- 18:42:47 INFO - PROCESS | 1677 | 18:42:48 INFO - TEST-INFO | 1677: exit 0 18:42:48 INFO - TEST-OK | kraken | took 57276ms 18:42:48 INFO - SUITE-END | took 1171s 18:42:48 INFO - Completed test suite (00:19:31) 18:42:48 INFO - javascript benchmark 18:42:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3383.7649258020824, 3426.7601267911255, 3464.549608550888, 3467.3412051710156, 3511.192425742079, 5472.671639701611, 5561.443855614437, 5617.859553511159, 5629.971850140749, 5647.774089036438, 5581.0, 5638.605297629158, 5646.943530564703, 5656.208130861683, 5662.5753068519925, 5065.341505604276, 5081.84754457365, 5084.415292241384, 5115.437301896788, 5173.068847607429, 5164.586833053347, 5167.224916262553, 5168.9224661630105, 5172.870678233036, 5176.120059589879, 5063.139266324715, 5117.078925793356, 5138.177891537355, 5148.716820574867, 5153.098207813637, 5140.434552199236, 5165.251038599419, 5188.014277287341, 5188.481151884819, 5257.1588545832865, 5001.824936127255, 5012.674176178537, 5047.394312682465, 5108.64239503235, 5119.590432765407, 5483.369412517572, 5515.669059856422, 5526.336839579276, 5553.944460555384, 5620.606557540974, 6181.196444462236, 6221.688915554249, 6225.719842607094, 6237.09562113491, 6250.624962502219, 6073.279660637198, 6088.543359248074, 6194.4115309045565, 6245.910891138545, 6297.905531417033, 5763.164341170507, 5787.392323806024, 5804.448577385142, 5824.359320474744, 5839.211706419579, 6232.875342493216, 6251.718672659741, 6265.122882796412, 6265.216847894013, 6300.338464461257, 5962.105684147413, 6056.0, 6129.14485165794, 6143.170671959318, 6198.132261483396, 6141.877162456815, 6217.409346112112, 6228.906566401508, 6229.0, 6232.0963460298, 6125.877482450326, 6164.075388691643, 6184.010558310649, 6184.412480814315, 6203.96898015516, 6103.450689437972, 6121.755129794848, 6174.722137503823, 6207.720652570645, 6237.625742455467, 4846.321514987904, 4854.247591623304, 4856.538628830255, 4889.193283108248, 4900.044491324157, 4381.846635367747, 4392.472903251566, 4407.559244075567, 4410.42664453619, 4449.755263460476, 5535.750891209906, 5620.353659329147, 5622.550195984311, 5629.549636029108, 5706.0, 5202.869928251824, 6189.0, 6222.439980401786, 6229.626222426669, 6237.376262373817, 5612.831615051555, 5626.606137570331, 5658.943410565924, 5678.630888992202, 5685.175649530877, 5232.712200828915, 5271.156614941668, 5343.5457986071615, 5361.490658387447, 5409.864753381197, 6220.471259942956, 6239.688015599293, 6261.749530018839, 6265.0602409637095, 6271.3728627136925, 6121.788327166137, 6209.813705588659, 6236.282827474898, 6245.219347581552, 6259.843503912257, 6205.348438413902, 6233.532485063548, 6242.750289988531, 6255.31191568918, 6267.905981410374, 6076.574639775174, 6110.938890611037, 6138.263408391022, 6153.630782153085, 6159.23009623797, 6105.702364394958, 6114.969425152845, 6222.844428889314, 6224.688765561613, 6231.688415579112, 6098.069176274391, 6105.945000794801, 6110.663913484801, 6111.0752052021135, 6138.048602466625, 6070.757169713339, 6079.908801368071, 6088.665123418255, 6099.420555047263, 6100.572959892765, 5700.5154561861045, 5826.912596310974, 5885.823425297248, 5915.763369465173, 5924.851878702894, 5838.065909454467, 5980.19267398913, 6019.0, 6122.093225952662, 6142.600730952474, 5855.151003104441, 5910.379410161871, 5912.201852749996, 5916.112583112567, 5920.200772895604], "unit": "score", "name": "dojo.html", "value": 5652.928278309265}, {"lowerIsBetter": false, "replicates": [435.59054488780527, 511.41443047710374, 515.4355980201681, 607.4381197392412, 641.95506314558, 38132.809335953316, 38497.0, 38548.0, 38564.22871542568, 38590.0, 41626.16747665045, 41950.16099678005, 41976.0, 42141.36787948175, 42179.0, 9441.81116377672, 9657.758556036086, 9666.420014799134, 9671.323007389485, 9698.90301096987, 9450.33847630666, 9559.80880382392, 9577.0, 9682.661106861262, 9736.51317434129, 9594.952025239863, 9661.71014869555, 9680.0, 9681.70954871355, 9699.224062075016, 9633.855492167622, 9720.854187187198, 9727.610895564168, 9729.173020293283, 9740.561674724619, 9376.296777741696, 9497.857532137023, 9529.047095290485, 9540.475273859935, 9543.618255269781, 32087.518687219475, 32695.0, 39875.20249595021, 40291.99270018244, 40452.797736011424, 3141.528770684393, 3250.983745081283, 3323.9169020774675, 3393.915152121192, 3636.381815091441, 23295.767042329528, 25766.87116564424, 26876.92492300306, 27562.0, 27718.02986895449, 2659.9335016624545, 2723.6867760207433, 2734.8359098453957, 2794.2176190666646, 2862.670792858827, 408231.0, 412117.0, 414476.92761536303, 414651.0, 416599.0, 45429.0, 64449.355506444335, 68918.31081689219, 69003.0, 69015.96476052863, 44643.10713785706, 44902.0, 44903.55096449059, 44904.0, 45027.77486112549, 15586.220688965734, 15836.841631583537, 15868.365265389486, 15872.841271587367, 15875.52373428799, 12691.746165076647, 12742.554010609585, 12777.361131943366, 12789.680257993625, 12798.936005319914, 14274.571762847132, 14274.643133921734, 14533.128012319296, 14533.491327803476, 14614.196219208046, 5309.3894202166475, 6223.595466294676, 6290.339514351019, 6313.526485513605, 6314.6113451151, 915.7619019055094, 918.169057003413, 980.9117179453883, 1034.6016783538391, 1146.8394424780538, 28979.56530652042, 29014.27464313409, 29595.26011849678, 29693.703062969093, 29725.851370743007, 983.6360546597662, 1019.6023550815188, 1119.6696974392412, 1144.8282757586262, 1196.9281843089443, 14637.121772693672, 14744.299755525706, 14868.0, 14996.325165367367, 15053.0, 526380.0, 527419.0, 533122.0, 534364.0, 534896.0, 58210.70894645499, 58647.0, 58741.0, 58785.706071470224, 58925.70537147287, 1338.4846833968797, 1348.9730205396033, 1449.39125567262, 1455.5051282563768, 1489.7616381378928, 26041.609375859756, 28373.148805535868, 28599.28501787472, 28923.0, 29122.417551649272, 45320.546794531634, 45798.77100614476, 45800.54199457963, 45865.54134458613, 45872.0, 325167.0, 335577.0, 336573.0, 336711.632883668, 337860.0, 29176.7082329174, 32368.514472282463, 32479.35041299208, 32855.0, 33206.16984575405, 40537.59462405338, 41117.383239252034, 41683.0, 41889.58110418857, 42273.15453690848, 34309.48535771915, 36241.27517449689, 36516.0, 36948.89153325404, 37871.24257514889, 35151.82424087863, 35294.64705353016, 35335.82332088323, 36110.0, 36202.45696314505, 36479.817600911825, 36683.0, 37601.43597846089, 37895.0, 38017.2396552073, 29844.253893652833, 31136.0, 31227.375452491277, 31237.531437028916, 31371.686283136878, 23568.0, 23597.75240456734, 23685.52628947446, 23949.0, 24118.276451706475], "unit": "score", "name": "ext.html", "value": 18675.934684149997}, {"lowerIsBetter": false, "replicates": [355.90034790258727, 358.12259963090435, 364.686369722039, 370.4184430444202, 371.6450789496028, 19646.410607681773, 20348.389548313557, 20595.2791652292, 21087.68368474474, 21097.94510274484, 19362.419127426165, 19523.219071237134, 20064.996750162507, 20100.39196864251, 20554.280600178958, 5151.922721159186, 5345.118055520835, 5392.379876314215, 5399.244105825188, 5405.540529055035, 3908.0, 4036.1120553478336, 4711.505291944348, 5288.365396152448, 5967.910481342762, 5939.227900372945, 5944.0, 5953.226080609515, 5957.582969192158, 5964.433378829026, 5700.942990570083, 5837.854053648651, 5886.6173698709445, 5913.940860591403, 5934.228550288456, 5596.524295434893, 5618.438156184389, 5624.21261023457, 5624.240727501776, 5624.915626265569, 13065.673358166121, 13485.932570337085, 13518.459261629523, 13519.0, 13542.390592423364, 2082.3648787119923, 2334.8599084055013, 2454.840435371695, 2605.8534244932357, 2798.328401183722, 7586.62066896653, 9964.551595178234, 10823.621173258976, 11130.0, 14492.0, 1675.7989041314997, 1699.7110491216522, 1743.555393374694, 1758.4900378890106, 1790.9641807163914, 90124.5493772527, 92773.53613231958, 93730.59404108944, 94847.52576237144, 95410.52294738551, 10782.4069676167, 10805.83791243132, 10807.83788243177, 10828.458577071115, 10887.346759194474, 13540.458381664623, 13591.52429664957, 13604.863951360558, 13620.523281685093, 13692.178469291874, 8258.958705206436, 8410.831783364298, 8434.493930364199, 8496.490210587384, 8502.574871256413, 8453.535055572003, 8471.534065626327, 8481.363897707697, 8546.102659220693, 8562.529060901586, 4289.356596510486, 4359.891002724894, 4368.191884501377, 4412.779361031936, 4418.337249412614, 1688.3331084221663, 1765.64687062588, 1768.8673349498838, 1778.4753497718204, 1834.5872178759673, 789.2226157235119, 912.7672443526858, 945.6595625574788, 971.7464470832688, 1011.8735158105237, 19069.904650476936, 19439.708404373945, 19545.902270488557, 19900.70148947767, 19914.800851991586, 869.6564856881496, 915.9221466175317, 919.1819280840058, 970.6990832841842, 971.9854202186973, 10495.632652857113, 10629.681109566725, 10640.35074563444, 10653.786924261627, 10759.677209683721, 528752.0, 539073.0, 555065.0, 564351.0, 628282.0, 59500.45494995547, 86036.0, 87887.0, 89101.0, 109664.0, 996.6960077176386, 999.8551658351147, 1013.3160116921196, 1018.5365658625308, 1018.6383833738915, 14031.859681403055, 17560.209790559198, 17654.293828246726, 18103.0, 18264.634707306046, 48172.0, 48821.511784883114, 49381.0, 50151.98176218877, 50361.244581332045, 69112.54437278016, 69589.60820783657, 69905.65047174731, 70209.89370318898, 70424.64787676028, 7600.399600399601, 7670.654820532978, 7753.534787912743, 7838.764837054898, 7954.681812727657, 8561.657533698582, 11636.12729045308, 12335.198212116184, 12343.382830858602, 12612.936935315265, 10648.254622176373, 10689.9465502672, 10829.783404331713, 10954.671359859218, 10990.0, 10383.844242336521, 10428.165746740091, 10530.789384212427, 10578.365298082139, 10808.189385796253, 10781.784364312512, 10795.19036072282, 10915.23593348458, 11099.889001109885, 11182.888171118184, 7549.358304544176, 7688.192739762245, 7748.883766743616, 7905.549279723305, 8046.517208967481, 10477.804269697815, 10551.419671918118, 10587.629432969808, 10772.461376931278, 10778.083862871743], "unit": "score", "name": "jquery.html", "value": 8928.678230062613}, {"lowerIsBetter": false, "replicates": [1441.8846492280618, 1580.1546172797553, 1613.0644226348718, 1881.670707626165, 2019.4850313170148, 7994.080680721719, 8552.230299273064, 8724.47653140812, 8737.12628737126, 8740.344474164447, 8468.576571171448, 8716.91283087169, 8724.73825785226, 8726.345524085687, 8738.563071846398, 2189.5511420158828, 2430.9756902430927, 2475.4430253193023, 2494.102123235643, 2505.223380751973, 2505.2108585795418, 2508.611165269386, 2514.09492582671, 2517.332906779696, 2519.2694118705554, 2036.2465887621602, 2423.6485709572103, 2484.1305543059875, 2487.6766020417413, 2494.5135698538793, 2457.8893949772123, 2460.052879641333, 2483.689538807649, 2484.354067942339, 2485.142625794098, 2437.025189924027, 2451.742567030472, 2469.2839076667747, 2479.417336925821, 2497.2383423055962, 8716.215540601313, 8795.956020219923, 8808.603612837374, 8813.42712723671, 8815.20663140314, 5436.456354364572, 5554.555635549146, 5591.692456914868, 5592.049351610236, 5593.52455041322, 3457.2048428861253, 3537.0, 3592.0660628236847, 3659.469376940329, 3659.8170091495585, 903.9186473217442, 983.6360546597805, 989.6635144051057, 990.5047476261869, 994.4977786217986, 12272.018238540895, 12282.201656892363, 12293.200941938745, 12293.446794894251, 12309.322987235699, 4870.391201099863, 4929.852104436873, 4969.801207951641, 4985.700857948535, 4997.325361076281, 10251.743706407251, 10308.072273495422, 10310.07209351162, 10321.535530901128, 10331.896681033093, 5553.250311208016, 5562.499375056264, 5577.661361273265, 5578.2748242728185, 5592.636478628876, 4443.400140980991, 4605.562471565196, 4777.641676874248, 5005.0, 5006.874828129253, 3825.5218097737784, 3932.46911666927, 3950.20995800841, 3964.900877478086, 4000.239954408653, 1288.2335010668637, 1297.47452281826, 1297.8702129786946, 1305.2364366845502, 1326.8009798530104, 1052.8894466081103, 1071.8959471744115, 1096.6161843354762, 1366.3373263966969, 1369.5275130080106, 7213.350798428167, 8117.350611951029, 8246.38152138592, 8309.626066826886, 8348.707795227137, 506.8758154252158, 511.4144304771091, 521.8643152780229, 523.7826302084592, 524.1063985904025, 6227.408396202353, 6249.1563638908165, 6300.527460440485, 6312.652804095819, 6315.305316415191, 10381.896181038244, 10715.571377144826, 10849.403282819363, 10852.077573406192, 10882.129429645609, 10499.160067194605, 10685.732856678645, 10711.303765255234, 10762.24664273509, 10773.946130269298, 8242.052164001216, 8342.833143337099, 8413.284870786052, 8421.578921053922, 8435.240828325357, 7720.459567830198, 7943.483673561431, 7950.16523265072, 7961.40289478303, 7995.040595128622, 9378.062193780568, 9607.231421486404, 9697.321187516805, 9812.0, 9853.408795472295, 9732.610695572097, 9842.163416109712, 9955.20358371343, 10021.298509104292, 10058.949705251427, 6486.740530378732, 6875.1749790025515, 7043.225245222919, 7445.218252083453, 7532.246775322643, 8268.586570671321, 8359.08050114499, 8359.874601880854, 8360.623771930399, 8385.161483851565, 7288.125424948828, 7402.814929626802, 7421.777346679608, 7544.6227688616445, 7579.924200757921, 5943.227380440515, 7176.21061683204, 7273.854522909618, 7335.193128755939, 7339.77980660581, 7603.125640551186, 7819.296263336099, 7879.606019698877, 7881.881771773543, 7886.921130788848, 7117.7152913882865, 7131.465140114616, 7155.534890232118, 7157.892631610426, 7193.820154496179, 7094.964525177341, 7111.0, 7123.25205853378, 7148.821279468055, 7229.457790665826], "unit": "score", "name": "mootools.html", "value": 4841.693325018007}, {"lowerIsBetter": false, "replicates": [325.0540925905614, 327.386150966937, 330.50259359663704, 331.2662452667342, 336.4532634468989, 6512.153420055392, 6551.443127334176, 6561.9015714764255, 6562.179727534059, 6567.901481477782, 6467.805965821021, 6546.3126371731, 6556.934430655692, 6556.967215163918, 6565.409113179813, 3949.6247856453665, 4611.4005179326805, 4722.834700785474, 4731.148393289207, 4791.305260737191, 4777.498362671921, 4778.880527986794, 4789.832355867546, 4812.085703716282, 4821.710697358152, 3959.2675355059405, 4666.4400271967415, 4755.64332675049, 4762.214234651278, 4762.761861906908, 4562.292844609091, 4660.953390466086, 4762.904741905159, 4763.261694437368, 4775.594074503671, 3438.4670376091744, 3867.3425517662067, 4098.282800509899, 4118.217538667644, 4118.608732170439, 5054.393472783289, 6156.199694039791, 6248.4064013918605, 6302.747890084391, 6310.33741457145, 5743.4256574342235, 5744.396838331999, 5752.165935939307, 5764.962306784777, 5767.711614419304, 6941.930580694179, 6994.930050699479, 6998.650067496605, 7003.5797852129035, 7010.684519196649, 4373.650107991353, 4550.385697930803, 4559.17934771741, 4598.724076555417, 4685.390899183119, 7254.093238345207, 7277.599732014737, 7339.0, 7350.926490735131, 7392.075990501187, 4602.125596136723, 4602.4477062752685, 4617.168909596305, 4624.1445332613575, 4633.72197668141, 4322.3516472528745, 4671.159191345522, 4671.182543054952, 4680.625549956064, 4690.81236750533, 5141.0, 5575.0522411190195, 5577.358603760538, 5578.748956296977, 5587.161925711094, 6759.194528503863, 6897.862042759217, 6988.720451181895, 6991.056207411934, 7016.5088443808445, 1366.549038817188, 1609.3643011010586, 1615.135902292268, 1631.7144499712504, 1633.3956436118713, 905.0677801864091, 969.3117886300664, 995.6664517386756, 1022.4274406332329, 1051.0225490293947, 5157.484251574812, 6459.063435801782, 6521.413072823469, 6562.179727534059, 6566.3105373936005, 7259.963700181465, 7298.0, 7301.08736407949, 7308.853822923512, 7310.0, 6513.478921686254, 6540.182477190351, 6580.901286480706, 6588.209414870246, 6591.307912669196, 3841.961580384216, 3889.922201555953, 3897.3569361055675, 3899.771571954825, 3900.2199560088097, 7313.853722925512, 7635.198304177981, 7644.961775191088, 7669.654865531064, 7677.385809135256, 7537.510061845963, 7585.0139481867, 7588.62056897153, 7604.619769011527, 7614.238576142452, 7626.161122276434, 7634.770956871303, 7647.08235011791, 7653.081630204411, 7656.234376562299, 6933.791986240421, 7315.707371705073, 7328.450366222448, 7338.706451742084, 7340.743073992385, 6591.077249185214, 7198.6040767756185, 7205.675744591401, 7209.990601315925, 7213.963930180315, 6800.31996800316, 7618.0, 7628.694852205849, 7642.006539149875, 7646.0, 4792.501473923985, 4837.467878533429, 4846.612271018381, 4846.854594362175, 4850.805967761391, 6147.262328520606, 6987.161540615159, 7037.824054398681, 7241.855162896818, 7253.963730181315, 5573.913086948006, 6974.302569742985, 6988.755393561201, 6989.33601307875, 6990.510664253454, 6904.861902762017, 6947.756828510978, 6948.756793512202, 6972.755953541602, 6980.267071957574, 6808.965955170391, 6814.965925170342, 6823.761168359282, 6831.555948863308, 6842.828929276808, 6710.83222919431, 6990.021397004525, 6996.0, 7006.439484841098, 7026.578405295699, 6599.670016499252, 6724.29394913527, 6726.865462690621, 6844.28135045813, 6853.109095817512], "unit": "score", "name": "prototype.html", "value": 5082.102170653656}, {"lowerIsBetter": false, "replicates": [711.4166383565475, 728.4427413029032, 731.9231480694527, 741.6625435426881, 763.2443880558249, 14895.478658246964, 14931.178785166812, 15068.246587670628, 15084.396624135035, 15093.6981260375, 11737.0, 12157.696057598543, 12246.0815438842, 12381.56664516742, 12467.501299948013, 725.0176011504415, 898.0211569389364, 914.4330515080659, 914.9980771055716, 916.2166347772659, 736.6095969136367, 899.8110396816676, 923.4274749655223, 927.5918595817852, 928.2944961829024, 972.6741541583579, 972.9902700973006, 978.5205249427801, 980.9950950245238, 983.4197823284261, 751.5002523321984, 955.5222388805597, 969.6557722008691, 973.4500007495777, 975.3903810118641, 725.354434553248, 726.0887586079489, 727.4689476681999, 727.9381252593536, 728.2098922668911, 14808.703825923421, 14824.3329050193, 14894.180820054893, 14925.25373731309, 14979.026363286352, 12494.0, 12512.436940337615, 12562.434690438951, 12780.680482987907, 12969.092163548461, 9849.21206303494, 10131.08820206185, 10814.459277036116, 10962.451877406098, 11579.884201157965, 3606.855725770966, 3964.603539646041, 4311.719738217006, 4314.82740690372, 4436.755978421185, 68745.65627171882, 75877.22145378865, 76794.23205767927, 76856.61571692106, 76989.23010769933, 9265.490398028038, 9833.115019648267, 10017.39895606266, 10034.24743144267, 10050.095491405662, 22457.32628021162, 22474.98862551189, 22477.100915963507, 22507.212247571584, 22536.098556057903, 7540.660670269851, 7618.657160427683, 7655.540667559964, 7699.576523291273, 7738.148803631596, 3017.7434918032213, 3885.611438856092, 3933.6853051755793, 4033.495813023372, 4033.838646454109, 3469.739769517246, 3523.6300188480354, 3524.647535246455, 3532.646735326447, 3537.6816086552335, 657.8914479110989, 671.2549070531705, 671.5232185148599, 673.7636437137809, 691.2948792231996, 480.2436163043221, 540.3272925208141, 551.7461967494917, 595.2440400691185, 604.1722839709538, 8074.677012919417, 8125.1062383137805, 8267.586620668942, 8290.585470726439, 8417.70538031166, 588.7203578300273, 602.1690067706625, 606.6299557270062, 607.6323824086453, 615.6952308607268, 3545.4859045438266, 3774.8678796241998, 3813.3517302058717, 3896.532416110085, 3996.4005399189773, 84443.57778211069, 85531.0, 85625.71561426584, 85783.14216857876, 86768.56615716881, 72878.0, 75911.0, 77076.61461692768, 79380.0, 79445.80831287535, 68460.0, 74601.0, 75128.4974300511, 75916.24083759202, 76691.61654191805, 8265.793355166168, 8283.668653253802, 8461.06928237881, 8592.65629374843, 8616.827663446571, 32925.34149317048, 39912.20175596414, 50886.71009804642, 51582.48417515777, 51796.741016294676, 59164.0, 65363.34636653573, 67908.0, 69999.65000174966, 71502.64248678723, 11075.113990880871, 11367.261128026652, 11453.312801231952, 11507.539698411969, 11688.298702077902, 11888.108391870472, 11908.821367679666, 12150.392480376122, 12468.002559795375, 12525.185862918881, 10974.890251097388, 11122.165837562054, 11179.329240245612, 11502.42487875586, 11625.953664170265, 10996.505157267782, 11065.280756750786, 11420.885791142315, 11514.481848316678, 11653.242539234923, 10254.077133058061, 10498.842517362398, 11049.834252486058, 11272.66182014541, 11496.31022138641, 9498.905010950079, 9539.952300238732, 9581.904180958101, 9604.423734575948, 9783.9021609783, 9374.906250937676, 9579.521023948635, 9604.75988100303, 9614.134727874525, 9822.901770982198], "unit": "score", "name": "yui.html", "value": 6894.004034287413}], "name": "dromaeo_css", "value": 7367.408122930459}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 108.0, 111.0, 111.0, 110.0, 116.0, 110.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 145.0, 158.0, 110.0, 128.0, 159.0, 150.0, 196.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 184.0, 189.0, 187.0, 186.0, 185.0, 185.0, 185.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.3}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 84.0, 80.0, 57.0, 57.0, 59.0, 83.0, 104.0, 83.0], "unit": "score", "name": "audio-fft", "value": 76.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 124.0, 78.0, 78.0, 79.0, 113.0, 79.0, 75.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 93.0, 87.0, 88.0, 84.0, 88.0, 130.0, 134.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 94.0, 95.0, 94.0, 92.0, 97.0, 119.0, 92.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 96.2}, {"lowerIsBetter": true, "replicates": [85.0, 88.0, 88.0, 87.0, 88.0, 87.0, 85.0, 87.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 53.0, 53.0, 54.0, 55.0, 52.0, 63.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 75.0, 79.0, 71.0, 70.0, 68.0, 65.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 83.0, 84.0, 81.0, 84.0, 83.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [124.0, 134.0, 133.0, 112.0, 129.0, 131.0, 135.0, 133.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [144.0, 130.0, 140.0, 139.0, 135.0, 129.0, 141.0, 139.0, 138.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1429.0}]} 18:42:48 INFO - Return code: 0 18:42:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:42:48 ERROR - # TBPL SUCCESS # 18:42:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:42:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:42:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:42:48 INFO - 2016-03-31 18:42:48.966 screenresolution[1681:9607] starting screenresolution argv=screenresolution get 18:42:48 INFO - 2016-03-31 18:42:48.971 screenresolution[1681:9607] Display 0: 1600x1200x32@60 18:42:48 INFO - 2016-03-31 18:42:48.977 screenresolution[1682:9610] starting screenresolution argv=screenresolution list 18:42:48 INFO - Available Modes on Display 0 18:42:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:42:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:42:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:42:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:42:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:42:49 INFO - Intel Iris: 18:42:49 INFO - Chipset Model: Intel Iris 18:42:49 INFO - Type: GPU 18:42:49 INFO - Bus: Built-In 18:42:49 INFO - VRAM (Dynamic, Max): 1536 MB 18:42:49 INFO - Vendor: Intel (0x8086) 18:42:49 INFO - Device ID: 0x0a2e 18:42:49 INFO - Revision ID: 0x0009 18:42:49 INFO - Displays: 18:42:49 INFO - Display: 18:42:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:42:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:42:49 INFO - Display Serial Number: 1600x1200 60 18:42:49 INFO - Main Display: Yes 18:42:49 INFO - Mirror: Off 18:42:49 INFO - Online: Yes 18:42:49 INFO - Rotation: Supported 18:42:49 INFO - Return code: 0 18:42:49 INFO - Running post-action listener: _resource_record_post_action 18:42:49 INFO - Running post-run listener: _resource_record_post_run 18:42:50 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39777792; Write bytes: 705410560; Read time: 431; Write time: 1908 18:42:50 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401635840; Write bytes: 391448576; Read time: 30052; Write time: 739 18:42:50 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32660992; Write bytes: 298577408; Read time: 343; Write time: 1129 18:42:50 INFO - Running post-run listener: _upload_blobber_files 18:42:50 INFO - Blob upload gear active. 18:42:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:50 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 18:42:50 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'] 18:42:50 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 18:42:51 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:42:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:42:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:53 INFO - (blobuploader) - INFO - Done attempting. 18:42:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:42:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:56 INFO - (blobuploader) - INFO - Done attempting. 18:42:56 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:56 INFO - Return code: 0 18:42:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:42:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84ae2541657dfc25b7ff82202aeafb84c34f00e96dc7fc97ff51811c80d8f2ca6227383e6053277bb05ec9d216f57105fc75a6f2a413722a9df2267a9c48852c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f245628aae845e6b1c3215cfbbec9a9055bfa4b1c443a4060ebae34ee3a09d163e8ef8900b3ee0b6d25be2ca40f1aa6696f1ecb3fe5bb0ea55cbbe64a9f218b"} 18:42:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:42:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:42:56 INFO - Contents: 18:42:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/84ae2541657dfc25b7ff82202aeafb84c34f00e96dc7fc97ff51811c80d8f2ca6227383e6053277bb05ec9d216f57105fc75a6f2a413722a9df2267a9c48852c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f245628aae845e6b1c3215cfbbec9a9055bfa4b1c443a4060ebae34ee3a09d163e8ef8900b3ee0b6d25be2ca40f1aa6696f1ecb3fe5bb0ea55cbbe64a9f218b"} 18:42:56 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:56 INFO - Copying logs to upload dir... 18:42:56 INFO - mkdir: /builds/slave/test/build/upload/logs 18:42:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.389769 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-03-31 18:42:55.876179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 18:42:55.880323) ========= 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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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/84ae2541657dfc25b7ff82202aeafb84c34f00e96dc7fc97ff51811c80d8f2ca6227383e6053277bb05ec9d216f57105fc75a6f2a413722a9df2267a9c48852c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f245628aae845e6b1c3215cfbbec9a9055bfa4b1c443a4060ebae34ee3a09d163e8ef8900b3ee0b6d25be2ca40f1aa6696f1ecb3fe5bb0ea55cbbe64a9f218b"} build_url:https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/a7yOhjl8SSWCM_kl3AHiFw/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/84ae2541657dfc25b7ff82202aeafb84c34f00e96dc7fc97ff51811c80d8f2ca6227383e6053277bb05ec9d216f57105fc75a6f2a413722a9df2267a9c48852c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2f245628aae845e6b1c3215cfbbec9a9055bfa4b1c443a4060ebae34ee3a09d163e8ef8900b3ee0b6d25be2ca40f1aa6696f1ecb3fe5bb0ea55cbbe64a9f218b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 18:42:55.918561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:42:55.918855) ========= 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.A0bVYme0jw/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.w6PA2tTf08/Listeners TMPDIR=/var/folders/3p/glv0cyh572g29ns0_2zrypmr00000w/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.005066 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 18:42:55.971673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 18:42:55.975013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 18:42:55.975357) ========= ========= Total master_lag: 15.79 =========