builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0128 starttime: 1454409389.35 results: success (0) buildid: 20160202014818 builduid: a8b39ad574654fa8a851ec5b804394f6 revision: 512496acf11d6ac95478123788572320004816ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.347405) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.347940) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.348294) ========= 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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.005495 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.400812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.401165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.428200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.429085) ========= 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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.005408 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.516595) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.516949) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.517385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:29.517721) ========= 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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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-02-02 02:36:29-- 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% 168M=0s 2016-02-02 02:36:30 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.866364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:30.401824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:30.402211) ========= 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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.026229 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:30.451338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 02:36:30.451930) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 512496acf11d6ac95478123788572320004816ea --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 512496acf11d6ac95478123788572320004816ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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-02-02 02:36:30,523 truncating revision to first 12 chars 2016-02-02 02:36:30,523 Setting DEBUG logging. 2016-02-02 02:36:30,523 attempt 1/10 2016-02-02 02:36:30,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/512496acf11d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 02:36:31,594 unpacking tar archive at: fx-team-512496acf11d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 02:36:31.784998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:31.785389) ========= echo 512496acf11d6ac95478123788572320004816ea in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'512496acf11d6ac95478123788572320004816ea'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 512496acf11d6ac95478123788572320004816ea program finished with exit code 0 elapsedTime=0.005968 script_repo_revision: '512496acf11d6ac95478123788572320004816ea' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:31.835819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:31.836187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 02:36:31.851846) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-02 02:36:31.852215) ========= /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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:36:32 INFO - MultiFileLogger online at 20160202 02:36:32 in /builds/slave/test 02:36:32 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 02:36:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:36:32 INFO - {'append_to_log': False, 02:36:32 INFO - 'base_work_dir': '/builds/slave/test', 02:36:32 INFO - 'blob_upload_branch': 'Fx-Team', 02:36:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:36:32 INFO - 'branch': 'Fx-Team', 02:36:32 INFO - 'buildbot_json_path': 'buildprops.json', 02:36:32 INFO - 'config_files': ('talos/mac_config.py',), 02:36:32 INFO - 'default_actions': ('clobber', 02:36:32 INFO - 'read-buildbot-config', 02:36:32 INFO - 'download-and-extract', 02:36:32 INFO - 'populate-webroot', 02:36:32 INFO - 'create-virtualenv', 02:36:32 INFO - 'install', 02:36:32 INFO - 'run-tests'), 02:36:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:36:32 INFO - 'download_minidump_stackwalk': True, 02:36:32 INFO - 'download_symbols': 'ondemand', 02:36:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:36:32 INFO - 'tooltool.py': '/tools/tooltool.py', 02:36:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:36:32 INFO - '/tools/misc-python/virtualenv.py')}, 02:36:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:36:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:36:32 INFO - 'installer_path': 'installer.exe', 02:36:32 INFO - 'log_level': 'info', 02:36:32 INFO - 'log_name': 'talos', 02:36:32 INFO - 'log_to_console': True, 02:36:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:36:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:36:32 INFO - 'opt_config_files': (), 02:36:32 INFO - 'pip_index': False, 02:36:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:36:32 INFO - 'cmd': ('bash', 02:36:32 INFO - '-c', 02:36:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:36:32 INFO - 'enabled': True, 02:36:32 INFO - 'halt_on_failure': False, 02:36:32 INFO - 'name': 'check_screen_resolution'},), 02:36:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:36:32 INFO - 'cmd': ('bash', 02:36:32 INFO - '-c', 02:36:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:36:32 INFO - 'enabled': True, 02:36:32 INFO - 'halt_on_failure': False, 02:36:32 INFO - 'name': 'check_screen_resolution'},), 02:36:32 INFO - 'run_cmd_checks_enabled': True, 02:36:32 INFO - 'sps_profile': False, 02:36:32 INFO - 'sps_profile_interval': 0, 02:36:32 INFO - 'suite': 'dromaeojs', 02:36:32 INFO - 'system_bits': '32', 02:36:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:36:32 INFO - 'title': 't-yosemite-r7-0128', 02:36:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:36:32 INFO - 'use_talos_json': True, 02:36:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:36:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:36:32 INFO - 'work_dir': 'build'} 02:36:32 INFO - ##### 02:36:32 INFO - ##### Running clobber step. 02:36:32 INFO - ##### 02:36:32 INFO - Running pre-action listener: _resource_record_pre_action 02:36:32 INFO - Running main action method: clobber 02:36:32 INFO - rmtree: /builds/slave/test/build 02:36:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:36:34 INFO - Running post-action listener: _resource_record_post_action 02:36:34 INFO - ##### 02:36:34 INFO - ##### Running read-buildbot-config step. 02:36:34 INFO - ##### 02:36:34 INFO - Running pre-action listener: _resource_record_pre_action 02:36:34 INFO - Running main action method: read_buildbot_config 02:36:34 INFO - Using buildbot properties: 02:36:34 INFO - { 02:36:34 INFO - "project": "", 02:36:34 INFO - "product": "firefox", 02:36:34 INFO - "script_repo_revision": "production", 02:36:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:36:34 INFO - "repository": "", 02:36:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:36:34 INFO - "buildid": "20160202014818", 02:36:34 INFO - "pgo_build": "False", 02:36:34 INFO - "basedir": "/builds/slave/test", 02:36:34 INFO - "buildnumber": 269, 02:36:34 INFO - "slavename": "t-yosemite-r7-0128", 02:36:34 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:36:34 INFO - "platform": "yosemite_r7", 02:36:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:36:34 INFO - "branch": "fx-team", 02:36:34 INFO - "repo_path": "integration/fx-team", 02:36:34 INFO - "revision": "512496acf11d6ac95478123788572320004816ea", 02:36:34 INFO - "stage_platform": "macosx64", 02:36:34 INFO - "builduid": "a8b39ad574654fa8a851ec5b804394f6", 02:36:34 INFO - "slavebuilddir": "test" 02:36:34 INFO - } 02:36:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:36:34 INFO - Running post-action listener: _resource_record_post_action 02:36:34 INFO - ##### 02:36:34 INFO - ##### Running download-and-extract step. 02:36:34 INFO - ##### 02:36:34 INFO - Running pre-action listener: _resource_record_pre_action 02:36:34 INFO - Running main action method: download_and_extract 02:36:34 INFO - mkdir: /builds/slave/test/build/tests 02:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:34 INFO - https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/test_packages.json 02:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/test_packages.json 02:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:36:39 INFO - Downloaded 1277 bytes. 02:36:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:36:39 INFO - Using the following test package requirements: 02:36:39 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:36:39 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:36:39 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:36:39 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'jsshell-mac.zip'], 02:36:39 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:36:39 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:36:39 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:36:39 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:36:39 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:36:39 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:36:39 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:36:39 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:36:39 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:39 INFO - https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:36:40 INFO - Downloaded 17116056 bytes. 02:36:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:36:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:36:43 INFO - Return code: 0 02:36:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:36: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')]} 02:36:43 INFO - https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:36:45 INFO - Downloaded 17116056 bytes. 02:36:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:36:49 INFO - Return code: 0 02:36:49 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')]} 02:36:49 INFO - https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:36:51 INFO - Downloaded 10706582 bytes. 02:36:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:36:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:36:51 INFO - Return code: 0 02:36:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:51 INFO - https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:36:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:36:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 02:36:54 INFO - Downloaded 111052980 bytes. 02:36:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:54 INFO - mkdir: /builds/slave/test/properties 02:36:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:54 INFO - Contents: 02:36:54 INFO - build_url:https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:36:54 INFO - Running post-action listener: _resource_record_post_action 02:36:54 INFO - Running post-action listener: set_extra_try_arguments 02:36:54 INFO - ##### 02:36:54 INFO - ##### Running populate-webroot step. 02:36:54 INFO - ##### 02:36:54 INFO - Running pre-action listener: _resource_record_pre_action 02:36:54 INFO - Running main action method: populate_webroot 02:36:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:54 INFO - '--tppagecycles', 02:36:54 INFO - '7'], 02:36:54 INFO - 'tests': ['tsvgm']}}, 02:36:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:36:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:36:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'tests': ['damp', 'tps']}, 02:36:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['damp', 'tps']}, 02:36:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:36:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:54 INFO - 'other': {'tests': ['a11yr', 02:36:54 INFO - 'ts_paint', 02:36:54 INFO - 'tpaint', 02:36:54 INFO - 'sessionrestore', 02:36:54 INFO - 'sessionrestore_no_auto_restore']}, 02:36:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['a11yr', 02:36:54 INFO - 'ts_paint', 02:36:54 INFO - 'tpaint', 02:36:54 INFO - 'sessionrestore', 02:36:54 INFO - 'sessionrestore_no_auto_restore']}, 02:36:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['a11yr', 02:36:54 INFO - 'ts_paint', 02:36:54 INFO - 'tpaint', 02:36:54 INFO - 'sessionrestore', 02:36:54 INFO - 'sessionrestore_no_auto_restore']}, 02:36:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['a11yr', 02:36:54 INFO - 'ts_paint', 02:36:54 INFO - 'tpaint', 02:36:54 INFO - 'sessionrestore', 02:36:54 INFO - 'sessionrestore_no_auto_restore']}, 02:36:54 INFO - 'other_l64': {'tests': ['a11yr', 02:36:54 INFO - 'ts_paint', 02:36:54 INFO - 'tpaint', 02:36:54 INFO - 'sessionrestore', 02:36:54 INFO - 'sessionrestore_no_auto_restore']}, 02:36:54 INFO - 'other_nol64': {'tests': ['a11yr', 02:36:54 INFO - 'ts_paint', 02:36:54 INFO - 'tpaint', 02:36:54 INFO - 'sessionrestore', 02:36:54 INFO - 'sessionrestore_no_auto_restore']}, 02:36:54 INFO - 'svgr': {'tests': ['tsvgx', 02:36:54 INFO - 'tsvgr_opacity', 02:36:54 INFO - 'tart', 02:36:54 INFO - 'tscrollx', 02:36:54 INFO - 'cart']}, 02:36:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['tsvgx', 02:36:54 INFO - 'tsvgr_opacity', 02:36:54 INFO - 'tart', 02:36:54 INFO - 'tscrollx', 02:36:54 INFO - 'cart']}, 02:36:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'tests': ['tp5o']}, 02:36:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'talos_options': ['--e10s'], 02:36:54 INFO - 'tests': ['tp5o']}, 02:36:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'talos_options': ['--xperf_path', 02:36:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:54 INFO - 'tests': ['tp5n']}, 02:36:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:54 INFO - 'talos_options': ['--e10s', 02:36:54 INFO - '--xperf_path', 02:36:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:54 INFO - 'tests': ['tp5n']}}, 02:36:54 INFO - 'talos.zip': {'path': '', 02:36:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:54 INFO - Running post-action listener: _resource_record_post_action 02:36:54 INFO - ##### 02:36:54 INFO - ##### Running create-virtualenv step. 02:36:54 INFO - ##### 02:36:54 INFO - Running pre-action listener: _resource_record_pre_action 02:36:54 INFO - Running main action method: create_virtualenv 02:36:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:54 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 02:36:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:54 INFO - Using real prefix '/tools/python27' 02:36:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:58 INFO - Installing pip.................done. 02:36:58 INFO - Return code: 0 02:36:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:58 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:36:58 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 02:36:58 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 02:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:58 INFO - 'HOME': '/Users/cltbld', 02:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:58 INFO - 'LOGNAME': 'cltbld', 02:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:58 INFO - 'MOZ_NO_REMOTE': '1', 02:36:58 INFO - 'NO_EM_RESTART': '1', 02:36:58 INFO - 'PAGER': '/bin/cat', 02:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:58 INFO - 'PWD': '/builds/slave/test', 02:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:58 INFO - 'SHELL': '/bin/bash', 02:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:36:58 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:58 INFO - 'USER': 'cltbld', 02:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:58 INFO - 'XPC_FLAGS': '0x0', 02:36:58 INFO - 'XPC_SERVICE_NAME': '0', 02:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:58 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 02:36:58 INFO - Cleaning up... 02:36:58 INFO - Return code: 0 02:36:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:58 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:36:58 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 02:36:58 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 02:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:36:58 INFO - 'HOME': '/Users/cltbld', 02:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:36:58 INFO - 'LOGNAME': 'cltbld', 02:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:58 INFO - 'MOZ_NO_REMOTE': '1', 02:36:58 INFO - 'NO_EM_RESTART': '1', 02:36:58 INFO - 'PAGER': '/bin/cat', 02:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:58 INFO - 'PWD': '/builds/slave/test', 02:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:36:58 INFO - 'SHELL': '/bin/bash', 02:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:36:58 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:36:58 INFO - 'USER': 'cltbld', 02:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:58 INFO - 'XPC_FLAGS': '0x0', 02:36:58 INFO - 'XPC_SERVICE_NAME': '0', 02:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:58 INFO - Downloading/unpacking psutil>=0.7.1 02:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:37:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:01 INFO - Installing collected packages: psutil 02:37:01 INFO - Running setup.py install for psutil 02:37:01 INFO - building 'psutil._psutil_osx' extension 02:37:01 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 02:37:02 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 02:37:02 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 02:37:02 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 02:37:02 INFO - building 'psutil._psutil_posix' extension 02:37:02 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 02:37:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:37:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:37:02 INFO - ^ 02:37:02 INFO - 1 warning generated. 02:37:02 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 02:37:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:02 INFO - Successfully installed psutil 02:37:02 INFO - Cleaning up... 02:37:02 INFO - Return code: 0 02:37:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:37:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:02 INFO - 'HOME': '/Users/cltbld', 02:37:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:02 INFO - 'LOGNAME': 'cltbld', 02:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:02 INFO - 'MOZ_NO_REMOTE': '1', 02:37:02 INFO - 'NO_EM_RESTART': '1', 02:37:02 INFO - 'PAGER': '/bin/cat', 02:37:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:02 INFO - 'PWD': '/builds/slave/test', 02:37:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:02 INFO - 'SHELL': '/bin/bash', 02:37:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:02 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:02 INFO - 'USER': 'cltbld', 02:37:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:02 INFO - 'XPC_FLAGS': '0x0', 02:37:02 INFO - 'XPC_SERVICE_NAME': '0', 02:37:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:37:03 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 02:37:03 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 02:37:03 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 02:37:03 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 02:37:03 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 02:37:03 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 02:37:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:37:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:37:05 INFO - Installing collected packages: mozsystemmonitor 02:37:05 INFO - Running setup.py install for mozsystemmonitor 02:37:05 INFO - Successfully installed mozsystemmonitor 02:37:05 INFO - Cleaning up... 02:37:05 INFO - Return code: 0 02:37:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:37:05 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')]} 02:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:05 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')]} 02:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:05 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:05 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 02:37:05 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 02:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:05 INFO - 'HOME': '/Users/cltbld', 02:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:05 INFO - 'LOGNAME': 'cltbld', 02:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:05 INFO - 'MOZ_NO_REMOTE': '1', 02:37:05 INFO - 'NO_EM_RESTART': '1', 02:37:05 INFO - 'PAGER': '/bin/cat', 02:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:05 INFO - 'PWD': '/builds/slave/test', 02:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:05 INFO - 'SHELL': '/bin/bash', 02:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:05 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:05 INFO - 'USER': 'cltbld', 02:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:05 INFO - 'XPC_FLAGS': '0x0', 02:37:05 INFO - 'XPC_SERVICE_NAME': '0', 02:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:08 INFO - Downloading blobuploader-1.2.4.tar.gz 02:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:37:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:37:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:09 INFO - Downloading docopt-0.6.1.tar.gz 02:37:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:37:09 INFO - Installing collected packages: blobuploader, requests, docopt 02:37:09 INFO - Running setup.py install for blobuploader 02:37:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:37:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:37:09 INFO - Running setup.py install for requests 02:37:10 INFO - Running setup.py install for docopt 02:37:10 INFO - Successfully installed blobuploader requests docopt 02:37:10 INFO - Cleaning up... 02:37:10 INFO - Return code: 0 02:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37: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')]} 02:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:10 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:10 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 02:37:10 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 02:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:10 INFO - 'HOME': '/Users/cltbld', 02:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:10 INFO - 'LOGNAME': 'cltbld', 02:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:10 INFO - 'MOZ_NO_REMOTE': '1', 02:37:10 INFO - 'NO_EM_RESTART': '1', 02:37:10 INFO - 'PAGER': '/bin/cat', 02:37:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:10 INFO - 'PWD': '/builds/slave/test', 02:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:10 INFO - 'SHELL': '/bin/bash', 02:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:10 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:10 INFO - 'USER': 'cltbld', 02:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:10 INFO - 'XPC_FLAGS': '0x0', 02:37:10 INFO - 'XPC_SERVICE_NAME': '0', 02:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:10 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-NpGIgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:10 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-kWiZi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:10 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-NLVx25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:10 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-CC0und-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:10 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-YMRC2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qOqbce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-ebGZoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qufyjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-UBPqay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-FvvlnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-M4R2H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-P_e1We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-_l7Vtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:11 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-j_uDEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:12 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-AV4vhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:12 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-B5AHwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:12 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-TcpICF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:37:12 INFO - Running setup.py install for manifestparser 02:37:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:37:12 INFO - Running setup.py install for mozcrash 02:37:12 INFO - Running setup.py install for mozdebug 02:37:12 INFO - Running setup.py install for mozdevice 02:37:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:37:12 INFO - Running setup.py install for mozfile 02:37:13 INFO - Running setup.py install for mozhttpd 02:37:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Running setup.py install for mozinfo 02:37:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Running setup.py install for mozInstall 02:37:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Running setup.py install for mozleak 02:37:13 INFO - Running setup.py install for mozlog 02:37:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Running setup.py install for moznetwork 02:37:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:37:13 INFO - Running setup.py install for mozprocess 02:37:14 INFO - Running setup.py install for mozprofile 02:37:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:37:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:37:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:37:14 INFO - Running setup.py install for mozrunner 02:37:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:37:14 INFO - Running setup.py install for mozscreenshot 02:37:14 INFO - Running setup.py install for moztest 02:37:14 INFO - Running setup.py install for mozversion 02:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:37:14 INFO - Cleaning up... 02:37:14 INFO - Return code: 0 02:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37: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')]} 02:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:14 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:14 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 02:37:14 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 02:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:14 INFO - 'HOME': '/Users/cltbld', 02:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:14 INFO - 'LOGNAME': 'cltbld', 02:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:14 INFO - 'MOZ_NO_REMOTE': '1', 02:37:14 INFO - 'NO_EM_RESTART': '1', 02:37:14 INFO - 'PAGER': '/bin/cat', 02:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:14 INFO - 'PWD': '/builds/slave/test', 02:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:14 INFO - 'SHELL': '/bin/bash', 02:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:14 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:14 INFO - 'USER': 'cltbld', 02:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:14 INFO - 'XPC_FLAGS': '0x0', 02:37:14 INFO - 'XPC_SERVICE_NAME': '0', 02:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-Mpcso9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-hd_oyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-UvzR6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-4O8y9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-4K0bJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-tePjWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-XcchDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-S681fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:15 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)) 02:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:15 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-0Nkhqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-qrwNa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-wFgbO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-2qM9Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-xTtgdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-kpBgz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-SWZupT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-LxbQeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:16 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)) 02:37:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:16 INFO - Running setup.py (path:/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/pip-KVKOeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:16 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)) 02:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:37:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:37:16 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)) 02:37:16 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)) 02:37:16 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)) 02:37:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:37:16 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 02:37:16 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 02:37:16 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 02:37:16 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 02:37:16 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 02:37:16 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 02:37:19 INFO - Downloading blessings-1.6.tar.gz 02:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:37:19 INFO - Installing collected packages: blessings 02:37:19 INFO - Running setup.py install for blessings 02:37:19 INFO - Successfully installed blessings 02:37:19 INFO - Cleaning up... 02:37:19 INFO - Return code: 0 02:37:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:19 INFO - Reading from file tmpfile_stdout 02:37:19 INFO - Current package versions: 02:37:19 INFO - blessings == 1.6 02:37:19 INFO - blobuploader == 1.2.4 02:37:19 INFO - docopt == 0.6.1 02:37:19 INFO - manifestparser == 1.1 02:37:19 INFO - mozInstall == 1.12 02:37:19 INFO - mozcrash == 0.16 02:37:19 INFO - mozdebug == 0.1 02:37:19 INFO - mozdevice == 0.48 02:37:19 INFO - mozfile == 1.2 02:37:19 INFO - mozhttpd == 0.7 02:37:19 INFO - mozinfo == 0.9 02:37:19 INFO - mozleak == 0.1 02:37:19 INFO - mozlog == 3.1 02:37:19 INFO - moznetwork == 0.27 02:37:19 INFO - mozprocess == 0.22 02:37:19 INFO - mozprofile == 0.28 02:37:19 INFO - mozrunner == 6.11 02:37:19 INFO - mozscreenshot == 0.1 02:37:19 INFO - mozsystemmonitor == 0.0 02:37:19 INFO - moztest == 0.7 02:37:19 INFO - mozversion == 1.4 02:37:19 INFO - psutil == 3.1.1 02:37:19 INFO - requests == 1.2.3 02:37:19 INFO - wsgiref == 0.1.2 02:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:19 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')]} 02:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:19 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')]} 02:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:19 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:19 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 02:37:19 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 02:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:19 INFO - 'HOME': '/Users/cltbld', 02:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:19 INFO - 'LOGNAME': 'cltbld', 02:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:19 INFO - 'MOZ_NO_REMOTE': '1', 02:37:19 INFO - 'NO_EM_RESTART': '1', 02:37:19 INFO - 'PAGER': '/bin/cat', 02:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:19 INFO - 'PWD': '/builds/slave/test', 02:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:19 INFO - 'SHELL': '/bin/bash', 02:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:19 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:19 INFO - 'USER': 'cltbld', 02:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:19 INFO - 'XPC_FLAGS': '0x0', 02:37:19 INFO - 'XPC_SERVICE_NAME': '0', 02:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 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)) 02:37:20 INFO - Cleaning up... 02:37:20 INFO - Return code: 0 02:37:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:37:20 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')]} 02:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:20 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')]} 02:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:20 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:20 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 02:37:20 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 02:37:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:20 INFO - 'HOME': '/Users/cltbld', 02:37:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:20 INFO - 'LOGNAME': 'cltbld', 02:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:20 INFO - 'MOZ_NO_REMOTE': '1', 02:37:20 INFO - 'NO_EM_RESTART': '1', 02:37:20 INFO - 'PAGER': '/bin/cat', 02:37:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:20 INFO - 'PWD': '/builds/slave/test', 02:37:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:20 INFO - 'SHELL': '/bin/bash', 02:37:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:20 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:20 INFO - 'USER': 'cltbld', 02:37:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:20 INFO - 'XPC_FLAGS': '0x0', 02:37:20 INFO - 'XPC_SERVICE_NAME': '0', 02:37:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:20 INFO - Downloading/unpacking jsonschema 02:37: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 02:37: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 02:37: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 02:37: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 02:37: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 02:37: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 02:37:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:37:22 INFO - Downloading/unpacking functools32 (from jsonschema) 02:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:22 INFO - Downloading functools32-3.2.3-2.tar.gz 02:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:37:23 INFO - warning: no files found matching '*.txt' 02:37:23 INFO - no previously-included directories found matching 'build' 02:37:23 INFO - no previously-included directories found matching 'dist' 02:37:23 INFO - no previously-included directories found matching '.git*' 02:37:23 INFO - Installing collected packages: jsonschema, functools32 02:37:23 INFO - Running setup.py install for functools32 02:37:23 INFO - warning: no files found matching '*.txt' 02:37:23 INFO - no previously-included directories found matching 'build' 02:37:23 INFO - no previously-included directories found matching 'dist' 02:37:23 INFO - no previously-included directories found matching '.git*' 02:37:23 INFO - Successfully installed jsonschema functools32 02:37:23 INFO - Cleaning up... 02:37:23 INFO - Return code: 0 02:37:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:37:23 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 0x10e2f6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2fd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32848fb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, '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.ZpWuJESFwe/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.YBG96CvNqs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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 02:37:23 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 02:37:23 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 02:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:37:23 INFO - 'HOME': '/Users/cltbld', 02:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:37:23 INFO - 'LOGNAME': 'cltbld', 02:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:23 INFO - 'MOZ_NO_REMOTE': '1', 02:37:23 INFO - 'NO_EM_RESTART': '1', 02:37:23 INFO - 'PAGER': '/bin/cat', 02:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:23 INFO - 'PWD': '/builds/slave/test', 02:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:37:23 INFO - 'SHELL': '/bin/bash', 02:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:37:23 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:37:23 INFO - 'USER': 'cltbld', 02:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:23 INFO - 'XPC_FLAGS': '0x0', 02:37:23 INFO - 'XPC_SERVICE_NAME': '0', 02:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:23 INFO - Downloading/unpacking flake8 02:37:23 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 02:37:23 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 02:37:23 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 02:37:23 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 02:37:23 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 02:37:23 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 02:37:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:37:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:37:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:37:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:37:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:37:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:37:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:37:27 INFO - no previously-included directories found matching 'docs/_build' 02:37:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:37:27 INFO - Running setup.py install for pep8 02:37:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:37:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:37:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:37:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:37:27 INFO - no previously-included directories found matching 'docs/_build' 02:37:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:37:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:37:27 INFO - Cleaning up... 02:37:27 INFO - Return code: 0 02:37:27 INFO - Running post-action listener: _resource_record_post_action 02:37:27 INFO - Running post-action listener: _start_resource_monitoring 02:37:27 INFO - Starting resource monitoring. 02:37:27 INFO - ##### 02:37:27 INFO - ##### Running install step. 02:37:27 INFO - ##### 02:37:27 INFO - Running pre-action listener: _resource_record_pre_action 02:37:27 INFO - Running main action method: install 02:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:27 INFO - Reading from file tmpfile_stdout 02:37:27 INFO - Detecting whether we're running mozinstall >=1.0... 02:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:37:27 INFO - Reading from file tmpfile_stdout 02:37:27 INFO - Output received: 02:37:27 INFO - Usage: mozinstall [options] installer 02:37:27 INFO - Options: 02:37:27 INFO - -h, --help show this help message and exit 02:37:27 INFO - -d DEST, --destination=DEST 02:37:27 INFO - Directory to install application into. [default: 02:37:27 INFO - "/builds/slave/test"] 02:37:27 INFO - --app=APP Application being installed. [default: firefox] 02:37:27 INFO - mkdir: /builds/slave/test/build/application 02:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:38:01 INFO - Reading from file tmpfile_stdout 02:38:01 INFO - Output received: 02:38:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:38:01 INFO - Running post-action listener: _resource_record_post_action 02:38:01 INFO - ##### 02:38:01 INFO - ##### Running run-tests step. 02:38:01 INFO - ##### 02:38:01 INFO - Running pre-action listener: _resource_record_pre_action 02:38:01 INFO - Running main action method: run_tests 02:38:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:38:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:38:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:38:01 INFO - 2016-02-02 02:38:01.394 screenresolution[1664:8645] starting screenresolution argv=screenresolution get 02:38:01 INFO - 2016-02-02 02:38:01.397 screenresolution[1664:8645] Display 0: 1600x1200x32@60 02:38:01 INFO - 2016-02-02 02:38:01.403 screenresolution[1665:8647] starting screenresolution argv=screenresolution list 02:38:01 INFO - Available Modes on Display 0 02:38:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:38:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:38:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:38:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:38:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:38:01 INFO - Intel Iris: 02:38:01 INFO - Chipset Model: Intel Iris 02:38:01 INFO - Type: GPU 02:38:01 INFO - Bus: Built-In 02:38:01 INFO - VRAM (Dynamic, Max): 1536 MB 02:38:01 INFO - Vendor: Intel (0x8086) 02:38:01 INFO - Device ID: 0x0a2e 02:38:01 INFO - Revision ID: 0x0009 02:38:01 INFO - Displays: 02:38:01 INFO - Display: 02:38:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:38:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:38:01 INFO - Display Serial Number: 1600x1200 60 02:38:01 INFO - Main Display: Yes 02:38:01 INFO - Mirror: Off 02:38:01 INFO - Online: Yes 02:38:01 INFO - Rotation: Supported 02:38:01 INFO - Return code: 0 02:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:38:01 INFO - Python 2.7.3 02:38:01 INFO - Return code: 0 02:38:01 INFO - grabbing minidump binary from tooltool 02:38:01 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')]} 02:38:01 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 0x10e19bd30>, '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 0x10dfbedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e191b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:38:01 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 02:38:01 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 02:38:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:38:01 INFO - Return code: 0 02:38:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:38:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:38:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:38:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:38:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:38:02 INFO - Return code: 0 02:38:02 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/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 02:38:02 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/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --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 02:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZpWuJESFwe/Render', 02:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:38:02 INFO - 'HOME': '/Users/cltbld', 02:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:38:02 INFO - 'LOGNAME': 'cltbld', 02:38:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:02 INFO - 'MOZ_NO_REMOTE': '1', 02:38:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:02 INFO - 'NO_EM_RESTART': '1', 02:38:02 INFO - 'PAGER': '/bin/cat', 02:38:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:02 INFO - 'PWD': '/builds/slave/test', 02:38:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:38:02 INFO - 'SHELL': '/bin/bash', 02:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YBG96CvNqs/Listeners', 02:38:02 INFO - 'TMPDIR': '/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/', 02:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:38:02 INFO - 'USER': 'cltbld', 02:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:02 INFO - 'XPC_FLAGS': '0x0', 02:38:02 INFO - 'XPC_SERVICE_NAME': '0', 02:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:38:02 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/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 02:38:03 INFO - mozversion application_buildid: 20160202014818 02:38:03 INFO - mozversion application_changeset: 512496acf11d6ac95478123788572320004816ea 02:38:03 INFO - mozversion application_display_name: Nightly 02:38:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:38:03 INFO - mozversion application_name: Firefox 02:38:03 INFO - mozversion application_remotingname: firefox 02:38:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:38:03 INFO - mozversion application_vendor: Mozilla 02:38:03 INFO - mozversion application_version: 47.0a1 02:38:03 INFO - mozversion platform_buildid: 20160202014818 02:38:03 INFO - mozversion platform_changeset: 512496acf11d6ac95478123788572320004816ea 02:38:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:38:03 INFO - mozversion platform_version: 47.0a1 02:38:03 INFO - using testdate: 1454409483 02:38:03 INFO - actual date: 1454409483 02:38:03 INFO - starting webserver on 'localhost:49282' 02:38:03 INFO - SUITE-START | Running 2 tests 02:38:03 INFO - TEST-START | dromaeo_css 02:38:03 INFO - operating with platform_type : mac_ 02:38:03 INFO - Initialising browser for dromaeo_css test... 02:38:03 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpbxh_WG/profile http://localhost:49282/getInfo.html) 02:38:03 INFO - PROCESS | 1683 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 02:38:05 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 02:38:05 INFO - PROCESS | 1683 | colorDepth:24 02:38:05 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 02:38:05 INFO - PROCESS | 1683 | __metrics 02:38:05 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:38:05 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:38:05 INFO - PROCESS | 1683 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:38:06 INFO - TEST-INFO | 1683: exit 0 02:38:06 INFO - Browser initialized. 02:38:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:06 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmpbxh_WG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:18 INFO - PROCESS | 1687 | RSS: Main: 241131520 02:38:18 INFO - PROCESS | 1687 | 02:39:09 INFO - PROCESS | 1687 | 1454409549205 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] 02:41:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 02:41:21 INFO - PROCESS | 1687 | RSS: Main: 350322688 02:41:21 INFO - PROCESS | 1687 | 02:44:24 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 02:44:24 INFO - PROCESS | 1687 | RSS: Main: 382779392 02:44:24 INFO - PROCESS | 1687 | 02:47:27 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 02:47:27 INFO - PROCESS | 1687 | RSS: Main: 379232256 02:47:27 INFO - PROCESS | 1687 | 02:50:29 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 02:50:30 INFO - PROCESS | 1687 | RSS: Main: 340512768 02:50:30 INFO - PROCESS | 1687 | 02:53:33 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 02:53:34 INFO - PROCESS | 1687 | RSS: Main: 342683648 02:53:34 INFO - PROCESS | 1687 | 02:56:36 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 02:56:37 INFO - PROCESS | 1687 | RSS: Main: 413814784 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | __start_tp_report 02:56:37 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 02:56:37 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 02:56:37 INFO - PROCESS | 1687 | |i|pagename|runs| 02:56:37 INFO - PROCESS | 1687 | |0;dojo.html;3379.222778760885;3416.9829150854243;3459.705924996375;3473.096994781356;3488.1802776347567;5496.258005169301;5566.137248726453;5579.191017302489;5601.439856014396;5610.130429783385;5536.778528858841;5565.970295495336;5571.8607034824045;5600.691961942091;5602.887942241153;5056.165732654108;5069.518395752398;5098.770555325001;5099.235114732783;5144.3826740791155;5237.952409518092;5263.684178949256;5266.473352664722;5267.868303292429;5268.4994925482015;5237.659552129118;5249.685018898859;5251.553617942461;5257.290265814105;5259.579233661317;5248.632595718302;5251.002309561171;5262.421133675292;5263.1578947368425;5278.868028299285;4695.647826412998;4769.42766867978;5094.592432605383;5219.973900130475;5240.816571419982;4651;5534.363548191969;5606.719664016783;5613.663180209201;5638.154276858463;5588.938101760693;5803.53571714266;6126.7549298028025;6127.87744245117;6128.233970753656;6052.515798736091;6056.3338032816355;6057.223166361789;6139.201903752528;6144.832481828483;5693;5710.71446427677;5721.828345149611;5730.255066841367;5776.768929242783;6218.875622487525;6221.191245138103;6227.750889964442;6238.1890354254565;6245.875082498324;5654.858628534237;5769.913451298234;5940.554458415636;5946.524278057745;6089.025755879038;6125.632462052291;6148.600340977911;6156.753729850845;6158.476529495043;6161.507079433724;6056.848578785565;6080.9391906081255;6081.6351018939;6084.209052823193;6089.086637004485;5521.613487055867;5704.80033198836;5913.349531551526;6031.517478601789;6074.119252708332;4841.491643377465;4845.491223421561;4857.781399837016;4864;4875.878103047452;4321.48142222929;4328.11273688893;4328.437303150633;4328.848490302824;4349.238883195429;5545.057340252167;5606.6916319602815;5621.381648018714;5668.404817494104;5677.772889084473;5951.256092988377;5973.880522389528;5991.610545314541;5994.310654274727;5996.5202783777195;5504.834854954358;5512.39363669996;5537.58468114893;5626.943730562723;5724.828255152269;5253.3958594761325;5286.20706893969;5291.1798671206025;5294.41761406245;5350.304460420199;6226.221722284715;6233;6240.7503699851495;6243.469305108935;6243.843903902348;6084.269887613515;6103.51950425029;6129.448349648553;6164.137020816999;6194.9690251550255;6204.224471940827;6242;6245.6252624842655;6255.46828519581;6268.843278918063;6038.909416358671;6070.271567411939;6070.939290607037;6074.453299203093;6075.878482430238;6048.213732214784;6122.602030867979;6127.479164271087;6140.815775526563;6163.260408750979;5786.247787787561;5910.852228694317;5984.371640977634;6004.399560044136;6043.939560604338;5924.555658325729;5966.433188847052;5974.761009559569;5979.5814292999075;5985.191999080069;5701.258836351248;5736.512396446349;5788.884222315614;5831.067029275296;5832.679202643895;4895.828645997373;5923.763049477972;5967.6121052131475;5970.58205925581;5990.371011043778;4801.327814105958;5775.653460792366;5778.16216648592;5792.942070579409;5795.217645617788 02:56:37 INFO - PROCESS | 1687 | |1;ext.html;427.32056030910843;461.27579699871217;495.1063330688108;550.7081246939118;562.493755619942;29169;29624.111276661708;36989.44515832261;37749.433758493644;37809.62190378096;32151.67848321516;40261.59738402615;40410.59589404105;40519;40584.59415405845;9396.201322887562;9609.231261499064;9611.90388096117;9620.855687164698;9624.181944534723;9472.242220622367;9568.712938611818;9609.327347085708;9617.086376794194;9617.90382096177;9547.570359333846;9636.469994150319;9793.657221997231;9806.411615303068;9809;9668.613255469772;9770.853437198377;9781.755456113582;9787.314887957846;9808.46053467059;9565.952170239174;9690.75773105671;9701.951490242574;9712.174465170468;9731.318807683465;39108.82673519799;39502.802485987675;39518.80240598807;39546.80226598877;39567;3193.7445004399824;3230.7576931729977;3429.228423604669;3457.4640930655787;3765.717571182145;25815.35461613456;26004.479910401875;26778.464430711276;26778.5983210252;27147.1855844323;2117.6400011998;2523.205190365029;2543.860087695176;2548.503041906829;2572.1254773376954;471588;476382;476491;476715;476731;55724.44275557274;56903;56909;63379;67239.66380168068;62295.37704622986;62654.686726566986;63127;63135.474581017166;63179.36820631827;15807.786909832632;16000.03999760018;16000.919995399949;16027.519174424786;16030.358785648677;11170.664880053611;11361.977422031892;11364.602238921598;12299.954503867271;12550.435230414654;20210.39368818938;20456.977151142382;20501.897490512452;20513.794862051487;20552.58894822125;7348.889766653505;8670.86993695095;8810.647574097093;8814.735557933273;8898.154675305836;915.624593916491;1084.2789544952518;1103.564092183599;1133.9319640821577;1134.869490008643;27388.863055684593;27553.311167220578;28917.277068073465;28917.855410723234;29345.266368340534;1086.8043752124536;1100.763335882789;1115.1524841120645;1186.400867561893;1188.7028242939266;14203.502877399447;14717.484888028868;14807.555773326818;14904.329305181293;15157;542646.2867685637;547582;548467.0613175428;548591;548813;56369.7181514098;56991.14513282304;57125.42874571201;57150.42849571534;57318;1425.6150839273546;1436.1383170097859;1452.0924422236103;1452.2230606625405;1468.2291796806549;28990.7100928988;29527;30168.94408695685;30291.783275216905;30558;54571.45428545664;55167.448325517835;55236;55373.446265536826;55417.44582554123;496586;500470;500714;506035;506201.9379806155;34662.480062798575;42315.57684423116;42559.680039995;43707.34438983354;43886;40806.387904182055;40895.795521022206;40924.386134207416;41397;41978.580214197464;33782;34904.65095349115;35009.82495087508;35293;35330.64669353273;27688.723112768614;29725.405491889607;36649.81675091608;37158.8142059288;37618;33092.00723978285;34123.82938085393;34541.30917381689;34629.82685086558;34917.650823492455;30500.237494062825;30816.691833082277;31340;31345.902893399532;31488.370232595676;20063.899680501505;20939.790602093784;22220.333389998326;24741.752582473946;24944.126955557193 02:56:37 INFO - PROCESS | 1687 | |2;jquery.html;327.2554937517148;363.17559140750495;369.09571549703236;371.6692143991848;374.0331243734945;14398.856011439882;14717.558473245794;18273.81726182738;18587.628247435045;18965.810341896595;10842.241043126965;11305.604303849346;14503.782443263359;17884.821151788477;17911.73132403015;4955.554000139987;5134.0758663440565;5141.228815677641;5141.511556402136;5151.587872970172;3787.280416720814;3959.871436640558;3979.6617287530594;5326.3075800145925;5593.860153496154;5661.150827375906;5883.88232235355;5897.292324921015;5901.232839730829;5904.793332233373;5541.445855414467;5674.659520428788;5678.829635110953;5699.914501282464;5795.768169273224;5390.5418039466695;5452.863678408032;5472.699001554913;5495.175723641446;5675.148727690838;12640.49438022478;12797.360131993362;12811.487540498369;19914.80085199144;23599.29202123939;2095.19335056003;2128.1806504495726;2144.2495126705685;2709.91870243893;2744.5745909384077;9037.017784131287;9615.326927115104;9672.468014259213;9813.754656133653;10263.178945684327;1744.5258756350863;1784.8929064256056;1827.2964908510187;1841.1990784009;1866.9066546672748;96123;98518;98607;99289;99924.50037749838;10853.24027318096;11003;11017.283876548;11017.338959662446;11162.274452160584;13119.672008199872;13225.537106201236;13257.403416846266;13258.602241932758;13273.336333183495;8299.585020748938;8342.66629334832;8353.33173346131;8394.874076888851;8395.664173433117;8370.790730231793;8393.95803020981;8395.790105247417;8445.324374050062;8495;3491.4762785581856;4333.523312435629;4335.393044973706;4379.605835474823;4389.4513185851765;1710.0680129329546;1771.2206629083162;1775.334249656379;1775.7070083436347;1776.8933863968202;812.5490352854223;893.115815342806;931.0828833598899;945.1824172091092;1008.4050410257836;18624;18974;19161.90419047896;19793.10931008108;19816.009199539967;902.6299217320998;939.9812003759887;948.2271948362063;973.7127547373542;1039.5218199628105;9015.459072455673;10766.73083172927;10808.351498910091;10858.837117443245;10864.239503234698;630576;755952;760215;777263;779652;96292.51853740687;106732;107697;107877;108650;1162.651204638622;1163.4938801621322;1180.557291015869;1199.1186477938709;1199.1545960098285;14717.632059198606;16111.436099736453;17757.64484710273;17856.732149018037;18182.636347273245;46404;46571;46706.76646616745;47470.762646187926;48637.75681121572;64793.67603162143;66076;66425;67905.85129784458;69690.65154674194;7229.63851807397;7543;7630.694772209272;7657.846843063219;7720.459567830198;9442;11801.35092569917;11868.347240901488;12061.336626485276;12140.635780926586;9187.265018798615;10313.793724125626;10360.430176340373;10397.896021039693;10499.265051446326;8009.799755006172;9193.77015574616;10266.589336426758;10276.691699249035;10344.534495947852;10292.742681432725;10403;10470.738231543968;10479.94760026195;10588.311759735592;7534.39724822002;7557.244275572399;7601.429892758176;7617.542947423172;7631.542107473348;9688.608709851438;10470.319429237075;10558.841617375592;10611.469426528796;10686.625968091079 02:56:37 INFO - PROCESS | 1687 | |3;mootools.html;1219.311089234582;1533.1107957384716;1561.7735428362885;1793.2826869252297;1935.9516012099705;7907.960460197698;8105.351571874243;8627.95686021569;8730.65077396905;8753.737387878375;8529.914700852989;8612.526311052905;8680.045195028557;8687.305015598753;8699.608517616707;2178.684090806832;2223.966640500386;2415.10641062807;2436.378723425524;2441.279822452381;2234.4078819112947;2238.4963383238805;2243.9439014024697;2245.0907382510027;2382.618780995041;2436.5735996200683;2441.060191826151;2443.1082654831034;2447.363685441789;2452.043702955849;2378.95242095158;2444.938876528074;2447.4248551590363;2452.7792498675117;2466.025919761702;2391.7369089400327;2438.707355117397;2449.9510009799706;2455.594826853567;2458.5820410530073;8593.742187734315;8767.649294028231;8790.252828509585;8804.207621314112;8808.207261346446;5245.632805703603;5344.839654810362;5349.732513374316;5386.461353864622;5391.946080539184;3629.27414517095;3632.3098611263777;3638.5088013118157;3724.1062145085257;3744.5319335083113;863.9697610583662;1059.9523021463976;1071.1056268016139;1071.2554774431774;1077.5959015369237;11931.164818462712;11938.761224775542;11942.164048516608;11966.982806461461;11974;4769.189237829508;4823.469418363977;4884.145274576935;4894.706317620954;4909.828156014522;10102.393856368495;10149.492525373702;10152.187824973984;10168.796624067478;10189.286749927582;5407.945920540823;5432.185172224198;5435.374931882884;5438.265834112423;5463.644863083887;4889.095517329305;4946.851594452172;4954.801807927714;4955.801767929314;4958.231474121517;3283.83580820958;3937.645611894943;3948.861789837342;3959.2873282808796;3991.880243592697;1201.1291813435364;1236.252067499168;1238.4612693478366;1275.113795911851;1298.2275546050084;1100.6863044032573;1278.8849003589721;1327.8074679171466;1341.3092257487401;1341.724946386008;7770.300672939463;7826.804329891798;7873;7874.330681892104;7877.960610197027;1170.4615876696644;1171.689502281896;1172.8123500240092;1174.74155685749;1194.146185477388;6009.639421634716;6120.60216085953;6123.632582045091;6124.693765311717;6126.356732543019;10023.498825058718;10644.042036216777;10662.733431664115;10773.138148948065;10786.460676966277;10212.642557510451;10517.211209159344;10624.096951759033;10624.681259562225;10651.520681569347;8153.8776918346275;8289.8342033159;8311.875321870177;8314.210150035617;8323.583820809057;7642.273983971736;7719.536827790126;7764.883526747216;7780.688772449039;7930.643121059682;9385.296102792181;9390;9418.764530886783;9479.810403791747;9599.280053996117;9415.058494150804;9814.969428210221;9827.459489728133;9904.851427228454;9915.603375865174;6306.873862522815;7366.926330736624;7370.557766534025;7473.962630186814;7487.812804679927;7814.413918956215;8022.879656805269;8026.077001144943;8030.598470076589;8033.437659363788;7483.363914067365;7628.656710448154;7635.083789945242;7762.184970578234;7776.300132988058;7421.443391745533;7476.102867655699;7485.251474852471;7564.4704870658525;7568.243175682388;6831.385175334244;7350.970864078926;7610.200928902607;7670.884936725842;7689.92310076892;6877.759278425231;6928.861422771617;6943.583384996917;6943.618101004291;6956.060931774348;6808.795736127726;6981.406580440516;6995.650217489207;7005.719771209298;7007.229204787367 02:56:37 INFO - PROCESS | 1687 | |4;prototype.html;327.7427219632588;331;335.874047232288;340.0953463786329;340.2293804532732;5565.526930210932;6624.867502649944;6636.53544251902;6660.66696665166;6670.6331151786635;6255.718492667829;6282.560220784547;6471.1263979362775;6477.157969463963;6536;4773.973595676929;4794.2329227323635;4820.542048505386;4830.6135509159185;4856.684315519488;4800.007996681373;4876.195427754434;4879.463259041502;4881.4630390657;4896.46138924718;3744.2511497700434;3866.76799392036;4611.6310695144475;4753.47711751707;4759.095771803363;4759.738214398207;4794.520547945178;4802.51974802517;4803.207470767319;4822.590079843235;4137.275976704064;4147.3778933159965;4149.128682976579;4154.335306350999;4156.584341565849;5321.2284218788445;6092.573519853612;6101.603395779304;6265.27216306297;6265.404786545271;5732.455416735445;5753.453421924911;5756.338021127582;5765.913511297334;5774.105013722879;6982.1272340957385;6991.615461149635;7001.074704456264;7004.92995070053;7007.194172670157;4656.41794775653;4657.091867085919;4657.88355291117;4670.206064968929;4675.579197872208;7164;7429.85140297191;7436.888446673304;7454.515456495311;7474.962625186894;4761.666683332133;4767.332573439721;4767.904641907143;4769.379980602569;4777;4833.250846118857;4848.200046992207;4850.75746212688;4859.635527335464;4860.222364421676;4690.179218636725;5345.545628621533;5735.311762588516;5737.282839645044;5748.827535173951;6081.391860813883;6759.357861003196;6961.617111058839;7027.367536921702;7050.330218629222;1623.9675206495804;1636.9263383147786;1644.925978330978;1647.3822316631263;1647.538689167035;1049.1030169205371;1055.3773273768513;1067.1356201476829;1071.4963966935527;1083.6803143072812;6552.213734351908;6582.736690532325;6615.791341199514;6617.974213996742;6619.437347825393;7277.19950805411;7278.599677017709;7291.708331666674;7304.123505179413;7305.671244793997;5365.409804921455;6388.1155059257635;6394.648294343763;6587.703553340111;6615.933840661628;3843.7501562398356;3889.280483110577;3900.921981560353;3903.4144878268485;3905.882823515299;6260;7735.845283094307;7743.380529557622;7761.72833950809;7769.456138070281;7381.66782494789;7494.887576686354;7603.809904752426;7609.048868891388;7614.695412183451;7739.071311442663;7744.3417309528195;7746.38028957682;7756.185600511865;7759.2240775921955;7358.889616655647;7362.889556656762;7366.521176123535;7370.226126256666;7373.483856130019;6930.410915072275;7144.535605185646;7195.388391986739;7247.347738703542;7248.0939882514685;6317.652529110943;7717.922820771721;7721.227877212234;7721.343685786771;7738.806529836799;3875.844966201433;4646.442426908792;4694.108119457293;4700.412448443944;4704.435467743892;7068.3285087916565;7279.272072792678;7309.5248808827255;7319.817004574716;7355.77932662021;7027.6837542309695;7073.221945586084;7085.645717713991;7088.255733147946;7093.184283807428;5789.623674461147;6757.662116894037;7094.148702155774;7094.787156385317;7117.928820711727;6803.455723542006;6808.62552559614;6818.454523638196;6828.351306625863;6831.795046148623;6742.393184613408;6846.246912839484;6859.382655561023;6899.655017249218;6944.965275173794;6700.296468870698;6782.321767823179;6814.352636499525;6891.138607674041;6912.758053468105 02:56:37 INFO - PROCESS | 1687 | |5;yui.html;660.5376236634356;676.1851968378102;690.9758158464455;707.2008630247819;726.4333819620696;13945.233012184326;14090.788638170436;14098.506552270646;14115.999999999987;14136.575902722909;12584.622461326175;14180.00739948204;14571.344289506971;14582.343794529244;14601;685.4790359326922;699.164498424383;856.6616186606287;874.0909454167657;875.6234819027816;686.7836631461099;691.0360047733434;691.7855464805926;692.8856738638119;836.1972506393869;757.685560492395;914.8627705844143;920.7283851263893;921.0559176843756;922.0594993107027;913.7350168451142;916.6883259691704;916.9174774270281;918.1140199707314;920.6823645842173;539.156220514893;541.4991133201772;542.9864253393657;544.4038777538589;545.0271265790545;13882.791758123636;14085.788713169311;14099.929500352433;14109.78835317471;14113.223772692498;11870.703232419171;11876;12080.758384832254;12242.81635775464;12399.876001239962;9933.751656208653;9998;10009.349392289478;10011;10029.247806414549;3428.434308339121;3474.4267195912644;3474.878379256739;3508.7894726316504;3514.1741690702665;81257.59371203106;82241.9999999994;82537.76193357045;82897.75653365205;82948;8655.78360540979;8658.090900455487;8816.559172041372;8851.513166775889;8954.86567701485;19742.40772776819;19993.900030499753;20199.596008079756;20478.488037798877;20505.2823151189;7290.781276561605;7296.890546641805;7311.159216690149;7405.296496832792;7675.808104797425;4012.057166565855;4087.182563487255;4098.200850834119;4098.6516146127915;4112.115895082572;3438.9312213755584;3493.5807703075284;3503.0016445312963;3503.737219708532;3505.158761897126;617.2253821454136;627.1470799712388;630.334996578614;650.7592190889401;651.1632552170438;586.9559783016291;595.9202383680922;612.574260888687;626.2610120058284;626.3548544998658;6573.605583664899;8344.374171937008;8488.830223395498;8658.437201581877;8709.477431354138;524.8871492629103;532.3186321508475;581.1979468333673;611.7277811373896;625.2309659119309;3989.9800500997308;4263.296556068214;4341.674374421931;4411.18393097278;4427.579379958899;85971;91683.16633667289;91828;91839.54080229557;91906.08093918975;70978;71363;71602.28397716061;71605;72421.27578724145;63914.6804265985;64449.355506445274;65412.67293663501;65982;68308.63382732417;8481.87277190855;8694.869576956224;8698.434601750865;8710;8960.820783584422;41905;44529.777351113036;46705.76647116743;48528.75735621299;49426;63282.68358658177;65389;68831.65584172047;69008.3099169002;70373.85139931981;10594.31136976094;10683.679489615013;10805;10826.67519974402;11111.38887361203;11796.351200684045;11815.232009919328;12089.57686480969;12354.75290494203;12547.372631368578;10119.342242754197;10461.633842815465;10642.467876605984;10688.038076573146;10859.782804344028;11095.445227738743;11178.105751539695;11319.434028298718;11510.82733759011;12195.573154939535;10911.399873007062;10949.233553651167;10966.396848173426;11310.717232069264;11319.660410187707;8967.865482017645;8977.730668079968;9075.863862041942;9501.88986220366;9705.223582113273;7912.723054693058;8731.869021964549;9010.414323068979;9660.275479338938;9671.951640241754 02:56:37 INFO - PROCESS | 1687 | __end_tp_report 02:56:37 INFO - PROCESS | 1687 | __start_cc_report 02:56:37 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,963 02:56:37 INFO - PROCESS | 1687 | __end_cc_report 02:56:37 INFO - PROCESS | 1687 | __startTimestamp1454410597060__endTimestamp 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | ------- Summary: start ------- 02:56:37 INFO - PROCESS | 1687 | Number of tests: 6 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | [#0] dojo.html Cycles:165 Average:5616.06 Median:5769.91 stddev:606.96 (10.5%) stddev-sans-first:582.91 02:56:37 INFO - PROCESS | 1687 | Values: 3379.2 3417.0 3459.7 3473.1 3488.2 5496.3 5566.1 5579.2 5601.4 5610.1 5536.8 5566.0 5571.9 5600.7 5602.9 5056.2 5069.5 5098.8 5099.2 5144.4 5238.0 5263.7 5266.5 5267.9 5268.5 5237.7 5249.7 5251.6 5257.3 5259.6 5248.6 5251.0 5262.4 5263.2 5278.9 4695.6 4769.4 5094.6 5220.0 5240.8 4651.0 5534.4 5606.7 5613.7 5638.2 5588.9 5803.5 6126.8 6127.9 6128.2 6052.5 6056.3 6057.2 6139.2 6144.8 5693.0 5710.7 5721.8 5730.3 5776.8 6218.9 6221.2 6227.8 6238.2 6245.9 5654.9 5769.9 5940.6 5946.5 6089.0 6125.6 6148.6 6156.8 6158.5 6161.5 6056.8 6080.9 6081.6 6084.2 6089.1 5521.6 5704.8 5913.3 6031.5 6074.1 4841.5 4845.5 4857.8 4864.0 4875.9 4321.5 4328.1 4328.4 4328.8 4349.2 5545.1 5606.7 5621.4 5668.4 5677.8 5951.3 5973.9 5991.6 5994.3 5996.5 5504.8 5512.4 5537.6 5626.9 5724.8 5253.4 5286.2 5291.2 5294.4 5350.3 6226.2 6233.0 6240.8 6243.5 6243.8 6084.3 6103.5 6129.4 6164.1 6195.0 6204.2 6242.0 6245.6 6255.5 6268.8 6038.9 6070.3 6070.9 6074.5 6075.9 6048.2 6122.6 6127.5 6140.8 6163.3 5786.2 5910.9 5984.4 6004.4 6043.9 5924.6 5966.4 5974.8 5979.6 5985.2 5701.3 5736.5 5788.9 5831.1 5832.7 4895.8 5923.8 5967.6 5970.6 5990.4 4801.3 5775.7 5778.2 5792.9 5795.2 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | [#1] ext.html Cycles:180 Average:64616.02 Median:38459.22 stddev:135565.16 (352.5%) stddev-sans-first:135859.79 02:56:37 INFO - PROCESS | 1687 | Values: 427.3 461.3 495.1 550.7 562.5 29169.0 29624.1 36989.4 37749.4 37809.6 32151.7 40261.6 40410.6 40519.0 40584.6 9396.2 9609.2 9611.9 9620.9 9624.2 9472.2 9568.7 9609.3 9617.1 9617.9 9547.6 9636.5 9793.7 9806.4 9809.0 9668.6 9770.9 9781.8 9787.3 9808.5 9566.0 9690.8 9702.0 9712.2 9731.3 39108.8 39502.8 39518.8 39546.8 39567.0 3193.7 3230.8 3429.2 3457.5 3765.7 25815.4 26004.5 26778.5 26778.6 27147.2 2117.6 2523.2 2543.9 2548.5 2572.1 471588.0 476382.0 476491.0 476715.0 476731.0 55724.4 56903.0 56909.0 63379.0 67239.7 62295.4 62654.7 63127.0 63135.5 63179.4 15807.8 16000.0 16000.9 16027.5 16030.4 11170.7 11362.0 11364.6 12300.0 12550.4 20210.4 20457.0 20501.9 20513.8 20552.6 7348.9 8670.9 8810.6 8814.7 8898.2 915.6 1084.3 1103.6 1133.9 1134.9 27388.9 27553.3 28917.3 28917.9 29345.3 1086.8 1100.8 1115.2 1186.4 1188.7 14203.5 14717.5 14807.6 14904.3 15157.0 542646.3 547582.0 548467.1 548591.0 548813.0 56369.7 56991.1 57125.4 57150.4 57318.0 1425.6 1436.1 1452.1 1452.2 1468.2 28990.7 29527.0 30168.9 30291.8 30558.0 54571.5 55167.4 55236.0 55373.4 55417.4 496586.0 500470.0 500714.0 506035.0 506201.9 34662.5 42315.6 42559.7 43707.3 43886.0 40806.4 40895.8 40924.4 41397.0 41978.6 33782.0 34904.7 35009.8 35293.0 35330.6 27688.7 29725.4 36649.8 37158.8 37618.0 33092.0 34123.8 34541.3 34629.8 34917.7 30500.2 30816.7 31340.0 31345.9 31488.4 20063.9 20939.8 22220.3 24741.8 24944.1 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | [#2] jquery.html Cycles:180 Average:36428.64 Median:372.85 stddev:122191.86 (32772.3%) stddev-sans-first:122504.57 02:56:37 INFO - PROCESS | 1687 | Values: 327.3 363.2 369.1 371.7 374.0 14398.9 14717.6 18273.8 18587.6 18965.8 10842.2 11305.6 14503.8 17884.8 17911.7 4955.6 5134.1 5141.2 5141.5 5151.6 3787.3 3959.9 3979.7 5326.3 5593.9 5661.2 5883.9 5897.3 5901.2 5904.8 5541.4 5674.7 5678.8 5699.9 5795.8 5390.5 5452.9 5472.7 5495.2 5675.1 12640.5 12797.4 12811.5 19914.8 23599.3 2095.2 2128.2 2144.2 2709.9 2744.6 9037.0 9615.3 9672.5 9813.8 10263.2 1744.5 1784.9 1827.3 1841.2 1866.9 96123.0 98518.0 98607.0 99289.0 99924.5 10853.2 11003.0 11017.3 11017.3 11162.3 13119.7 13225.5 13257.4 13258.6 13273.3 8299.6 8342.7 8353.3 8394.9 8395.7 8370.8 8394.0 8395.8 8445.3 8495.0 3491.5 4333.5 4335.4 4379.6 4389.5 1710.1 1771.2 1775.3 1775.7 1776.9 812.5 893.1 931.1 945.2 1008.4 18624.0 18974.0 19161.9 19793.1 19816.0 902.6 940.0 948.2 973.7 1039.5 9015.5 10766.7 10808.4 10858.8 10864.2 630576.0 755952.0 760215.0 777263.0 779652.0 96292.5 106732.0 107697.0 107877.0 108650.0 1162.7 1163.5 1180.6 1199.1 1199.2 14717.6 16111.4 17757.6 17856.7 18182.6 46404.0 46571.0 46706.8 47470.8 48637.8 64793.7 66076.0 66425.0 67905.9 69690.7 7229.6 7543.0 7630.7 7657.8 7720.5 9442.0 11801.4 11868.3 12061.3 12140.6 9187.3 10313.8 10360.4 10397.9 10499.3 8009.8 9193.8 10266.6 10276.7 10344.5 10292.7 10403.0 10470.7 10479.9 10588.3 7534.4 7557.2 7601.4 7617.5 7631.5 9688.6 10470.3 10558.8 10611.5 10686.6 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | [#3] mootools.html Cycles:180 Average:6007.27 Median:5347.29 stddev:3163.45 (59.2%) stddev-sans-first:3151.85 02:56:37 INFO - PROCESS | 1687 | Values: 1219.3 1533.1 1561.8 1793.3 1936.0 7908.0 8105.4 8628.0 8730.7 8753.7 8529.9 8612.5 8680.0 8687.3 8699.6 2178.7 2224.0 2415.1 2436.4 2441.3 2234.4 2238.5 2243.9 2245.1 2382.6 2436.6 2441.1 2443.1 2447.4 2452.0 2379.0 2444.9 2447.4 2452.8 2466.0 2391.7 2438.7 2450.0 2455.6 2458.6 8593.7 8767.6 8790.3 8804.2 8808.2 5245.6 5344.8 5349.7 5386.5 5391.9 3629.3 3632.3 3638.5 3724.1 3744.5 864.0 1060.0 1071.1 1071.3 1077.6 11931.2 11938.8 11942.2 11967.0 11974.0 4769.2 4823.5 4884.1 4894.7 4909.8 10102.4 10149.5 10152.2 10168.8 10189.3 5407.9 5432.2 5435.4 5438.3 5463.6 4889.1 4946.9 4954.8 4955.8 4958.2 3283.8 3937.6 3948.9 3959.3 3991.9 1201.1 1236.3 1238.5 1275.1 1298.2 1100.7 1278.9 1327.8 1341.3 1341.7 7770.3 7826.8 7873.0 7874.3 7878.0 1170.5 1171.7 1172.8 1174.7 1194.1 6009.6 6120.6 6123.6 6124.7 6126.4 10023.5 10644.0 10662.7 10773.1 10786.5 10212.6 10517.2 10624.1 10624.7 10651.5 8153.9 8289.8 8311.9 8314.2 8323.6 7642.3 7719.5 7764.9 7780.7 7930.6 9385.3 9390.0 9418.8 9479.8 9599.3 9415.1 9815.0 9827.5 9904.9 9915.6 6306.9 7366.9 7370.6 7474.0 7487.8 7814.4 8022.9 8026.1 8030.6 8033.4 7483.4 7628.7 7635.1 7762.2 7776.3 7421.4 7476.1 7485.3 7564.5 7568.2 6831.4 7351.0 7610.2 7670.9 7689.9 6877.8 6928.9 6943.6 6943.6 6956.1 6808.8 6981.4 6995.7 7005.7 7007.2 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | [#4] prototype.html Cycles:180 Average:5733.42 Median:6474.14 stddev:1839.86 (28.4%) stddev-sans-first:1799.73 02:56:37 INFO - PROCESS | 1687 | Values: 327.7 331.0 335.9 340.1 340.2 5565.5 6624.9 6636.5 6660.7 6670.6 6255.7 6282.6 6471.1 6477.2 6536.0 4774.0 4794.2 4820.5 4830.6 4856.7 4800.0 4876.2 4879.5 4881.5 4896.5 3744.3 3866.8 4611.6 4753.5 4759.1 4759.7 4794.5 4802.5 4803.2 4822.6 4137.3 4147.4 4149.1 4154.3 4156.6 5321.2 6092.6 6101.6 6265.3 6265.4 5732.5 5753.5 5756.3 5765.9 5774.1 6982.1 6991.6 7001.1 7004.9 7007.2 4656.4 4657.1 4657.9 4670.2 4675.6 7164.0 7429.9 7436.9 7454.5 7475.0 4761.7 4767.3 4767.9 4769.4 4777.0 4833.3 4848.2 4850.8 4859.6 4860.2 4690.2 5345.5 5735.3 5737.3 5748.8 6081.4 6759.4 6961.6 7027.4 7050.3 1624.0 1636.9 1644.9 1647.4 1647.5 1049.1 1055.4 1067.1 1071.5 1083.7 6552.2 6582.7 6615.8 6618.0 6619.4 7277.2 7278.6 7291.7 7304.1 7305.7 5365.4 6388.1 6394.6 6587.7 6615.9 3843.8 3889.3 3900.9 3903.4 3905.9 6260.0 7735.8 7743.4 7761.7 7769.5 7381.7 7494.9 7603.8 7609.0 7614.7 7739.1 7744.3 7746.4 7756.2 7759.2 7358.9 7362.9 7366.5 7370.2 7373.5 6930.4 7144.5 7195.4 7247.3 7248.1 6317.7 7717.9 7721.2 7721.3 7738.8 3875.8 4646.4 4694.1 4700.4 4704.4 7068.3 7279.3 7309.5 7319.8 7355.8 7027.7 7073.2 7085.6 7088.3 7093.2 5789.6 6757.7 7094.1 7094.8 7117.9 6803.5 6808.6 6818.5 6828.4 6831.8 6742.4 6846.2 6859.4 6899.7 6945.0 6700.3 6782.3 6814.4 6891.1 6912.8 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - PROCESS | 1687 | [#5] yui.html Cycles:180 Average:17704.87 Median:621.23 stddev:24920.04 (4011.4%) stddev-sans-first:24957.08 02:56:37 INFO - PROCESS | 1687 | Values: 660.5 676.2 691.0 707.2 726.4 13945.2 14090.8 14098.5 14116.0 14136.6 12584.6 14180.0 14571.3 14582.3 14601.0 685.5 699.2 856.7 874.1 875.6 686.8 691.0 691.8 692.9 836.2 757.7 914.9 920.7 921.1 922.1 913.7 916.7 916.9 918.1 920.7 539.2 541.5 543.0 544.4 545.0 13882.8 14085.8 14099.9 14109.8 14113.2 11870.7 11876.0 12080.8 12242.8 12399.9 9933.8 9998.0 10009.3 10011.0 10029.2 3428.4 3474.4 3474.9 3508.8 3514.2 81257.6 82242.0 82537.8 82897.8 82948.0 8655.8 8658.1 8816.6 8851.5 8954.9 19742.4 19993.9 20199.6 20478.5 20505.3 7290.8 7296.9 7311.2 7405.3 7675.8 4012.1 4087.2 4098.2 4098.7 4112.1 3438.9 3493.6 3503.0 3503.7 3505.2 617.2 627.1 630.3 650.8 651.2 587.0 595.9 612.6 626.3 626.4 6573.6 8344.4 8488.8 8658.4 8709.5 524.9 532.3 581.2 611.7 625.2 3990.0 4263.3 4341.7 4411.2 4427.6 85971.0 91683.2 91828.0 91839.5 91906.1 70978.0 71363.0 71602.3 71605.0 72421.3 63914.7 64449.4 65412.7 65982.0 68308.6 8481.9 8694.9 8698.4 8710.0 8960.8 41905.0 44529.8 46705.8 48528.8 49426.0 63282.7 65389.0 68831.7 69008.3 70373.9 10594.3 10683.7 10805.0 10826.7 11111.4 11796.4 11815.2 12089.6 12354.8 12547.4 10119.3 10461.6 10642.5 10688.0 10859.8 11095.4 11178.1 11319.4 11510.8 12195.6 10911.4 10949.2 10966.4 11310.7 11319.7 8967.9 8977.7 9075.9 9501.9 9705.2 7912.7 8731.9 9010.4 9660.3 9672.0 02:56:37 INFO - PROCESS | 1687 | -------- Summary: end -------- 02:56:37 INFO - PROCESS | 1687 | 02:56:37 INFO - TEST-INFO | 1687: exit 0 02:56:37 INFO - TEST-OK | dromaeo_css | took 1114390ms 02:56:37 INFO - TEST-START | kraken 02:56:37 INFO - operating with platform_type : mac_ 02:56:37 INFO - Initialising browser for kraken test... 02:56:37 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmp2lzRg1/profile http://localhost:49282/getInfo.html) 02:56:37 INFO - PROCESS | 1693 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 02:56:39 INFO - PROCESS | 1693 | __metrics Screen width/height:1600/1200 02:56:39 INFO - PROCESS | 1693 | colorDepth:24 02:56:39 INFO - PROCESS | 1693 | Browser inner width/height: 1024/689 02:56:39 INFO - PROCESS | 1693 | __metrics 02:56:39 INFO - PROCESS | 1693 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:56:40 INFO - PROCESS | 1693 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:56:40 INFO - PROCESS | 1693 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:56:40 INFO - TEST-INFO | 1693: exit 0 02:56:40 INFO - Browser initialized. 02:56:40 INFO - Running cycle 1/1 for kraken test... 02:56:40 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rg/gwlnpvp52557f_83wf586mv000000w/T/tmp2lzRg1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:56:52 INFO - PROCESS | 1695 | RSS: Main: 242950144 02:56:52 INFO - PROCESS | 1695 | 02:56:55 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 02:56:55 INFO - PROCESS | 1695 | RSS: Main: 288935936 02:56:55 INFO - PROCESS | 1695 | 02:56:58 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 02:56:58 INFO - PROCESS | 1695 | RSS: Main: 299331584 02:56:58 INFO - PROCESS | 1695 | 02:57:02 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 02:57:02 INFO - PROCESS | 1695 | RSS: Main: 286830592 02:57:02 INFO - PROCESS | 1695 | 02:57:04 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 02:57:05 INFO - PROCESS | 1695 | RSS: Main: 290308096 02:57:05 INFO - PROCESS | 1695 | 02:57:07 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:07 INFO - PROCESS | 1695 | RSS: Main: 289959936 02:57:07 INFO - PROCESS | 1695 | 02:57:10 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:11 INFO - PROCESS | 1695 | RSS: Main: 290856960 02:57:11 INFO - PROCESS | 1695 | 02:57:14 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 02:57:14 INFO - PROCESS | 1695 | RSS: Main: 290353152 02:57:14 INFO - PROCESS | 1695 | 02:57:17 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 02:57:17 INFO - PROCESS | 1695 | RSS: Main: 291295232 02:57:17 INFO - PROCESS | 1695 | 02:57:19 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:57:20 INFO - PROCESS | 1695 | RSS: Main: 323993600 02:57:20 INFO - PROCESS | 1695 | 02:57:21 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:57:22 INFO - PROCESS | 1695 | RSS: Main: 324030464 02:57:22 INFO - PROCESS | 1695 | 02:57:24 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:57:25 INFO - PROCESS | 1695 | RSS: Main: 331751424 02:57:25 INFO - PROCESS | 1695 | 02:57:27 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:57:28 INFO - PROCESS | 1695 | RSS: Main: 333524992 02:57:28 INFO - PROCESS | 1695 | 02:57:30 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:57:31 INFO - PROCESS | 1695 | RSS: Main: 332984320 02:57:31 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 02:57:33 INFO - PROCESS | 1695 | RSS: Main: 393916416 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | __start_tp_report 02:57:33 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 02:57:33 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 02:57:33 INFO - PROCESS | 1695 | |i|pagename|runs| 02:57:33 INFO - PROCESS | 1695 | |0;ai-astar;111;108;110;111;111;111;115;110;111;111 02:57:33 INFO - PROCESS | 1695 | |1;audio-beat-detection;157;118;144;154;118;142;118;153;145;121 02:57:33 INFO - PROCESS | 1695 | |2;audio-dft;190;186;186;186;188;184;187;185;183;181 02:57:33 INFO - PROCESS | 1695 | |3;audio-fft;75;76;90;78;58;59;58;80;78;56 02:57:33 INFO - PROCESS | 1695 | |4;audio-oscillator;93;92;122;78;78;80;110;78;101;111 02:57:33 INFO - PROCESS | 1695 | |5;imaging-gaussian-blur;85;90;84;90;84;99;130;90;84;91 02:57:33 INFO - PROCESS | 1695 | |6;imaging-darkroom;93;93;94;93;93;93;96;93;93;94 02:57:33 INFO - PROCESS | 1695 | |7;imaging-desaturate;87;87;86;87;85;86;85;86;85;85 02:57:33 INFO - PROCESS | 1695 | |8;json-parse-financial;53;55;55;54;53;53;55;64;51;53 02:57:33 INFO - PROCESS | 1695 | |9;json-stringify-tinderbox;63;64;65;77;69;69;67;66;66;65 02:57:33 INFO - PROCESS | 1695 | |10;stanford-crypto-aes;90;108;108;67;95;96;108;106;73;97 02:57:33 INFO - PROCESS | 1695 | |11;stanford-crypto-ccm;125;128;134;135;107;118;123;123;130;123 02:57:33 INFO - PROCESS | 1695 | |12;stanford-crypto-pbkdf2;137;126;138;137;136;126;138;137;135;136 02:57:33 INFO - PROCESS | 1695 | |13;stanford-crypto-sha256-iterative;66;65;65;65;67;66;68;67;66;65 02:57:33 INFO - PROCESS | 1695 | __end_tp_report 02:57:33 INFO - PROCESS | 1695 | __start_cc_report 02:57:33 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,1156 02:57:33 INFO - PROCESS | 1695 | __end_cc_report 02:57:33 INFO - PROCESS | 1695 | __startTimestamp1454410653452__endTimestamp 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | ------- Summary: start ------- 02:57:33 INFO - PROCESS | 1695 | Number of tests: 14 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.73 (1.6%) stddev-sans-first:1.83 02:57:33 INFO - PROCESS | 1695 | Values: 111.0 108.0 110.0 111.0 111.0 111.0 115.0 110.0 111.0 111.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:144.50 stddev:16.40 (11.4%) stddev-sans-first:15.72 02:57:33 INFO - PROCESS | 1695 | Values: 157.0 118.0 144.0 154.0 118.0 142.0 118.0 153.0 145.0 121.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.00 stddev:2.55 (1.4%) stddev-sans-first:2.15 02:57:33 INFO - PROCESS | 1695 | Values: 190.0 186.0 186.0 186.0 188.0 184.0 187.0 185.0 183.0 181.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#3] audio-fft Cycles:10 Average:70.80 Median:77.00 stddev:11.96 (15.5%) stddev-sans-first:12.59 02:57:33 INFO - PROCESS | 1695 | Values: 75.0 76.0 90.0 78.0 58.0 59.0 58.0 80.0 78.0 56.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:78.00 stddev:16.15 (20.7%) stddev-sans-first:17.12 02:57:33 INFO - PROCESS | 1695 | Values: 93.0 92.0 122.0 78.0 78.0 80.0 110.0 78.0 101.0 111.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:90.00 stddev:13.91 (15.5%) stddev-sans-first:14.48 02:57:33 INFO - PROCESS | 1695 | Values: 85.0 90.0 84.0 90.0 84.0 99.0 130.0 90.0 84.0 91.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 02:57:33 INFO - PROCESS | 1695 | Values: 93.0 93.0 94.0 93.0 93.0 93.0 96.0 93.0 93.0 94.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 02:57:33 INFO - PROCESS | 1695 | Values: 87.0 87.0 86.0 87.0 85.0 86.0 85.0 86.0 85.0 85.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:3.53 (6.5%) stddev-sans-first:3.70 02:57:33 INFO - PROCESS | 1695 | Values: 53.0 55.0 55.0 54.0 53.0 53.0 55.0 64.0 51.0 53.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:66.50 stddev:3.98 (6.0%) stddev-sans-first:3.94 02:57:33 INFO - PROCESS | 1695 | Values: 63.0 64.0 65.0 77.0 69.0 69.0 67.0 66.0 66.0 65.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:81.50 stddev:14.63 (17.9%) stddev-sans-first:15.41 02:57:33 INFO - PROCESS | 1695 | Values: 90.0 108.0 108.0 67.0 95.0 96.0 108.0 106.0 73.0 97.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:126.50 stddev:8.15 (6.4%) stddev-sans-first:8.65 02:57:33 INFO - PROCESS | 1695 | Values: 125.0 128.0 134.0 135.0 107.0 118.0 123.0 123.0 130.0 123.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.60 Median:137.00 stddev:4.62 (3.4%) stddev-sans-first:4.82 02:57:33 INFO - PROCESS | 1695 | Values: 137.0 126.0 138.0 137.0 136.0 126.0 138.0 137.0 135.0 136.0 02:57:33 INFO - PROCESS | 1695 | 02:57:33 INFO - PROCESS | 1695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 02:57:33 INFO - PROCESS | 1695 | Values: 66.0 65.0 65.0 65.0 67.0 66.0 68.0 67.0 66.0 65.0 02:57:33 INFO - PROCESS | 1695 | -------- Summary: end -------- 02:57:33 INFO - PROCESS | 1695 | 02:57:34 INFO - TEST-INFO | 1695: exit 0 02:57:34 INFO - TEST-OK | kraken | took 56557ms 02:57:34 INFO - SUITE-END | took 1170s 02:57:34 INFO - Completed test suite (00:19:31) 02:57:34 INFO - Working with test: dromaeo_css 02:57:34 INFO - Generating results file: dromaeo_css 02:57:34 INFO - Working with test: kraken 02:57:34 INFO - Generating results file: kraken 02:57:34 INFO - javascript benchmark 02:57:34 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:57:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 02:57:35 INFO - process_Request line: dromaeo_css 7370.54 graph.html#tests=[[72,64,59]] 02:57:35 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:57:35 INFO - process_Request line: kraken 1412.40 graph.html#tests=[[232,64,59]] 02:57:35 INFO - RETURN: dromaeo_css: 7370.54 02:57:35 INFO - RETURN: kraken: 1412.40 02:57:35 INFO - javascript benchmark 02:57:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3379.222778760885, 3416.9829150854243, 3459.705924996375, 3473.096994781356, 3488.1802776347567, 5496.258005169301, 5566.137248726453, 5579.191017302489, 5601.439856014396, 5610.130429783385, 5536.778528858841, 5565.970295495336, 5571.8607034824045, 5600.691961942091, 5602.887942241153, 5056.165732654108, 5069.518395752398, 5098.770555325001, 5099.235114732783, 5144.3826740791155, 5237.952409518092, 5263.684178949256, 5266.473352664722, 5267.868303292429, 5268.4994925482015, 5237.659552129118, 5249.685018898859, 5251.553617942461, 5257.290265814105, 5259.579233661317, 5248.632595718302, 5251.002309561171, 5262.421133675292, 5263.1578947368425, 5278.868028299285, 4695.647826412998, 4769.42766867978, 5094.592432605383, 5219.973900130475, 5240.816571419982, 4651.0, 5534.363548191969, 5606.719664016783, 5613.663180209201, 5638.154276858463, 5588.938101760693, 5803.53571714266, 6126.7549298028025, 6127.87744245117, 6128.233970753656, 6052.515798736091, 6056.3338032816355, 6057.223166361789, 6139.201903752528, 6144.832481828483, 5693.0, 5710.71446427677, 5721.828345149611, 5730.255066841367, 5776.768929242783, 6218.875622487525, 6221.191245138103, 6227.750889964442, 6238.1890354254565, 6245.875082498324, 5654.858628534237, 5769.913451298234, 5940.554458415636, 5946.524278057745, 6089.025755879038, 6125.632462052291, 6148.600340977911, 6156.753729850845, 6158.476529495043, 6161.507079433724, 6056.848578785565, 6080.9391906081255, 6081.6351018939, 6084.209052823193, 6089.086637004485, 5521.613487055867, 5704.80033198836, 5913.349531551526, 6031.517478601789, 6074.119252708332, 4841.491643377465, 4845.491223421561, 4857.781399837016, 4864.0, 4875.878103047452, 4321.48142222929, 4328.11273688893, 4328.437303150633, 4328.848490302824, 4349.238883195429, 5545.057340252167, 5606.6916319602815, 5621.381648018714, 5668.404817494104, 5677.772889084473, 5951.256092988377, 5973.880522389528, 5991.610545314541, 5994.310654274727, 5996.5202783777195, 5504.834854954358, 5512.39363669996, 5537.58468114893, 5626.943730562723, 5724.828255152269, 5253.3958594761325, 5286.20706893969, 5291.1798671206025, 5294.41761406245, 5350.304460420199, 6226.221722284715, 6233.0, 6240.7503699851495, 6243.469305108935, 6243.843903902348, 6084.269887613515, 6103.51950425029, 6129.448349648553, 6164.137020816999, 6194.9690251550255, 6204.224471940827, 6242.0, 6245.6252624842655, 6255.46828519581, 6268.843278918063, 6038.909416358671, 6070.271567411939, 6070.939290607037, 6074.453299203093, 6075.878482430238, 6048.213732214784, 6122.602030867979, 6127.479164271087, 6140.815775526563, 6163.260408750979, 5786.247787787561, 5910.852228694317, 5984.371640977634, 6004.399560044136, 6043.939560604338, 5924.555658325729, 5966.433188847052, 5974.761009559569, 5979.5814292999075, 5985.191999080069, 5701.258836351248, 5736.512396446349, 5788.884222315614, 5831.067029275296, 5832.679202643895, 4895.828645997373, 5923.763049477972, 5967.6121052131475, 5970.58205925581, 5990.371011043778, 4801.327814105958, 5775.653460792366, 5778.16216648592, 5792.942070579409, 5795.217645617788], "unit": "score", "name": "dojo.html", "value": 5580.07594028793}, {"lowerIsBetter": false, "replicates": [427.32056030910843, 461.27579699871217, 495.1063330688108, 550.7081246939118, 562.493755619942, 29169.0, 29624.111276661708, 36989.44515832261, 37749.433758493644, 37809.62190378096, 32151.67848321516, 40261.59738402615, 40410.59589404105, 40519.0, 40584.59415405845, 9396.201322887562, 9609.231261499064, 9611.90388096117, 9620.855687164698, 9624.181944534723, 9472.242220622367, 9568.712938611818, 9609.327347085708, 9617.086376794194, 9617.90382096177, 9547.570359333846, 9636.469994150319, 9793.657221997231, 9806.411615303068, 9809.0, 9668.613255469772, 9770.853437198377, 9781.755456113582, 9787.314887957846, 9808.46053467059, 9565.952170239174, 9690.75773105671, 9701.951490242574, 9712.174465170468, 9731.318807683465, 39108.82673519799, 39502.802485987675, 39518.80240598807, 39546.80226598877, 39567.0, 3193.7445004399824, 3230.7576931729977, 3429.228423604669, 3457.4640930655787, 3765.717571182145, 25815.35461613456, 26004.479910401875, 26778.464430711276, 26778.5983210252, 27147.1855844323, 2117.6400011998, 2523.205190365029, 2543.860087695176, 2548.503041906829, 2572.1254773376954, 471588.0, 476382.0, 476491.0, 476715.0, 476731.0, 55724.44275557274, 56903.0, 56909.0, 63379.0, 67239.66380168068, 62295.37704622986, 62654.686726566986, 63127.0, 63135.474581017166, 63179.36820631827, 15807.786909832632, 16000.03999760018, 16000.919995399949, 16027.519174424786, 16030.358785648677, 11170.664880053611, 11361.977422031892, 11364.602238921598, 12299.954503867271, 12550.435230414654, 20210.39368818938, 20456.977151142382, 20501.897490512452, 20513.794862051487, 20552.58894822125, 7348.889766653505, 8670.86993695095, 8810.647574097093, 8814.735557933273, 8898.154675305836, 915.624593916491, 1084.2789544952518, 1103.564092183599, 1133.9319640821577, 1134.869490008643, 27388.863055684593, 27553.311167220578, 28917.277068073465, 28917.855410723234, 29345.266368340534, 1086.8043752124536, 1100.763335882789, 1115.1524841120645, 1186.400867561893, 1188.7028242939266, 14203.502877399447, 14717.484888028868, 14807.555773326818, 14904.329305181293, 15157.0, 542646.2867685637, 547582.0, 548467.0613175428, 548591.0, 548813.0, 56369.7181514098, 56991.14513282304, 57125.42874571201, 57150.42849571534, 57318.0, 1425.6150839273546, 1436.1383170097859, 1452.0924422236103, 1452.2230606625405, 1468.2291796806549, 28990.7100928988, 29527.0, 30168.94408695685, 30291.783275216905, 30558.0, 54571.45428545664, 55167.448325517835, 55236.0, 55373.446265536826, 55417.44582554123, 496586.0, 500470.0, 500714.0, 506035.0, 506201.9379806155, 34662.480062798575, 42315.57684423116, 42559.680039995, 43707.34438983354, 43886.0, 40806.387904182055, 40895.795521022206, 40924.386134207416, 41397.0, 41978.580214197464, 33782.0, 34904.65095349115, 35009.82495087508, 35293.0, 35330.64669353273, 27688.723112768614, 29725.405491889607, 36649.81675091608, 37158.8142059288, 37618.0, 33092.00723978285, 34123.82938085393, 34541.30917381689, 34629.82685086558, 34917.650823492455, 30500.237494062825, 30816.691833082277, 31340.0, 31345.902893399532, 31488.370232595676, 20063.899680501505, 20939.790602093784, 22220.333389998326, 24741.752582473946, 24944.126955557193], "unit": "score", "name": "ext.html", "value": 19482.56491290821}, {"lowerIsBetter": false, "replicates": [327.2554937517148, 363.17559140750495, 369.09571549703236, 371.6692143991848, 374.0331243734945, 14398.856011439882, 14717.558473245794, 18273.81726182738, 18587.628247435045, 18965.810341896595, 10842.241043126965, 11305.604303849346, 14503.782443263359, 17884.821151788477, 17911.73132403015, 4955.554000139987, 5134.0758663440565, 5141.228815677641, 5141.511556402136, 5151.587872970172, 3787.280416720814, 3959.871436640558, 3979.6617287530594, 5326.3075800145925, 5593.860153496154, 5661.150827375906, 5883.88232235355, 5897.292324921015, 5901.232839730829, 5904.793332233373, 5541.445855414467, 5674.659520428788, 5678.829635110953, 5699.914501282464, 5795.768169273224, 5390.5418039466695, 5452.863678408032, 5472.699001554913, 5495.175723641446, 5675.148727690838, 12640.49438022478, 12797.360131993362, 12811.487540498369, 19914.80085199144, 23599.29202123939, 2095.19335056003, 2128.1806504495726, 2144.2495126705685, 2709.91870243893, 2744.5745909384077, 9037.017784131287, 9615.326927115104, 9672.468014259213, 9813.754656133653, 10263.178945684327, 1744.5258756350863, 1784.8929064256056, 1827.2964908510187, 1841.1990784009, 1866.9066546672748, 96123.0, 98518.0, 98607.0, 99289.0, 99924.50037749838, 10853.24027318096, 11003.0, 11017.283876548, 11017.338959662446, 11162.274452160584, 13119.672008199872, 13225.537106201236, 13257.403416846266, 13258.602241932758, 13273.336333183495, 8299.585020748938, 8342.66629334832, 8353.33173346131, 8394.874076888851, 8395.664173433117, 8370.790730231793, 8393.95803020981, 8395.790105247417, 8445.324374050062, 8495.0, 3491.4762785581856, 4333.523312435629, 4335.393044973706, 4379.605835474823, 4389.4513185851765, 1710.0680129329546, 1771.2206629083162, 1775.334249656379, 1775.7070083436347, 1776.8933863968202, 812.5490352854223, 893.115815342806, 931.0828833598899, 945.1824172091092, 1008.4050410257836, 18624.0, 18974.0, 19161.90419047896, 19793.10931008108, 19816.009199539967, 902.6299217320998, 939.9812003759887, 948.2271948362063, 973.7127547373542, 1039.5218199628105, 9015.459072455673, 10766.73083172927, 10808.351498910091, 10858.837117443245, 10864.239503234698, 630576.0, 755952.0, 760215.0, 777263.0, 779652.0, 96292.51853740687, 106732.0, 107697.0, 107877.0, 108650.0, 1162.651204638622, 1163.4938801621322, 1180.557291015869, 1199.1186477938709, 1199.1545960098285, 14717.632059198606, 16111.436099736453, 17757.64484710273, 17856.732149018037, 18182.636347273245, 46404.0, 46571.0, 46706.76646616745, 47470.762646187926, 48637.75681121572, 64793.67603162143, 66076.0, 66425.0, 67905.85129784458, 69690.65154674194, 7229.63851807397, 7543.0, 7630.694772209272, 7657.846843063219, 7720.459567830198, 9442.0, 11801.35092569917, 11868.347240901488, 12061.336626485276, 12140.635780926586, 9187.265018798615, 10313.793724125626, 10360.430176340373, 10397.896021039693, 10499.265051446326, 8009.799755006172, 9193.77015574616, 10266.589336426758, 10276.691699249035, 10344.534495947852, 10292.742681432725, 10403.0, 10470.738231543968, 10479.94760026195, 10588.311759735592, 7534.39724822002, 7557.244275572399, 7601.429892758176, 7617.542947423172, 7631.542107473348, 9688.608709851438, 10470.319429237075, 10558.841617375592, 10611.469426528796, 10686.625968091079], "unit": "score", "name": "jquery.html", "value": 8837.006808198994}, {"lowerIsBetter": false, "replicates": [1219.311089234582, 1533.1107957384716, 1561.7735428362885, 1793.2826869252297, 1935.9516012099705, 7907.960460197698, 8105.351571874243, 8627.95686021569, 8730.65077396905, 8753.737387878375, 8529.914700852989, 8612.526311052905, 8680.045195028557, 8687.305015598753, 8699.608517616707, 2178.684090806832, 2223.966640500386, 2415.10641062807, 2436.378723425524, 2441.279822452381, 2234.4078819112947, 2238.4963383238805, 2243.9439014024697, 2245.0907382510027, 2382.618780995041, 2436.5735996200683, 2441.060191826151, 2443.1082654831034, 2447.363685441789, 2452.043702955849, 2378.95242095158, 2444.938876528074, 2447.4248551590363, 2452.7792498675117, 2466.025919761702, 2391.7369089400327, 2438.707355117397, 2449.9510009799706, 2455.594826853567, 2458.5820410530073, 8593.742187734315, 8767.649294028231, 8790.252828509585, 8804.207621314112, 8808.207261346446, 5245.632805703603, 5344.839654810362, 5349.732513374316, 5386.461353864622, 5391.946080539184, 3629.27414517095, 3632.3098611263777, 3638.5088013118157, 3724.1062145085257, 3744.5319335083113, 863.9697610583662, 1059.9523021463976, 1071.1056268016139, 1071.2554774431774, 1077.5959015369237, 11931.164818462712, 11938.761224775542, 11942.164048516608, 11966.982806461461, 11974.0, 4769.189237829508, 4823.469418363977, 4884.145274576935, 4894.706317620954, 4909.828156014522, 10102.393856368495, 10149.492525373702, 10152.187824973984, 10168.796624067478, 10189.286749927582, 5407.945920540823, 5432.185172224198, 5435.374931882884, 5438.265834112423, 5463.644863083887, 4889.095517329305, 4946.851594452172, 4954.801807927714, 4955.801767929314, 4958.231474121517, 3283.83580820958, 3937.645611894943, 3948.861789837342, 3959.2873282808796, 3991.880243592697, 1201.1291813435364, 1236.252067499168, 1238.4612693478366, 1275.113795911851, 1298.2275546050084, 1100.6863044032573, 1278.8849003589721, 1327.8074679171466, 1341.3092257487401, 1341.724946386008, 7770.300672939463, 7826.804329891798, 7873.0, 7874.330681892104, 7877.960610197027, 1170.4615876696644, 1171.689502281896, 1172.8123500240092, 1174.74155685749, 1194.146185477388, 6009.639421634716, 6120.60216085953, 6123.632582045091, 6124.693765311717, 6126.356732543019, 10023.498825058718, 10644.042036216777, 10662.733431664115, 10773.138148948065, 10786.460676966277, 10212.642557510451, 10517.211209159344, 10624.096951759033, 10624.681259562225, 10651.520681569347, 8153.8776918346275, 8289.8342033159, 8311.875321870177, 8314.210150035617, 8323.583820809057, 7642.273983971736, 7719.536827790126, 7764.883526747216, 7780.688772449039, 7930.643121059682, 9385.296102792181, 9390.0, 9418.764530886783, 9479.810403791747, 9599.280053996117, 9415.058494150804, 9814.969428210221, 9827.459489728133, 9904.851427228454, 9915.603375865174, 6306.873862522815, 7366.926330736624, 7370.557766534025, 7473.962630186814, 7487.812804679927, 7814.413918956215, 8022.879656805269, 8026.077001144943, 8030.598470076589, 8033.437659363788, 7483.363914067365, 7628.656710448154, 7635.083789945242, 7762.184970578234, 7776.300132988058, 7421.443391745533, 7476.102867655699, 7485.251474852471, 7564.4704870658525, 7568.243175682388, 6831.385175334244, 7350.970864078926, 7610.200928902607, 7670.884936725842, 7689.92310076892, 6877.759278425231, 6928.861422771617, 6943.583384996917, 6943.618101004291, 6956.060931774348, 6808.795736127726, 6981.406580440516, 6995.650217489207, 7005.719771209298, 7007.229204787367], "unit": "score", "name": "mootools.html", "value": 4896.025262819283}, {"lowerIsBetter": false, "replicates": [327.7427219632588, 331.0, 335.874047232288, 340.0953463786329, 340.2293804532732, 5565.526930210932, 6624.867502649944, 6636.53544251902, 6660.66696665166, 6670.6331151786635, 6255.718492667829, 6282.560220784547, 6471.1263979362775, 6477.157969463963, 6536.0, 4773.973595676929, 4794.2329227323635, 4820.542048505386, 4830.6135509159185, 4856.684315519488, 4800.007996681373, 4876.195427754434, 4879.463259041502, 4881.4630390657, 4896.46138924718, 3744.2511497700434, 3866.76799392036, 4611.6310695144475, 4753.47711751707, 4759.095771803363, 4759.738214398207, 4794.520547945178, 4802.51974802517, 4803.207470767319, 4822.590079843235, 4137.275976704064, 4147.3778933159965, 4149.128682976579, 4154.335306350999, 4156.584341565849, 5321.2284218788445, 6092.573519853612, 6101.603395779304, 6265.27216306297, 6265.404786545271, 5732.455416735445, 5753.453421924911, 5756.338021127582, 5765.913511297334, 5774.105013722879, 6982.1272340957385, 6991.615461149635, 7001.074704456264, 7004.92995070053, 7007.194172670157, 4656.41794775653, 4657.091867085919, 4657.88355291117, 4670.206064968929, 4675.579197872208, 7164.0, 7429.85140297191, 7436.888446673304, 7454.515456495311, 7474.962625186894, 4761.666683332133, 4767.332573439721, 4767.904641907143, 4769.379980602569, 4777.0, 4833.250846118857, 4848.200046992207, 4850.75746212688, 4859.635527335464, 4860.222364421676, 4690.179218636725, 5345.545628621533, 5735.311762588516, 5737.282839645044, 5748.827535173951, 6081.391860813883, 6759.357861003196, 6961.617111058839, 7027.367536921702, 7050.330218629222, 1623.9675206495804, 1636.9263383147786, 1644.925978330978, 1647.3822316631263, 1647.538689167035, 1049.1030169205371, 1055.3773273768513, 1067.1356201476829, 1071.4963966935527, 1083.6803143072812, 6552.213734351908, 6582.736690532325, 6615.791341199514, 6617.974213996742, 6619.437347825393, 7277.19950805411, 7278.599677017709, 7291.708331666674, 7304.123505179413, 7305.671244793997, 5365.409804921455, 6388.1155059257635, 6394.648294343763, 6587.703553340111, 6615.933840661628, 3843.7501562398356, 3889.280483110577, 3900.921981560353, 3903.4144878268485, 3905.882823515299, 6260.0, 7735.845283094307, 7743.380529557622, 7761.72833950809, 7769.456138070281, 7381.66782494789, 7494.887576686354, 7603.809904752426, 7609.048868891388, 7614.695412183451, 7739.071311442663, 7744.3417309528195, 7746.38028957682, 7756.185600511865, 7759.2240775921955, 7358.889616655647, 7362.889556656762, 7366.521176123535, 7370.226126256666, 7373.483856130019, 6930.410915072275, 7144.535605185646, 7195.388391986739, 7247.347738703542, 7248.0939882514685, 6317.652529110943, 7717.922820771721, 7721.227877212234, 7721.343685786771, 7738.806529836799, 3875.844966201433, 4646.442426908792, 4694.108119457293, 4700.412448443944, 4704.435467743892, 7068.3285087916565, 7279.272072792678, 7309.5248808827255, 7319.817004574716, 7355.77932662021, 7027.6837542309695, 7073.221945586084, 7085.645717713991, 7088.255733147946, 7093.184283807428, 5789.623674461147, 6757.662116894037, 7094.148702155774, 7094.787156385317, 7117.928820711727, 6803.455723542006, 6808.62552559614, 6818.454523638196, 6828.351306625863, 6831.795046148623, 6742.393184613408, 6846.246912839484, 6859.382655561023, 6899.655017249218, 6944.965275173794, 6700.296468870698, 6782.321767823179, 6814.352636499525, 6891.138607674041, 6912.758053468105], "unit": "score", "name": "prototype.html", "value": 5124.099235223082}, {"lowerIsBetter": false, "replicates": [660.5376236634356, 676.1851968378102, 690.9758158464455, 707.2008630247819, 726.4333819620696, 13945.233012184326, 14090.788638170436, 14098.506552270646, 14115.999999999987, 14136.575902722909, 12584.622461326175, 14180.00739948204, 14571.344289506971, 14582.343794529244, 14601.0, 685.4790359326922, 699.164498424383, 856.6616186606287, 874.0909454167657, 875.6234819027816, 686.7836631461099, 691.0360047733434, 691.7855464805926, 692.8856738638119, 836.1972506393869, 757.685560492395, 914.8627705844143, 920.7283851263893, 921.0559176843756, 922.0594993107027, 913.7350168451142, 916.6883259691704, 916.9174774270281, 918.1140199707314, 920.6823645842173, 539.156220514893, 541.4991133201772, 542.9864253393657, 544.4038777538589, 545.0271265790545, 13882.791758123636, 14085.788713169311, 14099.929500352433, 14109.78835317471, 14113.223772692498, 11870.703232419171, 11876.0, 12080.758384832254, 12242.81635775464, 12399.876001239962, 9933.751656208653, 9998.0, 10009.349392289478, 10011.0, 10029.247806414549, 3428.434308339121, 3474.4267195912644, 3474.878379256739, 3508.7894726316504, 3514.1741690702665, 81257.59371203106, 82241.9999999994, 82537.76193357045, 82897.75653365205, 82948.0, 8655.78360540979, 8658.090900455487, 8816.559172041372, 8851.513166775889, 8954.86567701485, 19742.40772776819, 19993.900030499753, 20199.596008079756, 20478.488037798877, 20505.2823151189, 7290.781276561605, 7296.890546641805, 7311.159216690149, 7405.296496832792, 7675.808104797425, 4012.057166565855, 4087.182563487255, 4098.200850834119, 4098.6516146127915, 4112.115895082572, 3438.9312213755584, 3493.5807703075284, 3503.0016445312963, 3503.737219708532, 3505.158761897126, 617.2253821454136, 627.1470799712388, 630.334996578614, 650.7592190889401, 651.1632552170438, 586.9559783016291, 595.9202383680922, 612.574260888687, 626.2610120058284, 626.3548544998658, 6573.605583664899, 8344.374171937008, 8488.830223395498, 8658.437201581877, 8709.477431354138, 524.8871492629103, 532.3186321508475, 581.1979468333673, 611.7277811373896, 625.2309659119309, 3989.9800500997308, 4263.296556068214, 4341.674374421931, 4411.18393097278, 4427.579379958899, 85971.0, 91683.16633667289, 91828.0, 91839.54080229557, 91906.08093918975, 70978.0, 71363.0, 71602.28397716061, 71605.0, 72421.27578724145, 63914.6804265985, 64449.355506445274, 65412.67293663501, 65982.0, 68308.63382732417, 8481.87277190855, 8694.869576956224, 8698.434601750865, 8710.0, 8960.820783584422, 41905.0, 44529.777351113036, 46705.76647116743, 48528.75735621299, 49426.0, 63282.68358658177, 65389.0, 68831.65584172047, 69008.3099169002, 70373.85139931981, 10594.31136976094, 10683.679489615013, 10805.0, 10826.67519974402, 11111.38887361203, 11796.351200684045, 11815.232009919328, 12089.57686480969, 12354.75290494203, 12547.372631368578, 10119.342242754197, 10461.633842815465, 10642.467876605984, 10688.038076573146, 10859.782804344028, 11095.445227738743, 11178.105751539695, 11319.434028298718, 11510.82733759011, 12195.573154939535, 10911.399873007062, 10949.233553651167, 10966.396848173426, 11310.717232069264, 11319.660410187707, 8967.865482017645, 8977.730668079968, 9075.863862041942, 9501.88986220366, 9705.223582113273, 7912.723054693058, 8731.869021964549, 9010.414323068979, 9660.275479338938, 9671.951640241754], "unit": "score", "name": "yui.html", "value": 6651.338208476752}], "name": "dromaeo_css", "value": 7370.540768892376}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 111.0, 111.0, 111.0, 115.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 118.0, 144.0, 154.0, 118.0, 142.0, 118.0, 153.0, 145.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 137.0}, {"lowerIsBetter": true, "replicates": [190.0, 186.0, 186.0, 186.0, 188.0, 184.0, 187.0, 185.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 185.6}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 90.0, 78.0, 58.0, 59.0, 58.0, 80.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.8}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 122.0, 78.0, 78.0, 80.0, 110.0, 78.0, 101.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 84.0, 90.0, 84.0, 99.0, 130.0, 90.0, 84.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 96.0, 93.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 86.0, 87.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 54.0, 53.0, 53.0, 55.0, 64.0, 51.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 77.0, 69.0, 69.0, 67.0, 66.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [90.0, 108.0, 108.0, 67.0, 95.0, 96.0, 108.0, 106.0, 73.0, 97.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.8}, {"lowerIsBetter": true, "replicates": [125.0, 128.0, 134.0, 135.0, 107.0, 118.0, 123.0, 123.0, 130.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 138.0, 137.0, 136.0, 126.0, 138.0, 137.0, 135.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.6}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 67.0, 66.0, 68.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1412.3999999999999}]} 02:57:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1412.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7370.54"}}} 02:57:35 INFO - Return code: 0 02:57:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:57:35 INFO - # TBPL SUCCESS # 02:57:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:57:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:57:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:57:35 INFO - 2016-02-02 02:57:35.311 screenresolution[1699:10620] starting screenresolution argv=screenresolution get 02:57:35 INFO - 2016-02-02 02:57:35.314 screenresolution[1699:10620] Display 0: 1600x1200x32@60 02:57:35 INFO - 2016-02-02 02:57:35.320 screenresolution[1700:10623] starting screenresolution argv=screenresolution list 02:57:35 INFO - Available Modes on Display 0 02:57:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:57:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:57:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:57:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:57:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:57:35 INFO - Intel Iris: 02:57:35 INFO - Chipset Model: Intel Iris 02:57:35 INFO - Type: GPU 02:57:35 INFO - Bus: Built-In 02:57:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:57:35 INFO - Vendor: Intel (0x8086) 02:57:35 INFO - Device ID: 0x0a2e 02:57:35 INFO - Revision ID: 0x0009 02:57:35 INFO - Displays: 02:57:35 INFO - Display: 02:57:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:57:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:57:35 INFO - Display Serial Number: 1600x1200 60 02:57:35 INFO - Main Display: Yes 02:57:35 INFO - Mirror: Off 02:57:35 INFO - Online: Yes 02:57:35 INFO - Rotation: Supported 02:57:35 INFO - Return code: 0 02:57:35 INFO - Running post-action listener: _resource_record_post_action 02:57:35 INFO - Running post-run listener: _resource_record_post_run 02:57:36 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34004480; Write bytes: 711301120; Read time: 356; Write time: 1933 02:57:36 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384688640; Write bytes: 380513792; Read time: 28606; Write time: 723 02:57:36 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 33062400; Write bytes: 301214208; Read time: 341; Write time: 1143 02:57:36 INFO - Running post-run listener: _upload_blobber_files 02:57:36 INFO - Blob upload gear active. 02:57:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:57:36 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 02:57:36 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'] 02:57:36 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 02:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:38 INFO - (blobuploader) - INFO - Done attempting. 02:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:57:39 INFO - (blobuploader) - INFO - Done attempting. 02:57:39 INFO - (blobuploader) - INFO - Iteration through files over. 02:57:39 INFO - Return code: 0 02:57:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:57:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:57:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfa41e1a452b14409c9ac9602bda535ed15e7e411eb94bb84d486bf8afdf22261f2b7bf7a8b762142300fd0a16e8d57e6442c43b75759cd43001eeec72683f46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e90b3148776df555655eaf5dc90bd6ac98a4597b5777349371df0628aa460fec877f35f9835d7f485c365e6e2a7b7dbb1bef8b8a241f09ba9603995d227f9e83"} 02:57:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:57:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:57:39 INFO - Contents: 02:57:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfa41e1a452b14409c9ac9602bda535ed15e7e411eb94bb84d486bf8afdf22261f2b7bf7a8b762142300fd0a16e8d57e6442c43b75759cd43001eeec72683f46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e90b3148776df555655eaf5dc90bd6ac98a4597b5777349371df0628aa460fec877f35f9835d7f485c365e6e2a7b7dbb1bef8b8a241f09ba9603995d227f9e83"} 02:57:39 INFO - Running post-run listener: copy_logs_to_upload_dir 02:57:39 INFO - Copying logs to upload dir... 02:57:39 INFO - mkdir: /builds/slave/test/build/upload/logs 02:57:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.434356 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-02 02:57:39.328886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 02:57:39.333112) ========= 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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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/bfa41e1a452b14409c9ac9602bda535ed15e7e411eb94bb84d486bf8afdf22261f2b7bf7a8b762142300fd0a16e8d57e6442c43b75759cd43001eeec72683f46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e90b3148776df555655eaf5dc90bd6ac98a4597b5777349371df0628aa460fec877f35f9835d7f485c365e6e2a7b7dbb1bef8b8a241f09ba9603995d227f9e83"} build_url:https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/OJDas6nrSKuFQCf97BQMvw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfa41e1a452b14409c9ac9602bda535ed15e7e411eb94bb84d486bf8afdf22261f2b7bf7a8b762142300fd0a16e8d57e6442c43b75759cd43001eeec72683f46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e90b3148776df555655eaf5dc90bd6ac98a4597b5777349371df0628aa460fec877f35f9835d7f485c365e6e2a7b7dbb1bef8b8a241f09ba9603995d227f9e83"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 02:57:39.366817) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:57:39.367373) ========= 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.ZpWuJESFwe/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.YBG96CvNqs/Listeners TMPDIR=/var/folders/rg/gwlnpvp52557f_83wf586mv000000w/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.005134 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 02:57:39.418084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 02:57:39.418634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 02:57:39.419322) ========= ========= Total master_lag: 0.34 =========