builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0162 starttime: 1455723589.8 results: success (0) buildid: 20160217053850 builduid: fbf281b141f1420e8d4007412fc389c9 revision: 5ce212e97896db95fea3a47a9676c5c7a3033fca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:39:49.803486) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 07:39:49.803973) ========= ========= Started set props: basedir (results: 0, elapsed: 17 secs) (at 2016-02-17 07:39:49.804267) ========= 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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005735 basedir: '/builds/slave/test' ========= master_lag: 17.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 17 secs) (at 2016-02-17 07:40:06.982731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 32 secs) (at 2016-02-17 07:40:06.987047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 32 secs) (at 2016-02-17 07:40:39.104392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:40:39.104663) ========= 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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005367 ========= master_lag: 1.60 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-17 07:40:40.712543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:40:40.712809) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 07:40:40.713181) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-02-17 07:40:40.713477) ========= 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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-17 07:40:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-02-17 07:40:41 (45.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.617698 ========= master_lag: 9.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-02-17 07:40:50.548278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2016-02-17 07:40:50.548557) ========= 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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.019067 ========= master_lag: 12.82 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 12 secs) (at 2016-02-17 07:41:03.387788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-02-17 07:41:03.388108) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ce212e97896db95fea3a47a9676c5c7a3033fca --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 5ce212e97896db95fea3a47a9676c5c7a3033fca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-17 07:41:04,935 truncating revision to first 12 chars 2016-02-17 07:41:04,935 Setting DEBUG logging. 2016-02-17 07:41:04,935 attempt 1/10 2016-02-17 07:41:04,935 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ce212e97896?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 07:41:06,591 unpacking tar archive at: fx-team-5ce212e97896/testing/mozharness/ program finished with exit code 0 elapsedTime=1.898100 ========= master_lag: 6.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2016-02-17 07:41:11.502050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 4 secs) (at 2016-02-17 07:41:11.502362) ========= echo 5ce212e97896db95fea3a47a9676c5c7a3033fca in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ce212e97896db95fea3a47a9676c5c7a3033fca'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 5ce212e97896db95fea3a47a9676c5c7a3033fca program finished with exit code 0 elapsedTime=0.004989 script_repo_revision: '5ce212e97896db95fea3a47a9676c5c7a3033fca' ========= master_lag: 4.85 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 4 secs) (at 2016-02-17 07:41:16.356722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 15 secs) (at 2016-02-17 07:41:16.357008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 15 secs) (at 2016-02-17 07:41:31.940396) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-17 07:41:31.940657) ========= /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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:41:32 INFO - MultiFileLogger online at 20160217 07:41:32 in /builds/slave/test 07:41:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:41:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:32 INFO - {'append_to_log': False, 07:41:32 INFO - 'base_work_dir': '/builds/slave/test', 07:41:32 INFO - 'blob_upload_branch': 'Fx-Team', 07:41:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:32 INFO - 'branch': 'Fx-Team', 07:41:32 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:32 INFO - 'config_files': ('talos/mac_config.py',), 07:41:32 INFO - 'default_actions': ('clobber', 07:41:32 INFO - 'read-buildbot-config', 07:41:32 INFO - 'download-and-extract', 07:41:32 INFO - 'populate-webroot', 07:41:32 INFO - 'create-virtualenv', 07:41:32 INFO - 'install', 07:41:32 INFO - 'run-tests'), 07:41:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:32 INFO - 'download_minidump_stackwalk': True, 07:41:32 INFO - 'download_symbols': 'ondemand', 07:41:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:32 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:32 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:32 INFO - 'installer_path': 'installer.exe', 07:41:32 INFO - 'log_level': 'info', 07:41:32 INFO - 'log_name': 'talos', 07:41:32 INFO - 'log_to_console': True, 07:41:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:41:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:41:32 INFO - 'opt_config_files': (), 07:41:32 INFO - 'pip_index': False, 07:41:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:32 INFO - 'cmd': ('bash', 07:41:32 INFO - '-c', 07:41:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:32 INFO - 'enabled': True, 07:41:32 INFO - 'halt_on_failure': False, 07:41:32 INFO - 'name': 'check_screen_resolution'},), 07:41:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:32 INFO - 'cmd': ('bash', 07:41:32 INFO - '-c', 07:41:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:32 INFO - 'enabled': True, 07:41:32 INFO - 'halt_on_failure': False, 07:41:32 INFO - 'name': 'check_screen_resolution'},), 07:41:32 INFO - 'run_cmd_checks_enabled': True, 07:41:32 INFO - 'sps_profile': False, 07:41:32 INFO - 'sps_profile_interval': 0, 07:41:32 INFO - 'suite': 'dromaeojs', 07:41:32 INFO - 'system_bits': '32', 07:41:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:32 INFO - 'title': 't-yosemite-r7-0162', 07:41:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:32 INFO - 'use_talos_json': True, 07:41:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:32 INFO - 'work_dir': 'build'} 07:41:32 INFO - ##### 07:41:32 INFO - ##### Running clobber step. 07:41:32 INFO - ##### 07:41:32 INFO - Running pre-action listener: _resource_record_pre_action 07:41:32 INFO - Running main action method: clobber 07:41:32 INFO - rmtree: /builds/slave/test/build 07:41:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:33 INFO - Running post-action listener: _resource_record_post_action 07:41:33 INFO - ##### 07:41:33 INFO - ##### Running read-buildbot-config step. 07:41:33 INFO - ##### 07:41:33 INFO - Running pre-action listener: _resource_record_pre_action 07:41:33 INFO - Running main action method: read_buildbot_config 07:41:33 INFO - Using buildbot properties: 07:41:33 INFO - { 07:41:33 INFO - "project": "", 07:41:33 INFO - "product": "firefox", 07:41:33 INFO - "script_repo_revision": "production", 07:41:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:41:33 INFO - "repository": "", 07:41:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:41:33 INFO - "buildid": "20160217053850", 07:41:33 INFO - "pgo_build": "False", 07:41:33 INFO - "basedir": "/builds/slave/test", 07:41:33 INFO - "buildnumber": 379, 07:41:33 INFO - "slavename": "t-yosemite-r7-0162", 07:41:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:41:33 INFO - "platform": "yosemite_r7", 07:41:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:41:33 INFO - "branch": "fx-team", 07:41:33 INFO - "repo_path": "integration/fx-team", 07:41:33 INFO - "revision": "5ce212e97896db95fea3a47a9676c5c7a3033fca", 07:41:33 INFO - "stage_platform": "macosx64", 07:41:33 INFO - "builduid": "fbf281b141f1420e8d4007412fc389c9", 07:41:33 INFO - "slavebuilddir": "test" 07:41:33 INFO - } 07:41:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:41:33 INFO - Running post-action listener: _resource_record_post_action 07:41:33 INFO - ##### 07:41:33 INFO - ##### Running download-and-extract step. 07:41:33 INFO - ##### 07:41:33 INFO - Running pre-action listener: _resource_record_pre_action 07:41:33 INFO - Running main action method: download_and_extract 07:41:33 INFO - mkdir: /builds/slave/test/build/tests 07:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:33 INFO - https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:41:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/test_packages.json 07:41:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/test_packages.json 07:41:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:41:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:41:34 INFO - Downloaded 1277 bytes. 07:41:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:41:34 INFO - Using the following test package requirements: 07:41:34 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:41:34 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:41:34 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:41:34 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'jsshell-mac.zip'], 07:41:34 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:41:34 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:41:34 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:41:34 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:41:34 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:41:34 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:41:34 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:41:34 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:41:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:41:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:34 INFO - https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:41:35 INFO - Downloaded 17806454 bytes. 07:41:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:41:38 INFO - Return code: 0 07:41:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:38 INFO - https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:41:40 INFO - Downloaded 17806454 bytes. 07:41:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:41:43 INFO - Return code: 0 07:41:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:43 INFO - https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:41:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:41:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:41:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:41:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:41:44 INFO - Downloaded 10707015 bytes. 07:41:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:41:44 INFO - Return code: 0 07:41:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:44 INFO - https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:41:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:41:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:41:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:41:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 07:41:47 INFO - Downloaded 111229716 bytes. 07:41:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:41:47 INFO - mkdir: /builds/slave/test/properties 07:41:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:47 INFO - Contents: 07:41:47 INFO - build_url:https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:41:48 INFO - Running post-action listener: _resource_record_post_action 07:41:48 INFO - Running post-action listener: set_extra_try_arguments 07:41:48 INFO - ##### 07:41:48 INFO - ##### Running populate-webroot step. 07:41:48 INFO - ##### 07:41:48 INFO - Running pre-action listener: _resource_record_pre_action 07:41:48 INFO - Running main action method: populate_webroot 07:41:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:48 INFO - '--tppagecycles', 07:41:48 INFO - '7'], 07:41:48 INFO - 'tests': ['tsvgm']}}, 07:41:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:41:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:41:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'tests': ['damp', 'tps']}, 07:41:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['damp', 'tps']}, 07:41:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:41:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:48 INFO - 'other': {'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore']}, 07:41:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore']}, 07:41:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore']}, 07:41:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore']}, 07:41:48 INFO - 'other_l64': {'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore']}, 07:41:48 INFO - 'other_nol64': {'tests': ['a11yr', 07:41:48 INFO - 'ts_paint', 07:41:48 INFO - 'tpaint', 07:41:48 INFO - 'sessionrestore', 07:41:48 INFO - 'sessionrestore_no_auto_restore']}, 07:41:48 INFO - 'svgr': {'tests': ['tsvgx', 07:41:48 INFO - 'tsvgr_opacity', 07:41:48 INFO - 'tart', 07:41:48 INFO - 'tscrollx', 07:41:48 INFO - 'cart']}, 07:41:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['tsvgx', 07:41:48 INFO - 'tsvgr_opacity', 07:41:48 INFO - 'tart', 07:41:48 INFO - 'tscrollx', 07:41:48 INFO - 'cart']}, 07:41:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'tests': ['tp5o']}, 07:41:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--e10s'], 07:41:48 INFO - 'tests': ['tp5o']}, 07:41:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--xperf_path', 07:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:48 INFO - 'tests': ['tp5n']}, 07:41:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:48 INFO - 'talos_options': ['--e10s', 07:41:48 INFO - '--xperf_path', 07:41:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:48 INFO - 'tests': ['tp5n']}}, 07:41:48 INFO - 'talos.zip': {'path': '', 07:41:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:48 INFO - Running post-action listener: _resource_record_post_action 07:41:48 INFO - ##### 07:41:48 INFO - ##### Running create-virtualenv step. 07:41:48 INFO - ##### 07:41:48 INFO - Running pre-action listener: _resource_record_pre_action 07:41:48 INFO - Running main action method: create_virtualenv 07:41:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:48 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 07:41:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:48 INFO - Using real prefix '/tools/python27' 07:41:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:52 INFO - Installing pip.................done. 07:41:52 INFO - Return code: 0 07:41:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:52 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')]} 07:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:52 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')]} 07:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:52 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:41:52 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 07:41:52 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 07:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:52 INFO - 'HOME': '/Users/cltbld', 07:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:52 INFO - 'LOGNAME': 'cltbld', 07:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:52 INFO - 'MOZ_NO_REMOTE': '1', 07:41:52 INFO - 'NO_EM_RESTART': '1', 07:41:52 INFO - 'PAGER': '/bin/cat', 07:41:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:52 INFO - 'PWD': '/builds/slave/test', 07:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:52 INFO - 'SHELL': '/bin/bash', 07:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:41:52 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:52 INFO - 'USER': 'cltbld', 07:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:52 INFO - 'XPC_FLAGS': '0x0', 07:41:52 INFO - 'XPC_SERVICE_NAME': '0', 07:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:52 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 07:41:52 INFO - Cleaning up... 07:41:52 INFO - Return code: 0 07:41:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:41:52 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')]} 07:41:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:52 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')]} 07:41:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:52 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:41:52 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 07:41:52 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 07:41:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:41:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:52 INFO - 'HOME': '/Users/cltbld', 07:41:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:52 INFO - 'LOGNAME': 'cltbld', 07:41:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:52 INFO - 'MOZ_NO_REMOTE': '1', 07:41:52 INFO - 'NO_EM_RESTART': '1', 07:41:52 INFO - 'PAGER': '/bin/cat', 07:41:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:52 INFO - 'PWD': '/builds/slave/test', 07:41:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:52 INFO - 'SHELL': '/bin/bash', 07:41:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:41:52 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:41:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:52 INFO - 'USER': 'cltbld', 07:41:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:52 INFO - 'XPC_FLAGS': '0x0', 07:41:52 INFO - 'XPC_SERVICE_NAME': '0', 07:41:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:52 INFO - Downloading/unpacking psutil>=0.7.1 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:55 INFO - Installing collected packages: psutil 07:41:55 INFO - Running setup.py install for psutil 07:41:55 INFO - building 'psutil._psutil_osx' extension 07:41:55 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 07:41:56 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 07:41:56 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 07:41:56 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 07:41:56 INFO - building 'psutil._psutil_posix' extension 07:41:56 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 07:41:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:41:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:41:56 INFO - ^ 07:41:56 INFO - 1 warning generated. 07:41:56 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 07:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:56 INFO - Successfully installed psutil 07:41:56 INFO - Cleaning up... 07:41:56 INFO - Return code: 0 07:41:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:41:56 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')]} 07:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 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')]} 07:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:41:56 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 07:41:56 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 07:41:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:41:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:56 INFO - 'HOME': '/Users/cltbld', 07:41:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:56 INFO - 'LOGNAME': 'cltbld', 07:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:56 INFO - 'MOZ_NO_REMOTE': '1', 07:41:56 INFO - 'NO_EM_RESTART': '1', 07:41:56 INFO - 'PAGER': '/bin/cat', 07:41:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:56 INFO - 'PWD': '/builds/slave/test', 07:41:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:56 INFO - 'SHELL': '/bin/bash', 07:41:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:41:56 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:41:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:56 INFO - 'USER': 'cltbld', 07:41:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:56 INFO - 'XPC_FLAGS': '0x0', 07:41:56 INFO - 'XPC_SERVICE_NAME': '0', 07:41:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:41:56 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 07:41:56 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 07:41:56 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 07:41:56 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 07:41:56 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 07:41:56 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 07:41:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:41:59 INFO - Installing collected packages: mozsystemmonitor 07:41:59 INFO - Running setup.py install for mozsystemmonitor 07:41:59 INFO - Successfully installed mozsystemmonitor 07:41:59 INFO - Cleaning up... 07:41:59 INFO - Return code: 0 07:41:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:59 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')]} 07:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:59 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')]} 07:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:59 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:41:59 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 07:41:59 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 07:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:59 INFO - 'HOME': '/Users/cltbld', 07:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:59 INFO - 'LOGNAME': 'cltbld', 07:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:59 INFO - 'MOZ_NO_REMOTE': '1', 07:41:59 INFO - 'NO_EM_RESTART': '1', 07:41:59 INFO - 'PAGER': '/bin/cat', 07:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:59 INFO - 'PWD': '/builds/slave/test', 07:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:59 INFO - 'SHELL': '/bin/bash', 07:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:41:59 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:59 INFO - 'USER': 'cltbld', 07:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:59 INFO - 'XPC_FLAGS': '0x0', 07:41:59 INFO - 'XPC_SERVICE_NAME': '0', 07:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:59 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 07:41:59 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 07:41:59 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 07:41:59 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 07:41:59 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 07:41:59 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 07:42:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:42:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:03 INFO - Downloading docopt-0.6.1.tar.gz 07:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:42:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:42:03 INFO - Running setup.py install for blobuploader 07:42:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:42:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:42:03 INFO - Running setup.py install for requests 07:42:03 INFO - Running setup.py install for docopt 07:42:04 INFO - Successfully installed blobuploader requests docopt 07:42:04 INFO - Cleaning up... 07:42:04 INFO - Return code: 0 07:42:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:04 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')]} 07:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 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')]} 07:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:42:04 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 07:42:04 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 07:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:04 INFO - 'HOME': '/Users/cltbld', 07:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:04 INFO - 'LOGNAME': 'cltbld', 07:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:04 INFO - 'MOZ_NO_REMOTE': '1', 07:42:04 INFO - 'NO_EM_RESTART': '1', 07:42:04 INFO - 'PAGER': '/bin/cat', 07:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:04 INFO - 'PWD': '/builds/slave/test', 07:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:04 INFO - 'SHELL': '/bin/bash', 07:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:42:04 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:04 INFO - 'USER': 'cltbld', 07:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:04 INFO - 'XPC_FLAGS': '0x0', 07:42:04 INFO - 'XPC_SERVICE_NAME': '0', 07:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:04 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-KfD8mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:04 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3IOphH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:04 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-XCETbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:04 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7RVcdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:04 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-DeiDeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-F5W0nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0ghVog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-rki1HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-QchU58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-p_gUZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-B67yYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-IvTw35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-2zIO0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-IvRUSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:05 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-4WQn6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-sprIto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:06 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xgx_ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:06 INFO - Running setup.py install for manifestparser 07:42:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozcrash 07:42:06 INFO - Running setup.py install for mozdebug 07:42:06 INFO - Running setup.py install for mozdevice 07:42:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:06 INFO - Running setup.py install for mozfile 07:42:07 INFO - Running setup.py install for mozhttpd 07:42:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Running setup.py install for mozinfo 07:42:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Running setup.py install for mozInstall 07:42:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Running setup.py install for mozleak 07:42:07 INFO - Running setup.py install for mozlog 07:42:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Running setup.py install for moznetwork 07:42:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:07 INFO - Running setup.py install for mozprocess 07:42:08 INFO - Running setup.py install for mozprofile 07:42:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:08 INFO - Running setup.py install for mozrunner 07:42:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:08 INFO - Running setup.py install for mozscreenshot 07:42:08 INFO - Running setup.py install for moztest 07:42:08 INFO - Running setup.py install for mozversion 07:42:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:08 INFO - Cleaning up... 07:42:08 INFO - Return code: 0 07:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:08 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')]} 07:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:08 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')]} 07:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:08 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:42:08 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 07:42:08 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 07:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:08 INFO - 'HOME': '/Users/cltbld', 07:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:08 INFO - 'LOGNAME': 'cltbld', 07:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:08 INFO - 'MOZ_NO_REMOTE': '1', 07:42:08 INFO - 'NO_EM_RESTART': '1', 07:42:08 INFO - 'PAGER': '/bin/cat', 07:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:08 INFO - 'PWD': '/builds/slave/test', 07:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:08 INFO - 'SHELL': '/bin/bash', 07:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:42:08 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:08 INFO - 'USER': 'cltbld', 07:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:08 INFO - 'XPC_FLAGS': '0x0', 07:42:08 INFO - 'XPC_SERVICE_NAME': '0', 07:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-i_LBw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-8gdLbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0rquUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3HjJ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-AiDOpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-4KR5eC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ytddmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-XZvAwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:09 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)) 07:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:09 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-D8co22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-EfH2No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-vd5uhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-N6PGSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-WWg8Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-aDnnP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-OqRgZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-c1MjA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:10 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)) 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:10 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-HDUz4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:10 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)) 07:42:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:42:10 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)) 07:42:10 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)) 07:42:10 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)) 07:42:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:13 INFO - Downloading blessings-1.6.tar.gz 07:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:13 INFO - Installing collected packages: blessings 07:42:13 INFO - Running setup.py install for blessings 07:42:13 INFO - Successfully installed blessings 07:42:13 INFO - Cleaning up... 07:42:13 INFO - Return code: 0 07:42:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:13 INFO - Reading from file tmpfile_stdout 07:42:13 INFO - Current package versions: 07:42:13 INFO - blessings == 1.6 07:42:13 INFO - blobuploader == 1.2.4 07:42:13 INFO - docopt == 0.6.1 07:42:13 INFO - manifestparser == 1.1 07:42:13 INFO - mozInstall == 1.12 07:42:13 INFO - mozcrash == 0.16 07:42:13 INFO - mozdebug == 0.1 07:42:13 INFO - mozdevice == 0.48 07:42:13 INFO - mozfile == 1.2 07:42:13 INFO - mozhttpd == 0.7 07:42:13 INFO - mozinfo == 0.9 07:42:13 INFO - mozleak == 0.1 07:42:13 INFO - mozlog == 3.1 07:42:13 INFO - moznetwork == 0.27 07:42:13 INFO - mozprocess == 0.22 07:42:13 INFO - mozprofile == 0.28 07:42:13 INFO - mozrunner == 6.11 07:42:13 INFO - mozscreenshot == 0.1 07:42:13 INFO - mozsystemmonitor == 0.0 07:42:13 INFO - moztest == 0.7 07:42:13 INFO - mozversion == 1.4 07:42:13 INFO - psutil == 3.1.1 07:42:13 INFO - requests == 1.2.3 07:42:13 INFO - wsgiref == 0.1.2 07:42:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:13 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 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:42:13 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 07:42:13 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 07:42:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:42:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:13 INFO - 'HOME': '/Users/cltbld', 07:42:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:13 INFO - 'LOGNAME': 'cltbld', 07:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:13 INFO - 'MOZ_NO_REMOTE': '1', 07:42:13 INFO - 'NO_EM_RESTART': '1', 07:42:13 INFO - 'PAGER': '/bin/cat', 07:42:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:13 INFO - 'PWD': '/builds/slave/test', 07:42:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:13 INFO - 'SHELL': '/bin/bash', 07:42:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:42:13 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:42:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:13 INFO - 'USER': 'cltbld', 07:42:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:13 INFO - 'XPC_FLAGS': '0x0', 07:42:13 INFO - 'XPC_SERVICE_NAME': '0', 07:42:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 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)) 07:42:14 INFO - Cleaning up... 07:42:14 INFO - Return code: 0 07:42:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:14 INFO - 'HOME': '/Users/cltbld', 07:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:14 INFO - 'LOGNAME': 'cltbld', 07:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:14 INFO - 'MOZ_NO_REMOTE': '1', 07:42:14 INFO - 'NO_EM_RESTART': '1', 07:42:14 INFO - 'PAGER': '/bin/cat', 07:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:14 INFO - 'PWD': '/builds/slave/test', 07:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:14 INFO - 'SHELL': '/bin/bash', 07:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:42:14 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:14 INFO - 'USER': 'cltbld', 07:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:14 INFO - 'XPC_FLAGS': '0x0', 07:42:14 INFO - 'XPC_SERVICE_NAME': '0', 07:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:14 INFO - Downloading/unpacking jsonschema 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:16 INFO - Downloading/unpacking functools32 (from jsonschema) 07:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:16 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:17 INFO - warning: no files found matching '*.txt' 07:42:17 INFO - no previously-included directories found matching 'build' 07:42:17 INFO - no previously-included directories found matching 'dist' 07:42:17 INFO - no previously-included directories found matching '.git*' 07:42:17 INFO - Installing collected packages: jsonschema, functools32 07:42:17 INFO - Running setup.py install for functools32 07:42:17 INFO - warning: no files found matching '*.txt' 07:42:17 INFO - no previously-included directories found matching 'build' 07:42:17 INFO - no previously-included directories found matching 'dist' 07:42:17 INFO - no previously-included directories found matching '.git*' 07:42:17 INFO - Successfully installed jsonschema functools32 07:42:17 INFO - Cleaning up... 07:42:17 INFO - Return code: 0 07:42:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10143da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1014454c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f864156c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, '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.UTBAInPvuz/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.9l9VKZJuLa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 07:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:42:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:42:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:17 INFO - 'HOME': '/Users/cltbld', 07:42:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:17 INFO - 'LOGNAME': 'cltbld', 07:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:17 INFO - 'MOZ_NO_REMOTE': '1', 07:42:17 INFO - 'NO_EM_RESTART': '1', 07:42:17 INFO - 'PAGER': '/bin/cat', 07:42:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:17 INFO - 'PWD': '/builds/slave/test', 07:42:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:17 INFO - 'SHELL': '/bin/bash', 07:42:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:42:17 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:42:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:17 INFO - 'USER': 'cltbld', 07:42:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:17 INFO - 'XPC_FLAGS': '0x0', 07:42:17 INFO - 'XPC_SERVICE_NAME': '0', 07:42:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:17 INFO - Downloading/unpacking flake8 07:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:42:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:42:19 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 07:42:19 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 07:42:19 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 07:42:19 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 07:42:19 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 07:42:19 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 07:42:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:42:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:42:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:21 INFO - no previously-included directories found matching 'docs/_build' 07:42:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:42:21 INFO - Running setup.py install for pep8 07:42:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:21 INFO - no previously-included directories found matching 'docs/_build' 07:42:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:42:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:42:21 INFO - Cleaning up... 07:42:21 INFO - Return code: 0 07:42:21 INFO - Running post-action listener: _resource_record_post_action 07:42:21 INFO - Running post-action listener: _start_resource_monitoring 07:42:21 INFO - Starting resource monitoring. 07:42:21 INFO - ##### 07:42:21 INFO - ##### Running install step. 07:42:21 INFO - ##### 07:42:21 INFO - Running pre-action listener: _resource_record_pre_action 07:42:21 INFO - Running main action method: install 07:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:21 INFO - Reading from file tmpfile_stdout 07:42:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:21 INFO - Reading from file tmpfile_stdout 07:42:21 INFO - Output received: 07:42:21 INFO - Usage: mozinstall [options] installer 07:42:21 INFO - Options: 07:42:21 INFO - -h, --help show this help message and exit 07:42:21 INFO - -d DEST, --destination=DEST 07:42:21 INFO - Directory to install application into. [default: 07:42:21 INFO - "/builds/slave/test"] 07:42:21 INFO - --app=APP Application being installed. [default: firefox] 07:42:21 INFO - mkdir: /builds/slave/test/build/application 07:42:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:42:56 INFO - Reading from file tmpfile_stdout 07:42:56 INFO - Output received: 07:42:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:42:56 INFO - Running post-action listener: _resource_record_post_action 07:42:56 INFO - ##### 07:42:56 INFO - ##### Running run-tests step. 07:42:56 INFO - ##### 07:42:56 INFO - Running pre-action listener: _resource_record_pre_action 07:42:56 INFO - Running main action method: run_tests 07:42:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:56 INFO - 2016-02-17 07:42:56.505 screenresolution[1950:12834] starting screenresolution argv=screenresolution get 07:42:56 INFO - 2016-02-17 07:42:56.508 screenresolution[1950:12834] Display 0: 1600x1200x32@60 07:42:56 INFO - 2016-02-17 07:42:56.513 screenresolution[1951:12836] starting screenresolution argv=screenresolution list 07:42:56 INFO - Available Modes on Display 0 07:42:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:56 INFO - Intel Iris: 07:42:56 INFO - Chipset Model: Intel Iris 07:42:56 INFO - Type: GPU 07:42:56 INFO - Bus: Built-In 07:42:56 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:56 INFO - Vendor: Intel (0x8086) 07:42:56 INFO - Device ID: 0x0a2e 07:42:56 INFO - Revision ID: 0x0009 07:42:56 INFO - Displays: 07:42:56 INFO - Display: 07:42:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:56 INFO - Display Serial Number: 1600x1200 60 07:42:56 INFO - Main Display: Yes 07:42:56 INFO - Mirror: Off 07:42:56 INFO - Online: Yes 07:42:56 INFO - Rotation: Supported 07:42:56 INFO - Return code: 0 07:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:56 INFO - Python 2.7.3 07:42:56 INFO - Return code: 0 07:42:56 INFO - grabbing minidump binary from tooltool 07:42:56 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')]} 07:42:56 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 0x1012e1d30>, '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 0x101105db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1012d8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:56 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 07:42:56 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 07:42:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:56 INFO - Return code: 0 07:42:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:42:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:42:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:58 INFO - Return code: 0 07:42:58 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/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 07:42:58 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/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --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 07:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UTBAInPvuz/Render', 07:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:58 INFO - 'HOME': '/Users/cltbld', 07:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:58 INFO - 'LOGNAME': 'cltbld', 07:42:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:58 INFO - 'MOZ_NO_REMOTE': '1', 07:42:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:58 INFO - 'NO_EM_RESTART': '1', 07:42:58 INFO - 'PAGER': '/bin/cat', 07:42:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:58 INFO - 'PWD': '/builds/slave/test', 07:42:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:58 INFO - 'SHELL': '/bin/bash', 07:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9l9VKZJuLa/Listeners', 07:42:58 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 07:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:58 INFO - 'USER': 'cltbld', 07:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:58 INFO - 'XPC_FLAGS': '0x0', 07:42:58 INFO - 'XPC_SERVICE_NAME': '0', 07:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:58 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/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 07:42:58 INFO - mozversion application_buildid: 20160217053850 07:42:58 INFO - mozversion application_changeset: 5ce212e97896db95fea3a47a9676c5c7a3033fca 07:42:58 INFO - mozversion application_display_name: Nightly 07:42:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:58 INFO - mozversion application_name: Firefox 07:42:58 INFO - mozversion application_remotingname: firefox 07:42:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:42:58 INFO - mozversion application_vendor: Mozilla 07:42:58 INFO - mozversion application_version: 47.0a1 07:42:58 INFO - mozversion platform_buildid: 20160217053850 07:42:58 INFO - mozversion platform_changeset: 5ce212e97896db95fea3a47a9676c5c7a3033fca 07:42:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:42:58 INFO - mozversion platform_version: 47.0a1 07:42:58 INFO - using testdate: 1455723778 07:42:58 INFO - actual date: 1455723778 07:42:58 INFO - starting webserver on 'localhost:49617' 07:42:58 INFO - SUITE-START | Running 2 tests 07:42:58 INFO - TEST-START | dromaeo_css 07:42:58 INFO - operating with platform_type : mac_ 07:42:58 INFO - Initialising browser for dromaeo_css test... 07:42:58 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp5KJXTZ/profile http://localhost:49617/getInfo.html) 07:43:00 INFO - PROCESS | 1969 | __metrics Screen width/height:1600/1200 07:43:00 INFO - PROCESS | 1969 | colorDepth:24 07:43:00 INFO - PROCESS | 1969 | Browser inner width/height: 1024/689 07:43:00 INFO - PROCESS | 1969 | __metrics 07:43:00 INFO - PROCESS | 1969 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:43:00 INFO - PROCESS | 1969 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:01 INFO - TEST-INFO | 1969: exit 0 07:43:01 INFO - Browser initialized. 07:43:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:01 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp5KJXTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:12 INFO - PROCESS | 1972 | RSS: Main: 244772864 07:43:12 INFO - PROCESS | 1972 | 07:44:04 INFO - PROCESS | 1972 | 1455723844499 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] 07:46:14 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49617/tests/dromaeo/cssquery-ext.html) 07:46:16 INFO - PROCESS | 1972 | RSS: Main: 468029440 07:46:16 INFO - PROCESS | 1972 | 07:49:19 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49617/tests/dromaeo/cssquery-ext.html (next: http://localhost:49617/tests/dromaeo/cssquery-jquery.html) 07:49:19 INFO - PROCESS | 1972 | RSS: Main: 379465728 07:49:19 INFO - PROCESS | 1972 | 07:52:21 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49617/tests/dromaeo/cssquery-mootools.html) 07:52:22 INFO - PROCESS | 1972 | RSS: Main: 376905728 07:52:22 INFO - PROCESS | 1972 | 07:55:24 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49617/tests/dromaeo/cssquery-prototype.html) 07:55:25 INFO - PROCESS | 1972 | RSS: Main: 370847744 07:55:25 INFO - PROCESS | 1972 | 07:58:28 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49617/tests/dromaeo/cssquery-yui.html) 07:58:28 INFO - PROCESS | 1972 | RSS: Main: 345563136 07:58:28 INFO - PROCESS | 1972 | 08:01:31 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49617/tests/dromaeo/cssquery-yui.html (next: http://localhost:49617/tests/dromaeo/cssquery-dojo.html) 08:01:32 INFO - PROCESS | 1972 | RSS: Main: 381313024 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | __start_tp_report 08:01:32 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 08:01:32 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 08:01:32 INFO - PROCESS | 1972 | |i|pagename|runs| 08:01:32 INFO - PROCESS | 1972 | |0;dojo.html;2904.4771941050617;3377.3751855906658;3452.171478845078;3484.7909125452493;3506.351325004874;5544.223808666779;5596.636218645785;5613.2141500189955;5620.988222120017;5631.746571404286;4844.442889067758;5615.185798059279;5637.041702910505;5638.126090455976;5658.094704847225;5031.698098114125;5069.366329208849;5074.441811400752;5093.388793344785;5228.712420816853;5175.896482070356;5178.6116041297055;5212.8436146915465;5217.634765566412;5230.895382092375;4985.651004429691;5066.493350664941;5119.104156772569;5159.5614372778355;5170.870728231786;5147.356580427447;5160;5175.094358487249;5180.430152683201;5212.869678258036;5047.545720885138;5104.770285337132;5122.564582010534;5134.332536770196;5143.3313669223135;5060.7722652480725;5398.676079435247;5509.228707980846;5530.778768849241;5534.695591742453;6054.212952316215;6056.6063205891915;6072.787452439144;6078.088286756978;6083.66539840313;4960.305557221992;6051.515878729735;6076.696165191767;6099.69501524922;6101.359357267467;5620.803271885465;5640.238567793377;5652.265205523256;5730.656160630376;5742.770289188427;6183.876322473526;6221.4089661482085;6292.370762923671;6296.401841825019;6306.24325080984;5941.435563621449;5963.701814909237;5977.940220597825;5978.491828194652;5978.970105149447;6126.448619624255;6127.724252408652;6136.631802091889;6140.600860944024;6146.723397447036;5957.2255606771705;6058.515318774487;6059.000264956233;6077.604955677955;6082.847928801815;6107.552954153525;6140.508759299245;6151.938480615226;6175.59858609189;6180.81457556274;4831.492693267156;4846.055019271279;4853.6602437829715;4854.247591623304;4913.877153071202;4264.552222016644;4298.634616057608;4321.481422229353;4355.5426680198125;4357.237483440385;5523.116301391758;5533.889322213533;5535.225068490415;5536.612437129363;5540.806071787468;6093.268807743099;6110.114033465212;6113.174721412642;6118.0211166214085;6128.908066379008;5403.459654034644;5476.7535460904355;5533.418991005967;5538.75075621598;5546;5276.762545685377;5277.393099793496;5284.339457567804;5290.603204759658;5297.735113244323;6127.525510585588;6189.81430557075;6286.748530058747;6298.464630506367;6301.149344838388;6204.937950620436;6207.689615519296;6223.439890409885;6250.281217660027;6258.749650013949;6247.96876015617;6259.718312675849;6269.62382257066;6287.528435367274;6287.685615719104;5884.205632239764;5972.58191926561;5997.55018373615;6011.60924539921;6081.6655083969035;6022.247219097613;6034.366391528826;6049.941260279522;6054.424829641177;6058.545609079249;5681.545476361964;5835.7373918174635;5843.707814609337;5849.327327357409;5856.765729370948;5390.811321603725;6004.549658775697;6093.48205402528;6100.206973093647;6114.113453549299;5209.973950130225;5691.7438715257085;5841;5880.852978675567;5882.352941176553;5893.528517718487;5986.9401305986385;6004.159417681441;6010.87978240424;6017.06735456005;5741.569382296261;5839.824805255849;5865.413458654271;5870.119482077723;5947.940520594739 08:01:32 INFO - PROCESS | 1972 | |1;ext.html;488.17011081162036;522.3366324767543;566.3486989961542;575.0856138739405;575.1143239411307;24801.883915223814;29307.67308172957;29663.40673186535;29701.96043138488;29811.95658151965;33978.32043359131;38205.61794382055;38523.61476385242;40130.79934600323;40139.598604013954;9437.905620943788;9652.469114198717;9672.854907176397;9680.709578712649;9690.951545242264;9629.27780416468;9790.412575245473;9800.607975681;9802.166815820663;9806.11744942955;9748.805023899518;9842.261830362751;9848;9848.950755246215;9856.605735770561;9719.708408747749;9819.31264811467;9820.214382849426;9834.459104749236;9839.508024598741;9551.761205969837;9679.661211857621;9687.32188746788;9696.321257511978;9697.515124243759;38573.807130964444;38846.611533884585;38865.222695545934;38877;38904.805475972724;3002.2944608017096;3015.8469046444156;3034.408290383376;3071.616047994001;3089.686455514885;27774.583381249297;27836.582451263246;27885.163445096478;28262.858685706644;28900.710992890014;2791.3998490324475;2815.9155225343275;2823.3365159187574;2838.886444542216;2857.8285302881895;413877;484763;486835;487438;488336.5583172097;51818;52632.73683631558;59294;59618.80762384728;60671.69664151651;61181.69409152926;61969.380306197265;62114.757704846554;62216;62236;15565.844341556665;15731.842681573267;15789.052656840626;15857.365705371656;15881.52355429339;10992.835107473395;11097.223194376316;11099.944500277446;11104.389258590694;12197.268163910194;18755.249790008245;18807.717884231748;18966.525836853914;18969.482441404656;18971.43085707431;7072.504924655224;8278.917210827934;8480.74557763268;8501.95749021251;8541.103184165697;906.4515967839494;919.2875521470913;963.2781279201521;971.4802580619335;1106.1703722208345;28836.567451488245;28948.855255724007;29236;29457.55813662797;29637;993.5082134343402;1065.8755013460873;1071.8552995345685;1094.1574987259764;1167.6030149749126;14986.700265994838;15008.699826003418;15150.696986060437;15267;15290.464833730766;515032;527885;528702;529104;529124;54032;54035.729821350644;54037.72981135148;54097.1885421719;54329.185062224096;1261.6656586004717;1271.650296168561;1318.967025824362;1420.3027382278078;1438.1155589312707;27100.72899270982;27159.04943326974;27671;27672.308192295353;27677.861610691816;41612;41776.74669759912;41824.79087604542;41896.3715544261;45088.64734057983;506812;510246;511718.4414077906;512236;512933;28335.858320708263;29246;29254.561181581867;29260.707392925797;29312.41375172527;40334;40680.59319406768;40770;41021.38467922924;41111.38332925068;34292;34570.82714586411;34846;35959.82020089883;36025.09937251485;35146.82426587953;35206.64793352034;35278.82360588181;35383.64616353803;35453.645463545035;34140.31719365648;34976.65023349734;35052.64947350596;35131.824340878135;35181.47227791534;29694.703052969195;31298.843505783236;31353;31376;31510.36979260356;20738.48153796167;23075.423114421603;24060.87969560211;24264.757352426248;24945 08:01:32 INFO - PROCESS | 1972 | |2;jquery.html;300.81048939168323;364.8868850656296;365.2858661317125;366.0920916128004;373.1343283582091;14560.927195364035;15661.295241714122;19201.61596768064;20230.29193978209;20837.166513339467;20670.689939650918;20839;21308.8934555327;21544.676829847525;21553.46116347092;6361.045843123534;6522.7390904363765;6553.868922621545;6558.6064836109745;6574;4558.794854231567;4718.740469274206;4750.764801151691;6508.381703738138;7418.814529636776;7228.566286022829;7320.816979575527;7363;7407.000054992561;7419.33226009659;7086.291370862924;7197.496175267734;7310.268973102674;7439.962800185965;7448.106227252711;6999.335063168991;7000.859982800315;7001.229864714877;7009.1589009318695;7022.964885175541;25690;25850.48299034009;26317.605235921477;26416.471670566672;27052.59421108685;2170.2437903862005;2395.988020059906;2523.2178024812365;2900.666423361319;3066.647335556417;13732.038757286993;15313.846861531354;15450.768238476432;15481.14853683047;15962.600934976603;1884.7832499262622;1930.94207173785;1954.6090781843545;1978.6636271833822;1989.7512810898638;62250;72939;74238;113795.86204137935;113829;10323.225758068174;10712.78574428507;10872.836907446395;10882.891171088346;10968.561257549769;12023.519059237708;12342.506299748089;12368.690782730504;12961.351932403342;13007.934960325138;6430.7106180222;6920.619365934821;7899.565523896241;8379.664813407395;8386.87419688705;6789;8373.204545568162;8425.241728244488;8480.109588493242;8497.107803680648;4388.012697143117;4429.247028005182;4432.445944256968;4440.134173836135;4479.529649386833;1815.8638102142393;1861.2741030997922;1890.8014658460663;1895.5450691834137;1899.173859371178;391.38357087587167;858.8711693246063;909.8999110097884;1004.1765752083368;1010.5851807469454;11344.546218151181;11357.829632555518;11516.963473287444;11563.6530904073;11627.476763545661;436.8733067410479;448.26708331877614;448.3879504476366;452.76003718029494;472.3693868685275;5375.6774593524515;5891.646501209855;6030.095485677183;6046.486048685823;6133.110698948627;685921;686502;733116;752628;783255.7534910942;113181;116793;122097.99999999822;123056.38471807583;124064.75935240713;1024.7233247023262;1081.9296745711504;1113.3375641493299;1175.5826681528106;1176.147293212414;17660.02869842171;17889.28442862271;17986.730199047288;18070.277188912296;18384.080795960417;50814.47556573309;50902.49097508978;50959.49040509547;51739.895606263744;52933.7353313231;67108.3289167102;67193.3280667187;72340.27659723336;74876;74969.62515187389;7229.783106506813;7624.923750762421;7676.347510461674;7696.653650585849;7721.92278077212;10091.293609447268;12297.139200255897;12372.319522426353;12573.87426125727;12586.307753073303;10534.315269507457;10751;10918.94540527324;10921.563137474412;11013.559457621606;10585.9470702646;10614;10651.934806519286;10737.946310268399;10956.013958743433;6112.847178820565;10475.895241047492;10706.036456718934;10777;11068.5572577096;7504.812379690333;7691.769246922601;7694.269044440769;7807.336376408069;7903.209679032051;8663.917010373703;10942.507587158438;11090.447337372612;11173.273737207055;11227.71930701739 08:01:32 INFO - PROCESS | 1972 | |3;mootools.html;1407.7114191590724;1548.6051056980473;1572.080333005192;1809.231076792363;1943.9222431102758;7632.503887247325;8615.31077513799;8774.341924355684;8785.472871627691;8788.472691638499;8456.91543084569;8750.474971501699;8759.649614015432;8768.956155219215;8775.122487751221;2167.5881582499355;2226.543558570497;2420.8426452280546;2464.4208610976407;2502.6621406110216;2459.827812053157;2494.189388448752;2500.962485562718;2506.2982364937757;2509.498100379922;2464.7904928081134;2491.364702000987;2498.113169824713;2498.475320182764;2499.4251322195905;2348.53029394121;2404.483036147219;2417.492326611414;2421.987890060556;2424.6605475233305;2324.1981516376823;2340.578695834749;2431.088341871798;2483.279848843833;2485.092941076512;8823.867641985375;8919.509426981513;8921.955390223073;8948.328875334377;8984;5371.785128594852;5537.335519737617;5588.2455868458055;5589.692566908819;5615.326160860682;3572;3622.619624939396;3684.1526448916898;3702.9629703702885;3723.1250656095795;984.5618699678646;989.302541708094;998.990010099897;1013.3109485549824;1023.0076825479273;12089.516419343216;12101.334426606621;12103.334316612583;12119.636410907598;12137;4879.365682461257;4882.487338829372;4937.925931111036;4993.325901003318;4999;10281.948590257001;10300.690979270634;10309.484525773682;10312.484375781181;10321.432321222255;4547.295169248771;5564.554835613141;5565.66606003633;5566.415526369673;5566.443355664401;4973.875653108701;4989.0770207511005;5024.42219144803;5042.596592272609;5052.7726252318735;3883.0680636647003;3937.8621748238675;3939.1727737174942;3941.2117576484816;3984.920301593952;1281.2888846690175;1285.8392700912386;1289.3037759609892;1301.9609411717663;1307.2744626732065;1073.1736562846565;1092.011729384908;1093.830456279278;1259.9559015434415;1361.4213959067554;8113.188681131957;8179.182081791892;8193.8361232775;8198.8360232795;8242.587870606445;1072.0351683484926;1107.855978722761;1116.9497372618252;1183.508843829801;1196.976060478803;6264.780732674426;6283.465905398001;6330.68346582669;6346.174997250328;6348.333424990309;10638.468076596295;11096.00135987765;11098.834622364697;11133.721656958642;11190.832137517944;10436.321639093434;10915.672529824118;10948.014678678797;10956.780864382668;10993.34039957589;8317.875231871527;8425.45234559764;8442.227132302285;8447.113053129333;8454.365922555833;7779.377649788116;7837.020372453443;7851.803704907423;7908.52548847071;7934.325582325567;9427.434353938786;9691.2731545133;9795.412275263507;9797.167240784613;9856.063673950963;8798.956005219932;9790.951045244728;10054.949725251327;10316.329438586468;10335.84496232542;5685.8862822742485;6348.809535713936;6522.902156467751;6899.896501552581;6911.101556797584;8217.342612591097;8235.711750088718;8281.917180828355;8282.337413006824;8288.70989515364;7374.963125184339;7556.206598307319;7575.886361704689;7648.73229436967;7745.380369570534;7348.448866334939;7474.701011959461;7561.848763024819;7574.5076570022775;7624.390048796194;7593.392528597809;7657.57883316423;7658.889461028231;7659.008657748914;7666.57833819123;6872.41584465306;6884;6916.896246556406;6945.791626251221;6948.9305106950305;6140.355262697352;7030.191527974144;7097.183823860116;7106;7144.607046612278 08:01:32 INFO - PROCESS | 1972 | |4;prototype.html;268.4711119095382;321.350871240095;322.3955084217093;326.4874147588287;333.80305619684384;6512.055751915976;6548.770793022245;6716.597004179746;6782.864342713149;6790.762323318685;6479.449246814014;6569.638669873155;6607.636579988099;6635.834104147399;6641.767538136166;4916.704997700132;4918.680285781422;4923.679960802537;4926.211806111023;4951.084049450845;3871.845126194949;4818.253170758538;4828.855134345975;4872.220444728844;4975.4527002029745;4853.538913803183;4859.125357435661;4865.975670121645;4874.2444921037295;4915.8525244242555;4901.09329773993;4927.630427717918;4928.211486162197;4931.852044438672;4937.136001199776;4200.264953633133;4207.474065741782;4224.831006759726;4232.238197124517;4248.638865696419;6283.748650053993;6432.456210509491;6465.579737317059;6473.352664733536;6504.056911747817;5047.343845300087;5707.601637598815;5881.47066763989;5897.085951677497;5902.380250073724;6850.280720524323;7071.398931090864;7177.964110179468;7180.676869540883;7190.892136617955;4622.399088118523;4729.266963620645;4733.242681170997;4734.786934587952;4745.454272758642;7450.18048014718;7587.734429294948;7597.696092156362;7609.847803043964;7626.733064342721;4673.065386922629;4844.709317440965;4848.490908454562;4852.902941941142;4853.296272040534;4912.312276281324;4931.7040977541465;4934.605231581465;4937.481564435682;4947.925781113287;5841.824745257649;5876.177335173079;5877.794277200363;5902.822915312548;5915.911261331084;7191.89212161818;7203.89194162088;7205.135383753983;7206.783796486114;7225.313595208552;1498.116111494202;1657.2542355939875;1689.3833750680913;1716.9570760730833;1719.968019188502;1098.8132017557034;1112.3103675721104;1117.6591139702307;1130.6494986554194;1133.3369978562469;6721.227058888193;6731.259561448237;6731.932680673229;6740.561863478858;6747.595144291358;7405.8889116663295;7435.25647435263;7439.702411903571;7454.776356709307;7484.738034168887;6543.770968016097;6735.360140786617;6737.258901520829;6750.649870025916;6757.898631520531;3911.1395492991496;3955.624215699504;3957.5448823385104;3964.385520244367;3971.2653159165648;7858.764237072897;7860.528368297921;7865.764027079197;7869.370450363957;7899.881501777478;6290.528210384148;7521.323080922743;7708.306252437307;7724.7682569523;7725.304722574995;6163.691815409212;7576.545407275581;7804;7814.023247094114;7833.843323133506;7314;7345.853082938418;7481.102267727908;7493.213212612597;7512.699492020258;7296.7446139384865;7347.8163045924275;7357.337839594462;7358.337749602561;7383.483156179016;7656.387489000978;7762.068551773823;7857.05715314166;7861.213878612093;7865.370770338473;4659.534046595313;4704.9529504704515;4710.552497512731;4714.434267887876;4742.691725037999;7072.611006394698;7414.406847452083;7426.405887529093;7447.88828167567;7466.25337466249;6307.369263073656;6910;7210.495265331377;7216.89174662391;7223.386012188813;7182.209956904632;7198.2801719829695;7199.71201151948;7206.063211782434;7213.098362704662;6833.624150671761;6992;6996.860062798817;7002.859942801014;7018.33325834045;7190.892136618059;7198.5680859148615;7199.8560028800175;7207.099112610924;7215.639218039182;7022.54353467023;7022.894656580053;7031.613261270679;7042.894356584553;7046.753363632453 08:01:32 INFO - PROCESS | 1972 | |5;yui.html;634.264253465979;658.4699317049774;701.5615240474704;728.9794287996806;783.8907945257461;15031.699366012674;15248;15289.541313760577;15313.92343038286;17266.136693165354;15948.601284967852;15948.681026379465;15989.760153597676;16023.759643605355;16026.35894564216;600.2916558461014;704.0284407517619;863.7926897544576;879.2526352600303;880.744584070622;851.4891065360765;856.8543347630917;870.2776695342882;870.9390342676015;871.424859592669;921.5991043895893;922.4096578189964;925.0379605210607;925.6436272035247;926.0970553710146;732.1104857598017;744.2520267131498;920.0707285641483;921.7004473546058;944.8393773058527;679.7111227728195;680.3400701319712;680.7787469072522;681.7204945972128;681.8738533371293;15124.697506049817;15169.924150379287;15188.620284492865;15237.61905952349;15240.923795381063;12482.375881205904;12748;12821.807672884914;12949.158304710163;12961.675958101028;10212.94893525535;10235.6417525387;10239.514381845223;10253.487057983843;10355.430451325174;3497.562804649419;3538.31002954424;3547.9822600887087;3557.1285035166293;3557.62644922282;61711.07433388503;77885.44229115442;79701.20298796995;79918.60040699759;79995.6000220001;9528.857067143997;9555.23558115349;9735.41587504752;9818.116369526777;9929.602815887429;18354.63290734178;22224.77775222227;22224.88887555552;22249.77750222477;22274.99762510691;7410.481266311414;7466.2027833001985;7575.318221360104;7610.1628820829665;7689.192634773268;3951.9802400988387;4032.737872038308;4072.735272207297;4109.198706252312;4222.9577704222565;3602.5316708827686;3657.908552286161;3663.670269675742;3674.9816250918575;3691.963080369162;549.1926867504761;645.7191121862005;662.3707477896018;673.5756473421714;699.9720011199597;509.96175286853634;519.773334929566;581.7324030945813;606.6084757233128;608.3733754233147;8708.912910870937;9246.4914429707;9274.95362523183;9447.76380590477;9508.239340852715;429.98925026874576;555.7304707216997;615.258613370887;617.8146556033172;632.1623848400887;3793.79134147619;3985.980070099689;4045.6763458923215;4092.4884389451317;4146.440230568895;98467.01532984579;99813;100480;100645.49677251567;104443;83987.5800620993;85154.14845851586;85493;85583.28833423297;86133.27733445421;75487.62256188683;75572.62213688897;75905.86141207887;77602.61198694083;77733;7972.2824945755165;8101.230383113595;8173.673053078048;8426.831463370576;8456.915430845613;50812.49187508078;51251;51551.2267315998;52007.73996129995;52845.20732188944;66972;74756;75336.62331688307;76013;76080.85878711713;8139.674413023413;9866.901330986886;9912.504374781376;10247.897521024694;10741.677749667522;10874.293170943864;11058.391788451712;11488.655340339803;11857.644270671894;11869.287842729118;10362.171026318027;10771.46142692878;10813.243072984815;10820.621278255223;11185.993260606585;10578.523966421375;10818.621348252773;10825.350478971286;10830.133589312994;10920;10435.217358698279;10545.472726363805;10669.46652667379;10763.784724305313;11192.552297908318;9001.279897608307;9008.607233643996;9180.540972951192;9192.080791920755;9206.355555111079;8626.698065567674;8685.706294265075;10018.810706716775;10103.848442273518;10244.48777561104 08:01:32 INFO - PROCESS | 1972 | __end_tp_report 08:01:32 INFO - PROCESS | 1972 | __start_cc_report 08:01:32 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,1228 08:01:32 INFO - PROCESS | 1972 | __end_cc_report 08:01:32 INFO - PROCESS | 1972 | __startTimestamp1455724892062__endTimestamp 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | ------- Summary: start ------- 08:01:32 INFO - PROCESS | 1972 | Number of tests: 6 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | [#0] dojo.html Cycles:165 Average:5617.04 Median:5839.82 stddev:629.16 (10.8%) stddev-sans-first:594.02 08:01:32 INFO - PROCESS | 1972 | Values: 2904.5 3377.4 3452.2 3484.8 3506.4 5544.2 5596.6 5613.2 5621.0 5631.7 4844.4 5615.2 5637.0 5638.1 5658.1 5031.7 5069.4 5074.4 5093.4 5228.7 5175.9 5178.6 5212.8 5217.6 5230.9 4985.7 5066.5 5119.1 5159.6 5170.9 5147.4 5160.0 5175.1 5180.4 5212.9 5047.5 5104.8 5122.6 5134.3 5143.3 5060.8 5398.7 5509.2 5530.8 5534.7 6054.2 6056.6 6072.8 6078.1 6083.7 4960.3 6051.5 6076.7 6099.7 6101.4 5620.8 5640.2 5652.3 5730.7 5742.8 6183.9 6221.4 6292.4 6296.4 6306.2 5941.4 5963.7 5977.9 5978.5 5979.0 6126.4 6127.7 6136.6 6140.6 6146.7 5957.2 6058.5 6059.0 6077.6 6082.8 6107.6 6140.5 6151.9 6175.6 6180.8 4831.5 4846.1 4853.7 4854.2 4913.9 4264.6 4298.6 4321.5 4355.5 4357.2 5523.1 5533.9 5535.2 5536.6 5540.8 6093.3 6110.1 6113.2 6118.0 6128.9 5403.5 5476.8 5533.4 5538.8 5546.0 5276.8 5277.4 5284.3 5290.6 5297.7 6127.5 6189.8 6286.7 6298.5 6301.1 6204.9 6207.7 6223.4 6250.3 6258.7 6248.0 6259.7 6269.6 6287.5 6287.7 5884.2 5972.6 5997.6 6011.6 6081.7 6022.2 6034.4 6049.9 6054.4 6058.5 5681.5 5835.7 5843.7 5849.3 5856.8 5390.8 6004.5 6093.5 6100.2 6114.1 5210.0 5691.7 5841.0 5880.9 5882.4 5893.5 5986.9 6004.2 6010.9 6017.1 5741.6 5839.8 5865.4 5870.1 5947.9 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | [#1] ext.html Cycles:180 Average:63117.02 Median:37115.36 stddev:134257.16 (361.7%) stddev-sans-first:134551.44 08:01:32 INFO - PROCESS | 1972 | Values: 488.2 522.3 566.3 575.1 575.1 24801.9 29307.7 29663.4 29702.0 29812.0 33978.3 38205.6 38523.6 40130.8 40139.6 9437.9 9652.5 9672.9 9680.7 9691.0 9629.3 9790.4 9800.6 9802.2 9806.1 9748.8 9842.3 9848.0 9849.0 9856.6 9719.7 9819.3 9820.2 9834.5 9839.5 9551.8 9679.7 9687.3 9696.3 9697.5 38573.8 38846.6 38865.2 38877.0 38904.8 3002.3 3015.8 3034.4 3071.6 3089.7 27774.6 27836.6 27885.2 28262.9 28900.7 2791.4 2815.9 2823.3 2838.9 2857.8 413877.0 484763.0 486835.0 487438.0 488336.6 51818.0 52632.7 59294.0 59618.8 60671.7 61181.7 61969.4 62114.8 62216.0 62236.0 15565.8 15731.8 15789.1 15857.4 15881.5 10992.8 11097.2 11099.9 11104.4 12197.3 18755.2 18807.7 18966.5 18969.5 18971.4 7072.5 8278.9 8480.7 8502.0 8541.1 906.5 919.3 963.3 971.5 1106.2 28836.6 28948.9 29236.0 29457.6 29637.0 993.5 1065.9 1071.9 1094.2 1167.6 14986.7 15008.7 15150.7 15267.0 15290.5 515032.0 527885.0 528702.0 529104.0 529124.0 54032.0 54035.7 54037.7 54097.2 54329.2 1261.7 1271.7 1319.0 1420.3 1438.1 27100.7 27159.0 27671.0 27672.3 27677.9 41612.0 41776.7 41824.8 41896.4 45088.6 506812.0 510246.0 511718.4 512236.0 512933.0 28335.9 29246.0 29254.6 29260.7 29312.4 40334.0 40680.6 40770.0 41021.4 41111.4 34292.0 34570.8 34846.0 35959.8 36025.1 35146.8 35206.6 35278.8 35383.6 35453.6 34140.3 34976.7 35052.6 35131.8 35181.5 29694.7 31298.8 31353.0 31376.0 31510.4 20738.5 23075.4 24060.9 24264.8 24945.0 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | [#2] jquery.html Cycles:180 Average:36946.58 Median:1600.74 stddev:120114.79 (7503.7%) stddev-sans-first:120420.23 08:01:32 INFO - PROCESS | 1972 | Values: 300.8 364.9 365.3 366.1 373.1 14560.9 15661.3 19201.6 20230.3 20837.2 20670.7 20839.0 21308.9 21544.7 21553.5 6361.0 6522.7 6553.9 6558.6 6574.0 4558.8 4718.7 4750.8 6508.4 7418.8 7228.6 7320.8 7363.0 7407.0 7419.3 7086.3 7197.5 7310.3 7440.0 7448.1 6999.3 7000.9 7001.2 7009.2 7023.0 25690.0 25850.5 26317.6 26416.5 27052.6 2170.2 2396.0 2523.2 2900.7 3066.6 13732.0 15313.8 15450.8 15481.1 15962.6 1884.8 1930.9 1954.6 1978.7 1989.8 62250.0 72939.0 74238.0 113795.9 113829.0 10323.2 10712.8 10872.8 10882.9 10968.6 12023.5 12342.5 12368.7 12961.4 13007.9 6430.7 6920.6 7899.6 8379.7 8386.9 6789.0 8373.2 8425.2 8480.1 8497.1 4388.0 4429.2 4432.4 4440.1 4479.5 1815.9 1861.3 1890.8 1895.5 1899.2 391.4 858.9 909.9 1004.2 1010.6 11344.5 11357.8 11517.0 11563.7 11627.5 436.9 448.3 448.4 452.8 472.4 5375.7 5891.6 6030.1 6046.5 6133.1 685921.0 686502.0 733116.0 752628.0 783255.8 113181.0 116793.0 122098.0 123056.4 124064.8 1024.7 1081.9 1113.3 1175.6 1176.1 17660.0 17889.3 17986.7 18070.3 18384.1 50814.5 50902.5 50959.5 51739.9 52933.7 67108.3 67193.3 72340.3 74876.0 74969.6 7229.8 7624.9 7676.3 7696.7 7721.9 10091.3 12297.1 12372.3 12573.9 12586.3 10534.3 10751.0 10918.9 10921.6 11013.6 10585.9 10614.0 10651.9 10737.9 10956.0 6112.8 10475.9 10706.0 10777.0 11068.6 7504.8 7691.8 7694.3 7807.3 7903.2 8663.9 10942.5 11090.4 11173.3 11227.7 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | [#3] mootools.html Cycles:180 Average:6082.30 Median:5212.28 stddev:3233.73 (62.0%) stddev-sans-first:3223.71 08:01:32 INFO - PROCESS | 1972 | Values: 1407.7 1548.6 1572.1 1809.2 1943.9 7632.5 8615.3 8774.3 8785.5 8788.5 8456.9 8750.5 8759.6 8769.0 8775.1 2167.6 2226.5 2420.8 2464.4 2502.7 2459.8 2494.2 2501.0 2506.3 2509.5 2464.8 2491.4 2498.1 2498.5 2499.4 2348.5 2404.5 2417.5 2422.0 2424.7 2324.2 2340.6 2431.1 2483.3 2485.1 8823.9 8919.5 8922.0 8948.3 8984.0 5371.8 5537.3 5588.2 5589.7 5615.3 3572.0 3622.6 3684.2 3703.0 3723.1 984.6 989.3 999.0 1013.3 1023.0 12089.5 12101.3 12103.3 12119.6 12137.0 4879.4 4882.5 4937.9 4993.3 4999.0 10281.9 10300.7 10309.5 10312.5 10321.4 4547.3 5564.6 5565.7 5566.4 5566.4 4973.9 4989.1 5024.4 5042.6 5052.8 3883.1 3937.9 3939.2 3941.2 3984.9 1281.3 1285.8 1289.3 1302.0 1307.3 1073.2 1092.0 1093.8 1260.0 1361.4 8113.2 8179.2 8193.8 8198.8 8242.6 1072.0 1107.9 1116.9 1183.5 1197.0 6264.8 6283.5 6330.7 6346.2 6348.3 10638.5 11096.0 11098.8 11133.7 11190.8 10436.3 10915.7 10948.0 10956.8 10993.3 8317.9 8425.5 8442.2 8447.1 8454.4 7779.4 7837.0 7851.8 7908.5 7934.3 9427.4 9691.3 9795.4 9797.2 9856.1 8799.0 9791.0 10054.9 10316.3 10335.8 5685.9 6348.8 6522.9 6899.9 6911.1 8217.3 8235.7 8281.9 8282.3 8288.7 7375.0 7556.2 7575.9 7648.7 7745.4 7348.4 7474.7 7561.8 7574.5 7624.4 7593.4 7657.6 7658.9 7659.0 7666.6 6872.4 6884.0 6916.9 6945.8 6948.9 6140.4 7030.2 7097.2 7106.0 7144.6 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | [#4] prototype.html Cycles:180 Average:5885.38 Median:6679.18 stddev:1876.11 (28.1%) stddev-sans-first:1833.39 08:01:32 INFO - PROCESS | 1972 | Values: 268.5 321.4 322.4 326.5 333.8 6512.1 6548.8 6716.6 6782.9 6790.8 6479.4 6569.6 6607.6 6635.8 6641.8 4916.7 4918.7 4923.7 4926.2 4951.1 3871.8 4818.3 4828.9 4872.2 4975.5 4853.5 4859.1 4866.0 4874.2 4915.9 4901.1 4927.6 4928.2 4931.9 4937.1 4200.3 4207.5 4224.8 4232.2 4248.6 6283.7 6432.5 6465.6 6473.4 6504.1 5047.3 5707.6 5881.5 5897.1 5902.4 6850.3 7071.4 7178.0 7180.7 7190.9 4622.4 4729.3 4733.2 4734.8 4745.5 7450.2 7587.7 7597.7 7609.8 7626.7 4673.1 4844.7 4848.5 4852.9 4853.3 4912.3 4931.7 4934.6 4937.5 4947.9 5841.8 5876.2 5877.8 5902.8 5915.9 7191.9 7203.9 7205.1 7206.8 7225.3 1498.1 1657.3 1689.4 1717.0 1720.0 1098.8 1112.3 1117.7 1130.6 1133.3 6721.2 6731.3 6731.9 6740.6 6747.6 7405.9 7435.3 7439.7 7454.8 7484.7 6543.8 6735.4 6737.3 6750.6 6757.9 3911.1 3955.6 3957.5 3964.4 3971.3 7858.8 7860.5 7865.8 7869.4 7899.9 6290.5 7521.3 7708.3 7724.8 7725.3 6163.7 7576.5 7804.0 7814.0 7833.8 7314.0 7345.9 7481.1 7493.2 7512.7 7296.7 7347.8 7357.3 7358.3 7383.5 7656.4 7762.1 7857.1 7861.2 7865.4 4659.5 4705.0 4710.6 4714.4 4742.7 7072.6 7414.4 7426.4 7447.9 7466.3 6307.4 6910.0 7210.5 7216.9 7223.4 7182.2 7198.3 7199.7 7206.1 7213.1 6833.6 6992.0 6996.9 7002.9 7018.3 7190.9 7198.6 7199.9 7207.1 7215.6 7022.5 7022.9 7031.6 7042.9 7046.8 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - PROCESS | 1972 | [#5] yui.html Cycles:180 Average:18999.26 Median:607.49 stddev:27361.75 (4504.1%) stddev-sans-first:27403.76 08:01:32 INFO - PROCESS | 1972 | Values: 634.3 658.5 701.6 729.0 783.9 15031.7 15248.0 15289.5 15313.9 17266.1 15948.6 15948.7 15989.8 16023.8 16026.4 600.3 704.0 863.8 879.3 880.7 851.5 856.9 870.3 870.9 871.4 921.6 922.4 925.0 925.6 926.1 732.1 744.3 920.1 921.7 944.8 679.7 680.3 680.8 681.7 681.9 15124.7 15169.9 15188.6 15237.6 15240.9 12482.4 12748.0 12821.8 12949.2 12961.7 10212.9 10235.6 10239.5 10253.5 10355.4 3497.6 3538.3 3548.0 3557.1 3557.6 61711.1 77885.4 79701.2 79918.6 79995.6 9528.9 9555.2 9735.4 9818.1 9929.6 18354.6 22224.8 22224.9 22249.8 22275.0 7410.5 7466.2 7575.3 7610.2 7689.2 3952.0 4032.7 4072.7 4109.2 4223.0 3602.5 3657.9 3663.7 3675.0 3692.0 549.2 645.7 662.4 673.6 700.0 510.0 519.8 581.7 606.6 608.4 8708.9 9246.5 9275.0 9447.8 9508.2 430.0 555.7 615.3 617.8 632.2 3793.8 3986.0 4045.7 4092.5 4146.4 98467.0 99813.0 100480.0 100645.5 104443.0 83987.6 85154.1 85493.0 85583.3 86133.3 75487.6 75572.6 75905.9 77602.6 77733.0 7972.3 8101.2 8173.7 8426.8 8456.9 50812.5 51251.0 51551.2 52007.7 52845.2 66972.0 74756.0 75336.6 76013.0 76080.9 8139.7 9866.9 9912.5 10247.9 10741.7 10874.3 11058.4 11488.7 11857.6 11869.3 10362.2 10771.5 10813.2 10820.6 11186.0 10578.5 10818.6 10825.4 10830.1 10920.0 10435.2 10545.5 10669.5 10763.8 11192.6 9001.3 9008.6 9180.5 9192.1 9206.4 8626.7 8685.7 10018.8 10103.8 10244.5 08:01:32 INFO - PROCESS | 1972 | -------- Summary: end -------- 08:01:32 INFO - PROCESS | 1972 | 08:01:32 INFO - TEST-INFO | 1972: exit 0 08:01:32 INFO - TEST-OK | dromaeo_css | took 1114295ms 08:01:32 INFO - TEST-START | kraken 08:01:32 INFO - operating with platform_type : mac_ 08:01:32 INFO - Initialising browser for kraken test... 08:01:32 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpWBh20u/profile http://localhost:49617/getInfo.html) 08:01:34 INFO - PROCESS | 1975 | __metrics Screen width/height:1600/1200 08:01:34 INFO - PROCESS | 1975 | colorDepth:24 08:01:34 INFO - PROCESS | 1975 | Browser inner width/height: 1024/689 08:01:34 INFO - PROCESS | 1975 | __metrics 08:01:34 INFO - PROCESS | 1975 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:01:34 INFO - PROCESS | 1975 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:35 INFO - TEST-INFO | 1975: exit 0 08:01:35 INFO - Browser initialized. 08:01:35 INFO - Running cycle 1/1 for kraken test... 08:01:35 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpWBh20u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:47 INFO - PROCESS | 1977 | RSS: Main: 244346880 08:01:47 INFO - PROCESS | 1977 | 08:01:50 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49617/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:50 INFO - PROCESS | 1977 | RSS: Main: 290631680 08:01:50 INFO - PROCESS | 1977 | 08:01:53 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49617/tests/kraken/driver.html?testName=audio-dft) 08:01:53 INFO - PROCESS | 1977 | RSS: Main: 301002752 08:01:53 INFO - PROCESS | 1977 | 08:01:57 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49617/tests/kraken/driver.html?testName=audio-fft) 08:01:57 INFO - PROCESS | 1977 | RSS: Main: 288137216 08:01:57 INFO - PROCESS | 1977 | 08:01:59 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49617/tests/kraken/driver.html?testName=audio-oscillator) 08:02:00 INFO - PROCESS | 1977 | RSS: Main: 291745792 08:02:00 INFO - PROCESS | 1977 | 08:02:02 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:02 INFO - PROCESS | 1977 | RSS: Main: 290529280 08:02:02 INFO - PROCESS | 1977 | 08:02:05 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49617/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:06 INFO - PROCESS | 1977 | RSS: Main: 291872768 08:02:06 INFO - PROCESS | 1977 | 08:02:09 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49617/tests/kraken/driver.html?testName=imaging-desaturate) 08:02:09 INFO - PROCESS | 1977 | RSS: Main: 289984512 08:02:09 INFO - PROCESS | 1977 | 08:02:12 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49617/tests/kraken/driver.html?testName=json-parse-financial) 08:02:13 INFO - PROCESS | 1977 | RSS: Main: 291536896 08:02:13 INFO - PROCESS | 1977 | 08:02:14 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:02:15 INFO - PROCESS | 1977 | RSS: Main: 325959680 08:02:15 INFO - PROCESS | 1977 | 08:02:17 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:17 INFO - PROCESS | 1977 | RSS: Main: 324919296 08:02:17 INFO - PROCESS | 1977 | 08:02:20 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:20 INFO - PROCESS | 1977 | RSS: Main: 333254656 08:02:20 INFO - PROCESS | 1977 | 08:02:23 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:23 INFO - PROCESS | 1977 | RSS: Main: 333422592 08:02:23 INFO - PROCESS | 1977 | 08:02:26 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:26 INFO - PROCESS | 1977 | RSS: Main: 333643776 08:02:26 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:49617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49617/tests/kraken/driver.html?testName=ai-astar) 08:02:28 INFO - PROCESS | 1977 | RSS: Main: 394829824 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | __start_tp_report 08:02:28 INFO - PROCESS | 1977 | _x_x_mozilla_page_load 08:02:28 INFO - PROCESS | 1977 | _x_x_mozilla_page_load_details 08:02:28 INFO - PROCESS | 1977 | |i|pagename|runs| 08:02:28 INFO - PROCESS | 1977 | |0;ai-astar;112;109;112;154;164;112;115;111;112;111 08:02:28 INFO - PROCESS | 1977 | |1;audio-beat-detection;158;122;148;154;120;145;142;119;159;118 08:02:28 INFO - PROCESS | 1977 | |2;audio-dft;185;185;186;188;187;183;185;182;183;185 08:02:28 INFO - PROCESS | 1977 | |3;audio-fft;74;77;87;91;47;57;69;99;103;80 08:02:28 INFO - PROCESS | 1977 | |4;audio-oscillator;92;93;129;78;81;83;110;76;78;110 08:02:28 INFO - PROCESS | 1977 | |5;imaging-gaussian-blur;92;97;91;95;91;97;87;97;87;93 08:02:28 INFO - PROCESS | 1977 | |6;imaging-darkroom;95;96;96;96;108;145;104;97;95;94 08:02:28 INFO - PROCESS | 1977 | |7;imaging-desaturate;100;130;141;88;122;89;85;89;88;101 08:02:28 INFO - PROCESS | 1977 | |8;json-parse-financial;55;55;52;54;53;55;55;64;52;51 08:02:28 INFO - PROCESS | 1977 | |9;json-stringify-tinderbox;63;63;75;77;69;68;66;67;69;67 08:02:28 INFO - PROCESS | 1977 | |10;stanford-crypto-aes;86;81;83;83;81;79;80;81;84;84 08:02:28 INFO - PROCESS | 1977 | |11;stanford-crypto-ccm;127;127;125;140;120;126;125;121;121;127 08:02:28 INFO - PROCESS | 1977 | |12;stanford-crypto-pbkdf2;135;161;136;138;137;126;137;136;138;136 08:02:28 INFO - PROCESS | 1977 | |13;stanford-crypto-sha256-iterative;65;66;65;67;66;65;64;66;66;65 08:02:28 INFO - PROCESS | 1977 | __end_tp_report 08:02:28 INFO - PROCESS | 1977 | __start_cc_report 08:02:28 INFO - PROCESS | 1977 | _x_x_mozilla_cycle_collect,1144 08:02:28 INFO - PROCESS | 1977 | __end_cc_report 08:02:28 INFO - PROCESS | 1977 | __startTimestamp1455724948738__endTimestamp 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | ------- Summary: start ------- 08:02:28 INFO - PROCESS | 1977 | Number of tests: 14 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#0] ai-astar Cycles:10 Average:121.20 Median:112.00 stddev:20.12 (18.0%) stddev-sans-first:21.06 08:02:28 INFO - PROCESS | 1977 | Values: 112.0 109.0 112.0 154.0 164.0 112.0 115.0 111.0 112.0 111.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#1] audio-beat-detection Cycles:10 Average:138.50 Median:146.50 stddev:17.00 (11.6%) stddev-sans-first:16.50 08:02:28 INFO - PROCESS | 1977 | Values: 158.0 122.0 148.0 154.0 120.0 145.0 142.0 119.0 159.0 118.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.85 (1.0%) stddev-sans-first:1.96 08:02:28 INFO - PROCESS | 1977 | Values: 185.0 185.0 186.0 188.0 187.0 183.0 185.0 182.0 183.0 185.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#3] audio-fft Cycles:10 Average:78.40 Median:78.50 stddev:17.70 (22.5%) stddev-sans-first:18.70 08:02:28 INFO - PROCESS | 1977 | Values: 74.0 77.0 87.0 91.0 47.0 57.0 69.0 99.0 103.0 80.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.50 stddev:17.82 (22.4%) stddev-sans-first:18.90 08:02:28 INFO - PROCESS | 1977 | Values: 92.0 93.0 129.0 78.0 81.0 83.0 110.0 76.0 78.0 110.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:94.00 stddev:3.83 (4.1%) stddev-sans-first:4.06 08:02:28 INFO - PROCESS | 1977 | Values: 92.0 97.0 91.0 95.0 91.0 97.0 87.0 97.0 87.0 93.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:95.50 stddev:15.56 (16.3%) stddev-sans-first:16.26 08:02:28 INFO - PROCESS | 1977 | Values: 95.0 96.0 96.0 96.0 108.0 145.0 104.0 97.0 95.0 94.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#7] imaging-desaturate Cycles:10 Average:103.30 Median:86.50 stddev:20.31 (23.5%) stddev-sans-first:21.51 08:02:28 INFO - PROCESS | 1977 | Values: 100.0 130.0 141.0 88.0 122.0 89.0 85.0 89.0 88.0 101.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:3.63 (6.6%) stddev-sans-first:3.84 08:02:28 INFO - PROCESS | 1977 | Values: 55.0 55.0 52.0 54.0 53.0 55.0 55.0 64.0 52.0 51.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:4.55 (6.6%) stddev-sans-first:4.39 08:02:28 INFO - PROCESS | 1977 | Values: 63.0 63.0 75.0 77.0 69.0 68.0 66.0 67.0 69.0 67.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:2.15 (2.6%) stddev-sans-first:1.79 08:02:28 INFO - PROCESS | 1977 | Values: 86.0 81.0 83.0 83.0 81.0 79.0 80.0 81.0 84.0 84.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.50 stddev:5.65 (4.5%) stddev-sans-first:5.97 08:02:28 INFO - PROCESS | 1977 | Values: 127.0 127.0 125.0 140.0 120.0 126.0 125.0 121.0 121.0 127.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.00 Median:137.00 stddev:8.79 (6.4%) stddev-sans-first:9.26 08:02:28 INFO - PROCESS | 1977 | Values: 135.0 161.0 136.0 138.0 137.0 126.0 137.0 136.0 138.0 136.0 08:02:28 INFO - PROCESS | 1977 | 08:02:28 INFO - PROCESS | 1977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 08:02:28 INFO - PROCESS | 1977 | Values: 65.0 66.0 65.0 67.0 66.0 65.0 64.0 66.0 66.0 65.0 08:02:28 INFO - PROCESS | 1977 | -------- Summary: end -------- 08:02:28 INFO - PROCESS | 1977 | 08:02:29 INFO - TEST-INFO | 1977: exit 0 08:02:29 INFO - TEST-OK | kraken | took 56828ms 08:02:29 INFO - SUITE-END | took 1171s 08:02:29 INFO - Completed test suite (00:19:31) 08:02:29 INFO - Working with test: dromaeo_css 08:02:29 INFO - Generating results file: dromaeo_css 08:02:29 INFO - Working with test: kraken 08:02:29 INFO - Generating results file: kraken 08:02:29 INFO - javascript benchmark 08:02:29 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:02:29 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 08:02:29 INFO - process_Request line: dromaeo_css 7452.34 graph.html#tests=[[72,64,59]] 08:02:29 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:02:30 INFO - process_Request line: kraken 1449.20 graph.html#tests=[[232,64,59]] 08:02:30 INFO - RETURN: dromaeo_css: 7452.34 08:02:30 INFO - RETURN: kraken: 1449.20 08:02:30 INFO - javascript benchmark 08:02:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2904.4771941050617, 3377.3751855906658, 3452.171478845078, 3484.7909125452493, 3506.351325004874, 5544.223808666779, 5596.636218645785, 5613.2141500189955, 5620.988222120017, 5631.746571404286, 4844.442889067758, 5615.185798059279, 5637.041702910505, 5638.126090455976, 5658.094704847225, 5031.698098114125, 5069.366329208849, 5074.441811400752, 5093.388793344785, 5228.712420816853, 5175.896482070356, 5178.6116041297055, 5212.8436146915465, 5217.634765566412, 5230.895382092375, 4985.651004429691, 5066.493350664941, 5119.104156772569, 5159.5614372778355, 5170.870728231786, 5147.356580427447, 5160.0, 5175.094358487249, 5180.430152683201, 5212.869678258036, 5047.545720885138, 5104.770285337132, 5122.564582010534, 5134.332536770196, 5143.3313669223135, 5060.7722652480725, 5398.676079435247, 5509.228707980846, 5530.778768849241, 5534.695591742453, 6054.212952316215, 6056.6063205891915, 6072.787452439144, 6078.088286756978, 6083.66539840313, 4960.305557221992, 6051.515878729735, 6076.696165191767, 6099.69501524922, 6101.359357267467, 5620.803271885465, 5640.238567793377, 5652.265205523256, 5730.656160630376, 5742.770289188427, 6183.876322473526, 6221.4089661482085, 6292.370762923671, 6296.401841825019, 6306.24325080984, 5941.435563621449, 5963.701814909237, 5977.940220597825, 5978.491828194652, 5978.970105149447, 6126.448619624255, 6127.724252408652, 6136.631802091889, 6140.600860944024, 6146.723397447036, 5957.2255606771705, 6058.515318774487, 6059.000264956233, 6077.604955677955, 6082.847928801815, 6107.552954153525, 6140.508759299245, 6151.938480615226, 6175.59858609189, 6180.81457556274, 4831.492693267156, 4846.055019271279, 4853.6602437829715, 4854.247591623304, 4913.877153071202, 4264.552222016644, 4298.634616057608, 4321.481422229353, 4355.5426680198125, 4357.237483440385, 5523.116301391758, 5533.889322213533, 5535.225068490415, 5536.612437129363, 5540.806071787468, 6093.268807743099, 6110.114033465212, 6113.174721412642, 6118.0211166214085, 6128.908066379008, 5403.459654034644, 5476.7535460904355, 5533.418991005967, 5538.75075621598, 5546.0, 5276.762545685377, 5277.393099793496, 5284.339457567804, 5290.603204759658, 5297.735113244323, 6127.525510585588, 6189.81430557075, 6286.748530058747, 6298.464630506367, 6301.149344838388, 6204.937950620436, 6207.689615519296, 6223.439890409885, 6250.281217660027, 6258.749650013949, 6247.96876015617, 6259.718312675849, 6269.62382257066, 6287.528435367274, 6287.685615719104, 5884.205632239764, 5972.58191926561, 5997.55018373615, 6011.60924539921, 6081.6655083969035, 6022.247219097613, 6034.366391528826, 6049.941260279522, 6054.424829641177, 6058.545609079249, 5681.545476361964, 5835.7373918174635, 5843.707814609337, 5849.327327357409, 5856.765729370948, 5390.811321603725, 6004.549658775697, 6093.48205402528, 6100.206973093647, 6114.113453549299, 5209.973950130225, 5691.7438715257085, 5841.0, 5880.852978675567, 5882.352941176553, 5893.528517718487, 5986.9401305986385, 6004.159417681441, 6010.87978240424, 6017.06735456005, 5741.569382296261, 5839.824805255849, 5865.413458654271, 5870.119482077723, 5947.940520594739], "unit": "score", "name": "dojo.html", "value": 5577.613256380499}, {"lowerIsBetter": false, "replicates": [488.17011081162036, 522.3366324767543, 566.3486989961542, 575.0856138739405, 575.1143239411307, 24801.883915223814, 29307.67308172957, 29663.40673186535, 29701.96043138488, 29811.95658151965, 33978.32043359131, 38205.61794382055, 38523.61476385242, 40130.79934600323, 40139.598604013954, 9437.905620943788, 9652.469114198717, 9672.854907176397, 9680.709578712649, 9690.951545242264, 9629.27780416468, 9790.412575245473, 9800.607975681, 9802.166815820663, 9806.11744942955, 9748.805023899518, 9842.261830362751, 9848.0, 9848.950755246215, 9856.605735770561, 9719.708408747749, 9819.31264811467, 9820.214382849426, 9834.459104749236, 9839.508024598741, 9551.761205969837, 9679.661211857621, 9687.32188746788, 9696.321257511978, 9697.515124243759, 38573.807130964444, 38846.611533884585, 38865.222695545934, 38877.0, 38904.805475972724, 3002.2944608017096, 3015.8469046444156, 3034.408290383376, 3071.616047994001, 3089.686455514885, 27774.583381249297, 27836.582451263246, 27885.163445096478, 28262.858685706644, 28900.710992890014, 2791.3998490324475, 2815.9155225343275, 2823.3365159187574, 2838.886444542216, 2857.8285302881895, 413877.0, 484763.0, 486835.0, 487438.0, 488336.5583172097, 51818.0, 52632.73683631558, 59294.0, 59618.80762384728, 60671.69664151651, 61181.69409152926, 61969.380306197265, 62114.757704846554, 62216.0, 62236.0, 15565.844341556665, 15731.842681573267, 15789.052656840626, 15857.365705371656, 15881.52355429339, 10992.835107473395, 11097.223194376316, 11099.944500277446, 11104.389258590694, 12197.268163910194, 18755.249790008245, 18807.717884231748, 18966.525836853914, 18969.482441404656, 18971.43085707431, 7072.504924655224, 8278.917210827934, 8480.74557763268, 8501.95749021251, 8541.103184165697, 906.4515967839494, 919.2875521470913, 963.2781279201521, 971.4802580619335, 1106.1703722208345, 28836.567451488245, 28948.855255724007, 29236.0, 29457.55813662797, 29637.0, 993.5082134343402, 1065.8755013460873, 1071.8552995345685, 1094.1574987259764, 1167.6030149749126, 14986.700265994838, 15008.699826003418, 15150.696986060437, 15267.0, 15290.464833730766, 515032.0, 527885.0, 528702.0, 529104.0, 529124.0, 54032.0, 54035.729821350644, 54037.72981135148, 54097.1885421719, 54329.185062224096, 1261.6656586004717, 1271.650296168561, 1318.967025824362, 1420.3027382278078, 1438.1155589312707, 27100.72899270982, 27159.04943326974, 27671.0, 27672.308192295353, 27677.861610691816, 41612.0, 41776.74669759912, 41824.79087604542, 41896.3715544261, 45088.64734057983, 506812.0, 510246.0, 511718.4414077906, 512236.0, 512933.0, 28335.858320708263, 29246.0, 29254.561181581867, 29260.707392925797, 29312.41375172527, 40334.0, 40680.59319406768, 40770.0, 41021.38467922924, 41111.38332925068, 34292.0, 34570.82714586411, 34846.0, 35959.82020089883, 36025.09937251485, 35146.82426587953, 35206.64793352034, 35278.82360588181, 35383.64616353803, 35453.645463545035, 34140.31719365648, 34976.65023349734, 35052.64947350596, 35131.824340878135, 35181.47227791534, 29694.703052969195, 31298.843505783236, 31353.0, 31376.0, 31510.36979260356, 20738.48153796167, 23075.423114421603, 24060.87969560211, 24264.757352426248, 24945.0], "unit": "score", "name": "ext.html", "value": 18895.071051785857}, {"lowerIsBetter": false, "replicates": [300.81048939168323, 364.8868850656296, 365.2858661317125, 366.0920916128004, 373.1343283582091, 14560.927195364035, 15661.295241714122, 19201.61596768064, 20230.29193978209, 20837.166513339467, 20670.689939650918, 20839.0, 21308.8934555327, 21544.676829847525, 21553.46116347092, 6361.045843123534, 6522.7390904363765, 6553.868922621545, 6558.6064836109745, 6574.0, 4558.794854231567, 4718.740469274206, 4750.764801151691, 6508.381703738138, 7418.814529636776, 7228.566286022829, 7320.816979575527, 7363.0, 7407.000054992561, 7419.33226009659, 7086.291370862924, 7197.496175267734, 7310.268973102674, 7439.962800185965, 7448.106227252711, 6999.335063168991, 7000.859982800315, 7001.229864714877, 7009.1589009318695, 7022.964885175541, 25690.0, 25850.48299034009, 26317.605235921477, 26416.471670566672, 27052.59421108685, 2170.2437903862005, 2395.988020059906, 2523.2178024812365, 2900.666423361319, 3066.647335556417, 13732.038757286993, 15313.846861531354, 15450.768238476432, 15481.14853683047, 15962.600934976603, 1884.7832499262622, 1930.94207173785, 1954.6090781843545, 1978.6636271833822, 1989.7512810898638, 62250.0, 72939.0, 74238.0, 113795.86204137935, 113829.0, 10323.225758068174, 10712.78574428507, 10872.836907446395, 10882.891171088346, 10968.561257549769, 12023.519059237708, 12342.506299748089, 12368.690782730504, 12961.351932403342, 13007.934960325138, 6430.7106180222, 6920.619365934821, 7899.565523896241, 8379.664813407395, 8386.87419688705, 6789.0, 8373.204545568162, 8425.241728244488, 8480.109588493242, 8497.107803680648, 4388.012697143117, 4429.247028005182, 4432.445944256968, 4440.134173836135, 4479.529649386833, 1815.8638102142393, 1861.2741030997922, 1890.8014658460663, 1895.5450691834137, 1899.173859371178, 391.38357087587167, 858.8711693246063, 909.8999110097884, 1004.1765752083368, 1010.5851807469454, 11344.546218151181, 11357.829632555518, 11516.963473287444, 11563.6530904073, 11627.476763545661, 436.8733067410479, 448.26708331877614, 448.3879504476366, 452.76003718029494, 472.3693868685275, 5375.6774593524515, 5891.646501209855, 6030.095485677183, 6046.486048685823, 6133.110698948627, 685921.0, 686502.0, 733116.0, 752628.0, 783255.7534910942, 113181.0, 116793.0, 122097.99999999822, 123056.38471807583, 124064.75935240713, 1024.7233247023262, 1081.9296745711504, 1113.3375641493299, 1175.5826681528106, 1176.147293212414, 17660.02869842171, 17889.28442862271, 17986.730199047288, 18070.277188912296, 18384.080795960417, 50814.47556573309, 50902.49097508978, 50959.49040509547, 51739.895606263744, 52933.7353313231, 67108.3289167102, 67193.3280667187, 72340.27659723336, 74876.0, 74969.62515187389, 7229.783106506813, 7624.923750762421, 7676.347510461674, 7696.653650585849, 7721.92278077212, 10091.293609447268, 12297.139200255897, 12372.319522426353, 12573.87426125727, 12586.307753073303, 10534.315269507457, 10751.0, 10918.94540527324, 10921.563137474412, 11013.559457621606, 10585.9470702646, 10614.0, 10651.934806519286, 10737.946310268399, 10956.013958743433, 6112.847178820565, 10475.895241047492, 10706.036456718934, 10777.0, 11068.5572577096, 7504.812379690333, 7691.769246922601, 7694.269044440769, 7807.336376408069, 7903.209679032051, 8663.917010373703, 10942.507587158438, 11090.447337372612, 11173.273737207055, 11227.71930701739], "unit": "score", "name": "jquery.html", "value": 9087.656514867656}, {"lowerIsBetter": false, "replicates": [1407.7114191590724, 1548.6051056980473, 1572.080333005192, 1809.231076792363, 1943.9222431102758, 7632.503887247325, 8615.31077513799, 8774.341924355684, 8785.472871627691, 8788.472691638499, 8456.91543084569, 8750.474971501699, 8759.649614015432, 8768.956155219215, 8775.122487751221, 2167.5881582499355, 2226.543558570497, 2420.8426452280546, 2464.4208610976407, 2502.6621406110216, 2459.827812053157, 2494.189388448752, 2500.962485562718, 2506.2982364937757, 2509.498100379922, 2464.7904928081134, 2491.364702000987, 2498.113169824713, 2498.475320182764, 2499.4251322195905, 2348.53029394121, 2404.483036147219, 2417.492326611414, 2421.987890060556, 2424.6605475233305, 2324.1981516376823, 2340.578695834749, 2431.088341871798, 2483.279848843833, 2485.092941076512, 8823.867641985375, 8919.509426981513, 8921.955390223073, 8948.328875334377, 8984.0, 5371.785128594852, 5537.335519737617, 5588.2455868458055, 5589.692566908819, 5615.326160860682, 3572.0, 3622.619624939396, 3684.1526448916898, 3702.9629703702885, 3723.1250656095795, 984.5618699678646, 989.302541708094, 998.990010099897, 1013.3109485549824, 1023.0076825479273, 12089.516419343216, 12101.334426606621, 12103.334316612583, 12119.636410907598, 12137.0, 4879.365682461257, 4882.487338829372, 4937.925931111036, 4993.325901003318, 4999.0, 10281.948590257001, 10300.690979270634, 10309.484525773682, 10312.484375781181, 10321.432321222255, 4547.295169248771, 5564.554835613141, 5565.66606003633, 5566.415526369673, 5566.443355664401, 4973.875653108701, 4989.0770207511005, 5024.42219144803, 5042.596592272609, 5052.7726252318735, 3883.0680636647003, 3937.8621748238675, 3939.1727737174942, 3941.2117576484816, 3984.920301593952, 1281.2888846690175, 1285.8392700912386, 1289.3037759609892, 1301.9609411717663, 1307.2744626732065, 1073.1736562846565, 1092.011729384908, 1093.830456279278, 1259.9559015434415, 1361.4213959067554, 8113.188681131957, 8179.182081791892, 8193.8361232775, 8198.8360232795, 8242.587870606445, 1072.0351683484926, 1107.855978722761, 1116.9497372618252, 1183.508843829801, 1196.976060478803, 6264.780732674426, 6283.465905398001, 6330.68346582669, 6346.174997250328, 6348.333424990309, 10638.468076596295, 11096.00135987765, 11098.834622364697, 11133.721656958642, 11190.832137517944, 10436.321639093434, 10915.672529824118, 10948.014678678797, 10956.780864382668, 10993.34039957589, 8317.875231871527, 8425.45234559764, 8442.227132302285, 8447.113053129333, 8454.365922555833, 7779.377649788116, 7837.020372453443, 7851.803704907423, 7908.52548847071, 7934.325582325567, 9427.434353938786, 9691.2731545133, 9795.412275263507, 9797.167240784613, 9856.063673950963, 8798.956005219932, 9790.951045244728, 10054.949725251327, 10316.329438586468, 10335.84496232542, 5685.8862822742485, 6348.809535713936, 6522.902156467751, 6899.896501552581, 6911.101556797584, 8217.342612591097, 8235.711750088718, 8281.917180828355, 8282.337413006824, 8288.70989515364, 7374.963125184339, 7556.206598307319, 7575.886361704689, 7648.73229436967, 7745.380369570534, 7348.448866334939, 7474.701011959461, 7561.848763024819, 7574.5076570022775, 7624.390048796194, 7593.392528597809, 7657.57883316423, 7658.889461028231, 7659.008657748914, 7666.57833819123, 6872.41584465306, 6884.0, 6916.896246556406, 6945.791626251221, 6948.9305106950305, 6140.355262697352, 7030.191527974144, 7097.183823860116, 7106.0, 7144.607046612278], "unit": "score", "name": "mootools.html", "value": 4938.35570000399}, {"lowerIsBetter": false, "replicates": [268.4711119095382, 321.350871240095, 322.3955084217093, 326.4874147588287, 333.80305619684384, 6512.055751915976, 6548.770793022245, 6716.597004179746, 6782.864342713149, 6790.762323318685, 6479.449246814014, 6569.638669873155, 6607.636579988099, 6635.834104147399, 6641.767538136166, 4916.704997700132, 4918.680285781422, 4923.679960802537, 4926.211806111023, 4951.084049450845, 3871.845126194949, 4818.253170758538, 4828.855134345975, 4872.220444728844, 4975.4527002029745, 4853.538913803183, 4859.125357435661, 4865.975670121645, 4874.2444921037295, 4915.8525244242555, 4901.09329773993, 4927.630427717918, 4928.211486162197, 4931.852044438672, 4937.136001199776, 4200.264953633133, 4207.474065741782, 4224.831006759726, 4232.238197124517, 4248.638865696419, 6283.748650053993, 6432.456210509491, 6465.579737317059, 6473.352664733536, 6504.056911747817, 5047.343845300087, 5707.601637598815, 5881.47066763989, 5897.085951677497, 5902.380250073724, 6850.280720524323, 7071.398931090864, 7177.964110179468, 7180.676869540883, 7190.892136617955, 4622.399088118523, 4729.266963620645, 4733.242681170997, 4734.786934587952, 4745.454272758642, 7450.18048014718, 7587.734429294948, 7597.696092156362, 7609.847803043964, 7626.733064342721, 4673.065386922629, 4844.709317440965, 4848.490908454562, 4852.902941941142, 4853.296272040534, 4912.312276281324, 4931.7040977541465, 4934.605231581465, 4937.481564435682, 4947.925781113287, 5841.824745257649, 5876.177335173079, 5877.794277200363, 5902.822915312548, 5915.911261331084, 7191.89212161818, 7203.89194162088, 7205.135383753983, 7206.783796486114, 7225.313595208552, 1498.116111494202, 1657.2542355939875, 1689.3833750680913, 1716.9570760730833, 1719.968019188502, 1098.8132017557034, 1112.3103675721104, 1117.6591139702307, 1130.6494986554194, 1133.3369978562469, 6721.227058888193, 6731.259561448237, 6731.932680673229, 6740.561863478858, 6747.595144291358, 7405.8889116663295, 7435.25647435263, 7439.702411903571, 7454.776356709307, 7484.738034168887, 6543.770968016097, 6735.360140786617, 6737.258901520829, 6750.649870025916, 6757.898631520531, 3911.1395492991496, 3955.624215699504, 3957.5448823385104, 3964.385520244367, 3971.2653159165648, 7858.764237072897, 7860.528368297921, 7865.764027079197, 7869.370450363957, 7899.881501777478, 6290.528210384148, 7521.323080922743, 7708.306252437307, 7724.7682569523, 7725.304722574995, 6163.691815409212, 7576.545407275581, 7804.0, 7814.023247094114, 7833.843323133506, 7314.0, 7345.853082938418, 7481.102267727908, 7493.213212612597, 7512.699492020258, 7296.7446139384865, 7347.8163045924275, 7357.337839594462, 7358.337749602561, 7383.483156179016, 7656.387489000978, 7762.068551773823, 7857.05715314166, 7861.213878612093, 7865.370770338473, 4659.534046595313, 4704.9529504704515, 4710.552497512731, 4714.434267887876, 4742.691725037999, 7072.611006394698, 7414.406847452083, 7426.405887529093, 7447.88828167567, 7466.25337466249, 6307.369263073656, 6910.0, 7210.495265331377, 7216.89174662391, 7223.386012188813, 7182.209956904632, 7198.2801719829695, 7199.71201151948, 7206.063211782434, 7213.098362704662, 6833.624150671761, 6992.0, 6996.860062798817, 7002.859942801014, 7018.33325834045, 7190.892136618059, 7198.5680859148615, 7199.8560028800175, 7207.099112610924, 7215.639218039182, 7022.54353467023, 7022.894656580053, 7031.613261270679, 7042.894356584553, 7046.753363632453], "unit": "score", "name": "prototype.html", "value": 5249.750518392112}, {"lowerIsBetter": false, "replicates": [634.264253465979, 658.4699317049774, 701.5615240474704, 728.9794287996806, 783.8907945257461, 15031.699366012674, 15248.0, 15289.541313760577, 15313.92343038286, 17266.136693165354, 15948.601284967852, 15948.681026379465, 15989.760153597676, 16023.759643605355, 16026.35894564216, 600.2916558461014, 704.0284407517619, 863.7926897544576, 879.2526352600303, 880.744584070622, 851.4891065360765, 856.8543347630917, 870.2776695342882, 870.9390342676015, 871.424859592669, 921.5991043895893, 922.4096578189964, 925.0379605210607, 925.6436272035247, 926.0970553710146, 732.1104857598017, 744.2520267131498, 920.0707285641483, 921.7004473546058, 944.8393773058527, 679.7111227728195, 680.3400701319712, 680.7787469072522, 681.7204945972128, 681.8738533371293, 15124.697506049817, 15169.924150379287, 15188.620284492865, 15237.61905952349, 15240.923795381063, 12482.375881205904, 12748.0, 12821.807672884914, 12949.158304710163, 12961.675958101028, 10212.94893525535, 10235.6417525387, 10239.514381845223, 10253.487057983843, 10355.430451325174, 3497.562804649419, 3538.31002954424, 3547.9822600887087, 3557.1285035166293, 3557.62644922282, 61711.07433388503, 77885.44229115442, 79701.20298796995, 79918.60040699759, 79995.6000220001, 9528.857067143997, 9555.23558115349, 9735.41587504752, 9818.116369526777, 9929.602815887429, 18354.63290734178, 22224.77775222227, 22224.88887555552, 22249.77750222477, 22274.99762510691, 7410.481266311414, 7466.2027833001985, 7575.318221360104, 7610.1628820829665, 7689.192634773268, 3951.9802400988387, 4032.737872038308, 4072.735272207297, 4109.198706252312, 4222.9577704222565, 3602.5316708827686, 3657.908552286161, 3663.670269675742, 3674.9816250918575, 3691.963080369162, 549.1926867504761, 645.7191121862005, 662.3707477896018, 673.5756473421714, 699.9720011199597, 509.96175286853634, 519.773334929566, 581.7324030945813, 606.6084757233128, 608.3733754233147, 8708.912910870937, 9246.4914429707, 9274.95362523183, 9447.76380590477, 9508.239340852715, 429.98925026874576, 555.7304707216997, 615.258613370887, 617.8146556033172, 632.1623848400887, 3793.79134147619, 3985.980070099689, 4045.6763458923215, 4092.4884389451317, 4146.440230568895, 98467.01532984579, 99813.0, 100480.0, 100645.49677251567, 104443.0, 83987.5800620993, 85154.14845851586, 85493.0, 85583.28833423297, 86133.27733445421, 75487.62256188683, 75572.62213688897, 75905.86141207887, 77602.61198694083, 77733.0, 7972.2824945755165, 8101.230383113595, 8173.673053078048, 8426.831463370576, 8456.915430845613, 50812.49187508078, 51251.0, 51551.2267315998, 52007.73996129995, 52845.20732188944, 66972.0, 74756.0, 75336.62331688307, 76013.0, 76080.85878711713, 8139.674413023413, 9866.901330986886, 9912.504374781376, 10247.897521024694, 10741.677749667522, 10874.293170943864, 11058.391788451712, 11488.655340339803, 11857.644270671894, 11869.287842729118, 10362.171026318027, 10771.46142692878, 10813.243072984815, 10820.621278255223, 11185.993260606585, 10578.523966421375, 10818.621348252773, 10825.350478971286, 10830.133589312994, 10920.0, 10435.217358698279, 10545.472726363805, 10669.46652667379, 10763.784724305313, 11192.552297908318, 9001.279897608307, 9008.607233643996, 9180.540972951192, 9192.080791920755, 9206.355555111079, 8626.698065567674, 8685.706294265075, 10018.810706716775, 10103.848442273518, 10244.48777561104], "unit": "score", "name": "yui.html", "value": 6898.49519735642}], "name": "dromaeo_css", "value": 7452.3424700559135}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 154.0, 164.0, 112.0, 115.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 121.2}, {"lowerIsBetter": true, "replicates": [158.0, 122.0, 148.0, 154.0, 120.0, 145.0, 142.0, 119.0, 159.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 138.5}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 188.0, 187.0, 183.0, 185.0, 182.0, 183.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 87.0, 91.0, 47.0, 57.0, 69.0, 99.0, 103.0, 80.0], "unit": "score", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 129.0, 78.0, 81.0, 83.0, 110.0, 76.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 91.0, 95.0, 91.0, 97.0, 87.0, 97.0, 87.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 108.0, 145.0, 104.0, 97.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 102.6}, {"lowerIsBetter": true, "replicates": [100.0, 130.0, 141.0, 88.0, 122.0, 89.0, 85.0, 89.0, 88.0, 101.0], "unit": "score", "name": "imaging-desaturate", "value": 103.3}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 52.0, 54.0, 53.0, 55.0, 55.0, 64.0, 52.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 75.0, 77.0, 69.0, 68.0, 66.0, 67.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [86.0, 81.0, 83.0, 83.0, 81.0, 79.0, 80.0, 81.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 125.0, 140.0, 120.0, 126.0, 125.0, 121.0, 121.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [135.0, 161.0, 136.0, 138.0, 137.0, 126.0, 137.0, 136.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 67.0, 66.0, 65.0, 64.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1449.2000000000003}]} 08:02:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1449.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7452.34"}}} 08:02:30 INFO - Return code: 0 08:02:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:02:30 INFO - # TBPL SUCCESS # 08:02:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:02:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:02:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:02:30 INFO - 2016-02-17 08:02:30.154 screenresolution[1981:14811] starting screenresolution argv=screenresolution get 08:02:30 INFO - 2016-02-17 08:02:30.157 screenresolution[1981:14811] Display 0: 1600x1200x32@60 08:02:30 INFO - 2016-02-17 08:02:30.163 screenresolution[1982:14814] starting screenresolution argv=screenresolution list 08:02:30 INFO - Available Modes on Display 0 08:02:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:02:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:02:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:02:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:02:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:02:30 INFO - Intel Iris: 08:02:30 INFO - Chipset Model: Intel Iris 08:02:30 INFO - Type: GPU 08:02:30 INFO - Bus: Built-In 08:02:30 INFO - VRAM (Dynamic, Max): 1536 MB 08:02:30 INFO - Vendor: Intel (0x8086) 08:02:30 INFO - Device ID: 0x0a2e 08:02:30 INFO - Revision ID: 0x0009 08:02:30 INFO - Displays: 08:02:30 INFO - Display: 08:02:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:02:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:02:30 INFO - Display Serial Number: 1600x1200 60 08:02:30 INFO - Main Display: Yes 08:02:30 INFO - Mirror: Off 08:02:30 INFO - Online: Yes 08:02:30 INFO - Rotation: Supported 08:02:30 INFO - Return code: 0 08:02:30 INFO - Running post-action listener: _resource_record_post_action 08:02:30 INFO - Running post-run listener: _resource_record_post_run 08:02:31 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 2514944; Write bytes: 709325312; Read time: 41; Write time: 1980 08:02:31 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384633344; Write bytes: 380086272; Read time: 29566; Write time: 748 08:02:31 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2514944; Write bytes: 301734400; Read time: 41; Write time: 1175 08:02:31 INFO - Running post-run listener: _upload_blobber_files 08:02:31 INFO - Blob upload gear active. 08:02:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:31 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 08:02:31 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'] 08:02:31 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 08:02:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:32 INFO - (blobuploader) - INFO - Done attempting. 08:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:33 INFO - (blobuploader) - INFO - Done attempting. 08:02:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:33 INFO - Return code: 0 08:02:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dddcc26a26c2bfc23a3ba5deed71511fc0b166e656d5573a6bd23a098e137c04e98d195ad6dcf4b2878a9b918f6ccc522768bf52530851de4e4dce08b5110e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9912b59755cd6dbc56ab10209fccaea0393821a00b6222e06a835a5f3fa0c1f6e48cca18694d2d97577804a4e1c98da1ae5d36d706a9138e587c8a06ac9857d"} 08:02:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:33 INFO - Contents: 08:02:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dddcc26a26c2bfc23a3ba5deed71511fc0b166e656d5573a6bd23a098e137c04e98d195ad6dcf4b2878a9b918f6ccc522768bf52530851de4e4dce08b5110e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9912b59755cd6dbc56ab10209fccaea0393821a00b6222e06a835a5f3fa0c1f6e48cca18694d2d97577804a4e1c98da1ae5d36d706a9138e587c8a06ac9857d"} 08:02:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:33 INFO - Copying logs to upload dir... 08:02:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.206018 ========= master_lag: 9.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-02-17 08:02:42.464447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 26 secs) (at 2016-02-17 08:02:42.472267) ========= 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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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/7dddcc26a26c2bfc23a3ba5deed71511fc0b166e656d5573a6bd23a098e137c04e98d195ad6dcf4b2878a9b918f6ccc522768bf52530851de4e4dce08b5110e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9912b59755cd6dbc56ab10209fccaea0393821a00b6222e06a835a5f3fa0c1f6e48cca18694d2d97577804a4e1c98da1ae5d36d706a9138e587c8a06ac9857d"} build_url:https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/Wtl4xFPESMe1Dk6fGpVp3Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dddcc26a26c2bfc23a3ba5deed71511fc0b166e656d5573a6bd23a098e137c04e98d195ad6dcf4b2878a9b918f6ccc522768bf52530851de4e4dce08b5110e2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9912b59755cd6dbc56ab10209fccaea0393821a00b6222e06a835a5f3fa0c1f6e48cca18694d2d97577804a4e1c98da1ae5d36d706a9138e587c8a06ac9857d"}' ========= master_lag: 26.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 26 secs) (at 2016-02-17 08:03:08.950404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 mins, 11 secs) (at 2016-02-17 08:03:08.950713) ========= 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.UTBAInPvuz/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.9l9VKZJuLa/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005960 ========= master_lag: 71.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 mins, 11 secs) (at 2016-02-17 08:04:20.050824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 08:04:20.051192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 08:04:20.586262) ========= ========= Total master_lag: 158.76 =========