builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0195 starttime: 1459249029.2 results: success (0) buildid: 20160329025627 builduid: 0bf66b5fc6ab4ec49c3e8f3589275e01 revision: a7031fdd9cb9952d03721942ef8b0639bd144b6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.204888) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.205317) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.205604) ========= 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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.005507 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.235243) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.235558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.254771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.255137) ========= 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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.005444 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.304279) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.304594) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.304962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.308295) ========= 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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-29 03:57:09-- 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% 138M=0s 2016-03-29 03:57:09 (138 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.260889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.584983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.588327) ========= 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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.025474 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:09.637298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 03:57:09.637660) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7031fdd9cb9952d03721942ef8b0639bd144b6d --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 a7031fdd9cb9952d03721942ef8b0639bd144b6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-29 03:57:09,704 truncating revision to first 12 chars 2016-03-29 03:57:09,704 Setting DEBUG logging. 2016-03-29 03:57:09,704 attempt 1/10 2016-03-29 03:57:09,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7031fdd9cb9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 03:57:10,507 unpacking tar archive at: fx-team-a7031fdd9cb9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.047790 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 03:57:10.708658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:10.709037) ========= echo a7031fdd9cb9952d03721942ef8b0639bd144b6d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a7031fdd9cb9952d03721942ef8b0639bd144b6d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 a7031fdd9cb9952d03721942ef8b0639bd144b6d program finished with exit code 0 elapsedTime=0.004823 script_repo_revision: 'a7031fdd9cb9952d03721942ef8b0639bd144b6d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:10.761967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:10.762331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 03:57:10.779605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-29 03:57:10.779988) ========= /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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:10 INFO - MultiFileLogger online at 20160329 03:57:10 in /builds/slave/test 03:57:10 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 03:57:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:10 INFO - {'append_to_log': False, 03:57:10 INFO - 'base_work_dir': '/builds/slave/test', 03:57:10 INFO - 'blob_upload_branch': 'Fx-Team', 03:57:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:10 INFO - 'branch': 'Fx-Team', 03:57:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:10 INFO - 'config_files': ('talos/mac_config.py',), 03:57:10 INFO - 'default_actions': ('clobber', 03:57:10 INFO - 'read-buildbot-config', 03:57:10 INFO - 'download-and-extract', 03:57:10 INFO - 'populate-webroot', 03:57:10 INFO - 'create-virtualenv', 03:57:10 INFO - 'install', 03:57:10 INFO - 'run-tests'), 03:57:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:10 INFO - 'download_minidump_stackwalk': True, 03:57:10 INFO - 'download_symbols': 'ondemand', 03:57:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:10 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:10 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:10 INFO - 'installer_path': 'installer.exe', 03:57:10 INFO - 'log_level': 'info', 03:57:10 INFO - 'log_name': 'talos', 03:57:10 INFO - 'log_to_console': True, 03:57:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:57:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:57:10 INFO - 'opt_config_files': (), 03:57:10 INFO - 'pip_index': False, 03:57:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:57:10 INFO - 'cmd': ('bash', 03:57:10 INFO - '-c', 03:57:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:57:10 INFO - 'enabled': True, 03:57:10 INFO - 'halt_on_failure': False, 03:57:10 INFO - 'name': 'check_screen_resolution'},), 03:57:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:57:10 INFO - 'cmd': ('bash', 03:57:10 INFO - '-c', 03:57:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:57:10 INFO - 'enabled': True, 03:57:10 INFO - 'halt_on_failure': False, 03:57:10 INFO - 'name': 'check_screen_resolution'},), 03:57:10 INFO - 'run_cmd_checks_enabled': True, 03:57:10 INFO - 'sps_profile': False, 03:57:10 INFO - 'sps_profile_interval': 0, 03:57:10 INFO - 'suite': 'dromaeojs', 03:57:10 INFO - 'system_bits': '32', 03:57:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:10 INFO - 'title': 't-yosemite-r7-0195', 03:57:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:10 INFO - 'use_talos_json': True, 03:57:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:10 INFO - 'work_dir': 'build'} 03:57:10 INFO - ##### 03:57:10 INFO - ##### Running clobber step. 03:57:10 INFO - ##### 03:57:10 INFO - Running pre-action listener: _resource_record_pre_action 03:57:10 INFO - Running main action method: clobber 03:57:10 INFO - rmtree: /builds/slave/test/build 03:57:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:12 INFO - Running post-action listener: _resource_record_post_action 03:57:12 INFO - ##### 03:57:12 INFO - ##### Running read-buildbot-config step. 03:57:12 INFO - ##### 03:57:12 INFO - Running pre-action listener: _resource_record_pre_action 03:57:12 INFO - Running main action method: read_buildbot_config 03:57:12 INFO - Using buildbot properties: 03:57:12 INFO - { 03:57:12 INFO - "project": "", 03:57:12 INFO - "product": "firefox", 03:57:12 INFO - "script_repo_revision": "production", 03:57:12 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:57:12 INFO - "repository": "", 03:57:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:57:12 INFO - "buildid": "20160329025627", 03:57:12 INFO - "pgo_build": "False", 03:57:12 INFO - "basedir": "/builds/slave/test", 03:57:12 INFO - "buildnumber": 642, 03:57:12 INFO - "slavename": "t-yosemite-r7-0195", 03:57:12 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:57:12 INFO - "platform": "yosemite_r7", 03:57:12 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:57:12 INFO - "branch": "fx-team", 03:57:12 INFO - "repo_path": "integration/fx-team", 03:57:12 INFO - "revision": "a7031fdd9cb9952d03721942ef8b0639bd144b6d", 03:57:12 INFO - "stage_platform": "macosx64", 03:57:12 INFO - "builduid": "0bf66b5fc6ab4ec49c3e8f3589275e01", 03:57:12 INFO - "slavebuilddir": "test" 03:57:12 INFO - } 03:57:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:57:12 INFO - Running post-action listener: _resource_record_post_action 03:57:12 INFO - ##### 03:57:12 INFO - ##### Running download-and-extract step. 03:57:12 INFO - ##### 03:57:12 INFO - Running pre-action listener: _resource_record_pre_action 03:57:12 INFO - Running main action method: download_and_extract 03:57:12 INFO - mkdir: /builds/slave/test/build/tests 03:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:12 INFO - https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:57:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:57:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:57:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:57:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 03:57:14 INFO - Downloaded 1199 bytes. 03:57:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:57:14 INFO - Using the following test package requirements: 03:57:14 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:57:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:57:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:57:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'jsshell-mac.zip'], 03:57:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:57:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:57:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:57:14 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:57:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:57:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:57:14 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:57:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:57: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')]} 03:57:14 INFO - https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:57:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:57:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:57:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:57:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:57:19 INFO - Downloaded 17943880 bytes. 03:57:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:57:22 INFO - Return code: 0 03:57:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:22 INFO - https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:57:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:57:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:57:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:57:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:57:24 INFO - Downloaded 17943880 bytes. 03:57:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:57:27 INFO - Return code: 0 03:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:27 INFO - https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:57:31 INFO - Downloaded 10847531 bytes. 03:57:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:57:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:57:31 INFO - Return code: 0 03:57:31 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')]} 03:57:31 INFO - https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 03:57:35 INFO - Downloaded 111440200 bytes. 03:57:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:57:35 INFO - mkdir: /builds/slave/test/properties 03:57:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:35 INFO - Contents: 03:57:35 INFO - build_url:https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:57:36 INFO - Running post-action listener: _resource_record_post_action 03:57:36 INFO - Running post-action listener: set_extra_try_arguments 03:57:36 INFO - ##### 03:57:36 INFO - ##### Running populate-webroot step. 03:57:36 INFO - ##### 03:57:36 INFO - Running pre-action listener: _resource_record_pre_action 03:57:36 INFO - Running main action method: populate_webroot 03:57:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:57:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:57:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:57:36 INFO - '--tppagecycles', 03:57:36 INFO - '7'], 03:57:36 INFO - 'tests': ['tsvgm']}}, 03:57:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:57:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:57:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:57:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:57:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'tests': ['damp', 'tps']}, 03:57:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['damp', 'tps']}, 03:57:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:57:36 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['dromaeo_dom']}, 03:57:36 INFO - 'other': {'tests': ['a11yr', 03:57:36 INFO - 'ts_paint', 03:57:36 INFO - 'tpaint', 03:57:36 INFO - 'sessionrestore', 03:57:36 INFO - 'sessionrestore_no_auto_restore', 03:57:36 INFO - 'tabpaint']}, 03:57:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['a11yr', 03:57:36 INFO - 'ts_paint', 03:57:36 INFO - 'tpaint', 03:57:36 INFO - 'sessionrestore', 03:57:36 INFO - 'sessionrestore_no_auto_restore', 03:57:36 INFO - 'tabpaint']}, 03:57:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['a11yr', 03:57:36 INFO - 'ts_paint', 03:57:36 INFO - 'tpaint', 03:57:36 INFO - 'sessionrestore', 03:57:36 INFO - 'sessionrestore_no_auto_restore', 03:57:36 INFO - 'tabpaint']}, 03:57:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['a11yr', 03:57:36 INFO - 'ts_paint', 03:57:36 INFO - 'tpaint', 03:57:36 INFO - 'sessionrestore', 03:57:36 INFO - 'sessionrestore_no_auto_restore', 03:57:36 INFO - 'tabpaint']}, 03:57:36 INFO - 'other_l64': {'tests': ['a11yr', 03:57:36 INFO - 'ts_paint', 03:57:36 INFO - 'tpaint', 03:57:36 INFO - 'sessionrestore', 03:57:36 INFO - 'sessionrestore_no_auto_restore', 03:57:36 INFO - 'tabpaint']}, 03:57:36 INFO - 'other_nol64': {'tests': ['a11yr', 03:57:36 INFO - 'ts_paint', 03:57:36 INFO - 'tpaint', 03:57:36 INFO - 'sessionrestore', 03:57:36 INFO - 'sessionrestore_no_auto_restore', 03:57:36 INFO - 'tabpaint']}, 03:57:36 INFO - 'svgr': {'tests': ['tsvgx', 03:57:36 INFO - 'tsvgr_opacity', 03:57:36 INFO - 'tart', 03:57:36 INFO - 'tscrollx', 03:57:36 INFO - 'cart']}, 03:57:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['tsvgx', 03:57:36 INFO - 'tsvgr_opacity', 03:57:36 INFO - 'tart', 03:57:36 INFO - 'tscrollx', 03:57:36 INFO - 'cart']}, 03:57:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'tests': ['tp5o']}, 03:57:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'talos_options': ['--e10s'], 03:57:36 INFO - 'tests': ['tp5o']}, 03:57:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'talos_options': ['--xperf_path', 03:57:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:36 INFO - 'tests': ['tp5n']}, 03:57:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:36 INFO - 'talos_options': ['--e10s', 03:57:36 INFO - '--xperf_path', 03:57:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:36 INFO - 'tests': ['tp5n']}}, 03:57:36 INFO - 'talos.zip': {'path': '', 03:57:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:57:36 INFO - Running post-action listener: _resource_record_post_action 03:57:36 INFO - ##### 03:57:36 INFO - ##### Running create-virtualenv step. 03:57:36 INFO - ##### 03:57:36 INFO - Running pre-action listener: _resource_record_pre_action 03:57:36 INFO - Running main action method: create_virtualenv 03:57:36 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:36 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 03:57:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:36 INFO - Using real prefix '/tools/python27' 03:57:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:40 INFO - Installing pip.................done. 03:57:40 INFO - Return code: 0 03:57:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57:40 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')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:40 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 03:57:40 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 03:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:40 INFO - 'HOME': '/Users/cltbld', 03:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PAGER': '/bin/cat', 03:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:57:40 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - 'XPC_FLAGS': '0x0', 03:57:40 INFO - 'XPC_SERVICE_NAME': '0', 03:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 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 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:57:40 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')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:40 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 03:57:40 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 03:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:40 INFO - 'HOME': '/Users/cltbld', 03:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PAGER': '/bin/cat', 03:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:57:40 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - 'XPC_FLAGS': '0x0', 03:57:40 INFO - 'XPC_SERVICE_NAME': '0', 03:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 INFO - Downloading/unpacking psutil>=0.7.1 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:43 INFO - Installing collected packages: psutil 03:57:43 INFO - Running setup.py install for psutil 03:57:43 INFO - building 'psutil._psutil_osx' extension 03:57:43 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 03:57:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:57:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:57:44 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 03:57:44 INFO - building 'psutil._psutil_posix' extension 03:57:44 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 03:57:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:57:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:57:44 INFO - ^ 03:57:44 INFO - 1 warning generated. 03:57:44 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 03:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:44 INFO - Successfully installed psutil 03:57:44 INFO - Cleaning up... 03:57:45 INFO - Return code: 0 03:57:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:45 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:45 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 03:57:45 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 03:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:45 INFO - 'HOME': '/Users/cltbld', 03:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:45 INFO - 'LOGNAME': 'cltbld', 03:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:45 INFO - 'MOZ_NO_REMOTE': '1', 03:57:45 INFO - 'NO_EM_RESTART': '1', 03:57:45 INFO - 'PAGER': '/bin/cat', 03:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:45 INFO - 'PWD': '/builds/slave/test', 03:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:45 INFO - 'SHELL': '/bin/bash', 03:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:57:45 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:45 INFO - 'USER': 'cltbld', 03:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:45 INFO - 'XPC_FLAGS': '0x0', 03:57:45 INFO - 'XPC_SERVICE_NAME': '0', 03:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:57:48 INFO - Installing collected packages: mozsystemmonitor 03:57:48 INFO - Running setup.py install for mozsystemmonitor 03:57:48 INFO - Successfully installed mozsystemmonitor 03:57:48 INFO - Cleaning up... 03:57:48 INFO - Return code: 0 03:57:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:48 INFO - 'HOME': '/Users/cltbld', 03:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:48 INFO - 'LOGNAME': 'cltbld', 03:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:48 INFO - 'MOZ_NO_REMOTE': '1', 03:57:48 INFO - 'NO_EM_RESTART': '1', 03:57:48 INFO - 'PAGER': '/bin/cat', 03:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:48 INFO - 'PWD': '/builds/slave/test', 03:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:48 INFO - 'SHELL': '/bin/bash', 03:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:57:48 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:48 INFO - 'USER': 'cltbld', 03:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:48 INFO - 'XPC_FLAGS': '0x0', 03:57:48 INFO - 'XPC_SERVICE_NAME': '0', 03:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:48 INFO - Downloading/unpacking blobuploader==1.2.4 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:52 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 03:57:52 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 03:57:52 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 03:57:52 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 03:57:52 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 03:57:52 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 03:57:53 INFO - Downloading docopt-0.6.1.tar.gz 03:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:53 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:53 INFO - Running setup.py install for blobuploader 03:57:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:53 INFO - Running setup.py install for requests 03:57:53 INFO - Running setup.py install for docopt 03:57:53 INFO - Successfully installed blobuploader requests docopt 03:57:53 INFO - Cleaning up... 03:57:53 INFO - Return code: 0 03:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:53 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')]} 03:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:53 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')]} 03:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:53 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:53 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 03:57:53 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 03:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:53 INFO - 'HOME': '/Users/cltbld', 03:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:53 INFO - 'LOGNAME': 'cltbld', 03:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:53 INFO - 'MOZ_NO_REMOTE': '1', 03:57:53 INFO - 'NO_EM_RESTART': '1', 03:57:53 INFO - 'PAGER': '/bin/cat', 03:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:53 INFO - 'PWD': '/builds/slave/test', 03:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:53 INFO - 'SHELL': '/bin/bash', 03:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:57:53 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:53 INFO - 'USER': 'cltbld', 03:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:54 INFO - 'XPC_FLAGS': '0x0', 03:57:54 INFO - 'XPC_SERVICE_NAME': '0', 03:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-v2xBnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-LF4cyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-BORQb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-PMYprs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-D9g9Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-mDzN4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-_UtnRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:54 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Cc48m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-pMqBr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-kgTDCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-a2P92x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-ctLXKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-ZRMiXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-aePM4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-j1Fi5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-1sjrn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:55 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-VPX2cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:56 INFO - Running setup.py install for manifestparser 03:57:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:56 INFO - Running setup.py install for mozcrash 03:57:56 INFO - Running setup.py install for mozdebug 03:57:56 INFO - Running setup.py install for mozdevice 03:57:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:56 INFO - Running setup.py install for mozfile 03:57:56 INFO - Running setup.py install for mozhttpd 03:57:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:56 INFO - Running setup.py install for mozinfo 03:57:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Running setup.py install for mozInstall 03:57:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Running setup.py install for mozleak 03:57:57 INFO - Running setup.py install for mozlog 03:57:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Running setup.py install for moznetwork 03:57:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Running setup.py install for mozprocess 03:57:57 INFO - Running setup.py install for mozprofile 03:57:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:57 INFO - Running setup.py install for mozrunner 03:57:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Running setup.py install for mozscreenshot 03:57:58 INFO - Running setup.py install for moztest 03:57:58 INFO - Running setup.py install for mozversion 03:57:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:58 INFO - Cleaning up... 03:57:58 INFO - Return code: 0 03:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:58 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:57:58 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 03:57:58 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 03:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:57:58 INFO - 'HOME': '/Users/cltbld', 03:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:57:58 INFO - 'LOGNAME': 'cltbld', 03:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:58 INFO - 'MOZ_NO_REMOTE': '1', 03:57:58 INFO - 'NO_EM_RESTART': '1', 03:57:58 INFO - 'PAGER': '/bin/cat', 03:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:58 INFO - 'PWD': '/builds/slave/test', 03:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:57:58 INFO - 'SHELL': '/bin/bash', 03:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:57:58 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:57:58 INFO - 'USER': 'cltbld', 03:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:58 INFO - 'XPC_FLAGS': '0x0', 03:57:58 INFO - 'XPC_SERVICE_NAME': '0', 03:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:58 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Kp8Nfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-NKTedH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-W4j2bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-cMxsJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-MwMAPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-uNT2oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-X80iCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-S9CXER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-NVaAlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-AzuH_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:59 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)) 03:57:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:59 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-MUjxaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:00 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)) 03:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-yK3g4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:00 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)) 03:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-FA9FE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:00 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)) 03:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-4_tUtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:00 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)) 03:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-h8mdwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:00 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)) 03:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-CibCQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:00 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)) 03:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:00 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-jnxI0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:00 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)) 03:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:00 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)) 03:58:00 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)) 03:58:00 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)) 03:58:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:00 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 03:58:00 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 03:58:00 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 03:58:00 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 03:58:00 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 03:58:00 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 03:58:03 INFO - Downloading blessings-1.6.tar.gz 03:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:03 INFO - Installing collected packages: blessings 03:58:03 INFO - Running setup.py install for blessings 03:58:03 INFO - Successfully installed blessings 03:58:03 INFO - Cleaning up... 03:58:03 INFO - Return code: 0 03:58:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:03 INFO - Reading from file tmpfile_stdout 03:58:03 INFO - Current package versions: 03:58:03 INFO - blessings == 1.6 03:58:03 INFO - blobuploader == 1.2.4 03:58:03 INFO - docopt == 0.6.1 03:58:03 INFO - manifestparser == 1.1 03:58:03 INFO - mozInstall == 1.12 03:58:03 INFO - mozcrash == 0.17 03:58:03 INFO - mozdebug == 0.1 03:58:03 INFO - mozdevice == 0.48 03:58:03 INFO - mozfile == 1.2 03:58:03 INFO - mozhttpd == 0.7 03:58:03 INFO - mozinfo == 0.9 03:58:03 INFO - mozleak == 0.1 03:58:03 INFO - mozlog == 3.1 03:58:03 INFO - moznetwork == 0.27 03:58:03 INFO - mozprocess == 0.22 03:58:03 INFO - mozprofile == 0.28 03:58:03 INFO - mozrunner == 6.11 03:58:03 INFO - mozscreenshot == 0.1 03:58:03 INFO - mozsystemmonitor == 0.0 03:58:03 INFO - moztest == 0.7 03:58:03 INFO - mozversion == 1.4 03:58:03 INFO - psutil == 3.1.1 03:58:03 INFO - requests == 1.2.3 03:58:03 INFO - wsgiref == 0.1.2 03:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:03 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')]} 03:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:03 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')]} 03:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:03 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:58:03 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 03:58:03 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 03:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:03 INFO - 'HOME': '/Users/cltbld', 03:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:03 INFO - 'LOGNAME': 'cltbld', 03:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:03 INFO - 'MOZ_NO_REMOTE': '1', 03:58:03 INFO - 'NO_EM_RESTART': '1', 03:58:03 INFO - 'PAGER': '/bin/cat', 03:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:03 INFO - 'PWD': '/builds/slave/test', 03:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:03 INFO - 'SHELL': '/bin/bash', 03:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:58:03 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:03 INFO - 'USER': 'cltbld', 03:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:03 INFO - 'XPC_FLAGS': '0x0', 03:58:03 INFO - 'XPC_SERVICE_NAME': '0', 03:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 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)) 03:58:03 INFO - Cleaning up... 03:58:03 INFO - Return code: 0 03:58:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58:03 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')]} 03:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:03 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')]} 03:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:03 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:58:03 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 03:58:03 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 03:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:03 INFO - 'HOME': '/Users/cltbld', 03:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:03 INFO - 'LOGNAME': 'cltbld', 03:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:03 INFO - 'MOZ_NO_REMOTE': '1', 03:58:03 INFO - 'NO_EM_RESTART': '1', 03:58:03 INFO - 'PAGER': '/bin/cat', 03:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:03 INFO - 'PWD': '/builds/slave/test', 03:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:03 INFO - 'SHELL': '/bin/bash', 03:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:58:03 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:03 INFO - 'USER': 'cltbld', 03:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:03 INFO - 'XPC_FLAGS': '0x0', 03:58:03 INFO - 'XPC_SERVICE_NAME': '0', 03:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:04 INFO - Downloading/unpacking jsonschema 03:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:58:06 INFO - Downloading/unpacking functools32 (from jsonschema) 03:58:06 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 03:58:06 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 03:58:06 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 03:58:06 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 03:58:06 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 03:58:06 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 03:58:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:58:07 INFO - warning: no files found matching '*.txt' 03:58:07 INFO - no previously-included directories found matching 'build' 03:58:07 INFO - no previously-included directories found matching 'dist' 03:58:07 INFO - no previously-included directories found matching '.git*' 03:58:07 INFO - Installing collected packages: jsonschema, functools32 03:58:07 INFO - Running setup.py install for functools32 03:58:07 INFO - warning: no files found matching '*.txt' 03:58:07 INFO - no previously-included directories found matching 'build' 03:58:07 INFO - no previously-included directories found matching 'dist' 03:58:07 INFO - no previously-included directories found matching '.git*' 03:58:07 INFO - Successfully installed jsonschema functools32 03:58:07 INFO - Cleaning up... 03:58:07 INFO - Return code: 0 03:58:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:07 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 0x10c7c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd920d8ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, '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.Apyib3ZBvW/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.DElTyfLl5O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 03:58:07 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 03:58:07 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 03:58:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:58:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:07 INFO - 'HOME': '/Users/cltbld', 03:58:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:07 INFO - 'LOGNAME': 'cltbld', 03:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:07 INFO - 'MOZ_NO_REMOTE': '1', 03:58:07 INFO - 'NO_EM_RESTART': '1', 03:58:07 INFO - 'PAGER': '/bin/cat', 03:58:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:07 INFO - 'PWD': '/builds/slave/test', 03:58:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:07 INFO - 'SHELL': '/bin/bash', 03:58:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:58:07 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:58:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:07 INFO - 'USER': 'cltbld', 03:58:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:07 INFO - 'XPC_FLAGS': '0x0', 03:58:07 INFO - 'XPC_SERVICE_NAME': '0', 03:58:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:08 INFO - Downloading/unpacking flake8 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58: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 03:58:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:58:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:58:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 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 03:58:11 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 03:58:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:58:12 INFO - no previously-included directories found matching 'docs/_build' 03:58:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:58:12 INFO - Running setup.py install for pep8 03:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:58:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:58:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:58:12 INFO - no previously-included directories found matching 'docs/_build' 03:58:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:58:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:58:12 INFO - Cleaning up... 03:58:12 INFO - Return code: 0 03:58:12 INFO - Running post-action listener: _resource_record_post_action 03:58:12 INFO - Running post-action listener: _start_resource_monitoring 03:58:12 INFO - Starting resource monitoring. 03:58:12 INFO - ##### 03:58:12 INFO - ##### Running install step. 03:58:12 INFO - ##### 03:58:12 INFO - Running pre-action listener: _resource_record_pre_action 03:58:12 INFO - Running main action method: install 03:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:12 INFO - Reading from file tmpfile_stdout 03:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:12 INFO - Reading from file tmpfile_stdout 03:58:12 INFO - Output received: 03:58:12 INFO - Usage: mozinstall [options] installer 03:58:12 INFO - Options: 03:58:12 INFO - -h, --help show this help message and exit 03:58:12 INFO - -d DEST, --destination=DEST 03:58:12 INFO - Directory to install application into. [default: 03:58:12 INFO - "/builds/slave/test"] 03:58:12 INFO - --app=APP Application being installed. [default: firefox] 03:58:12 INFO - mkdir: /builds/slave/test/build/application 03:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:58:46 INFO - Reading from file tmpfile_stdout 03:58:46 INFO - Output received: 03:58:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:58:46 INFO - Running post-action listener: _resource_record_post_action 03:58:46 INFO - ##### 03:58:46 INFO - ##### Running run-tests step. 03:58:46 INFO - ##### 03:58:46 INFO - Running pre-action listener: _resource_record_pre_action 03:58:46 INFO - Running main action method: run_tests 03:58:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:58:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:58:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:58:46 INFO - 2016-03-29 03:58:46.493 screenresolution[1640:7378] starting screenresolution argv=screenresolution get 03:58:46 INFO - 2016-03-29 03:58:46.496 screenresolution[1640:7378] Display 0: 1600x1200x32@60 03:58:46 INFO - 2016-03-29 03:58:46.501 screenresolution[1641:7380] starting screenresolution argv=screenresolution list 03:58:46 INFO - Available Modes on Display 0 03:58:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:58:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:58:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:58:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:58:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:58:46 INFO - Intel Iris: 03:58:46 INFO - Chipset Model: Intel Iris 03:58:46 INFO - Type: GPU 03:58:46 INFO - Bus: Built-In 03:58:46 INFO - VRAM (Dynamic, Max): 1536 MB 03:58:46 INFO - Vendor: Intel (0x8086) 03:58:46 INFO - Device ID: 0x0a2e 03:58:46 INFO - Revision ID: 0x0009 03:58:46 INFO - Displays: 03:58:46 INFO - Display: 03:58:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:58:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:58:46 INFO - Display Serial Number: 1600x1200 60 03:58:46 INFO - Main Display: Yes 03:58:46 INFO - Mirror: Off 03:58:46 INFO - Online: Yes 03:58:46 INFO - Rotation: Supported 03:58:46 INFO - Return code: 0 03:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:58:46 INFO - Python 2.7.3 03:58:46 INFO - Return code: 0 03:58:46 INFO - grabbing minidump binary from tooltool 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:58:46 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 0x10c662e00>, '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 0x10c48bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c65db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:58:46 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 03:58:46 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 03:58:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:58:46 INFO - Return code: 0 03:58:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:58:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:58:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:58:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:58:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:58:48 INFO - Return code: 0 03:58:48 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/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--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 03:58:48 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/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0195 --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 03:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Apyib3ZBvW/Render', 03:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:48 INFO - 'HOME': '/Users/cltbld', 03:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:48 INFO - 'LOGNAME': 'cltbld', 03:58:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:58:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:48 INFO - 'MOZ_NO_REMOTE': '1', 03:58:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:58:48 INFO - 'NO_EM_RESTART': '1', 03:58:48 INFO - 'PAGER': '/bin/cat', 03:58:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:48 INFO - 'PWD': '/builds/slave/test', 03:58:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:48 INFO - 'SHELL': '/bin/bash', 03:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DElTyfLl5O/Listeners', 03:58:48 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 03:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:48 INFO - 'USER': 'cltbld', 03:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:48 INFO - 'XPC_FLAGS': '0x0', 03:58:48 INFO - 'XPC_SERVICE_NAME': '0', 03:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:48 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/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--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 03:58:48 INFO - mozversion application_buildid: 20160329025627 03:58:48 INFO - mozversion application_changeset: a7031fdd9cb9952d03721942ef8b0639bd144b6d 03:58:48 INFO - mozversion application_display_name: Nightly 03:58:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:58:48 INFO - mozversion application_name: Firefox 03:58:48 INFO - mozversion application_remotingname: firefox 03:58:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:58:48 INFO - mozversion application_vendor: Mozilla 03:58:48 INFO - mozversion application_version: 48.0a1 03:58:48 INFO - mozversion platform_buildid: 20160329025627 03:58:48 INFO - mozversion platform_changeset: a7031fdd9cb9952d03721942ef8b0639bd144b6d 03:58:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:58:48 INFO - mozversion platform_version: 48.0a1 03:58:48 INFO - using testdate: 1459249128 03:58:48 INFO - actual date: 1459249128 03:58:48 INFO - starting webserver on 'localhost:49278' 03:58:48 INFO - SUITE-START | Running 2 tests 03:58:48 INFO - TEST-START | dromaeo_css 03:58:48 INFO - operating with platform_type : mac_ 03:58:48 INFO - Initialising browser for dromaeo_css test... 03:58:48 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpoHfW4X/profile http://localhost:49278/getInfo.html) 03:58:50 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 03:58:50 INFO - PROCESS | 1659 | colorDepth:24 03:58:50 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 03:58:50 INFO - PROCESS | 1659 | __metrics 03:58:50 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:58:50 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:58:51 INFO - TEST-INFO | 1659: exit 0 03:58:51 INFO - Browser initialized. 03:58:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:51 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpoHfW4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:03 INFO - PROCESS | 1662 | RSS: Main: 244121600 03:59:03 INFO - PROCESS | 1662 | 03:59:54 INFO - PROCESS | 1662 | 1459249194706 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] 04:02:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 04:02:06 INFO - PROCESS | 1662 | RSS: Main: 330092544 04:02:06 INFO - PROCESS | 1662 | 04:05:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 04:05:09 INFO - PROCESS | 1662 | RSS: Main: 372871168 04:05:09 INFO - PROCESS | 1662 | 04:08:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 04:08:12 INFO - PROCESS | 1662 | RSS: Main: 372527104 04:08:12 INFO - PROCESS | 1662 | 04:11:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 04:11:15 INFO - PROCESS | 1662 | RSS: Main: 336052224 04:11:15 INFO - PROCESS | 1662 | 04:14:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 04:14:18 INFO - PROCESS | 1662 | RSS: Main: 336437248 04:14:18 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 04:17:21 INFO - PROCESS | 1662 | RSS: Main: 412450816 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | __start_tp_report 04:17:21 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 04:17:21 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 04:17:21 INFO - PROCESS | 1662 | |i|pagename|runs| 04:17:21 INFO - PROCESS | 1662 | |0;dojo.html;3435.6220815710276;3471.79169249845;3513.6662017108397;3528.7649322737047;3555.768875023123;5569.805056823012;5639.6334238274485;5643.943560564393;5662.462066103719;5664.376918538957;5525.972370138154;5650.802221922234;5793.420657934204;5814.592978491507;5823;5079.187330027196;5114.181730923053;5139.588832893378;5160.716160611165;5270;5249.842504724846;5291.31212942317;5301.840944771663;5311.49540793624;5357.464253574651;5081.187010078388;5111.08000559899;5185.688858668492;5200.115980283361;5226.895462090775;5153.175491921312;5165.070287348276;5175.637705360627;5179.430262671103;5215.687058776485;5098.97450512745;5132.820351287724;5177.301064356301;5179.04187725272;5180.870478238036;5492.395836457987;5547.278853749027;5566.359868615121;5608.49523542879;5630.09918413056;6185.721642526097;6192.9071063933625;6193.659348735818;6198.845028874269;6224.502039836802;6226.128342032119;6283.685815709242;6293.779717709904;6302.338254483305;6309.716062777186;5663.2637757091725;5733.856653583611;5746.712664366807;5779.508741756914;5786.768529258782;6322.747090116436;6329.367063293726;6331.936680633226;6349.9682501587195;6352.301246862841;5990.31111422192;6004.129401236796;6035.758569657164;6064.514838812885;6077.17958075663;6114.419130182626;6176.073588961602;6178.474829639531;6212.4408803207025;6214.5960512566535;6183.783567575113;6205.441510264098;6206.255249370014;6213.782517611952;6230.283517395467;6201.6899155042065;6221.782237621662;6237.345078766664;6237.625742455467;6238.376162383725;4742.430908291027;4836.202026665631;4873.780679869415;4881.95118048822;4917.704937703749;3736.551613806361;4372.562743725665;4439.5338489458145;4464.464264288306;4469.754163520973;4871.3667223260745;5643.943560564424;5649.406812284733;5653.406392328829;5710.914336284959;6252.937470625327;6258.249010118815;6269.279032911274;6282.371762823773;6283.2460104787715;5522.9447705523235;5597.608167428322;5634.295713035871;5637.971810141005;5663.80176693822;5260.947390526122;5322.068637988414;5326.227696983916;5344.4922732340365;5375.139977603565;6299.212598425197;6317.147185130132;6322.525810564226;6326.557141000086;6336.271328797247;6082.118092876596;6208.379162083756;6293.748250070129;6295.150154729053;6312.936870631235;6250.780972754606;6287.088372185916;6308.653024083719;6335.746570137328;6338.65137417428;6163.445289923929;6184.134221208944;6196.380361963767;6202.534809889186;6214.285357183981;6131.110988906495;6199.876002480015;6299.685015749286;6311.779087732091;6320.146780184617;6008.519318454426;6016.037434010537;6079.513638908788;6110.2550082019825;6129.725578588854;5978.491828194652;6069.02895536712;6091.969540152448;6099.786507472217;6127.264728232641;4902.7058376497525;5923.200367950271;5929.584929054925;5931.851703707269;5932.881342373042;5813.418658134153;5839.153322768259;5869.236999190078;5949.583529152917;5974.790882319098;5740.799072032459;5746.281714785652;5773.076307790733;5786.594938354275;5787.102999035156 04:17:21 INFO - PROCESS | 1662 | |1;ext.html;487.5952959043994;516.4238130891358;575.9424057594241;636.2841802971657;643.1349834472634;38213.42679859804;38609.613903860954;38661;38693.64572239972;38695;41617.583824161746;42131.94670133248;42202.155956880844;42223.57776422235;42386.364204536876;9417.24662027038;9655.082767137146;9657.372270802376;9659.227261819073;9659.420434773901;9537.28470364722;9685.515724213796;9686.951565242163;9704.466254356008;9723.319367644268;9713.757156071119;9719.46542940138;9734.951325243399;9826.606935722599;9833.262505312094;9678.612855485771;9782.755431114208;9788;9788.706338809847;9793;8963.551822408854;9043.412178208395;9467.390543607604;9648.421094734338;9655.613775448974;39978.60021399778;40603.59396406057;40608.18783624341;40619;40864;2812.70466601006;3187.298794265258;3374.6119196292493;3409.7783644063306;3605.1167463971233;28406.857965710245;29579.471497292026;29891.103266902028;29994;30051.248718781986;2200.713907192071;2761.8066735328534;2805.9158225253277;2858.3282928511785;2952.498075327178;477272;479217;480868;481308;481638;64439.03341449882;64872.35127648758;64943.02585461222;65017;65094.349056509775;67431.66284168646;67664.3083922906;67673.6616316925;67758.3224167752;67862.32137678658;15822.841771582367;17473.03898285581;17637.294508219784;17664.55838604045;17668.911655441898;11953.103517236243;12022.098342624338;12038.458269377725;12043.397830108459;13176.209427434385;15090.055299823967;19681.901590491954;19786.90106549458;20203.898980505004;20243.493912652008;8356.373272004625;8432.45189062709;8460.027096883938;8497.107803680525;8497.532635704973;926.2266007883358;935.8502639577634;1017.9338343007681;1092.7268182954263;1133.9659810205708;26152.476950461263;27906.14060931693;28574.714252857622;29493.852530737637;30329.545056824165;999.8900120986685;1046.8691413573304;1141.7716456708692;1145.5990403358758;1168.3982748884332;14642.487512936996;14657.04729192599;14847.109173449628;14943.551693448997;15034.323455444532;538901.30549347;544044;544448;545446;546147;58972;59502.512437188554;59523.40476595179;59554.702226489455;59618.70190649106;1315.1845855569418;1336.6190635668788;1426.557767092184;1428.5857101440465;1478.0466599043557;28478.715212848434;28480.85759571189;29118.98083567065;29219.561706574845;29295.414091718474;45371.319430207914;45836.85407864697;45934.08131837411;45973.31040034469;45979.54020459887;294316;296491;296553;296713;296726;27450.588241176;32340.83829580837;32938.83530582332;33040;33051;41042.79478602588;41669.58330416657;41820.372694409;42056.57943420527;42882;29688.406231875673;33554.832225839695;36050.819745901106;36093;37031.889043328745;29110.27224319324;31569.684303156675;34496.827515862264;35750.8212458936;37021.62978370182;35350.93947181589;35667.64332356643;35868;36147.819260903525;36550.63449365579;25396.619050714624;31708.682913171495;31871.203219919687;31927.521087184174;31953.68046319507;22004.559908801413;23623.40941476477;24005.27984160478;24132.517349652557;24399.39001524976 04:17:21 INFO - PROCESS | 1662 | |2;jquery.html;362.72070505710604;365.6252341350115;369.33335329729834;371.82524213619604;376.7362846007795;19156.90421547892;19382.86788453269;20052.799472005274;20078.397648070564;20093.397198084043;19770.505737356572;20259.784412935234;20504.66719663221;20570.971451427442;20590.279340223096;5528.778848846051;5789.305283366002;5837.09525023622;5840.328362238333;5848.853778655525;4062.0657248832786;4329.112531930962;6047.123167140762;6516.674166291667;6536.869262614745;6192.876142477147;6449.967750161242;6473.093766872642;6481;6502.284748677642;5236.947630523684;5419.918701219485;6082.543809214305;6184.103305020792;6186.7215975281;3735.290294843971;5333.679979201261;5577.52591029763;5581.888362232733;5591.720413979285;24663.533646635373;25040.248792536255;25560.744392556022;25835.74164258352;25907;2107.610092132945;2180.509385388291;2288.416453804269;2311.56080344734;2372;14163.008589398747;14238.501652442219;14268.215248161347;14803.111813291236;15153.318100685496;1721.9483415497555;1748.6764948484572;1760.119940029985;1807.9367222147293;1824.507383006594;101790.49104754429;102583.97416025819;103600.48199758952;104909;105069.47465262702;9261.703361529391;10163.542640581192;10296.27148805567;10849.891501085045;10887.183461240438;13455.192688438725;13516.729665406834;13519;13555.525556605471;13558.728825423435;8365.874511882326;8431.662733490715;8444.788880278042;8556.700515481929;8557.358198135165;7234.6382680865745;8722.433041852259;8965.417247878868;9129.726108216764;9134.314926380548;6161.4146656067605;6290.55966082379;6290.716917738621;6294.905576416358;6383.170187875639;1681.8486336229798;1750.291132091505;1788.0880750817178;1814.4919422561704;1830.7620009398693;918.6141820435433;987.4917709019154;1021.2748948246827;1086.364476781076;1124.1512657943201;20085.799142008684;20695.58608827815;20797.58404831895;21054.578908421747;21459.67810482844;984.8965858584745;996.2826764729383;1036.4921188617675;1043.801677681238;1044.0968562193648;8990.685326013558;11023.387752673016;11452.141089418326;11475.409836065626;11621.825672614917;575598;605024;620610;621263;626188;84804.57597712096;89316.78067730762;113145.86854131518;114658.28012579818;116419;989.8663680403198;1027.1782573940966;1027.4143738069229;1027.5941003303803;1027.7893031928436;16445.177741113137;18776.81223187805;19118.617627647647;19280.517987049876;19793.80206197977;47396.7630161847;48076.27885581789;48311.516884832105;48333.5166648329;48344.79138021578;60090.39909600848;60665.786684266954;65491.67254163699;65532;65594.36014099685;7708.730194443167;7747.1090824555895;7808.89159926828;7928.563928983961;8135.227153420416;11060.39167845744;12012.879871201525;12561.560345387868;12959.157654752411;12981.156224845356;9676.645269662113;10185.236107291834;10834.970677785597;11179.329240245612;11318.660440186479;8211.876821847558;8835;10695.358278503314;10968.945155274492;11008.064314533354;6437.969924812008;11001;11055.391953442639;11150.442477876237;11220.775584488429;7730.690772369042;7788.6214268746;7826.295633393022;8017.559034253172;8034.718784842503;8371.372147089114;10388.896111038794;10653.57385704563;10936.617218397636;11114.888851111386 04:17:21 INFO - PROCESS | 1662 | |3;mootools.html;1403.0248976961004;1588.3646541383446;1628.7312593422087;1908.446550500355;2027.3107143571183;7899.605019749011;8509.361797865162;8693.652253909844;8697;8722.302215822734;8335.666573337074;8588.484690918549;8616.396852220347;8626.35302352323;8628.91371086289;2177.3794468576457;2427.1262345555588;2464.938376540583;2484.776370126688;2485.8632775197357;2200.8679479231296;2203.8787866667326;2207.6909232707435;2211.0381983837;2215.2468160825315;2267.2178098555974;2311.9422014449688;2345.038534200978;2348.7064116985375;2351.7295511016196;2432.04220602415;2488.50229954009;2493.3891196656846;2494.1270555305678;2497.93837619013;2329.953400931972;2338;2340.3914982104607;2343.273585188597;2490.7011158660894;8677.1756683115;8750.693725719633;8767.561621918878;8769.210771030637;8782;5380.21986811914;5491.258680078218;5503.091989821674;5532.917006244909;5535.557155427556;3530.9823450882836;3554.928901421983;3560.537130173087;3708.4993525873933;3709.7959612221316;1043.1081425381265;1049.21833234241;1057.836035414512;1065.3820783945293;1067.0396643021343;11691.298522088617;11719.999999999915;11722.179447438682;11724.062075033977;11741.295522268605;4833.468318484964;4837.22604383304;4849.927251091236;4926.605871530269;4934.9013019739405;10040.945700701468;10047.849282260771;10049.045340692623;10063.698089057194;10078.445685487222;5451.427600102012;5471.781128754885;5474.124140137559;5502.477264659851;5519.806806761744;4436.755978421218;4537.500874903758;4752.524747525289;4859.173940430135;4948.356713627206;3800.6697655820794;3879.379299312153;3879.515060617423;3921.313770090223;3951.407288906687;1164.336328292882;1287.3884904670394;1298.8831005209577;1314.7830607949581;1332.3604669758377;1366.1598117157876;1396.4553824008644;1406.5006922542555;1410.189141243789;1410.4217270918873;8062.113167551564;8215.055268644062;8220.465669731448;8225.218604232588;8227.218414250636;519.6454299040346;522.5767128625826;523.3144580599427;525.7660341148229;533.5438200338732;6195.411435913581;6212.689365531705;6255.96872015637;6270.498360131179;6275.34108918557;10317.793644127076;10645.520951557199;10771.246012779031;10789.56841726322;10790.622328218475;10000.549975251131;10240.078392944672;10461.84307235392;10550.103241224428;10688.946555267174;8133.959330203311;8144.063432705197;8213.835723285501;8291.792705182297;8292.58537073144;7755.224477552425;7807.453478256468;7818.374530037697;7827.373810095292;7892.763217103496;9284.814303713752;9424.246060315296;9424.858627120462;9655.517224138905;9666.081722236377;9697.709068727949;9753.366031207948;9803.313768036169;9846.556904939152;9947.452890091114;6775.390214880685;6987.406070484066;7341.641796267708;7471.215522370073;7556.206598307099;6337.271213810471;7862.882056769267;7890.763277101696;7911.248431399008;7927.009123859518;7197.208307086112;7289.16174639902;7302.342789149002;7403.185649578434;7445.478816483011;7049.330313620198;7126.251743566851;7215.242399547972;7230.783076507713;7324.743633972786;7528.096628404407;7633.313001829862;7634.351080158249;7636.08366995964;7671.117821450604;6893;6968.0941477607585;6972.302769722987;6972.860542789014;6984.825379365557;6858.965705171442;6996.580205187502;6998.965005174941;7000.7549735759;7016.438684905297 04:17:21 INFO - PROCESS | 1662 | |4;prototype.html;325.3980136747018;328.15500087275274;333.9048371214204;335.14036496386774;337.6184911050514;6354.8729025419525;6378.425941665249;6404.231492220934;6454.3868332508455;6478.319776423478;6321.43107120359;6340.524460665445;6341.968290158543;6353.809385718436;6359.491240700744;4530.07133537624;4635.235186194274;4666.673332866701;4674.392328997225;4792.400949881257;3997.7001724870606;4611.754826196925;4695.225287827504;4799.448063472693;4810.711357318554;4719.811207551694;4720.64595155363;4736.218523943545;4740.6918550294295;4741.359916411275;4527.705699129546;4737.976310118462;4739.73931433771;4746.620270378361;4748.19280722278;3964.5044369453817;4069.8168582413864;4075.3275709508193;4078.2862998975356;4079.5920407958965;6011;6025.15647809307;6051.667158306292;6059.39406059395;6061.515078793686;5518.392976772552;5525.861853453695;5529.087700529408;5531.917021244684;5532.917006244869;6114.724837382329;6484.994825802009;6756.02037704535;6775.186977562675;6778.322167783232;4365.279728844736;4558.088382323548;4558.430196225472;4564.406627138484;4579.862604121881;7022.824429389255;7080.575165490087;7146.857062858766;7156.177039640456;7169.318914703095;3851.345271303885;4610.377599024156;4669.2062349400685;4682.578567928903;4688.5545873142;4769.2130798417875;4769.685068877097;4774.021325628238;4856.878578035577;4870.975645121752;5527.364353099365;5533.22534845122;5548.5838562108;5548.946889650774;5550.389457159709;5882.23530940975;6766.086578311963;6809.625470599066;6821.863562728817;6823.522353435212;1605.9839401605834;1653.5535405440705;1653.84288492593;1654.8179700232965;1655.8095818980971;1063.1494804156644;1074.1836204484491;1089.3550738385095;1090.7436752363187;1098.357460885375;6121.204243448323;6235.345288744707;6268.122462855204;6283.403076707706;6289.899267628147;6955.89566156508;7110.360067593838;7130.572165670076;7141.642917854087;7153.391961683211;6353.841153971095;6354.046892965999;6356.872862542723;6359.17330747;6371.23545174582;3687.022938921188;3747.1194269346684;3750.0437388465766;3753.9061523462133;3755.2114056048536;7105.857882842314;7387.298206670358;7402.888956665654;7405.629718514053;7407.740729074564;7283.344498995116;7309.561426314438;7321.78034658961;7322.304381083789;7328.450366222554;7364.852702945911;7367;7370.041894553781;7373.188949215582;7385.113786345673;7054.6472676367;7060;7061.152661680631;7067.681954312171;7072.752453664097;6073.635581865102;6950.617716025465;6974;6981.755638552626;6986.126734158231;7300.744473943387;7363.595002274712;7372.520786148883;7390.926090739239;7394;4656.3713898623255;4664;4665.440147182359;4673.112108699336;4678.368420263357;6400.423961843457;6787.592744435349;7087.433005359456;7090.4682148840075;7100.360967512948;6403.839904002437;6632.535722499379;6852.417544508772;6854.6229957352825;6870.20992585859;6048.637081775108;6817.386435220854;6868;6869.725210991504;6879.380855723009;5425.972870135624;6695.9665201675625;6726.293739157513;6726.730930762715;6736.66316684154;5759.481646651821;6659.967705005732;6857.759978400732;6859.279775623488;6868.175818901764;5496.31296087989;6524.902126468011;6684.465242780663;6743.325667433413;6743.561668491532 04:17:21 INFO - PROCESS | 1662 | |5;yui.html;677.5866721300008;697.1425147069107;765.1392183793232;787.2639082457898;788.0779487999037;15087.849121508782;15119.773203401945;15684;15684.764728529053;15686.686266274683;14410.711785764279;14513.854861451382;14530.854691453109;14538.055026423275;14541.272936353167;752.5183882315323;768.0169383189526;898.9550522473883;939.4691999020531;941.2187884056217;927.3740225347864;944.3483996042743;944.84882418813;945.1776954049986;945.5650400815633;987.9950600247024;989.9752506187367;990.7374545745383;992.7319623701596;995.4574756757548;791.7505985614513;973.1047436358567;984.5569493727779;986.5116767200246;988.3575675810745;732.9811561928923;733.6771820399007;736.054170391045;737.797105795905;740.3928778401713;15155.469558565397;15183.62040948974;15229.238538073052;15259.160746158957;15279.61800954985;12398.56605018829;12453.626391208278;12458.190217635914;12578.68553286166;12710.682232944158;8250.46371985819;9993.500324983794;10035.899641003569;10086.445245511493;10399.688009359732;3480.4953281774256;3500.579945340778;3588.6052534221217;3752.5496940367057;3766.4538641897047;76447.61776191139;76712;77198;77319;77370.06574835618;9448.196903263162;9551.665691700757;9563.808723825485;9770.804583908282;9777.951110244545;21826.817318268048;21864.781352186594;21887.562248754937;21894.23370182036;21896.671549926763;7191.244919283505;7202.567845929261;7233.89149162763;7236.204017558064;7377.077865266841;3968.6031396860085;4030.274550580865;4033.7176397651883;4051.230266249403;4067.1255680028344;3559.857605695743;3627.782333060025;3641.7814931104217;3647.215848592565;3648.52569166012;632.4339715954195;650.7136859781775;651.5307980504028;659.5053709717712;659.9538032337787;497.9617497517644;568.9928825977996;574.5518495573459;591.3849596419675;602.421675191812;7047.612381319077;7966.2033796621035;8020.077691065486;8134.227248411392;8169.591520423955;503.7254696190512;525.5900397689732;593.9821805345847;599.3706608061605;606.4360145065043;3055.9541606875914;3840.8271627776817;3846.942295865564;3883.30100581898;3888.1245312445717;93867;94947;95519.04480955102;95556;95829.52085239529;80865;80874.38251234942;81664;81899.59050204711;82730.58634706787;59182.40817591855;60716.39283607196;69128.6543567279;70573.58852822914;72983;7701.807454813675;7748.457607967388;7763.660224289948;7787.260210280015;7814.804629884298;42184.78907605565;44594.554054460335;46359;46765.76617116893;47140.585782426584;61640;63300;67687.66156169187;67742.30644233736;70427;10958;10985;11132.610358637408;11470.197086203885;11823.822642660194;9801.558929848032;11868.643940681794;11883.643490695293;11967.76064478723;11993.520259189883;11446.255993360737;11470.025047870691;11502.712432189262;11601.709957250798;11916.285022898654;11394.601188958346;11422.086233101498;11424.143189260672;11657.825132622847;11724.28945213384;11185;11187.440627968406;11347.262427942158;11677.532898683958;11744.119191060876;9158.527908932183;9208.631654733736;9272.72181834546;9416.199623032118;9867.358621689567;8847.336449766164;9185.402948808307;9242;9318.627254909728;9323.627054917728 04:17:21 INFO - PROCESS | 1662 | __end_tp_report 04:17:21 INFO - PROCESS | 1662 | __start_cc_report 04:17:21 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1266 04:17:21 INFO - PROCESS | 1662 | __end_cc_report 04:17:21 INFO - PROCESS | 1662 | __startTimestamp1459250241759__endTimestamp 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | ------- Summary: start ------- 04:17:21 INFO - PROCESS | 1662 | Number of tests: 6 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5705.29 Median:5839.15 stddev:643.20 (11.0%) stddev-sans-first:620.04 04:17:21 INFO - PROCESS | 1662 | Values: 3435.6 3471.8 3513.7 3528.8 3555.8 5569.8 5639.6 5643.9 5662.5 5664.4 5526.0 5650.8 5793.4 5814.6 5823.0 5079.2 5114.2 5139.6 5160.7 5270.0 5249.8 5291.3 5301.8 5311.5 5357.5 5081.2 5111.1 5185.7 5200.1 5226.9 5153.2 5165.1 5175.6 5179.4 5215.7 5099.0 5132.8 5177.3 5179.0 5180.9 5492.4 5547.3 5566.4 5608.5 5630.1 6185.7 6192.9 6193.7 6198.8 6224.5 6226.1 6283.7 6293.8 6302.3 6309.7 5663.3 5733.9 5746.7 5779.5 5786.8 6322.7 6329.4 6331.9 6350.0 6352.3 5990.3 6004.1 6035.8 6064.5 6077.2 6114.4 6176.1 6178.5 6212.4 6214.6 6183.8 6205.4 6206.3 6213.8 6230.3 6201.7 6221.8 6237.3 6237.6 6238.4 4742.4 4836.2 4873.8 4882.0 4917.7 3736.6 4372.6 4439.5 4464.5 4469.8 4871.4 5643.9 5649.4 5653.4 5710.9 6252.9 6258.2 6269.3 6282.4 6283.2 5522.9 5597.6 5634.3 5638.0 5663.8 5260.9 5322.1 5326.2 5344.5 5375.1 6299.2 6317.1 6322.5 6326.6 6336.3 6082.1 6208.4 6293.7 6295.2 6312.9 6250.8 6287.1 6308.7 6335.7 6338.7 6163.4 6184.1 6196.4 6202.5 6214.3 6131.1 6199.9 6299.7 6311.8 6320.1 6008.5 6016.0 6079.5 6110.3 6129.7 5978.5 6069.0 6092.0 6099.8 6127.3 4902.7 5923.2 5929.6 5931.9 5932.9 5813.4 5839.2 5869.2 5949.6 5974.8 5740.8 5746.3 5773.1 5786.6 5787.1 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59108.78 Median:37026.76 stddev:120456.69 (325.3%) stddev-sans-first:120714.20 04:17:21 INFO - PROCESS | 1662 | Values: 487.6 516.4 575.9 636.3 643.1 38213.4 38609.6 38661.0 38693.6 38695.0 41617.6 42131.9 42202.2 42223.6 42386.4 9417.2 9655.1 9657.4 9659.2 9659.4 9537.3 9685.5 9687.0 9704.5 9723.3 9713.8 9719.5 9735.0 9826.6 9833.3 9678.6 9782.8 9788.0 9788.7 9793.0 8963.6 9043.4 9467.4 9648.4 9655.6 39978.6 40603.6 40608.2 40619.0 40864.0 2812.7 3187.3 3374.6 3409.8 3605.1 28406.9 29579.5 29891.1 29994.0 30051.2 2200.7 2761.8 2805.9 2858.3 2952.5 477272.0 479217.0 480868.0 481308.0 481638.0 64439.0 64872.4 64943.0 65017.0 65094.3 67431.7 67664.3 67673.7 67758.3 67862.3 15822.8 17473.0 17637.3 17664.6 17668.9 11953.1 12022.1 12038.5 12043.4 13176.2 15090.1 19681.9 19786.9 20203.9 20243.5 8356.4 8432.5 8460.0 8497.1 8497.5 926.2 935.9 1017.9 1092.7 1134.0 26152.5 27906.1 28574.7 29493.9 30329.5 999.9 1046.9 1141.8 1145.6 1168.4 14642.5 14657.0 14847.1 14943.6 15034.3 538901.3 544044.0 544448.0 545446.0 546147.0 58972.0 59502.5 59523.4 59554.7 59618.7 1315.2 1336.6 1426.6 1428.6 1478.0 28478.7 28480.9 29119.0 29219.6 29295.4 45371.3 45836.9 45934.1 45973.3 45979.5 294316.0 296491.0 296553.0 296713.0 296726.0 27450.6 32340.8 32938.8 33040.0 33051.0 41042.8 41669.6 41820.4 42056.6 42882.0 29688.4 33554.8 36050.8 36093.0 37031.9 29110.3 31569.7 34496.8 35750.8 37021.6 35350.9 35667.6 35868.0 36147.8 36550.6 25396.6 31708.7 31871.2 31927.5 31953.7 22004.6 23623.4 24005.3 24132.5 24399.4 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33700.57 Median:13517.77 stddev:100720.29 (745.1%) stddev-sans-first:100971.73 04:17:21 INFO - PROCESS | 1662 | Values: 362.7 365.6 369.3 371.8 376.7 19156.9 19382.9 20052.8 20078.4 20093.4 19770.5 20259.8 20504.7 20571.0 20590.3 5528.8 5789.3 5837.1 5840.3 5848.9 4062.1 4329.1 6047.1 6516.7 6536.9 6192.9 6450.0 6473.1 6481.0 6502.3 5236.9 5419.9 6082.5 6184.1 6186.7 3735.3 5333.7 5577.5 5581.9 5591.7 24663.5 25040.2 25560.7 25835.7 25907.0 2107.6 2180.5 2288.4 2311.6 2372.0 14163.0 14238.5 14268.2 14803.1 15153.3 1721.9 1748.7 1760.1 1807.9 1824.5 101790.5 102584.0 103600.5 104909.0 105069.5 9261.7 10163.5 10296.3 10849.9 10887.2 13455.2 13516.7 13519.0 13555.5 13558.7 8365.9 8431.7 8444.8 8556.7 8557.4 7234.6 8722.4 8965.4 9129.7 9134.3 6161.4 6290.6 6290.7 6294.9 6383.2 1681.8 1750.3 1788.1 1814.5 1830.8 918.6 987.5 1021.3 1086.4 1124.2 20085.8 20695.6 20797.6 21054.6 21459.7 984.9 996.3 1036.5 1043.8 1044.1 8990.7 11023.4 11452.1 11475.4 11621.8 575598.0 605024.0 620610.0 621263.0 626188.0 84804.6 89316.8 113145.9 114658.3 116419.0 989.9 1027.2 1027.4 1027.6 1027.8 16445.2 18776.8 19118.6 19280.5 19793.8 47396.8 48076.3 48311.5 48333.5 48344.8 60090.4 60665.8 65491.7 65532.0 65594.4 7708.7 7747.1 7808.9 7928.6 8135.2 11060.4 12012.9 12561.6 12959.2 12981.2 9676.6 10185.2 10835.0 11179.3 11318.7 8211.9 8835.0 10695.4 10968.9 11008.1 6438.0 11001.0 11055.4 11150.4 11220.8 7730.7 7788.6 7826.3 8017.6 8034.7 8371.4 10388.9 10653.6 10936.6 11114.9 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5975.17 Median:5415.82 stddev:3167.22 (58.5%) stddev-sans-first:3157.46 04:17:21 INFO - PROCESS | 1662 | Values: 1403.0 1588.4 1628.7 1908.4 2027.3 7899.6 8509.4 8693.7 8697.0 8722.3 8335.7 8588.5 8616.4 8626.4 8628.9 2177.4 2427.1 2464.9 2484.8 2485.9 2200.9 2203.9 2207.7 2211.0 2215.2 2267.2 2311.9 2345.0 2348.7 2351.7 2432.0 2488.5 2493.4 2494.1 2497.9 2330.0 2338.0 2340.4 2343.3 2490.7 8677.2 8750.7 8767.6 8769.2 8782.0 5380.2 5491.3 5503.1 5532.9 5535.6 3531.0 3554.9 3560.5 3708.5 3709.8 1043.1 1049.2 1057.8 1065.4 1067.0 11691.3 11720.0 11722.2 11724.1 11741.3 4833.5 4837.2 4849.9 4926.6 4934.9 10040.9 10047.8 10049.0 10063.7 10078.4 5451.4 5471.8 5474.1 5502.5 5519.8 4436.8 4537.5 4752.5 4859.2 4948.4 3800.7 3879.4 3879.5 3921.3 3951.4 1164.3 1287.4 1298.9 1314.8 1332.4 1366.2 1396.5 1406.5 1410.2 1410.4 8062.1 8215.1 8220.5 8225.2 8227.2 519.6 522.6 523.3 525.8 533.5 6195.4 6212.7 6256.0 6270.5 6275.3 10317.8 10645.5 10771.2 10789.6 10790.6 10000.5 10240.1 10461.8 10550.1 10688.9 8134.0 8144.1 8213.8 8291.8 8292.6 7755.2 7807.5 7818.4 7827.4 7892.8 9284.8 9424.2 9424.9 9655.5 9666.1 9697.7 9753.4 9803.3 9846.6 9947.5 6775.4 6987.4 7341.6 7471.2 7556.2 6337.3 7862.9 7890.8 7911.2 7927.0 7197.2 7289.2 7302.3 7403.2 7445.5 7049.3 7126.3 7215.2 7230.8 7324.7 7528.1 7633.3 7634.4 7636.1 7671.1 6893.0 6968.1 6972.3 6972.9 6984.8 6859.0 6996.6 6999.0 7000.8 7016.4 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5582.59 Median:6286.65 stddev:1751.20 (27.9%) stddev-sans-first:1711.08 04:17:21 INFO - PROCESS | 1662 | Values: 325.4 328.2 333.9 335.1 337.6 6354.9 6378.4 6404.2 6454.4 6478.3 6321.4 6340.5 6342.0 6353.8 6359.5 4530.1 4635.2 4666.7 4674.4 4792.4 3997.7 4611.8 4695.2 4799.4 4810.7 4719.8 4720.6 4736.2 4740.7 4741.4 4527.7 4738.0 4739.7 4746.6 4748.2 3964.5 4069.8 4075.3 4078.3 4079.6 6011.0 6025.2 6051.7 6059.4 6061.5 5518.4 5525.9 5529.1 5531.9 5532.9 6114.7 6485.0 6756.0 6775.2 6778.3 4365.3 4558.1 4558.4 4564.4 4579.9 7022.8 7080.6 7146.9 7156.2 7169.3 3851.3 4610.4 4669.2 4682.6 4688.6 4769.2 4769.7 4774.0 4856.9 4871.0 5527.4 5533.2 5548.6 5548.9 5550.4 5882.2 6766.1 6809.6 6821.9 6823.5 1606.0 1653.6 1653.8 1654.8 1655.8 1063.1 1074.2 1089.4 1090.7 1098.4 6121.2 6235.3 6268.1 6283.4 6289.9 6955.9 7110.4 7130.6 7141.6 7153.4 6353.8 6354.0 6356.9 6359.2 6371.2 3687.0 3747.1 3750.0 3753.9 3755.2 7105.9 7387.3 7402.9 7405.6 7407.7 7283.3 7309.6 7321.8 7322.3 7328.5 7364.9 7367.0 7370.0 7373.2 7385.1 7054.6 7060.0 7061.2 7067.7 7072.8 6073.6 6950.6 6974.0 6981.8 6986.1 7300.7 7363.6 7372.5 7390.9 7394.0 4656.4 4664.0 4665.4 4673.1 4678.4 6400.4 6787.6 7087.4 7090.5 7100.4 6403.8 6632.5 6852.4 6854.6 6870.2 6048.6 6817.4 6868.0 6869.7 6879.4 5426.0 6696.0 6726.3 6726.7 6736.7 5759.5 6660.0 6857.8 6859.3 6868.2 5496.3 6524.9 6684.5 6743.3 6743.6 04:17:21 INFO - PROCESS | 1662 | 04:17:21 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18098.23 Median:31966.22 stddev:25528.81 (79.9%) stddev-sans-first:25566.91 04:17:21 INFO - PROCESS | 1662 | Values: 677.6 697.1 765.1 787.3 788.1 15087.8 15119.8 15684.0 15684.8 15686.7 14410.7 14513.9 14530.9 14538.1 14541.3 752.5 768.0 899.0 939.5 941.2 927.4 944.3 944.8 945.2 945.6 988.0 990.0 990.7 992.7 995.5 791.8 973.1 984.6 986.5 988.4 733.0 733.7 736.1 737.8 740.4 15155.5 15183.6 15229.2 15259.2 15279.6 12398.6 12453.6 12458.2 12578.7 12710.7 8250.5 9993.5 10035.9 10086.4 10399.7 3480.5 3500.6 3588.6 3752.5 3766.5 76447.6 76712.0 77198.0 77319.0 77370.1 9448.2 9551.7 9563.8 9770.8 9778.0 21826.8 21864.8 21887.6 21894.2 21896.7 7191.2 7202.6 7233.9 7236.2 7377.1 3968.6 4030.3 4033.7 4051.2 4067.1 3559.9 3627.8 3641.8 3647.2 3648.5 632.4 650.7 651.5 659.5 660.0 498.0 569.0 574.6 591.4 602.4 7047.6 7966.2 8020.1 8134.2 8169.6 503.7 525.6 594.0 599.4 606.4 3056.0 3840.8 3846.9 3883.3 3888.1 93867.0 94947.0 95519.0 95556.0 95829.5 80865.0 80874.4 81664.0 81899.6 82730.6 59182.4 60716.4 69128.7 70573.6 72983.0 7701.8 7748.5 7763.7 7787.3 7814.8 42184.8 44594.6 46359.0 46765.8 47140.6 61640.0 63300.0 67687.7 67742.3 70427.0 10958.0 10985.0 11132.6 11470.2 11823.8 9801.6 11868.6 11883.6 11967.8 11993.5 11446.3 11470.0 11502.7 11601.7 11916.3 11394.6 11422.1 11424.1 11657.8 11724.3 11185.0 11187.4 11347.3 11677.5 11744.1 9158.5 9208.6 9272.7 9416.2 9867.4 8847.3 9185.4 9242.0 9318.6 9323.6 04:17:21 INFO - PROCESS | 1662 | -------- Summary: end -------- 04:17:21 INFO - PROCESS | 1662 | 04:17:22 INFO - TEST-INFO | 1662: exit 0 04:17:22 INFO - TEST-OK | dromaeo_css | took 1114066ms 04:17:22 INFO - TEST-START | kraken 04:17:22 INFO - operating with platform_type : mac_ 04:17:22 INFO - Initialising browser for kraken test... 04:17:22 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpLfbO8y/profile http://localhost:49278/getInfo.html) 04:17:24 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 04:17:24 INFO - PROCESS | 1671 | colorDepth:24 04:17:24 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 04:17:24 INFO - PROCESS | 1671 | __metrics 04:17:24 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:17:24 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:17:25 INFO - TEST-INFO | 1671: exit 0 04:17:25 INFO - Browser initialized. 04:17:25 INFO - Running cycle 1/1 for kraken test... 04:17:25 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpLfbO8y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:17:37 INFO - PROCESS | 1673 | RSS: Main: 244240384 04:17:37 INFO - PROCESS | 1673 | 04:17:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 04:17:40 INFO - PROCESS | 1673 | RSS: Main: 290598912 04:17:40 INFO - PROCESS | 1673 | 04:17:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 04:17:44 INFO - PROCESS | 1673 | RSS: Main: 301244416 04:17:44 INFO - PROCESS | 1673 | 04:17:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 04:17:47 INFO - PROCESS | 1673 | RSS: Main: 287416320 04:17:47 INFO - PROCESS | 1673 | 04:17:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 04:17:50 INFO - PROCESS | 1673 | RSS: Main: 290246656 04:17:50 INFO - PROCESS | 1673 | 04:17:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:53 INFO - PROCESS | 1673 | RSS: Main: 291438592 04:17:53 INFO - PROCESS | 1673 | 04:17:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:56 INFO - PROCESS | 1673 | RSS: Main: 291434496 04:17:56 INFO - PROCESS | 1673 | 04:17:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:00 INFO - PROCESS | 1673 | RSS: Main: 291483648 04:18:00 INFO - PROCESS | 1673 | 04:18:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 04:18:03 INFO - PROCESS | 1673 | RSS: Main: 291774464 04:18:03 INFO - PROCESS | 1673 | 04:18:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:05 INFO - PROCESS | 1673 | RSS: Main: 325304320 04:18:05 INFO - PROCESS | 1673 | 04:18:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:07 INFO - PROCESS | 1673 | RSS: Main: 326004736 04:18:07 INFO - PROCESS | 1673 | 04:18:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:10 INFO - PROCESS | 1673 | RSS: Main: 330776576 04:18:10 INFO - PROCESS | 1673 | 04:18:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:13 INFO - PROCESS | 1673 | RSS: Main: 332357632 04:18:13 INFO - PROCESS | 1673 | 04:18:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:16 INFO - PROCESS | 1673 | RSS: Main: 332619776 04:18:16 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 04:18:18 INFO - PROCESS | 1673 | RSS: Main: 395886592 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | __start_tp_report 04:18:18 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 04:18:18 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 04:18:18 INFO - PROCESS | 1673 | |i|pagename|runs| 04:18:18 INFO - PROCESS | 1673 | |0;ai-astar;111;108;110;111;112;111;117;111;110;110 04:18:18 INFO - PROCESS | 1673 | |1;audio-beat-detection;158;146;175;193;143;142;140;119;163;118 04:18:18 INFO - PROCESS | 1673 | |2;audio-dft;184;184;186;188;188;184;183;185;183;187 04:18:18 INFO - PROCESS | 1673 | |3;audio-fft;77;75;83;83;75;83;85;108;80;57 04:18:18 INFO - PROCESS | 1673 | |4;audio-oscillator;95;92;126;80;82;84;111;87;114;153 04:18:18 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;88;85;132;86;86;84;87;84;87;84 04:18:18 INFO - PROCESS | 1673 | |6;imaging-darkroom;93;94;93;93;92;93;92;94;92;93 04:18:18 INFO - PROCESS | 1673 | |7;imaging-desaturate;88;87;88;87;83;87;86;87;87;86 04:18:18 INFO - PROCESS | 1673 | |8;json-parse-financial;54;55;55;53;53;54;55;66;54;53 04:18:18 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;63;62;70;78;70;68;66;67;68;67 04:18:18 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;83;82;84;83;83;82;84;82;81;85 04:18:18 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;134;116;127;135;131;135;123;122;122;132 04:18:18 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;170;133;141;141;142;131;142;140;142;141 04:18:18 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;66;67;69;69;69;68;66;68;68 04:18:18 INFO - PROCESS | 1673 | __end_tp_report 04:18:18 INFO - PROCESS | 1673 | __start_cc_report 04:18:18 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1245 04:18:18 INFO - PROCESS | 1673 | __end_cc_report 04:18:18 INFO - PROCESS | 1673 | __startTimestamp1459250298894__endTimestamp 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | ------- Summary: start ------- 04:18:18 INFO - PROCESS | 1673 | Number of tests: 14 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.33 (2.1%) stddev-sans-first:2.47 04:18:18 INFO - PROCESS | 1673 | Values: 111.0 108.0 110.0 111.0 112.0 111.0 117.0 111.0 110.0 110.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:152.00 stddev:23.38 (15.4%) stddev-sans-first:24.61 04:18:18 INFO - PROCESS | 1673 | Values: 158.0 146.0 175.0 193.0 143.0 142.0 140.0 119.0 163.0 118.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:1.93 (1.0%) stddev-sans-first:2.00 04:18:18 INFO - PROCESS | 1673 | Values: 184.0 184.0 186.0 188.0 188.0 184.0 183.0 185.0 183.0 187.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:80.60 Median:81.50 stddev:12.56 (15.4%) stddev-sans-first:13.26 04:18:18 INFO - PROCESS | 1673 | Values: 77.0 75.0 83.0 83.0 75.0 83.0 85.0 108.0 80.0 57.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:83.00 stddev:23.53 (28.3%) stddev-sans-first:24.80 04:18:18 INFO - PROCESS | 1673 | Values: 95.0 92.0 126.0 80.0 82.0 84.0 111.0 87.0 114.0 153.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:86.00 stddev:14.72 (17.1%) stddev-sans-first:15.59 04:18:18 INFO - PROCESS | 1673 | Values: 88.0 85.0 132.0 86.0 86.0 84.0 87.0 84.0 87.0 84.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 04:18:18 INFO - PROCESS | 1673 | Values: 93.0 94.0 93.0 93.0 92.0 93.0 92.0 94.0 92.0 93.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.43 (1.6%) stddev-sans-first:1.42 04:18:18 INFO - PROCESS | 1673 | Values: 88.0 87.0 88.0 87.0 83.0 87.0 86.0 87.0 87.0 86.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.88 (7.1%) stddev-sans-first:4.09 04:18:18 INFO - PROCESS | 1673 | Values: 54.0 55.0 55.0 53.0 53.0 54.0 55.0 66.0 54.0 53.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:4.41 (6.5%) stddev-sans-first:4.30 04:18:18 INFO - PROCESS | 1673 | Values: 63.0 62.0 70.0 78.0 70.0 68.0 66.0 67.0 68.0 67.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.20 (1.4%) stddev-sans-first:1.27 04:18:18 INFO - PROCESS | 1673 | Values: 83.0 82.0 84.0 83.0 83.0 82.0 84.0 82.0 81.0 85.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:131.50 stddev:6.67 (5.1%) stddev-sans-first:6.67 04:18:18 INFO - PROCESS | 1673 | Values: 134.0 116.0 127.0 135.0 131.0 135.0 123.0 122.0 122.0 132.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:141.50 stddev:10.50 (7.4%) stddev-sans-first:4.18 04:18:18 INFO - PROCESS | 1673 | Values: 170.0 133.0 141.0 141.0 142.0 131.0 142.0 140.0 142.0 141.0 04:18:18 INFO - PROCESS | 1673 | 04:18:18 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.20 04:18:18 INFO - PROCESS | 1673 | Values: 69.0 66.0 67.0 69.0 69.0 69.0 68.0 66.0 68.0 68.0 04:18:18 INFO - PROCESS | 1673 | -------- Summary: end -------- 04:18:18 INFO - PROCESS | 1673 | 04:18:19 INFO - TEST-INFO | 1673: exit 0 04:18:19 INFO - TEST-OK | kraken | took 57321ms 04:18:19 INFO - SUITE-END | took 1171s 04:18:20 INFO - Completed test suite (00:19:31) 04:18:20 INFO - javascript benchmark 04:18:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3435.6220815710276, 3471.79169249845, 3513.6662017108397, 3528.7649322737047, 3555.768875023123, 5569.805056823012, 5639.6334238274485, 5643.943560564393, 5662.462066103719, 5664.376918538957, 5525.972370138154, 5650.802221922234, 5793.420657934204, 5814.592978491507, 5823.0, 5079.187330027196, 5114.181730923053, 5139.588832893378, 5160.716160611165, 5270.0, 5249.842504724846, 5291.31212942317, 5301.840944771663, 5311.49540793624, 5357.464253574651, 5081.187010078388, 5111.08000559899, 5185.688858668492, 5200.115980283361, 5226.895462090775, 5153.175491921312, 5165.070287348276, 5175.637705360627, 5179.430262671103, 5215.687058776485, 5098.97450512745, 5132.820351287724, 5177.301064356301, 5179.04187725272, 5180.870478238036, 5492.395836457987, 5547.278853749027, 5566.359868615121, 5608.49523542879, 5630.09918413056, 6185.721642526097, 6192.9071063933625, 6193.659348735818, 6198.845028874269, 6224.502039836802, 6226.128342032119, 6283.685815709242, 6293.779717709904, 6302.338254483305, 6309.716062777186, 5663.2637757091725, 5733.856653583611, 5746.712664366807, 5779.508741756914, 5786.768529258782, 6322.747090116436, 6329.367063293726, 6331.936680633226, 6349.9682501587195, 6352.301246862841, 5990.31111422192, 6004.129401236796, 6035.758569657164, 6064.514838812885, 6077.17958075663, 6114.419130182626, 6176.073588961602, 6178.474829639531, 6212.4408803207025, 6214.5960512566535, 6183.783567575113, 6205.441510264098, 6206.255249370014, 6213.782517611952, 6230.283517395467, 6201.6899155042065, 6221.782237621662, 6237.345078766664, 6237.625742455467, 6238.376162383725, 4742.430908291027, 4836.202026665631, 4873.780679869415, 4881.95118048822, 4917.704937703749, 3736.551613806361, 4372.562743725665, 4439.5338489458145, 4464.464264288306, 4469.754163520973, 4871.3667223260745, 5643.943560564424, 5649.406812284733, 5653.406392328829, 5710.914336284959, 6252.937470625327, 6258.249010118815, 6269.279032911274, 6282.371762823773, 6283.2460104787715, 5522.9447705523235, 5597.608167428322, 5634.295713035871, 5637.971810141005, 5663.80176693822, 5260.947390526122, 5322.068637988414, 5326.227696983916, 5344.4922732340365, 5375.139977603565, 6299.212598425197, 6317.147185130132, 6322.525810564226, 6326.557141000086, 6336.271328797247, 6082.118092876596, 6208.379162083756, 6293.748250070129, 6295.150154729053, 6312.936870631235, 6250.780972754606, 6287.088372185916, 6308.653024083719, 6335.746570137328, 6338.65137417428, 6163.445289923929, 6184.134221208944, 6196.380361963767, 6202.534809889186, 6214.285357183981, 6131.110988906495, 6199.876002480015, 6299.685015749286, 6311.779087732091, 6320.146780184617, 6008.519318454426, 6016.037434010537, 6079.513638908788, 6110.2550082019825, 6129.725578588854, 5978.491828194652, 6069.02895536712, 6091.969540152448, 6099.786507472217, 6127.264728232641, 4902.7058376497525, 5923.200367950271, 5929.584929054925, 5931.851703707269, 5932.881342373042, 5813.418658134153, 5839.153322768259, 5869.236999190078, 5949.583529152917, 5974.790882319098, 5740.799072032459, 5746.281714785652, 5773.076307790733, 5786.594938354275, 5787.102999035156], "unit": "score", "name": "dojo.html", "value": 5664.860328831535}, {"lowerIsBetter": false, "replicates": [487.5952959043994, 516.4238130891358, 575.9424057594241, 636.2841802971657, 643.1349834472634, 38213.42679859804, 38609.613903860954, 38661.0, 38693.64572239972, 38695.0, 41617.583824161746, 42131.94670133248, 42202.155956880844, 42223.57776422235, 42386.364204536876, 9417.24662027038, 9655.082767137146, 9657.372270802376, 9659.227261819073, 9659.420434773901, 9537.28470364722, 9685.515724213796, 9686.951565242163, 9704.466254356008, 9723.319367644268, 9713.757156071119, 9719.46542940138, 9734.951325243399, 9826.606935722599, 9833.262505312094, 9678.612855485771, 9782.755431114208, 9788.0, 9788.706338809847, 9793.0, 8963.551822408854, 9043.412178208395, 9467.390543607604, 9648.421094734338, 9655.613775448974, 39978.60021399778, 40603.59396406057, 40608.18783624341, 40619.0, 40864.0, 2812.70466601006, 3187.298794265258, 3374.6119196292493, 3409.7783644063306, 3605.1167463971233, 28406.857965710245, 29579.471497292026, 29891.103266902028, 29994.0, 30051.248718781986, 2200.713907192071, 2761.8066735328534, 2805.9158225253277, 2858.3282928511785, 2952.498075327178, 477272.0, 479217.0, 480868.0, 481308.0, 481638.0, 64439.03341449882, 64872.35127648758, 64943.02585461222, 65017.0, 65094.349056509775, 67431.66284168646, 67664.3083922906, 67673.6616316925, 67758.3224167752, 67862.32137678658, 15822.841771582367, 17473.03898285581, 17637.294508219784, 17664.55838604045, 17668.911655441898, 11953.103517236243, 12022.098342624338, 12038.458269377725, 12043.397830108459, 13176.209427434385, 15090.055299823967, 19681.901590491954, 19786.90106549458, 20203.898980505004, 20243.493912652008, 8356.373272004625, 8432.45189062709, 8460.027096883938, 8497.107803680525, 8497.532635704973, 926.2266007883358, 935.8502639577634, 1017.9338343007681, 1092.7268182954263, 1133.9659810205708, 26152.476950461263, 27906.14060931693, 28574.714252857622, 29493.852530737637, 30329.545056824165, 999.8900120986685, 1046.8691413573304, 1141.7716456708692, 1145.5990403358758, 1168.3982748884332, 14642.487512936996, 14657.04729192599, 14847.109173449628, 14943.551693448997, 15034.323455444532, 538901.30549347, 544044.0, 544448.0, 545446.0, 546147.0, 58972.0, 59502.512437188554, 59523.40476595179, 59554.702226489455, 59618.70190649106, 1315.1845855569418, 1336.6190635668788, 1426.557767092184, 1428.5857101440465, 1478.0466599043557, 28478.715212848434, 28480.85759571189, 29118.98083567065, 29219.561706574845, 29295.414091718474, 45371.319430207914, 45836.85407864697, 45934.08131837411, 45973.31040034469, 45979.54020459887, 294316.0, 296491.0, 296553.0, 296713.0, 296726.0, 27450.588241176, 32340.83829580837, 32938.83530582332, 33040.0, 33051.0, 41042.79478602588, 41669.58330416657, 41820.372694409, 42056.57943420527, 42882.0, 29688.406231875673, 33554.832225839695, 36050.819745901106, 36093.0, 37031.889043328745, 29110.27224319324, 31569.684303156675, 34496.827515862264, 35750.8212458936, 37021.62978370182, 35350.93947181589, 35667.64332356643, 35868.0, 36147.819260903525, 36550.63449365579, 25396.619050714624, 31708.682913171495, 31871.203219919687, 31927.521087184174, 31953.68046319507, 22004.559908801413, 23623.40941476477, 24005.27984160478, 24132.517349652557, 24399.39001524976], "unit": "score", "name": "ext.html", "value": 19322.289005580802}, {"lowerIsBetter": false, "replicates": [362.72070505710604, 365.6252341350115, 369.33335329729834, 371.82524213619604, 376.7362846007795, 19156.90421547892, 19382.86788453269, 20052.799472005274, 20078.397648070564, 20093.397198084043, 19770.505737356572, 20259.784412935234, 20504.66719663221, 20570.971451427442, 20590.279340223096, 5528.778848846051, 5789.305283366002, 5837.09525023622, 5840.328362238333, 5848.853778655525, 4062.0657248832786, 4329.112531930962, 6047.123167140762, 6516.674166291667, 6536.869262614745, 6192.876142477147, 6449.967750161242, 6473.093766872642, 6481.0, 6502.284748677642, 5236.947630523684, 5419.918701219485, 6082.543809214305, 6184.103305020792, 6186.7215975281, 3735.290294843971, 5333.679979201261, 5577.52591029763, 5581.888362232733, 5591.720413979285, 24663.533646635373, 25040.248792536255, 25560.744392556022, 25835.74164258352, 25907.0, 2107.610092132945, 2180.509385388291, 2288.416453804269, 2311.56080344734, 2372.0, 14163.008589398747, 14238.501652442219, 14268.215248161347, 14803.111813291236, 15153.318100685496, 1721.9483415497555, 1748.6764948484572, 1760.119940029985, 1807.9367222147293, 1824.507383006594, 101790.49104754429, 102583.97416025819, 103600.48199758952, 104909.0, 105069.47465262702, 9261.703361529391, 10163.542640581192, 10296.27148805567, 10849.891501085045, 10887.183461240438, 13455.192688438725, 13516.729665406834, 13519.0, 13555.525556605471, 13558.728825423435, 8365.874511882326, 8431.662733490715, 8444.788880278042, 8556.700515481929, 8557.358198135165, 7234.6382680865745, 8722.433041852259, 8965.417247878868, 9129.726108216764, 9134.314926380548, 6161.4146656067605, 6290.55966082379, 6290.716917738621, 6294.905576416358, 6383.170187875639, 1681.8486336229798, 1750.291132091505, 1788.0880750817178, 1814.4919422561704, 1830.7620009398693, 918.6141820435433, 987.4917709019154, 1021.2748948246827, 1086.364476781076, 1124.1512657943201, 20085.799142008684, 20695.58608827815, 20797.58404831895, 21054.578908421747, 21459.67810482844, 984.8965858584745, 996.2826764729383, 1036.4921188617675, 1043.801677681238, 1044.0968562193648, 8990.685326013558, 11023.387752673016, 11452.141089418326, 11475.409836065626, 11621.825672614917, 575598.0, 605024.0, 620610.0, 621263.0, 626188.0, 84804.57597712096, 89316.78067730762, 113145.86854131518, 114658.28012579818, 116419.0, 989.8663680403198, 1027.1782573940966, 1027.4143738069229, 1027.5941003303803, 1027.7893031928436, 16445.177741113137, 18776.81223187805, 19118.617627647647, 19280.517987049876, 19793.80206197977, 47396.7630161847, 48076.27885581789, 48311.516884832105, 48333.5166648329, 48344.79138021578, 60090.39909600848, 60665.786684266954, 65491.67254163699, 65532.0, 65594.36014099685, 7708.730194443167, 7747.1090824555895, 7808.89159926828, 7928.563928983961, 8135.227153420416, 11060.39167845744, 12012.879871201525, 12561.560345387868, 12959.157654752411, 12981.156224845356, 9676.645269662113, 10185.236107291834, 10834.970677785597, 11179.329240245612, 11318.660440186479, 8211.876821847558, 8835.0, 10695.358278503314, 10968.945155274492, 11008.064314533354, 6437.969924812008, 11001.0, 11055.391953442639, 11150.442477876237, 11220.775584488429, 7730.690772369042, 7788.6214268746, 7826.295633393022, 8017.559034253172, 8034.718784842503, 8371.372147089114, 10388.896111038794, 10653.57385704563, 10936.617218397636, 11114.888851111386], "unit": "score", "name": "jquery.html", "value": 9421.915811382005}, {"lowerIsBetter": false, "replicates": [1403.0248976961004, 1588.3646541383446, 1628.7312593422087, 1908.446550500355, 2027.3107143571183, 7899.605019749011, 8509.361797865162, 8693.652253909844, 8697.0, 8722.302215822734, 8335.666573337074, 8588.484690918549, 8616.396852220347, 8626.35302352323, 8628.91371086289, 2177.3794468576457, 2427.1262345555588, 2464.938376540583, 2484.776370126688, 2485.8632775197357, 2200.8679479231296, 2203.8787866667326, 2207.6909232707435, 2211.0381983837, 2215.2468160825315, 2267.2178098555974, 2311.9422014449688, 2345.038534200978, 2348.7064116985375, 2351.7295511016196, 2432.04220602415, 2488.50229954009, 2493.3891196656846, 2494.1270555305678, 2497.93837619013, 2329.953400931972, 2338.0, 2340.3914982104607, 2343.273585188597, 2490.7011158660894, 8677.1756683115, 8750.693725719633, 8767.561621918878, 8769.210771030637, 8782.0, 5380.21986811914, 5491.258680078218, 5503.091989821674, 5532.917006244909, 5535.557155427556, 3530.9823450882836, 3554.928901421983, 3560.537130173087, 3708.4993525873933, 3709.7959612221316, 1043.1081425381265, 1049.21833234241, 1057.836035414512, 1065.3820783945293, 1067.0396643021343, 11691.298522088617, 11719.999999999915, 11722.179447438682, 11724.062075033977, 11741.295522268605, 4833.468318484964, 4837.22604383304, 4849.927251091236, 4926.605871530269, 4934.9013019739405, 10040.945700701468, 10047.849282260771, 10049.045340692623, 10063.698089057194, 10078.445685487222, 5451.427600102012, 5471.781128754885, 5474.124140137559, 5502.477264659851, 5519.806806761744, 4436.755978421218, 4537.500874903758, 4752.524747525289, 4859.173940430135, 4948.356713627206, 3800.6697655820794, 3879.379299312153, 3879.515060617423, 3921.313770090223, 3951.407288906687, 1164.336328292882, 1287.3884904670394, 1298.8831005209577, 1314.7830607949581, 1332.3604669758377, 1366.1598117157876, 1396.4553824008644, 1406.5006922542555, 1410.189141243789, 1410.4217270918873, 8062.113167551564, 8215.055268644062, 8220.465669731448, 8225.218604232588, 8227.218414250636, 519.6454299040346, 522.5767128625826, 523.3144580599427, 525.7660341148229, 533.5438200338732, 6195.411435913581, 6212.689365531705, 6255.96872015637, 6270.498360131179, 6275.34108918557, 10317.793644127076, 10645.520951557199, 10771.246012779031, 10789.56841726322, 10790.622328218475, 10000.549975251131, 10240.078392944672, 10461.84307235392, 10550.103241224428, 10688.946555267174, 8133.959330203311, 8144.063432705197, 8213.835723285501, 8291.792705182297, 8292.58537073144, 7755.224477552425, 7807.453478256468, 7818.374530037697, 7827.373810095292, 7892.763217103496, 9284.814303713752, 9424.246060315296, 9424.858627120462, 9655.517224138905, 9666.081722236377, 9697.709068727949, 9753.366031207948, 9803.313768036169, 9846.556904939152, 9947.452890091114, 6775.390214880685, 6987.406070484066, 7341.641796267708, 7471.215522370073, 7556.206598307099, 6337.271213810471, 7862.882056769267, 7890.763277101696, 7911.248431399008, 7927.009123859518, 7197.208307086112, 7289.16174639902, 7302.342789149002, 7403.185649578434, 7445.478816483011, 7049.330313620198, 7126.251743566851, 7215.242399547972, 7230.783076507713, 7324.743633972786, 7528.096628404407, 7633.313001829862, 7634.351080158249, 7636.08366995964, 7671.117821450604, 6893.0, 6968.0941477607585, 6972.302769722987, 6972.860542789014, 6984.825379365557, 6858.965705171442, 6996.580205187502, 6998.965005174941, 7000.7549735759, 7016.438684905297], "unit": "score", "name": "mootools.html", "value": 4796.419343672775}, {"lowerIsBetter": false, "replicates": [325.3980136747018, 328.15500087275274, 333.9048371214204, 335.14036496386774, 337.6184911050514, 6354.8729025419525, 6378.425941665249, 6404.231492220934, 6454.3868332508455, 6478.319776423478, 6321.43107120359, 6340.524460665445, 6341.968290158543, 6353.809385718436, 6359.491240700744, 4530.07133537624, 4635.235186194274, 4666.673332866701, 4674.392328997225, 4792.400949881257, 3997.7001724870606, 4611.754826196925, 4695.225287827504, 4799.448063472693, 4810.711357318554, 4719.811207551694, 4720.64595155363, 4736.218523943545, 4740.6918550294295, 4741.359916411275, 4527.705699129546, 4737.976310118462, 4739.73931433771, 4746.620270378361, 4748.19280722278, 3964.5044369453817, 4069.8168582413864, 4075.3275709508193, 4078.2862998975356, 4079.5920407958965, 6011.0, 6025.15647809307, 6051.667158306292, 6059.39406059395, 6061.515078793686, 5518.392976772552, 5525.861853453695, 5529.087700529408, 5531.917021244684, 5532.917006244869, 6114.724837382329, 6484.994825802009, 6756.02037704535, 6775.186977562675, 6778.322167783232, 4365.279728844736, 4558.088382323548, 4558.430196225472, 4564.406627138484, 4579.862604121881, 7022.824429389255, 7080.575165490087, 7146.857062858766, 7156.177039640456, 7169.318914703095, 3851.345271303885, 4610.377599024156, 4669.2062349400685, 4682.578567928903, 4688.5545873142, 4769.2130798417875, 4769.685068877097, 4774.021325628238, 4856.878578035577, 4870.975645121752, 5527.364353099365, 5533.22534845122, 5548.5838562108, 5548.946889650774, 5550.389457159709, 5882.23530940975, 6766.086578311963, 6809.625470599066, 6821.863562728817, 6823.522353435212, 1605.9839401605834, 1653.5535405440705, 1653.84288492593, 1654.8179700232965, 1655.8095818980971, 1063.1494804156644, 1074.1836204484491, 1089.3550738385095, 1090.7436752363187, 1098.357460885375, 6121.204243448323, 6235.345288744707, 6268.122462855204, 6283.403076707706, 6289.899267628147, 6955.89566156508, 7110.360067593838, 7130.572165670076, 7141.642917854087, 7153.391961683211, 6353.841153971095, 6354.046892965999, 6356.872862542723, 6359.17330747, 6371.23545174582, 3687.022938921188, 3747.1194269346684, 3750.0437388465766, 3753.9061523462133, 3755.2114056048536, 7105.857882842314, 7387.298206670358, 7402.888956665654, 7405.629718514053, 7407.740729074564, 7283.344498995116, 7309.561426314438, 7321.78034658961, 7322.304381083789, 7328.450366222554, 7364.852702945911, 7367.0, 7370.041894553781, 7373.188949215582, 7385.113786345673, 7054.6472676367, 7060.0, 7061.152661680631, 7067.681954312171, 7072.752453664097, 6073.635581865102, 6950.617716025465, 6974.0, 6981.755638552626, 6986.126734158231, 7300.744473943387, 7363.595002274712, 7372.520786148883, 7390.926090739239, 7394.0, 4656.3713898623255, 4664.0, 4665.440147182359, 4673.112108699336, 4678.368420263357, 6400.423961843457, 6787.592744435349, 7087.433005359456, 7090.4682148840075, 7100.360967512948, 6403.839904002437, 6632.535722499379, 6852.417544508772, 6854.6229957352825, 6870.20992585859, 6048.637081775108, 6817.386435220854, 6868.0, 6869.725210991504, 6879.380855723009, 5425.972870135624, 6695.9665201675625, 6726.293739157513, 6726.730930762715, 6736.66316684154, 5759.481646651821, 6659.967705005732, 6857.759978400732, 6859.279775623488, 6868.175818901764, 5496.31296087989, 6524.902126468011, 6684.465242780663, 6743.325667433413, 6743.561668491532], "unit": "score", "name": "prototype.html", "value": 5006.976817170472}, {"lowerIsBetter": false, "replicates": [677.5866721300008, 697.1425147069107, 765.1392183793232, 787.2639082457898, 788.0779487999037, 15087.849121508782, 15119.773203401945, 15684.0, 15684.764728529053, 15686.686266274683, 14410.711785764279, 14513.854861451382, 14530.854691453109, 14538.055026423275, 14541.272936353167, 752.5183882315323, 768.0169383189526, 898.9550522473883, 939.4691999020531, 941.2187884056217, 927.3740225347864, 944.3483996042743, 944.84882418813, 945.1776954049986, 945.5650400815633, 987.9950600247024, 989.9752506187367, 990.7374545745383, 992.7319623701596, 995.4574756757548, 791.7505985614513, 973.1047436358567, 984.5569493727779, 986.5116767200246, 988.3575675810745, 732.9811561928923, 733.6771820399007, 736.054170391045, 737.797105795905, 740.3928778401713, 15155.469558565397, 15183.62040948974, 15229.238538073052, 15259.160746158957, 15279.61800954985, 12398.56605018829, 12453.626391208278, 12458.190217635914, 12578.68553286166, 12710.682232944158, 8250.46371985819, 9993.500324983794, 10035.899641003569, 10086.445245511493, 10399.688009359732, 3480.4953281774256, 3500.579945340778, 3588.6052534221217, 3752.5496940367057, 3766.4538641897047, 76447.61776191139, 76712.0, 77198.0, 77319.0, 77370.06574835618, 9448.196903263162, 9551.665691700757, 9563.808723825485, 9770.804583908282, 9777.951110244545, 21826.817318268048, 21864.781352186594, 21887.562248754937, 21894.23370182036, 21896.671549926763, 7191.244919283505, 7202.567845929261, 7233.89149162763, 7236.204017558064, 7377.077865266841, 3968.6031396860085, 4030.274550580865, 4033.7176397651883, 4051.230266249403, 4067.1255680028344, 3559.857605695743, 3627.782333060025, 3641.7814931104217, 3647.215848592565, 3648.52569166012, 632.4339715954195, 650.7136859781775, 651.5307980504028, 659.5053709717712, 659.9538032337787, 497.9617497517644, 568.9928825977996, 574.5518495573459, 591.3849596419675, 602.421675191812, 7047.612381319077, 7966.2033796621035, 8020.077691065486, 8134.227248411392, 8169.591520423955, 503.7254696190512, 525.5900397689732, 593.9821805345847, 599.3706608061605, 606.4360145065043, 3055.9541606875914, 3840.8271627776817, 3846.942295865564, 3883.30100581898, 3888.1245312445717, 93867.0, 94947.0, 95519.04480955102, 95556.0, 95829.52085239529, 80865.0, 80874.38251234942, 81664.0, 81899.59050204711, 82730.58634706787, 59182.40817591855, 60716.39283607196, 69128.6543567279, 70573.58852822914, 72983.0, 7701.807454813675, 7748.457607967388, 7763.660224289948, 7787.260210280015, 7814.804629884298, 42184.78907605565, 44594.554054460335, 46359.0, 46765.76617116893, 47140.585782426584, 61640.0, 63300.0, 67687.66156169187, 67742.30644233736, 70427.0, 10958.0, 10985.0, 11132.610358637408, 11470.197086203885, 11823.822642660194, 9801.558929848032, 11868.643940681794, 11883.643490695293, 11967.76064478723, 11993.520259189883, 11446.255993360737, 11470.025047870691, 11502.712432189262, 11601.709957250798, 11916.285022898654, 11394.601188958346, 11422.086233101498, 11424.143189260672, 11657.825132622847, 11724.28945213384, 11185.0, 11187.440627968406, 11347.262427942158, 11677.532898683958, 11744.119191060876, 9158.527908932183, 9208.631654733736, 9272.72181834546, 9416.199623032118, 9867.358621689567, 8847.336449766164, 9185.402948808307, 9242.0, 9318.627254909728, 9323.627054917728], "unit": "score", "name": "yui.html", "value": 6870.597809541443}], "name": "dromaeo_css", "value": 7444.204962744401}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 111.0, 112.0, 111.0, 117.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [158.0, 146.0, 175.0, 193.0, 143.0, 142.0, 140.0, 119.0, 163.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 186.0, 188.0, 188.0, 184.0, 183.0, 185.0, 183.0, 187.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [77.0, 75.0, 83.0, 83.0, 75.0, 83.0, 85.0, 108.0, 80.0, 57.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 126.0, 80.0, 82.0, 84.0, 111.0, 87.0, 114.0, 153.0], "unit": "score", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 132.0, 86.0, 86.0, 84.0, 87.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 93.0, 93.0, 92.0, 93.0, 92.0, 94.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 88.0, 87.0, 83.0, 87.0, 86.0, 87.0, 87.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.6}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 53.0, 53.0, 54.0, 55.0, 66.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 70.0, 78.0, 70.0, 68.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 83.0, 83.0, 82.0, 84.0, 82.0, 81.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [134.0, 116.0, 127.0, 135.0, 131.0, 135.0, 123.0, 122.0, 122.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [170.0, 133.0, 141.0, 141.0, 142.0, 131.0, 142.0, 140.0, 142.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 67.0, 69.0, 69.0, 69.0, 68.0, 66.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1442.7}]} 04:18:20 INFO - Return code: 0 04:18:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:18:20 ERROR - # TBPL SUCCESS # 04:18:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:18:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:18:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:18:20 INFO - 2016-03-29 04:18:20.186 screenresolution[1677:9576] starting screenresolution argv=screenresolution get 04:18:20 INFO - 2016-03-29 04:18:20.189 screenresolution[1677:9576] Display 0: 1600x1200x32@60 04:18:20 INFO - 2016-03-29 04:18:20.195 screenresolution[1678:9579] starting screenresolution argv=screenresolution list 04:18:20 INFO - Available Modes on Display 0 04:18:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:18:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:18:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:18:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:18:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:18:20 INFO - Intel Iris: 04:18:20 INFO - Chipset Model: Intel Iris 04:18:20 INFO - Type: GPU 04:18:20 INFO - Bus: Built-In 04:18:20 INFO - VRAM (Dynamic, Max): 1536 MB 04:18:20 INFO - Vendor: Intel (0x8086) 04:18:20 INFO - Device ID: 0x0a2e 04:18:20 INFO - Revision ID: 0x0009 04:18:20 INFO - Displays: 04:18:20 INFO - Display: 04:18:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:18:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:18:20 INFO - Display Serial Number: 1600x1200 60 04:18:20 INFO - Main Display: Yes 04:18:20 INFO - Mirror: Off 04:18:20 INFO - Online: Yes 04:18:20 INFO - Rotation: Supported 04:18:20 INFO - Return code: 0 04:18:20 INFO - Running post-action listener: _resource_record_post_action 04:18:20 INFO - Running post-run listener: _resource_record_post_run 04:18:21 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39269888; Write bytes: 704962560; Read time: 433; Write time: 2036 04:18:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381716992; Write bytes: 375941120; Read time: 28547; Write time: 722 04:18:21 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38315520; Write bytes: 299939840; Read time: 418; Write time: 1256 04:18:21 INFO - Running post-run listener: _upload_blobber_files 04:18:21 INFO - Blob upload gear active. 04:18:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:18:21 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 04:18:21 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'] 04:18:21 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 04:18:23 INFO - (blobuploader) - INFO - Open directory for files ... 04:18:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:18:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:26 INFO - (blobuploader) - INFO - Done attempting. 04:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:18:29 INFO - (blobuploader) - INFO - Done attempting. 04:18:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:18:29 INFO - Return code: 0 04:18:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:18:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:18:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d14a7beebabd37111811df691cfa98c8d05bcecf38f00613792af2a977974416e6cbed75aa170aefb336690f9b03fd2a4ef7ef2c43456c3992ca443db51f52b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63edae3d4be4e04e7fefd3827ba601060a037dd1063c0e7d581b506cdcca8d5c0356ee27beb63386fedf060d98cccfc446e89b22b3e4220e46181c7deddaea03"} 04:18:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:18:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:18:29 INFO - Contents: 04:18:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d14a7beebabd37111811df691cfa98c8d05bcecf38f00613792af2a977974416e6cbed75aa170aefb336690f9b03fd2a4ef7ef2c43456c3992ca443db51f52b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63edae3d4be4e04e7fefd3827ba601060a037dd1063c0e7d581b506cdcca8d5c0356ee27beb63386fedf060d98cccfc446e89b22b3e4220e46181c7deddaea03"} 04:18:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:18:29 INFO - Copying logs to upload dir... 04:18:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:18:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.974515 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-03-29 04:18:29.818367) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 04:18:29.822704) ========= 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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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/4d14a7beebabd37111811df691cfa98c8d05bcecf38f00613792af2a977974416e6cbed75aa170aefb336690f9b03fd2a4ef7ef2c43456c3992ca443db51f52b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63edae3d4be4e04e7fefd3827ba601060a037dd1063c0e7d581b506cdcca8d5c0356ee27beb63386fedf060d98cccfc446e89b22b3e4220e46181c7deddaea03"} build_url:https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010968 build_url: 'https://queue.taskcluster.net/v1/task/KRuPKuocSriO2S8W7acI5A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d14a7beebabd37111811df691cfa98c8d05bcecf38f00613792af2a977974416e6cbed75aa170aefb336690f9b03fd2a4ef7ef2c43456c3992ca443db51f52b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/63edae3d4be4e04e7fefd3827ba601060a037dd1063c0e7d581b506cdcca8d5c0356ee27beb63386fedf060d98cccfc446e89b22b3e4220e46181c7deddaea03"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 04:18:29.876347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 04:18:29.876793) ========= 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.Apyib3ZBvW/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.DElTyfLl5O/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.005035 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 04:18:29.930327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 04:18:29.930631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 04:18:29.931026) ========= ========= Total master_lag: 0.33 =========