builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1455278652.69 results: success (0) buildid: 20160209083856 builduid: 403f360bd5a141d983f8512961491f49 revision: 9799df240b379e461fd1ea9dedea3bbe7dfb9631 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:12.695448) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:12.695860) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:12.696153) ========= 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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005731 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:12.750346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-02-12 04:04:12.750669) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-02-12 04:04:14.096322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:14.096768) ========= 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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.005592 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:14.262235) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:14.262643) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:14.263297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 04:04:14.263597) ========= 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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-12 04:04:14-- 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% 173M=0s 2016-02-12 04:04:15 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.924390 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 04:04:15.790015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:15.791507) ========= 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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.027346 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:15.879761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 04:04:15.880066) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9799df240b379e461fd1ea9dedea3bbe7dfb9631 --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 9799df240b379e461fd1ea9dedea3bbe7dfb9631 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-12 04:04:15,993 truncating revision to first 12 chars 2016-02-12 04:04:15,993 Setting DEBUG logging. 2016-02-12 04:04:15,993 attempt 1/10 2016-02-12 04:04:15,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9799df240b37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 04:04:16,753 unpacking tar archive at: fx-team-9799df240b37/testing/mozharness/ program finished with exit code 0 elapsedTime=1.010140 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 04:04:16.952149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:16.955478) ========= echo 9799df240b379e461fd1ea9dedea3bbe7dfb9631 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9799df240b379e461fd1ea9dedea3bbe7dfb9631'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 9799df240b379e461fd1ea9dedea3bbe7dfb9631 program finished with exit code 0 elapsedTime=0.005444 script_repo_revision: '9799df240b379e461fd1ea9dedea3bbe7dfb9631' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:17.005319) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:17.008662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 04:04:17.039677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-02-12 04:04:17.040030) ========= /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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:04:17 INFO - MultiFileLogger online at 20160212 04:04:17 in /builds/slave/test 04:04:17 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 04:04:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:17 INFO - {'append_to_log': False, 04:04:17 INFO - 'base_work_dir': '/builds/slave/test', 04:04:17 INFO - 'blob_upload_branch': 'Fx-Team', 04:04:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:17 INFO - 'branch': 'Fx-Team', 04:04:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:17 INFO - 'config_files': ('talos/mac_config.py',), 04:04:17 INFO - 'default_actions': ('clobber', 04:04:17 INFO - 'read-buildbot-config', 04:04:17 INFO - 'download-and-extract', 04:04:17 INFO - 'populate-webroot', 04:04:17 INFO - 'create-virtualenv', 04:04:17 INFO - 'install', 04:04:17 INFO - 'run-tests'), 04:04:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:17 INFO - 'download_minidump_stackwalk': True, 04:04:17 INFO - 'download_symbols': 'ondemand', 04:04:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:17 INFO - 'installer_path': 'installer.exe', 04:04:17 INFO - 'log_level': 'info', 04:04:17 INFO - 'log_name': 'talos', 04:04:17 INFO - 'log_to_console': True, 04:04:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:04:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:04:17 INFO - 'opt_config_files': (), 04:04:17 INFO - 'pip_index': False, 04:04:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:17 INFO - 'cmd': ('bash', 04:04:17 INFO - '-c', 04:04:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:17 INFO - 'enabled': True, 04:04:17 INFO - 'halt_on_failure': False, 04:04:17 INFO - 'name': 'check_screen_resolution'},), 04:04:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:17 INFO - 'cmd': ('bash', 04:04:17 INFO - '-c', 04:04:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:17 INFO - 'enabled': True, 04:04:17 INFO - 'halt_on_failure': False, 04:04:17 INFO - 'name': 'check_screen_resolution'},), 04:04:17 INFO - 'run_cmd_checks_enabled': True, 04:04:17 INFO - 'sps_profile': False, 04:04:17 INFO - 'sps_profile_interval': 0, 04:04:17 INFO - 'suite': 'dromaeojs', 04:04:17 INFO - 'system_bits': '32', 04:04:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:17 INFO - 'title': 't-yosemite-r7-0177', 04:04:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:17 INFO - 'use_talos_json': True, 04:04:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:17 INFO - 'work_dir': 'build'} 04:04:17 INFO - ##### 04:04:17 INFO - ##### Running clobber step. 04:04:17 INFO - ##### 04:04:17 INFO - Running pre-action listener: _resource_record_pre_action 04:04:17 INFO - Running main action method: clobber 04:04:17 INFO - rmtree: /builds/slave/test/build 04:04:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:18 INFO - Running post-action listener: _resource_record_post_action 04:04:18 INFO - ##### 04:04:18 INFO - ##### Running read-buildbot-config step. 04:04:18 INFO - ##### 04:04:18 INFO - Running pre-action listener: _resource_record_pre_action 04:04:18 INFO - Running main action method: read_buildbot_config 04:04:18 INFO - Using buildbot properties: 04:04:18 INFO - { 04:04:18 INFO - "project": "", 04:04:18 INFO - "product": "firefox", 04:04:18 INFO - "script_repo_revision": "production", 04:04:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:04:18 INFO - "repository": "", 04:04:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:04:18 INFO - "buildid": "20160209083856", 04:04:18 INFO - "pgo_build": "False", 04:04:18 INFO - "basedir": "/builds/slave/test", 04:04:18 INFO - "buildnumber": 367, 04:04:18 INFO - "slavename": "t-yosemite-r7-0177", 04:04:18 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:04:18 INFO - "platform": "yosemite_r7", 04:04:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:04:18 INFO - "branch": "fx-team", 04:04:18 INFO - "repo_path": "integration/fx-team", 04:04:18 INFO - "revision": "9799df240b379e461fd1ea9dedea3bbe7dfb9631", 04:04:18 INFO - "stage_platform": "macosx64", 04:04:18 INFO - "builduid": "403f360bd5a141d983f8512961491f49", 04:04:18 INFO - "slavebuilddir": "test" 04:04:18 INFO - } 04:04:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:04:18 INFO - Running post-action listener: _resource_record_post_action 04:04:18 INFO - ##### 04:04:18 INFO - ##### Running download-and-extract step. 04:04:18 INFO - ##### 04:04:18 INFO - Running pre-action listener: _resource_record_pre_action 04:04:18 INFO - Running main action method: download_and_extract 04:04:18 INFO - mkdir: /builds/slave/test/build/tests 04:04:18 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')]} 04:04:18 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:04:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json 04:04:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json 04:04:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:04:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:04:42 INFO - Downloaded 1277 bytes. 04:04:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:04:42 INFO - Using the following test package requirements: 04:04:42 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:04:42 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:04:42 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:04:42 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'jsshell-mac.zip'], 04:04:42 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:04:42 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:04:42 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:04:42 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:04:42 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:04:42 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:04:42 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:04:42 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:04:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:04:42 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')]} 04:04:42 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:04:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:04:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:04:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:04:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:05:05 INFO - Downloaded 17747173 bytes. 04:05:05 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'] 04:05:05 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 04:05:08 INFO - Return code: 0 04:05:08 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 04:05: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')]} 04:05:08 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:05:25 INFO - Downloaded 17747173 bytes. 04:05:25 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'] 04:05:25 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 04:05:28 INFO - Return code: 0 04:05:28 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')]} 04:05:28 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:05:29 INFO - Downloaded 10706547 bytes. 04:05:29 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'] 04:05:29 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 04:05:29 INFO - Return code: 0 04:05:29 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')]} 04:05:29 INFO - https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:05:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:05:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:05:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TzP9fzomQD6LLClrivCwVg/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 04:05:32 INFO - Downloaded 111247204 bytes. 04:05:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:05:32 INFO - mkdir: /builds/slave/test/properties 04:05:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:32 INFO - Contents: 04:05:32 INFO - build_url:https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:05:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - Running post-action listener: set_extra_try_arguments 04:05:33 INFO - ##### 04:05:33 INFO - ##### Running populate-webroot step. 04:05:33 INFO - ##### 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: populate_webroot 04:05:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:33 INFO - '--tppagecycles', 04:05:33 INFO - '7'], 04:05:33 INFO - 'tests': ['tsvgm']}}, 04:05:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:05:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:05:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'tests': ['damp', 'tps']}, 04:05:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['damp', 'tps']}, 04:05:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:05:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:33 INFO - 'other': {'tests': ['a11yr', 04:05:33 INFO - 'ts_paint', 04:05:33 INFO - 'tpaint', 04:05:33 INFO - 'sessionrestore', 04:05:33 INFO - 'sessionrestore_no_auto_restore']}, 04:05:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['a11yr', 04:05:33 INFO - 'ts_paint', 04:05:33 INFO - 'tpaint', 04:05:33 INFO - 'sessionrestore', 04:05:33 INFO - 'sessionrestore_no_auto_restore']}, 04:05:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['a11yr', 04:05:33 INFO - 'ts_paint', 04:05:33 INFO - 'tpaint', 04:05:33 INFO - 'sessionrestore', 04:05:33 INFO - 'sessionrestore_no_auto_restore']}, 04:05:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['a11yr', 04:05:33 INFO - 'ts_paint', 04:05:33 INFO - 'tpaint', 04:05:33 INFO - 'sessionrestore', 04:05:33 INFO - 'sessionrestore_no_auto_restore']}, 04:05:33 INFO - 'other_l64': {'tests': ['a11yr', 04:05:33 INFO - 'ts_paint', 04:05:33 INFO - 'tpaint', 04:05:33 INFO - 'sessionrestore', 04:05:33 INFO - 'sessionrestore_no_auto_restore']}, 04:05:33 INFO - 'other_nol64': {'tests': ['a11yr', 04:05:33 INFO - 'ts_paint', 04:05:33 INFO - 'tpaint', 04:05:33 INFO - 'sessionrestore', 04:05:33 INFO - 'sessionrestore_no_auto_restore']}, 04:05:33 INFO - 'svgr': {'tests': ['tsvgx', 04:05:33 INFO - 'tsvgr_opacity', 04:05:33 INFO - 'tart', 04:05:33 INFO - 'tscrollx', 04:05:33 INFO - 'cart']}, 04:05:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['tsvgx', 04:05:33 INFO - 'tsvgr_opacity', 04:05:33 INFO - 'tart', 04:05:33 INFO - 'tscrollx', 04:05:33 INFO - 'cart']}, 04:05:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'tests': ['tp5o']}, 04:05:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'talos_options': ['--e10s'], 04:05:33 INFO - 'tests': ['tp5o']}, 04:05:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'talos_options': ['--xperf_path', 04:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:33 INFO - 'tests': ['tp5n']}, 04:05:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:33 INFO - 'talos_options': ['--e10s', 04:05:33 INFO - '--xperf_path', 04:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:33 INFO - 'tests': ['tp5n']}}, 04:05:33 INFO - 'talos.zip': {'path': '', 04:05:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - ##### 04:05:33 INFO - ##### Running create-virtualenv step. 04:05:33 INFO - ##### 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: create_virtualenv 04:05:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:33 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 04:05:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:33 INFO - Using real prefix '/tools/python27' 04:05:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:36 INFO - Installing pip.................done. 04:05:36 INFO - Return code: 0 04:05:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:36 INFO - 'HOME': '/Users/cltbld', 04:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:36 INFO - 'LOGNAME': 'cltbld', 04:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:36 INFO - 'MOZ_NO_REMOTE': '1', 04:05:36 INFO - 'NO_EM_RESTART': '1', 04:05:36 INFO - 'PAGER': '/bin/cat', 04:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:36 INFO - 'PWD': '/builds/slave/test', 04:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:36 INFO - 'SHELL': '/bin/bash', 04:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:36 INFO - 'USER': 'cltbld', 04:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:36 INFO - 'XPC_FLAGS': '0x0', 04:05:36 INFO - 'XPC_SERVICE_NAME': '0', 04:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:37 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 04:05:37 INFO - Cleaning up... 04:05:37 INFO - Return code: 0 04:05:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:05:37 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')]} 04:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:37 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')]} 04:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:37 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 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:37 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 04:05:37 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 04:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:37 INFO - 'HOME': '/Users/cltbld', 04:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:37 INFO - 'LOGNAME': 'cltbld', 04:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:37 INFO - 'MOZ_NO_REMOTE': '1', 04:05:37 INFO - 'NO_EM_RESTART': '1', 04:05:37 INFO - 'PAGER': '/bin/cat', 04:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:37 INFO - 'PWD': '/builds/slave/test', 04:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:37 INFO - 'SHELL': '/bin/bash', 04:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:37 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:37 INFO - 'USER': 'cltbld', 04:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:37 INFO - 'XPC_FLAGS': '0x0', 04:05:37 INFO - 'XPC_SERVICE_NAME': '0', 04:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:37 INFO - Downloading/unpacking psutil>=0.7.1 04:05:37 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 04:05:37 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 04:05:37 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 04:05:37 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 04:05:37 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 04:05:37 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 04:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:40 INFO - Installing collected packages: psutil 04:05:40 INFO - Running setup.py install for psutil 04:05:40 INFO - building 'psutil._psutil_osx' extension 04:05:40 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 04:05:40 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 04:05:41 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 04:05:41 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 04:05:41 INFO - building 'psutil._psutil_posix' extension 04:05:41 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 04:05:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:05:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:05:41 INFO - ^ 04:05:41 INFO - 1 warning generated. 04:05:41 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 04:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:41 INFO - Successfully installed psutil 04:05:41 INFO - Cleaning up... 04:05:41 INFO - Return code: 0 04:05:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:05:41 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')]} 04:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:41 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')]} 04:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:41 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 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:41 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 04:05:41 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 04:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:41 INFO - 'HOME': '/Users/cltbld', 04:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:41 INFO - 'LOGNAME': 'cltbld', 04:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:41 INFO - 'MOZ_NO_REMOTE': '1', 04:05:41 INFO - 'NO_EM_RESTART': '1', 04:05:41 INFO - 'PAGER': '/bin/cat', 04:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:41 INFO - 'PWD': '/builds/slave/test', 04:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:41 INFO - 'SHELL': '/bin/bash', 04:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:41 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:41 INFO - 'USER': 'cltbld', 04:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:41 INFO - 'XPC_FLAGS': '0x0', 04:05:41 INFO - 'XPC_SERVICE_NAME': '0', 04:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 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 04:05:41 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 04:05:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:05:44 INFO - Installing collected packages: mozsystemmonitor 04:05:44 INFO - Running setup.py install for mozsystemmonitor 04:05:44 INFO - Successfully installed mozsystemmonitor 04:05:44 INFO - Cleaning up... 04:05:44 INFO - Return code: 0 04:05:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05: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')]} 04:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05: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')]} 04:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:44 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 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:44 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 04:05:44 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 04:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:44 INFO - 'HOME': '/Users/cltbld', 04:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:44 INFO - 'LOGNAME': 'cltbld', 04:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:44 INFO - 'MOZ_NO_REMOTE': '1', 04:05:44 INFO - 'NO_EM_RESTART': '1', 04:05:44 INFO - 'PAGER': '/bin/cat', 04:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:44 INFO - 'PWD': '/builds/slave/test', 04:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:44 INFO - 'SHELL': '/bin/bash', 04:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:44 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:44 INFO - 'USER': 'cltbld', 04:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:44 INFO - 'XPC_FLAGS': '0x0', 04:05:44 INFO - 'XPC_SERVICE_NAME': '0', 04:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:44 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 04:05:44 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 04:05:44 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 04:05:44 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 04:05:44 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 04:05:44 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 04:05:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:05:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:48 INFO - Downloading docopt-0.6.1.tar.gz 04:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:48 INFO - Running setup.py install for blobuploader 04:05:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:05:48 INFO - Running setup.py install for requests 04:05:48 INFO - Running setup.py install for docopt 04:05:48 INFO - Successfully installed blobuploader requests docopt 04:05:48 INFO - Cleaning up... 04:05:49 INFO - Return code: 0 04:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:49 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 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:49 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 04:05:49 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 04:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:49 INFO - 'HOME': '/Users/cltbld', 04:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:49 INFO - 'LOGNAME': 'cltbld', 04:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:49 INFO - 'MOZ_NO_REMOTE': '1', 04:05:49 INFO - 'NO_EM_RESTART': '1', 04:05:49 INFO - 'PAGER': '/bin/cat', 04:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:49 INFO - 'PWD': '/builds/slave/test', 04:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:49 INFO - 'SHELL': '/bin/bash', 04:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:49 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:49 INFO - 'USER': 'cltbld', 04:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:49 INFO - 'XPC_FLAGS': '0x0', 04:05:49 INFO - 'XPC_SERVICE_NAME': '0', 04:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gxkoxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-h0THJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-fgz9rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0Ifr8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-5WVLw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-oUNrOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xjeJml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:49 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xJkilR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wiwZaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-tRL80Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-CNxguK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-aUf1zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-T7I3OH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-IYwhrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-q8CjBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-4zKo2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Lah96H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:51 INFO - Running setup.py install for manifestparser 04:05:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Running setup.py install for mozcrash 04:05:51 INFO - Running setup.py install for mozdebug 04:05:51 INFO - Running setup.py install for mozdevice 04:05:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Running setup.py install for mozfile 04:05:51 INFO - Running setup.py install for mozhttpd 04:05:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:05:51 INFO - Running setup.py install for mozinfo 04:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Running setup.py install for mozInstall 04:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Running setup.py install for mozleak 04:05:52 INFO - Running setup.py install for mozlog 04:05:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Running setup.py install for moznetwork 04:05:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:05:52 INFO - Running setup.py install for mozprocess 04:05:52 INFO - Running setup.py install for mozprofile 04:05:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:05:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:05:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:05:53 INFO - Running setup.py install for mozrunner 04:05:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:05:53 INFO - Running setup.py install for mozscreenshot 04:05:53 INFO - Running setup.py install for moztest 04:05:53 INFO - Running setup.py install for mozversion 04:05:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:05:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:53 INFO - Cleaning up... 04:05:53 INFO - Return code: 0 04:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:53 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 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:53 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 04:05:53 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 04:05:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:53 INFO - 'HOME': '/Users/cltbld', 04:05:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:53 INFO - 'LOGNAME': 'cltbld', 04:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:53 INFO - 'MOZ_NO_REMOTE': '1', 04:05:53 INFO - 'NO_EM_RESTART': '1', 04:05:53 INFO - 'PAGER': '/bin/cat', 04:05:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:53 INFO - 'PWD': '/builds/slave/test', 04:05:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:53 INFO - 'SHELL': '/bin/bash', 04:05:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:53 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:53 INFO - 'USER': 'cltbld', 04:05:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:53 INFO - 'XPC_FLAGS': '0x0', 04:05:53 INFO - 'XPC_SERVICE_NAME': '0', 04:05:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:53 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3pOGeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-uRd2TC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JWApVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rggJUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-njCpdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-kFghiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-yPrRPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-hAdJdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-zNnKEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:54 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)) 04:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:54 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-NpRZqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-sleFgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xlsG5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-LHQALC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JA1Cx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-CqLjbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-KQY9JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:55 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)) 04:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-BRqeqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:55 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)) 04:05:55 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)) 04:05:55 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)) 04:05:55 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)) 04:05:55 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)) 04:05:55 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)) 04:05:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:05:57 INFO - Downloading blessings-1.6.tar.gz 04:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:58 INFO - Installing collected packages: blessings 04:05:58 INFO - Running setup.py install for blessings 04:05:58 INFO - Successfully installed blessings 04:05:58 INFO - Cleaning up... 04:05:58 INFO - Return code: 0 04:05:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:05:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:58 INFO - Reading from file tmpfile_stdout 04:05:58 INFO - Current package versions: 04:05:58 INFO - blessings == 1.6 04:05:58 INFO - blobuploader == 1.2.4 04:05:58 INFO - docopt == 0.6.1 04:05:58 INFO - manifestparser == 1.1 04:05:58 INFO - mozInstall == 1.12 04:05:58 INFO - mozcrash == 0.16 04:05:58 INFO - mozdebug == 0.1 04:05:58 INFO - mozdevice == 0.48 04:05:58 INFO - mozfile == 1.2 04:05:58 INFO - mozhttpd == 0.7 04:05:58 INFO - mozinfo == 0.9 04:05:58 INFO - mozleak == 0.1 04:05:58 INFO - mozlog == 3.1 04:05:58 INFO - moznetwork == 0.27 04:05:58 INFO - mozprocess == 0.22 04:05:58 INFO - mozprofile == 0.28 04:05:58 INFO - mozrunner == 6.11 04:05:58 INFO - mozscreenshot == 0.1 04:05:58 INFO - mozsystemmonitor == 0.0 04:05:58 INFO - moztest == 0.7 04:05:58 INFO - mozversion == 1.4 04:05:58 INFO - psutil == 3.1.1 04:05:58 INFO - requests == 1.2.3 04:05:58 INFO - wsgiref == 0.1.2 04:05:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 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 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:58 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 04:05:58 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 04:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:58 INFO - 'HOME': '/Users/cltbld', 04:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PAGER': '/bin/cat', 04:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:58 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - 'XPC_FLAGS': '0x0', 04:05:58 INFO - 'XPC_SERVICE_NAME': '0', 04:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 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)) 04:05:58 INFO - Cleaning up... 04:05:58 INFO - Return code: 0 04:05:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:05:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:05:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:58 INFO - 'HOME': '/Users/cltbld', 04:05:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:58 INFO - 'LOGNAME': 'cltbld', 04:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:58 INFO - 'MOZ_NO_REMOTE': '1', 04:05:58 INFO - 'NO_EM_RESTART': '1', 04:05:58 INFO - 'PAGER': '/bin/cat', 04:05:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:58 INFO - 'PWD': '/builds/slave/test', 04:05:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:58 INFO - 'SHELL': '/bin/bash', 04:05:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:05:58 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:05:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:58 INFO - 'USER': 'cltbld', 04:05:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:58 INFO - 'XPC_FLAGS': '0x0', 04:05:58 INFO - 'XPC_SERVICE_NAME': '0', 04:05:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:59 INFO - Downloading/unpacking jsonschema 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:05: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 04:06:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:01 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 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 04:06:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:01 INFO - warning: no files found matching '*.txt' 04:06:01 INFO - no previously-included directories found matching 'build' 04:06:01 INFO - no previously-included directories found matching 'dist' 04:06:01 INFO - no previously-included directories found matching '.git*' 04:06:01 INFO - Installing collected packages: jsonschema, functools32 04:06:02 INFO - Running setup.py install for functools32 04:06:02 INFO - warning: no files found matching '*.txt' 04:06:02 INFO - no previously-included directories found matching 'build' 04:06:02 INFO - no previously-included directories found matching 'dist' 04:06:02 INFO - no previously-included directories found matching '.git*' 04:06:02 INFO - Successfully installed jsonschema functools32 04:06:02 INFO - Cleaning up... 04:06:02 INFO - Return code: 0 04:06:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105445a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10544d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa52acc0bc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, '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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 04:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:06:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:06:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:02 INFO - 'HOME': '/Users/cltbld', 04:06:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:02 INFO - 'LOGNAME': 'cltbld', 04:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:02 INFO - 'MOZ_NO_REMOTE': '1', 04:06:02 INFO - 'NO_EM_RESTART': '1', 04:06:02 INFO - 'PAGER': '/bin/cat', 04:06:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:02 INFO - 'PWD': '/builds/slave/test', 04:06:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:02 INFO - 'SHELL': '/bin/bash', 04:06:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:06:02 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:06:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:02 INFO - 'USER': 'cltbld', 04:06:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:02 INFO - 'XPC_FLAGS': '0x0', 04:06:02 INFO - 'XPC_SERVICE_NAME': '0', 04:06:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:02 INFO - Downloading/unpacking flake8 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:06 INFO - no previously-included directories found matching 'docs/_build' 04:06:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:06 INFO - Running setup.py install for pep8 04:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:06 INFO - no previously-included directories found matching 'docs/_build' 04:06:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:06 INFO - Cleaning up... 04:06:06 INFO - Return code: 0 04:06:06 INFO - Running post-action listener: _resource_record_post_action 04:06:06 INFO - Running post-action listener: _start_resource_monitoring 04:06:06 INFO - Starting resource monitoring. 04:06:06 INFO - ##### 04:06:06 INFO - ##### Running install step. 04:06:06 INFO - ##### 04:06:06 INFO - Running pre-action listener: _resource_record_pre_action 04:06:06 INFO - Running main action method: install 04:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:06 INFO - Reading from file tmpfile_stdout 04:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:06 INFO - Reading from file tmpfile_stdout 04:06:06 INFO - Output received: 04:06:06 INFO - Usage: mozinstall [options] installer 04:06:06 INFO - Options: 04:06:06 INFO - -h, --help show this help message and exit 04:06:06 INFO - -d DEST, --destination=DEST 04:06:06 INFO - Directory to install application into. [default: 04:06:06 INFO - "/builds/slave/test"] 04:06:06 INFO - --app=APP Application being installed. [default: firefox] 04:06:06 INFO - mkdir: /builds/slave/test/build/application 04:06:06 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'] 04:06:06 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 04:06:41 INFO - Reading from file tmpfile_stdout 04:06:41 INFO - Output received: 04:06:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:06:41 INFO - Running post-action listener: _resource_record_post_action 04:06:41 INFO - ##### 04:06:41 INFO - ##### Running run-tests step. 04:06:41 INFO - ##### 04:06:41 INFO - Running pre-action listener: _resource_record_pre_action 04:06:41 INFO - Running main action method: run_tests 04:06:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:06:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:06:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:06:41 INFO - 2016-02-12 04:06:41.842 screenresolution[1661:8607] starting screenresolution argv=screenresolution get 04:06:41 INFO - 2016-02-12 04:06:41.844 screenresolution[1661:8607] Display 0: 1600x1200x32@60 04:06:41 INFO - 2016-02-12 04:06:41.850 screenresolution[1662:8609] starting screenresolution argv=screenresolution list 04:06:41 INFO - Available Modes on Display 0 04:06:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:06:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:06:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:06:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:06:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:06:42 INFO - Intel Iris: 04:06:42 INFO - Chipset Model: Intel Iris 04:06:42 INFO - Type: GPU 04:06:42 INFO - Bus: Built-In 04:06:42 INFO - VRAM (Dynamic, Max): 1536 MB 04:06:42 INFO - Vendor: Intel (0x8086) 04:06:42 INFO - Device ID: 0x0a2e 04:06:42 INFO - Revision ID: 0x0009 04:06:42 INFO - Displays: 04:06:42 INFO - Display: 04:06:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:06:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:06:42 INFO - Display Serial Number: 1600x1200 60 04:06:42 INFO - Main Display: Yes 04:06:42 INFO - Mirror: Off 04:06:42 INFO - Online: Yes 04:06:42 INFO - Rotation: Supported 04:06:42 INFO - Return code: 0 04:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:42 INFO - Python 2.7.3 04:06:42 INFO - Return code: 0 04:06:42 INFO - grabbing minidump binary from tooltool 04:06:42 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')]} 04:06:42 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 0x1052e9d30>, '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 0x10510ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:42 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 04:06:42 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 04:06:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:42 INFO - Return code: 0 04:06:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:06:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:06:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:06:43 INFO - Return code: 0 04:06:43 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/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 04:06:43 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/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 04:06:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nh3wwTwwaU/Render', 04:06:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:43 INFO - 'HOME': '/Users/cltbld', 04:06:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:43 INFO - 'LOGNAME': 'cltbld', 04:06:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:43 INFO - 'MOZ_NO_REMOTE': '1', 04:06:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:43 INFO - 'NO_EM_RESTART': '1', 04:06:43 INFO - 'PAGER': '/bin/cat', 04:06:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:43 INFO - 'PWD': '/builds/slave/test', 04:06:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:43 INFO - 'SHELL': '/bin/bash', 04:06:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ0yCwoj3q/Listeners', 04:06:43 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 04:06:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:43 INFO - 'USER': 'cltbld', 04:06:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:43 INFO - 'XPC_FLAGS': '0x0', 04:06:43 INFO - 'XPC_SERVICE_NAME': '0', 04:06:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:43 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/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 04:06:43 INFO - mozversion application_buildid: 20160209083856 04:06:43 INFO - mozversion application_changeset: 9799df240b379e461fd1ea9dedea3bbe7dfb9631 04:06:43 INFO - mozversion application_display_name: Nightly 04:06:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:43 INFO - mozversion application_name: Firefox 04:06:43 INFO - mozversion application_remotingname: firefox 04:06:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:06:43 INFO - mozversion application_vendor: Mozilla 04:06:43 INFO - mozversion application_version: 47.0a1 04:06:43 INFO - mozversion platform_buildid: 20160209083856 04:06:43 INFO - mozversion platform_changeset: 9799df240b379e461fd1ea9dedea3bbe7dfb9631 04:06:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:06:43 INFO - mozversion platform_version: 47.0a1 04:06:43 INFO - using testdate: 1455278803 04:06:43 INFO - actual date: 1455278803 04:06:44 INFO - starting webserver on 'localhost:49279' 04:06:44 INFO - SUITE-START | Running 2 tests 04:06:44 INFO - TEST-START | dromaeo_css 04:06:44 INFO - operating with platform_type : mac_ 04:06:44 INFO - Initialising browser for dromaeo_css test... 04:06:44 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpOVAU4c/profile http://localhost:49279/getInfo.html) 04:06:46 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 04:06:46 INFO - PROCESS | 1680 | colorDepth:24 04:06:46 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 04:06:46 INFO - PROCESS | 1680 | __metrics 04:06:46 INFO - PROCESS | 1680 | 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" 04:06:46 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:47 INFO - TEST-INFO | 1680: exit 0 04:06:47 INFO - Browser initialized. 04:06:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:47 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpOVAU4c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:58 INFO - PROCESS | 1684 | RSS: Main: 245719040 04:06:58 INFO - PROCESS | 1684 | 04:07:49 INFO - PROCESS | 1684 | 1455278869757 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:10:00 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 04:10:01 INFO - PROCESS | 1684 | RSS: Main: 362909696 04:10:01 INFO - PROCESS | 1684 | 04:13:04 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 04:13:04 INFO - PROCESS | 1684 | RSS: Main: 374030336 04:13:04 INFO - PROCESS | 1684 | 04:16:07 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 04:16:07 INFO - PROCESS | 1684 | RSS: Main: 380055552 04:16:07 INFO - PROCESS | 1684 | 04:19:09 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 04:19:10 INFO - PROCESS | 1684 | RSS: Main: 338817024 04:19:10 INFO - PROCESS | 1684 | 04:22:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 04:22:14 INFO - PROCESS | 1684 | RSS: Main: 340074496 04:22:14 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 04:25:17 INFO - PROCESS | 1684 | RSS: Main: 582471680 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | __start_tp_report 04:25:17 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 04:25:17 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 04:25:17 INFO - PROCESS | 1684 | |i|pagename|runs| 04:25:17 INFO - PROCESS | 1684 | |0;dojo.html;2645.7883369330457;3490.9127271818193;3507.1232191951995;3523.911902202443;3572.678458938695;5590.91613625796;5670.659760414378;5672.205891175238;5673.319201695797;5721.942780572193;5714.857128571788;5736.569757268201;5813.186153938452;5868.442497962697;5904.675242861641;5093.872653183682;5118.206677964903;5119.897602047957;5167.9483205168035;5284.630075894689;5251.2385704072885;5288.365396152467;5305.602079844008;5309.973450132763;5347.1177255752755;5091.618128640348;5117.360329958755;5122.641415100945;5172.61205409592;5214.556762675158;5112.539871411591;5190.4550022247495;5195.9480405195845;5229.555487783543;5238.580913526908;4333.869983900457;5095.0574143783515;5144.948550514484;5163.302954101186;5165.380154381498;5477.4796394342875;5583.916241256385;5613.578981576398;5617.634853734494;5624.381318055051;6130.601510901777;6229.470495007885;6233.158523599302;6235.719392627343;6237.688115594202;6234.438900498932;6246.094316324107;6267.9373206268265;6288;6293.622382657009;5654.886902261973;5718.571107166979;5759.395263497357;5777.306723193202;5781.768729250825;6226.097215903668;6228.22147231596;6234.812955611248;6250.624962502265;6270.529710271657;6053.122297266872;6059.333473317932;6083.695815209222;6119.938800612026;6134.263888333428;5285.68285902847;6107.795737660903;6187.443130118311;6205.689715514206;6253.249610046823;6121.727351053007;6139.539534534928;6140;6197.101420294032;6230.221222347207;6217.471514921192;6246.281677607133;6248.250209974832;6258.812235632939;6263;4836.056968891033;4864.854054378375;4869.537393947569;4905.5094490550655;4916.311716359713;3726;4322.805473753689;4361.0841723237845;4416.403785488982;4459.598636122764;5761.740721667535;5770.538356931435;5772.6536407815665;5790.42095790426;5799.3620701722775;5196.45437229093;6270.2789179244055;6290.654014029181;6293.937060629427;6306.369363063749;5614.157876318585;5674.829755107354;5687.345955215121;5707.800226992035;5802.738876750556;5345.438728933406;5367.302250707383;5376.247325374451;5378.973105134528;5383.81156659515;6272.8118156455375;6280.528960328085;6286.591371560834;6299.464545513591;6312.179416675803;6118.040554665315;6190.690465476799;6217.191765070512;6283.151774510383;6289.276733175743;5321.361436627474;6236.688165591611;6242.687865606792;6262.906056409249;6263.592866463665;6023.427774361428;6144.600600960924;6159.753609855735;6160.815175544741;6165.84585385369;6104.236970378703;6188.81433556994;6261.843453913689;6280.717367718555;6281.309056003927;5318.883034562785;5867.911981320198;6017.87964240704;6078.574499784972;6083.148359229623;5933.3769954154195;6044.335123136363;6051.818445446644;6063.878722425615;6091.116788065794;5889.322727886348;5930.822075337746;5932.466078052996;5944.851378715567;6006.789762358297;6045.909311360421;6080.179175811209;6084.056971169476;6086.543509236736;6093.969530152321;5740.540756739368;5873.500752436091;5889.67606781614;5934.7922822701;5935.080062590306 04:25:17 INFO - PROCESS | 1684 | |1;ext.html;482.40904891507887;509.91331473649467;530.9044372013036;562.5949316492126;580.2572706935122;30145.849270753642;37332.62667373329;37941.62058379415;38087.809560952155;38146.42780358297;41242.79378603103;41514.58485415152;41780.37329440061;41795;41858.95352616186;9481.857772133406;9713.514324283793;9736.561854716554;9740.074692904163;9741.31810773246;9587.80824383512;9772.560234789451;9777.168940640055;9798;9900.702978910609;9853.359531630456;9931.354461959985;9959.103680668739;9966.700998970005;9996.50017499122;9811.705648830546;9854.014598540125;9867.802643947152;9870.309078364517;9878.209743220525;9619.230461563127;9743.269254805848;9767.316287859852;9772.51137443132;9785.461799601018;39822.20355592901;40075.59924400748;40142.59857401447;40260;40285.39571906424;3234.8867789627484;3243.4161850866835;3342.448495998182;3369.107186595554;3521;28362.592051533928;28566.285842853886;29006.854965725248;29160.70839291601;29251.976180833783;2760.544510155822;2780.430011847566;2839.9716002839914;2883.351245969661;2958.7485063769604;361416;361687;362235;362327;363078;54660;55795.16307255394;62812;63381;64074;64376.678116610055;64742.028869566995;65025;65150;65245.67377163084;16656.250468728937;16856.915715421343;16857.325706971827;16858;16887.91556042212;10791.136709063256;10884.891151088546;12505.624831255076;12712.74574508523;12845.743085138245;15578.610534736723;19232.71150932737;19322.227110915686;19464.31874884372;19521.219151233792;7009.9299007010295;8604.655813767504;8614.22471977525;8647.524386158822;8670.306375489945;930.2743859789375;965.4931161140457;1002.3634991780272;1052.678932925465;1147.9081673466103;27159.72840271572;28069.298267543065;28107.43785124286;28364.85817570899;28466.430671386457;1105.1987309200927;1120.93834839083;1168.4508281108035;1192.1237890150733;1239.9194052386565;14418.990670653164;14606.269686515632;14638.487652932095;14972.775408368883;15026.948113631941;524923;529920;532524;532912;535396.3230183824;57717.71141144352;58105;58168.709156453944;58243;58390.20463669848;1432.9211893345757;1440.8559144085507;1448.1600671610652;1458.6645071633372;1470.5808844479486;27911.16266512008;28170.95726068483;28202.85898570494;28598;28643.14070577886;48268.7586562079;48643.5135648639;48647.75676121597;48650.270245945634;48735.512644874514;495699;497789;612418;631682;636364;25809.870950645127;31081.844590776902;31387;31538.842305788323;31600.525992110597;38362.61637383702;43985;44253.77873110614;44339.55660443354;44726.776366119266;37030.44454333133;37325.81337093297;37809.62190378061;38211.80894095512;38231.808840955615;35924.101897452776;35946.640533595375;36913.261734764616;37075.25849482941;37188.81405592955;28553.857230714544;34058;34067.48898766471;34820;34898;30413.239669008453;30816.84591577028;30916.917907873118;31281;32268.838655806572;24369.14707985212;24465.633015505136;24705.888235029826;24892.75107248977;24973 04:25:17 INFO - PROCESS | 1684 | |2;jquery.html;360.6285525908314;363.92357604902986;364.91242101895534;368.2120262637955;371.72863809419107;14976.550703478886;15115.697686046273;19231;19324.420267391964;20139.29512467064;11534.826977595343;11710.297382157056;11742.236754610944;12072.275663460177;19322.420327390202;3903.355946268862;5176.715280659562;5394.271773310612;5395.163749618815;5400.83797486076;4002.1195337025806;5653.6607803531715;5927.555433342495;5931.228940237763;5940.910886336708;5793.681347525884;5866.706664666771;6443.774467893625;6447.7743278985245;6450;5499.587530935196;6360.618362898194;6397.808065758011;6411.583247088947;6428.3250258722865;5537.612367134302;5702.429757024306;5713.228714123582;5715.771369145229;5744.281964754406;13028.739425211537;13453.865461345456;13484.528041518499;13494.797578036338;15569.37722491099;2185.2351676912954;2277.3168049585056;2288.645259984705;2372.4661951060875;2680.463907218564;8949.59726812295;9697.612095516171;9860.753481162956;9892.604295828158;10262.025107614765;1724.922378492971;1775.2189036823756;1782.269269599471;1799.5141311845728;1841.383136649224;92946;95261.52369238109;96145;97510.51244743801;97638;11175.497102630401;11338.03626691724;11387.544498219979;11429.371384573762;11536.538538458535;13503.932480337535;13641.045126841025;13650.385732642055;13675.726485470235;13699.904007679363;8482.448640838325;8492.980842298964;8496.70261540843;8575.399722019523;8638.222559969632;8577.914220857836;8593;8614.310855131574;8728.476291422536;8752.168543988311;4023.436718859362;4239.512456067591;4242.342436922282;4250.596193361625;4390.319500477367;1713.9914300428418;1789.105447276362;1808.408600431638;1866.56135808085;1878.417690515917;787.2481779900181;912.7900582865979;951.6383774165911;954.0602506531061;960.0063933828454;20017.99910004494;20553.588928221652;20583.588328233353;20705;20721.75669459837;958.1376760915093;1001.6594357918198;1011.726833754882;1031.9432431216205;1045.7751583409604;10125.594976201017;10367.963203679572;10391.84412233817;10432.832562662497;10457.320274182153;672407;675947;685233;696072;697298;106707;106845;107163.92836071695;107487;108553.91446085439;1201.873803250646;1213.1750409721299;1221.6396163131897;1224.7244370016854;1232.2729589542214;17238.913805430893;17520.561985950455;17553.385631502835;17562.20970056325;17818.91090544539;42754.14491710211;42898.78550607352;43329.783351083046;45442.63672089842;48422.27366589433;63446;65733;66378.66810665916;66888.66555667385;67274;7319.975203471412;7554.357879580297;7668.769936901679;7712.460127791001;7821.960890195513;7547.904191616766;8418.452800567944;11478.253913495597;11913.332133501144;11974.281543107441;10055.69832905014;10251.58993640246;10340.017698318648;10373.118284945562;10478.318909270873;8571;10348.741281468023;10395.32430392022;10482.737931551772;10607.310524815863;10427.217958653284;10737.946310268399;10899.891001089887;11059.990708408903;11166.771655118093;7683.385329173541;7685.03937007874;7733.729319473791;7739.7678069658;7770.8834367483405;6911.195841834533;10054.798904022025;10284.897151028694;10536.420496872746;10744.677659670222 04:25:17 INFO - PROCESS | 1684 | |3;mootools.html;1394.3028485757122;1533.9704084433245;1548.736714758491;1784.9732254016192;1930.9958821412856;7870.134285228627;8531;8698.999615044271;8704.173103555167;8713.041565427799;8415.91584084159;8645.740627781177;8665.95667021664;8670.132986701326;8670.219680228778;2148.79586439288;2206.227820262903;2209.62436385814;2456.1771806444817;2479.801615870735;2227.340631229736;2236.2955668964305;2445.4131008557997;2509.1719732488327;2510.472800711853;2439.280412278373;2460.8646524441147;2461.1755062054144;2468.4322605800676;2473.2703852363506;2431.0761910474084;2451.350392146083;2467.962980555284;2471.098049212034;2479.293401380598;2439.841410308342;2464.334629650002;2467.851928884255;2470.654108424822;2471.9752802471926;8550.52972086535;8722.476651400937;8753.3872628916;8776.16626420489;8807.64769409223;5332.893342133136;5473.644213126174;5476.780928762844;5482.369527504348;5488.094464413367;2760.8619569021466;3271.5910511186103;3511.7892926424242;3575.982120089409;3651.6713495785243;1046.832506798916;1058.6136060338;1060.4750648429076;1068.316277582348;1069.8716154061563;11726.472308746042;11746.060315174765;11791.941040294829;11872.228305160137;11974.760504789943;4864.78108485119;4900.926486102711;4942.294908256646;4954.826581069645;4968.180250258739;10085.193184545218;10095.141912937483;10104.797904041878;10116.34243774167;10116.696499105039;5448.210009548593;5450.945490545044;5451.836444906659;5462.399136095027;5469.535089517356;4883.877903052452;4940.011997600423;4945.727984960789;4947;4948.604111671058;3201.759868009862;3649.85400583979;3723.553173619183;3950.743201691881;4000.959990400117;1211.0372254058045;1232.06363163996;1273.6242808371553;1292.101989117573;1296.0797833538293;1312.5012495251742;1334.6129622409587;1347.6226656536185;1368.3021658954005;1368.904176707621;7950;7979.72070977513;8214.014318281845;8373.995120585569;8384;1100.5047728522036;1134.3760931487648;1195.1740914563693;1204.2112416367293;1220.3153063260684;5411.972940135274;6257.124002639634;6385.840353991188;6391.776287829904;6427.550071495044;10329.12202462784;10832.891671083345;10976;10979.341239525495;10980.286281391684;9922.40465572068;10828.891711082946;10840.241183117107;10848.294860834021;10850.782984340269;8163.183681631908;8278.586070696561;8281.503109813431;8306.335493160654;8394.160583941679;7996.5601891894175;8002.159773223728;8063.435559510778;8105.594720263845;8110.06734225548;9383.436993780395;9495;9550.188234000188;9589.904100958902;9664.420134791935;9749.80500389974;9774.364666296668;9823.919368869561;10069.89930100719;10082.747931301483;7491.138519070377;7548.094228692373;7636.160022397643;7639.121501027453;7647.388208943383;8071.636776345196;8182.713605023796;8191.959040204761;8201.097879233399;8224.876626850722;6373.458256048288;7642.235776422313;7691.653875575501;7766.728164514215;7790.454668173174;7474.887876681745;7559.3196612305155;7578.431617628589;7665.23347665229;7691.461597688108;7714.302853372249;7769.689212431439;7781.144074151725;7792.688292468464;7807.843843123219;6863.347981941708;7017.298270173146;7017.789466316019;7021.473389495706;7022.12223472066;7079.8938015930835;7149.964250178716;7159.212486626363;7166.355028047501;7167.1757747859665 04:25:17 INFO - PROCESS | 1684 | |4;prototype.html;313.8258266662002;322.0981252493019;324.0941568316556;327.24406620706185;331.55074873546346;5358.160175107195;6435.935640643598;6577.4080332770045;6668.299828518008;6673.26594074652;6524.184476940382;6652.933470665292;6694.732210711566;6699.598024118556;6732.764353247638;5037.06814239365;5041.8235361762345;5046.873828154307;5053.9241911371355;5090.872728181788;4090.5909409059004;4791.664583479158;4840.661153719241;5002.59979201663;5068.087744206042;4911.75441227939;4924.655274130812;4941;4945.752712364385;4946.925796113062;3998.7200895937294;4921.212605983025;4930.580900623451;4943.1102401567705;4958.776855041532;4245.660347172219;4251.171021650779;4252.957470425287;4254.170436764832;4261.062566235423;5478.479544443271;5632.5355407594325;5990.191324171268;6420.390062944013;6460.515461340371;5711.885762284773;5726.828195154152;5735.111057786008;5736.713164341766;5744.511716504102;6631.469482441393;6740.022696708998;7119.679614417312;7132.857342853165;7177.4258059355125;4451.132029254297;4553.4991150973365;4576.084783043405;4584.129015487047;4584.793684284182;7378.40972722181;7494.962525187339;7527.096748390229;7527.849443011164;7542.208068152875;4513.187626227311;4632.62938964882;4643.141018911512;4652.62778977681;4654.557817007379;4708.293755936568;4726.740029298421;4752.7623618818925;4757.167495688241;4763.428388593322;5741.425857414309;5743.741531631086;5745.253117094751;5763.991301522301;5769.278840144982;5719.370869204384;5790.36306006339;7131.393831524379;7143.89284160738;7150.713971441188;1593.0839767133712;1622.3997121065045;1643.2358953086873;1647.7857878475722;1650.1666658337463;1038.2835843268272;1050.7950949564915;1061.379093230469;1061.5965932945585;1064.499685147979;6688.230853451818;6689.866202675919;6695.832604184934;6703.832404189837;6721.798346049626;7419.035525381773;7421;7435.814104647319;7442.218567050381;7455.217202193691;6435.163428754232;6677.09859169006;6708.2956289589865;6720.361565651256;6733.326667333227;3908.101136738509;3939.3697008478507;3943.5464921533817;3944.1322908959983;3947.2302900934615;7756.340711039512;7756.340711039625;7760.534367937942;7784.299413052852;7790.220977902164;7398.96300518494;7619.809504762426;7627.961860190663;7634.847303053908;7664.118626357928;7046.541974771623;7177.600367928204;7854;7856.882146767803;7864.803379915548;7194.96402518005;7362.815929601803;7382.335589796944;7393.667284972296;7397.889031664637;5635.492805647511;6440.935590644033;6621.576361082391;7190.640467976685;7293.088363954505;6343.52423568225;6432.9678351607945;7872.134065252703;7878.684852605831;7895.973523442146;4678.555537223959;4720.315554244684;4725.29120631908;4730.432348118248;4738.763061846963;7244.275572442713;7496.137944136494;7496.25037496246;7504.774856754306;7511.812204694707;7198.424126070006;7202.819929501804;7207.459440542085;7208.135023797178;7214.96392518034;6914.619695916773;7130.607816570138;7186.461015423969;7204.423646108404;7208.35124838767;6948.922916947881;6984.40632546219;6986.336298051677;6988.126484189476;6988.825279368057;7108.857822843411;7126.8218294540975;7135.250798666273;7145.64271786419;7149.463790215651;6783.559068660521;6936.237013928565;6975;6998.895016574654;7057.541259818301 04:25:17 INFO - PROCESS | 1684 | |5;yui.html;647.8315637934139;671.1308855032732;729.4638440746047;742.5618884857932;758.6548120605129;15002.549923502285;15191.544253672408;15203.315850786714;15227.162506062163;15241.847581524182;13644.771970522652;13687.726245475085;13757.656058598515;13814.033017688766;13830.308484575782;841.8653015517534;855.9914400855974;857.6055014693248;858.120426562775;859.3898332184126;695.634791734341;708.5359089796166;709.1171491493099;838.4172999765166;864.4121997042009;895.4403497813867;908.582052255963;908.8046070094928;912.2428384440931;912.5026860361086;905.3210092430677;905.3888625178045;905.9094090590954;906.0260220263243;906.0576999920075;536.4635364635365;545.0897002006658;545.6862304175075;546.3443867359146;658.1214079204268;14683.339249733788;14721.190334531597;14758.335874885655;14766.70466590673;14822.925885370612;12222.938885305606;12370.44333005017;12422.937885310606;12566.68583285416;12729;9876.95061524695;9885.456299903502;9934.45360505172;9975.800483990351;10006.399616022989;3459.775114617542;3522.9119272018147;3530.7881527108457;3531.1525233943926;3535.734819888519;78367.21632783713;78462.21537784663;80284.59857700733;80962.59518702427;81191;9228.40015398997;9266.583003764847;9402.670906518239;9530.809383812284;9694.563744631509;20837.37487875366;20839.374818755463;20860.58278834415;20899.268525601532;20908.58182836335;7301.671424785791;7302.780916572511;7450.701971921062;7464.477486575996;7492.700291988368;3962.6829853611644;4034;4091.5090189176894;4112.773797441169;4115.36211887158;3452.896413107611;3511.3152935177395;3516.191276006533;3517.542719446507;3521.2253304273017;557.498251573579;582.2954225387244;582.5397935630804;666.5534092158168;694.4860803005739;503.7783375314923;506.02385823425465;546.7648910968243;551.4871169812033;575.4590684756315;8392.958035209786;8592.613332400057;8595.398322117517;8709.172628600272;8828.602712877808;495.96032317414523;590.4066413254651;597.4055814464635;601.8344955137372;607.419913982146;3893.7469064510715;3917.588653191374;3954.130091379892;4331.956680433155;4399.670024748157;86048;87694.32253291704;88277.67583486253;88289;88555;80206;80545;81463;81642.91785410706;81848.18151818405;53734.462655373725;68265;69495;70114;71610.64194679097;8760.868586971328;8807.515586642796;9013.278937684838;9016.323775716717;9047.185753282236;34227.31545369029;44222;48216.758916205195;48738.53784386474;49385.753071234416;62951.37048629455;63799.04301435575;64014;64135;65052;10633.734156646145;11004.944975275072;11183.88816111861;11213.775724485302;11294.378809165575;11851.881481185077;11901.047916166859;12345.444454999368;12875.420606072561;12883.48466061347;11429;11433.771324573629;11770.470328835052;11771.293722376684;11869.881301187223;10599.8940010602;11112.444257804076;11316.20786544934;11574.263860421004;11772.941135294268;8253.207049514447;10363.792724145324;11357.318560886373;11561.768764624829;11707.590234341757;8287.668493260444;8832.646694132163;9081.273498120003;9177;9435.150836424755;8556.786080347792;9496.667616633385;9671.323007389416;9703.272254581076;10160.644377446753 04:25:17 INFO - PROCESS | 1684 | __end_tp_report 04:25:17 INFO - PROCESS | 1684 | __start_cc_report 04:25:17 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1056 04:25:17 INFO - PROCESS | 1684 | __end_cc_report 04:25:17 INFO - PROCESS | 1684 | __startTimestamp1455279917538__endTimestamp 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | ------- Summary: start ------- 04:25:17 INFO - PROCESS | 1684 | Number of tests: 6 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5695.08 Median:5889.68 stddev:658.79 (11.2%) stddev-sans-first:615.85 04:25:17 INFO - PROCESS | 1684 | Values: 2645.8 3490.9 3507.1 3523.9 3572.7 5590.9 5670.7 5672.2 5673.3 5721.9 5714.9 5736.6 5813.2 5868.4 5904.7 5093.9 5118.2 5119.9 5167.9 5284.6 5251.2 5288.4 5305.6 5310.0 5347.1 5091.6 5117.4 5122.6 5172.6 5214.6 5112.5 5190.5 5195.9 5229.6 5238.6 4333.9 5095.1 5144.9 5163.3 5165.4 5477.5 5583.9 5613.6 5617.6 5624.4 6130.6 6229.5 6233.2 6235.7 6237.7 6234.4 6246.1 6267.9 6288.0 6293.6 5654.9 5718.6 5759.4 5777.3 5781.8 6226.1 6228.2 6234.8 6250.6 6270.5 6053.1 6059.3 6083.7 6119.9 6134.3 5285.7 6107.8 6187.4 6205.7 6253.2 6121.7 6139.5 6140.0 6197.1 6230.2 6217.5 6246.3 6248.3 6258.8 6263.0 4836.1 4864.9 4869.5 4905.5 4916.3 3726.0 4322.8 4361.1 4416.4 4459.6 5761.7 5770.5 5772.7 5790.4 5799.4 5196.5 6270.3 6290.7 6293.9 6306.4 5614.2 5674.8 5687.3 5707.8 5802.7 5345.4 5367.3 5376.2 5379.0 5383.8 6272.8 6280.5 6286.6 6299.5 6312.2 6118.0 6190.7 6217.2 6283.2 6289.3 5321.4 6236.7 6242.7 6262.9 6263.6 6023.4 6144.6 6159.8 6160.8 6165.8 6104.2 6188.8 6261.8 6280.7 6281.3 5318.9 5867.9 6017.9 6078.6 6083.1 5933.4 6044.3 6051.8 6063.9 6091.1 5889.3 5930.8 5932.5 5944.9 6006.8 6045.9 6080.2 6084.1 6086.5 6094.0 5740.5 5873.5 5889.7 5934.8 5935.1 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:63048.94 Median:37329.22 stddev:133199.13 (356.8%) stddev-sans-first:133489.95 04:25:17 INFO - PROCESS | 1684 | Values: 482.4 509.9 530.9 562.6 580.3 30145.8 37332.6 37941.6 38087.8 38146.4 41242.8 41514.6 41780.4 41795.0 41859.0 9481.9 9713.5 9736.6 9740.1 9741.3 9587.8 9772.6 9777.2 9798.0 9900.7 9853.4 9931.4 9959.1 9966.7 9996.5 9811.7 9854.0 9867.8 9870.3 9878.2 9619.2 9743.3 9767.3 9772.5 9785.5 39822.2 40075.6 40142.6 40260.0 40285.4 3234.9 3243.4 3342.4 3369.1 3521.0 28362.6 28566.3 29006.9 29160.7 29252.0 2760.5 2780.4 2840.0 2883.4 2958.7 361416.0 361687.0 362235.0 362327.0 363078.0 54660.0 55795.2 62812.0 63381.0 64074.0 64376.7 64742.0 65025.0 65150.0 65245.7 16656.3 16856.9 16857.3 16858.0 16887.9 10791.1 10884.9 12505.6 12712.7 12845.7 15578.6 19232.7 19322.2 19464.3 19521.2 7009.9 8604.7 8614.2 8647.5 8670.3 930.3 965.5 1002.4 1052.7 1147.9 27159.7 28069.3 28107.4 28364.9 28466.4 1105.2 1120.9 1168.5 1192.1 1239.9 14419.0 14606.3 14638.5 14972.8 15026.9 524923.0 529920.0 532524.0 532912.0 535396.3 57717.7 58105.0 58168.7 58243.0 58390.2 1432.9 1440.9 1448.2 1458.7 1470.6 27911.2 28171.0 28202.9 28598.0 28643.1 48268.8 48643.5 48647.8 48650.3 48735.5 495699.0 497789.0 612418.0 631682.0 636364.0 25809.9 31081.8 31387.0 31538.8 31600.5 38362.6 43985.0 44253.8 44339.6 44726.8 37030.4 37325.8 37809.6 38211.8 38231.8 35924.1 35946.6 36913.3 37075.3 37188.8 28553.9 34058.0 34067.5 34820.0 34898.0 30413.2 30816.8 30916.9 31281.0 32268.8 24369.1 24465.6 24705.9 24892.8 24973.0 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:34811.91 Median:1520.55 stddev:112890.26 (7424.3%) stddev-sans-first:113177.31 04:25:17 INFO - PROCESS | 1684 | Values: 360.6 363.9 364.9 368.2 371.7 14976.6 15115.7 19231.0 19324.4 20139.3 11534.8 11710.3 11742.2 12072.3 19322.4 3903.4 5176.7 5394.3 5395.2 5400.8 4002.1 5653.7 5927.6 5931.2 5940.9 5793.7 5866.7 6443.8 6447.8 6450.0 5499.6 6360.6 6397.8 6411.6 6428.3 5537.6 5702.4 5713.2 5715.8 5744.3 13028.7 13453.9 13484.5 13494.8 15569.4 2185.2 2277.3 2288.6 2372.5 2680.5 8949.6 9697.6 9860.8 9892.6 10262.0 1724.9 1775.2 1782.3 1799.5 1841.4 92946.0 95261.5 96145.0 97510.5 97638.0 11175.5 11338.0 11387.5 11429.4 11536.5 13503.9 13641.0 13650.4 13675.7 13699.9 8482.4 8493.0 8496.7 8575.4 8638.2 8577.9 8593.0 8614.3 8728.5 8752.2 4023.4 4239.5 4242.3 4250.6 4390.3 1714.0 1789.1 1808.4 1866.6 1878.4 787.2 912.8 951.6 954.1 960.0 20018.0 20553.6 20583.6 20705.0 20721.8 958.1 1001.7 1011.7 1031.9 1045.8 10125.6 10368.0 10391.8 10432.8 10457.3 672407.0 675947.0 685233.0 696072.0 697298.0 106707.0 106845.0 107163.9 107487.0 108553.9 1201.9 1213.2 1221.6 1224.7 1232.3 17238.9 17520.6 17553.4 17562.2 17818.9 42754.1 42898.8 43329.8 45442.6 48422.3 63446.0 65733.0 66378.7 66888.7 67274.0 7320.0 7554.4 7668.8 7712.5 7822.0 7547.9 8418.5 11478.3 11913.3 11974.3 10055.7 10251.6 10340.0 10373.1 10478.3 8571.0 10348.7 10395.3 10482.7 10607.3 10427.2 10737.9 10899.9 11060.0 11166.8 7683.4 7685.0 7733.7 7739.8 7770.9 6911.2 10054.8 10284.9 10536.4 10744.7 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:6068.56 Median:5150.54 stddev:3200.72 (62.1%) stddev-sans-first:3190.41 04:25:17 INFO - PROCESS | 1684 | Values: 1394.3 1534.0 1548.7 1785.0 1931.0 7870.1 8531.0 8699.0 8704.2 8713.0 8415.9 8645.7 8666.0 8670.1 8670.2 2148.8 2206.2 2209.6 2456.2 2479.8 2227.3 2236.3 2445.4 2509.2 2510.5 2439.3 2460.9 2461.2 2468.4 2473.3 2431.1 2451.4 2468.0 2471.1 2479.3 2439.8 2464.3 2467.9 2470.7 2472.0 8550.5 8722.5 8753.4 8776.2 8807.6 5332.9 5473.6 5476.8 5482.4 5488.1 2760.9 3271.6 3511.8 3576.0 3651.7 1046.8 1058.6 1060.5 1068.3 1069.9 11726.5 11746.1 11791.9 11872.2 11974.8 4864.8 4900.9 4942.3 4954.8 4968.2 10085.2 10095.1 10104.8 10116.3 10116.7 5448.2 5450.9 5451.8 5462.4 5469.5 4883.9 4940.0 4945.7 4947.0 4948.6 3201.8 3649.9 3723.6 3950.7 4001.0 1211.0 1232.1 1273.6 1292.1 1296.1 1312.5 1334.6 1347.6 1368.3 1368.9 7950.0 7979.7 8214.0 8374.0 8384.0 1100.5 1134.4 1195.2 1204.2 1220.3 5412.0 6257.1 6385.8 6391.8 6427.6 10329.1 10832.9 10976.0 10979.3 10980.3 9922.4 10828.9 10840.2 10848.3 10850.8 8163.2 8278.6 8281.5 8306.3 8394.2 7996.6 8002.2 8063.4 8105.6 8110.1 9383.4 9495.0 9550.2 9589.9 9664.4 9749.8 9774.4 9823.9 10069.9 10082.7 7491.1 7548.1 7636.2 7639.1 7647.4 8071.6 8182.7 8192.0 8201.1 8224.9 6373.5 7642.2 7691.7 7766.7 7790.5 7474.9 7559.3 7578.4 7665.2 7691.5 7714.3 7769.7 7781.1 7792.7 7807.8 6863.3 7017.3 7017.8 7021.5 7022.1 7079.9 7150.0 7159.2 7166.4 7167.2 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:5796.56 Median:6599.49 stddev:1856.11 (28.1%) stddev-sans-first:1815.12 04:25:17 INFO - PROCESS | 1684 | Values: 313.8 322.1 324.1 327.2 331.6 5358.2 6435.9 6577.4 6668.3 6673.3 6524.2 6652.9 6694.7 6699.6 6732.8 5037.1 5041.8 5046.9 5053.9 5090.9 4090.6 4791.7 4840.7 5002.6 5068.1 4911.8 4924.7 4941.0 4945.8 4946.9 3998.7 4921.2 4930.6 4943.1 4958.8 4245.7 4251.2 4253.0 4254.2 4261.1 5478.5 5632.5 5990.2 6420.4 6460.5 5711.9 5726.8 5735.1 5736.7 5744.5 6631.5 6740.0 7119.7 7132.9 7177.4 4451.1 4553.5 4576.1 4584.1 4584.8 7378.4 7495.0 7527.1 7527.8 7542.2 4513.2 4632.6 4643.1 4652.6 4654.6 4708.3 4726.7 4752.8 4757.2 4763.4 5741.4 5743.7 5745.3 5764.0 5769.3 5719.4 5790.4 7131.4 7143.9 7150.7 1593.1 1622.4 1643.2 1647.8 1650.2 1038.3 1050.8 1061.4 1061.6 1064.5 6688.2 6689.9 6695.8 6703.8 6721.8 7419.0 7421.0 7435.8 7442.2 7455.2 6435.2 6677.1 6708.3 6720.4 6733.3 3908.1 3939.4 3943.5 3944.1 3947.2 7756.3 7756.3 7760.5 7784.3 7790.2 7399.0 7619.8 7628.0 7634.8 7664.1 7046.5 7177.6 7854.0 7856.9 7864.8 7195.0 7362.8 7382.3 7393.7 7397.9 5635.5 6440.9 6621.6 7190.6 7293.1 6343.5 6433.0 7872.1 7878.7 7896.0 4678.6 4720.3 4725.3 4730.4 4738.8 7244.3 7496.1 7496.3 7504.8 7511.8 7198.4 7202.8 7207.5 7208.1 7215.0 6914.6 7130.6 7186.5 7204.4 7208.4 6948.9 6984.4 6986.3 6988.1 6988.8 7108.9 7126.8 7135.3 7145.6 7149.5 6783.6 6936.2 6975.0 6998.9 7057.5 04:25:17 INFO - PROCESS | 1684 | 04:25:17 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:17855.45 Median:593.91 stddev:24977.55 (4205.6%) stddev-sans-first:25014.19 04:25:17 INFO - PROCESS | 1684 | Values: 647.8 671.1 729.5 742.6 758.7 15002.5 15191.5 15203.3 15227.2 15241.8 13644.8 13687.7 13757.7 13814.0 13830.3 841.9 856.0 857.6 858.1 859.4 695.6 708.5 709.1 838.4 864.4 895.4 908.6 908.8 912.2 912.5 905.3 905.4 905.9 906.0 906.1 536.5 545.1 545.7 546.3 658.1 14683.3 14721.2 14758.3 14766.7 14822.9 12222.9 12370.4 12422.9 12566.7 12729.0 9877.0 9885.5 9934.5 9975.8 10006.4 3459.8 3522.9 3530.8 3531.2 3535.7 78367.2 78462.2 80284.6 80962.6 81191.0 9228.4 9266.6 9402.7 9530.8 9694.6 20837.4 20839.4 20860.6 20899.3 20908.6 7301.7 7302.8 7450.7 7464.5 7492.7 3962.7 4034.0 4091.5 4112.8 4115.4 3452.9 3511.3 3516.2 3517.5 3521.2 557.5 582.3 582.5 666.6 694.5 503.8 506.0 546.8 551.5 575.5 8393.0 8592.6 8595.4 8709.2 8828.6 496.0 590.4 597.4 601.8 607.4 3893.7 3917.6 3954.1 4332.0 4399.7 86048.0 87694.3 88277.7 88289.0 88555.0 80206.0 80545.0 81463.0 81642.9 81848.2 53734.5 68265.0 69495.0 70114.0 71610.6 8760.9 8807.5 9013.3 9016.3 9047.2 34227.3 44222.0 48216.8 48738.5 49385.8 62951.4 63799.0 64014.0 64135.0 65052.0 10633.7 11004.9 11183.9 11213.8 11294.4 11851.9 11901.0 12345.4 12875.4 12883.5 11429.0 11433.8 11770.5 11771.3 11869.9 10599.9 11112.4 11316.2 11574.3 11772.9 8253.2 10363.8 11357.3 11561.8 11707.6 8287.7 8832.6 9081.3 9177.0 9435.2 8556.8 9496.7 9671.3 9703.3 10160.6 04:25:17 INFO - PROCESS | 1684 | -------- Summary: end -------- 04:25:17 INFO - PROCESS | 1684 | 04:25:18 INFO - TEST-INFO | 1684: exit 0 04:25:18 INFO - TEST-OK | dromaeo_css | took 1114118ms 04:25:18 INFO - TEST-START | kraken 04:25:18 INFO - operating with platform_type : mac_ 04:25:18 INFO - Initialising browser for kraken test... 04:25:18 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpXbPCul/profile http://localhost:49279/getInfo.html) 04:25:20 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 04:25:20 INFO - PROCESS | 1690 | colorDepth:24 04:25:20 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 04:25:20 INFO - PROCESS | 1690 | __metrics 04:25:20 INFO - PROCESS | 1690 | 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" 04:25:20 INFO - PROCESS | 1690 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:21 INFO - TEST-INFO | 1690: exit 0 04:25:21 INFO - Browser initialized. 04:25:21 INFO - Running cycle 1/1 for kraken test... 04:25:21 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpXbPCul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:32 INFO - PROCESS | 1692 | RSS: Main: 245796864 04:25:32 INFO - PROCESS | 1692 | 04:25:35 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:36 INFO - PROCESS | 1692 | RSS: Main: 292790272 04:25:36 INFO - PROCESS | 1692 | 04:25:38 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 04:25:39 INFO - PROCESS | 1692 | RSS: Main: 301297664 04:25:39 INFO - PROCESS | 1692 | 04:25:42 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 04:25:43 INFO - PROCESS | 1692 | RSS: Main: 285618176 04:25:43 INFO - PROCESS | 1692 | 04:25:45 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 04:25:45 INFO - PROCESS | 1692 | RSS: Main: 287604736 04:25:45 INFO - PROCESS | 1692 | 04:25:47 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:48 INFO - PROCESS | 1692 | RSS: Main: 289644544 04:25:48 INFO - PROCESS | 1692 | 04:25:51 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:51 INFO - PROCESS | 1692 | RSS: Main: 289869824 04:25:51 INFO - PROCESS | 1692 | 04:25:54 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:55 INFO - PROCESS | 1692 | RSS: Main: 290492416 04:25:55 INFO - PROCESS | 1692 | 04:25:57 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 04:25:58 INFO - PROCESS | 1692 | RSS: Main: 291811328 04:25:58 INFO - PROCESS | 1692 | 04:26:00 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:00 INFO - PROCESS | 1692 | RSS: Main: 325455872 04:26:00 INFO - PROCESS | 1692 | 04:26:02 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:03 INFO - PROCESS | 1692 | RSS: Main: 325689344 04:26:03 INFO - PROCESS | 1692 | 04:26:05 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:05 INFO - PROCESS | 1692 | RSS: Main: 333369344 04:26:05 INFO - PROCESS | 1692 | 04:26:08 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:08 INFO - PROCESS | 1692 | RSS: Main: 333848576 04:26:08 INFO - PROCESS | 1692 | 04:26:11 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:12 INFO - PROCESS | 1692 | RSS: Main: 334491648 04:26:12 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 04:26:13 INFO - PROCESS | 1692 | RSS: Main: 394657792 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | __start_tp_report 04:26:13 INFO - PROCESS | 1692 | _x_x_mozilla_page_load 04:26:13 INFO - PROCESS | 1692 | _x_x_mozilla_page_load_details 04:26:13 INFO - PROCESS | 1692 | |i|pagename|runs| 04:26:13 INFO - PROCESS | 1692 | |0;ai-astar;111;107;110;112;111;112;117;112;112;113 04:26:13 INFO - PROCESS | 1692 | |1;audio-beat-detection;155;122;145;157;122;142;142;123;155;119 04:26:13 INFO - PROCESS | 1692 | |2;audio-dft;183;183;184;185;186;184;185;186;189;183 04:26:13 INFO - PROCESS | 1692 | |3;audio-fft;103;70;83;77;56;59;59;80;76;58 04:26:13 INFO - PROCESS | 1692 | |4;audio-oscillator;93;100;128;79;81;80;105;77;77;112 04:26:13 INFO - PROCESS | 1692 | |5;imaging-gaussian-blur;119;95;88;95;88;95;88;94;89;95 04:26:13 INFO - PROCESS | 1692 | |6;imaging-darkroom;96;97;96;97;97;97;97;96;97;97 04:26:13 INFO - PROCESS | 1692 | |7;imaging-desaturate;88;87;85;85;84;85;85;84;92;130 04:26:13 INFO - PROCESS | 1692 | |8;json-parse-financial;56;55;54;53;54;54;53;64;51;54 04:26:13 INFO - PROCESS | 1692 | |9;json-stringify-tinderbox;62;71;71;74;70;66;65;68;72;68 04:26:13 INFO - PROCESS | 1692 | |10;stanford-crypto-aes;82;81;84;79;83;82;83;83;84;83 04:26:13 INFO - PROCESS | 1692 | |11;stanford-crypto-ccm;127;134;123;137;120;119;124;125;122;121 04:26:13 INFO - PROCESS | 1692 | |12;stanford-crypto-pbkdf2;140;126;141;138;140;137;140;137;136;139 04:26:13 INFO - PROCESS | 1692 | |13;stanford-crypto-sha256-iterative;68;67;65;66;66;68;65;67;67;66 04:26:13 INFO - PROCESS | 1692 | __end_tp_report 04:26:13 INFO - PROCESS | 1692 | __start_cc_report 04:26:13 INFO - PROCESS | 1692 | _x_x_mozilla_cycle_collect,1222 04:26:13 INFO - PROCESS | 1692 | __end_cc_report 04:26:13 INFO - PROCESS | 1692 | __startTimestamp1455279973947__endTimestamp 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | ------- Summary: start ------- 04:26:13 INFO - PROCESS | 1692 | Number of tests: 14 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:2.64 04:26:13 INFO - PROCESS | 1692 | Values: 111.0 107.0 110.0 112.0 111.0 112.0 117.0 112.0 112.0 113.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:143.50 stddev:15.34 (10.7%) stddev-sans-first:15.02 04:26:13 INFO - PROCESS | 1692 | Values: 155.0 122.0 145.0 157.0 122.0 142.0 142.0 123.0 155.0 119.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.87 (1.0%) stddev-sans-first:1.87 04:26:13 INFO - PROCESS | 1692 | Values: 183.0 183.0 184.0 185.0 186.0 184.0 185.0 186.0 189.0 183.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#3] audio-fft Cycles:10 Average:72.10 Median:73.00 stddev:14.84 (20.3%) stddev-sans-first:10.72 04:26:13 INFO - PROCESS | 1692 | Values: 103.0 70.0 83.0 77.0 56.0 59.0 59.0 80.0 76.0 58.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:78.00 stddev:17.64 (22.6%) stddev-sans-first:18.71 04:26:13 INFO - PROCESS | 1692 | Values: 93.0 100.0 128.0 79.0 81.0 80.0 105.0 77.0 77.0 112.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:94.50 stddev:9.18 (9.7%) stddev-sans-first:3.48 04:26:13 INFO - PROCESS | 1692 | Values: 119.0 95.0 88.0 95.0 88.0 95.0 88.0 94.0 89.0 95.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:26:13 INFO - PROCESS | 1692 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 97.0 97.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#7] imaging-desaturate Cycles:10 Average:90.50 Median:85.00 stddev:14.09 (16.6%) stddev-sans-first:14.91 04:26:13 INFO - PROCESS | 1692 | Values: 88.0 87.0 85.0 85.0 84.0 85.0 85.0 84.0 92.0 130.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.49 (6.5%) stddev-sans-first:3.67 04:26:13 INFO - PROCESS | 1692 | Values: 56.0 55.0 54.0 53.0 54.0 54.0 53.0 64.0 51.0 54.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:70.50 stddev:3.62 (5.1%) stddev-sans-first:2.92 04:26:13 INFO - PROCESS | 1692 | Values: 62.0 71.0 71.0 74.0 70.0 66.0 65.0 68.0 72.0 68.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 04:26:13 INFO - PROCESS | 1692 | Values: 82.0 81.0 84.0 79.0 83.0 82.0 83.0 83.0 84.0 83.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:124.50 stddev:5.96 (4.8%) stddev-sans-first:6.28 04:26:13 INFO - PROCESS | 1692 | Values: 127.0 134.0 123.0 137.0 120.0 119.0 124.0 125.0 122.0 121.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.40 Median:139.50 stddev:4.33 (3.1%) stddev-sans-first:4.48 04:26:13 INFO - PROCESS | 1692 | Values: 140.0 126.0 141.0 138.0 140.0 137.0 140.0 137.0 136.0 139.0 04:26:13 INFO - PROCESS | 1692 | 04:26:13 INFO - PROCESS | 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 04:26:13 INFO - PROCESS | 1692 | Values: 68.0 67.0 65.0 66.0 66.0 68.0 65.0 67.0 67.0 66.0 04:26:13 INFO - PROCESS | 1692 | -------- Summary: end -------- 04:26:13 INFO - PROCESS | 1692 | 04:26:14 INFO - TEST-INFO | 1692: exit 0 04:26:14 INFO - TEST-OK | kraken | took 56704ms 04:26:14 INFO - SUITE-END | took 1170s 04:26:15 INFO - Completed test suite (00:19:31) 04:26:15 INFO - Working with test: dromaeo_css 04:26:15 INFO - Generating results file: dromaeo_css 04:26:15 INFO - Working with test: kraken 04:26:15 INFO - Generating results file: kraken 04:26:15 INFO - javascript benchmark 04:26:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:26:15 INFO - process_Request line: dromaeo_css 7435.98 graph.html#tests=[[72,64,59]] 04:26:15 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:26:15 INFO - process_Request line: kraken 1416.80 graph.html#tests=[[232,64,59]] 04:26:15 INFO - RETURN: dromaeo_css: 7435.98 04:26:15 INFO - RETURN: kraken: 1416.80 04:26:15 INFO - javascript benchmark 04:26:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2645.7883369330457, 3490.9127271818193, 3507.1232191951995, 3523.911902202443, 3572.678458938695, 5590.91613625796, 5670.659760414378, 5672.205891175238, 5673.319201695797, 5721.942780572193, 5714.857128571788, 5736.569757268201, 5813.186153938452, 5868.442497962697, 5904.675242861641, 5093.872653183682, 5118.206677964903, 5119.897602047957, 5167.9483205168035, 5284.630075894689, 5251.2385704072885, 5288.365396152467, 5305.602079844008, 5309.973450132763, 5347.1177255752755, 5091.618128640348, 5117.360329958755, 5122.641415100945, 5172.61205409592, 5214.556762675158, 5112.539871411591, 5190.4550022247495, 5195.9480405195845, 5229.555487783543, 5238.580913526908, 4333.869983900457, 5095.0574143783515, 5144.948550514484, 5163.302954101186, 5165.380154381498, 5477.4796394342875, 5583.916241256385, 5613.578981576398, 5617.634853734494, 5624.381318055051, 6130.601510901777, 6229.470495007885, 6233.158523599302, 6235.719392627343, 6237.688115594202, 6234.438900498932, 6246.094316324107, 6267.9373206268265, 6288.0, 6293.622382657009, 5654.886902261973, 5718.571107166979, 5759.395263497357, 5777.306723193202, 5781.768729250825, 6226.097215903668, 6228.22147231596, 6234.812955611248, 6250.624962502265, 6270.529710271657, 6053.122297266872, 6059.333473317932, 6083.695815209222, 6119.938800612026, 6134.263888333428, 5285.68285902847, 6107.795737660903, 6187.443130118311, 6205.689715514206, 6253.249610046823, 6121.727351053007, 6139.539534534928, 6140.0, 6197.101420294032, 6230.221222347207, 6217.471514921192, 6246.281677607133, 6248.250209974832, 6258.812235632939, 6263.0, 4836.056968891033, 4864.854054378375, 4869.537393947569, 4905.5094490550655, 4916.311716359713, 3726.0, 4322.805473753689, 4361.0841723237845, 4416.403785488982, 4459.598636122764, 5761.740721667535, 5770.538356931435, 5772.6536407815665, 5790.42095790426, 5799.3620701722775, 5196.45437229093, 6270.2789179244055, 6290.654014029181, 6293.937060629427, 6306.369363063749, 5614.157876318585, 5674.829755107354, 5687.345955215121, 5707.800226992035, 5802.738876750556, 5345.438728933406, 5367.302250707383, 5376.247325374451, 5378.973105134528, 5383.81156659515, 6272.8118156455375, 6280.528960328085, 6286.591371560834, 6299.464545513591, 6312.179416675803, 6118.040554665315, 6190.690465476799, 6217.191765070512, 6283.151774510383, 6289.276733175743, 5321.361436627474, 6236.688165591611, 6242.687865606792, 6262.906056409249, 6263.592866463665, 6023.427774361428, 6144.600600960924, 6159.753609855735, 6160.815175544741, 6165.84585385369, 6104.236970378703, 6188.81433556994, 6261.843453913689, 6280.717367718555, 6281.309056003927, 5318.883034562785, 5867.911981320198, 6017.87964240704, 6078.574499784972, 6083.148359229623, 5933.3769954154195, 6044.335123136363, 6051.818445446644, 6063.878722425615, 6091.116788065794, 5889.322727886348, 5930.822075337746, 5932.466078052996, 5944.851378715567, 6006.789762358297, 6045.909311360421, 6080.179175811209, 6084.056971169476, 6086.543509236736, 6093.969530152321, 5740.540756739368, 5873.500752436091, 5889.67606781614, 5934.7922822701, 5935.080062590306], "unit": "score", "name": "dojo.html", "value": 5652.716652347477}, {"lowerIsBetter": false, "replicates": [482.40904891507887, 509.91331473649467, 530.9044372013036, 562.5949316492126, 580.2572706935122, 30145.849270753642, 37332.62667373329, 37941.62058379415, 38087.809560952155, 38146.42780358297, 41242.79378603103, 41514.58485415152, 41780.37329440061, 41795.0, 41858.95352616186, 9481.857772133406, 9713.514324283793, 9736.561854716554, 9740.074692904163, 9741.31810773246, 9587.80824383512, 9772.560234789451, 9777.168940640055, 9798.0, 9900.702978910609, 9853.359531630456, 9931.354461959985, 9959.103680668739, 9966.700998970005, 9996.50017499122, 9811.705648830546, 9854.014598540125, 9867.802643947152, 9870.309078364517, 9878.209743220525, 9619.230461563127, 9743.269254805848, 9767.316287859852, 9772.51137443132, 9785.461799601018, 39822.20355592901, 40075.59924400748, 40142.59857401447, 40260.0, 40285.39571906424, 3234.8867789627484, 3243.4161850866835, 3342.448495998182, 3369.107186595554, 3521.0, 28362.592051533928, 28566.285842853886, 29006.854965725248, 29160.70839291601, 29251.976180833783, 2760.544510155822, 2780.430011847566, 2839.9716002839914, 2883.351245969661, 2958.7485063769604, 361416.0, 361687.0, 362235.0, 362327.0, 363078.0, 54660.0, 55795.16307255394, 62812.0, 63381.0, 64074.0, 64376.678116610055, 64742.028869566995, 65025.0, 65150.0, 65245.67377163084, 16656.250468728937, 16856.915715421343, 16857.325706971827, 16858.0, 16887.91556042212, 10791.136709063256, 10884.891151088546, 12505.624831255076, 12712.74574508523, 12845.743085138245, 15578.610534736723, 19232.71150932737, 19322.227110915686, 19464.31874884372, 19521.219151233792, 7009.9299007010295, 8604.655813767504, 8614.22471977525, 8647.524386158822, 8670.306375489945, 930.2743859789375, 965.4931161140457, 1002.3634991780272, 1052.678932925465, 1147.9081673466103, 27159.72840271572, 28069.298267543065, 28107.43785124286, 28364.85817570899, 28466.430671386457, 1105.1987309200927, 1120.93834839083, 1168.4508281108035, 1192.1237890150733, 1239.9194052386565, 14418.990670653164, 14606.269686515632, 14638.487652932095, 14972.775408368883, 15026.948113631941, 524923.0, 529920.0, 532524.0, 532912.0, 535396.3230183824, 57717.71141144352, 58105.0, 58168.709156453944, 58243.0, 58390.20463669848, 1432.9211893345757, 1440.8559144085507, 1448.1600671610652, 1458.6645071633372, 1470.5808844479486, 27911.16266512008, 28170.95726068483, 28202.85898570494, 28598.0, 28643.14070577886, 48268.7586562079, 48643.5135648639, 48647.75676121597, 48650.270245945634, 48735.512644874514, 495699.0, 497789.0, 612418.0, 631682.0, 636364.0, 25809.870950645127, 31081.844590776902, 31387.0, 31538.842305788323, 31600.525992110597, 38362.61637383702, 43985.0, 44253.77873110614, 44339.55660443354, 44726.776366119266, 37030.44454333133, 37325.81337093297, 37809.62190378061, 38211.80894095512, 38231.808840955615, 35924.101897452776, 35946.640533595375, 36913.261734764616, 37075.25849482941, 37188.81405592955, 28553.857230714544, 34058.0, 34067.48898766471, 34820.0, 34898.0, 30413.239669008453, 30816.84591577028, 30916.917907873118, 31281.0, 32268.838655806572, 24369.14707985212, 24465.633015505136, 24705.888235029826, 24892.75107248977, 24973.0], "unit": "score", "name": "ext.html", "value": 19514.63150344034}, {"lowerIsBetter": false, "replicates": [360.6285525908314, 363.92357604902986, 364.91242101895534, 368.2120262637955, 371.72863809419107, 14976.550703478886, 15115.697686046273, 19231.0, 19324.420267391964, 20139.29512467064, 11534.826977595343, 11710.297382157056, 11742.236754610944, 12072.275663460177, 19322.420327390202, 3903.355946268862, 5176.715280659562, 5394.271773310612, 5395.163749618815, 5400.83797486076, 4002.1195337025806, 5653.6607803531715, 5927.555433342495, 5931.228940237763, 5940.910886336708, 5793.681347525884, 5866.706664666771, 6443.774467893625, 6447.7743278985245, 6450.0, 5499.587530935196, 6360.618362898194, 6397.808065758011, 6411.583247088947, 6428.3250258722865, 5537.612367134302, 5702.429757024306, 5713.228714123582, 5715.771369145229, 5744.281964754406, 13028.739425211537, 13453.865461345456, 13484.528041518499, 13494.797578036338, 15569.37722491099, 2185.2351676912954, 2277.3168049585056, 2288.645259984705, 2372.4661951060875, 2680.463907218564, 8949.59726812295, 9697.612095516171, 9860.753481162956, 9892.604295828158, 10262.025107614765, 1724.922378492971, 1775.2189036823756, 1782.269269599471, 1799.5141311845728, 1841.383136649224, 92946.0, 95261.52369238109, 96145.0, 97510.51244743801, 97638.0, 11175.497102630401, 11338.03626691724, 11387.544498219979, 11429.371384573762, 11536.538538458535, 13503.932480337535, 13641.045126841025, 13650.385732642055, 13675.726485470235, 13699.904007679363, 8482.448640838325, 8492.980842298964, 8496.70261540843, 8575.399722019523, 8638.222559969632, 8577.914220857836, 8593.0, 8614.310855131574, 8728.476291422536, 8752.168543988311, 4023.436718859362, 4239.512456067591, 4242.342436922282, 4250.596193361625, 4390.319500477367, 1713.9914300428418, 1789.105447276362, 1808.408600431638, 1866.56135808085, 1878.417690515917, 787.2481779900181, 912.7900582865979, 951.6383774165911, 954.0602506531061, 960.0063933828454, 20017.99910004494, 20553.588928221652, 20583.588328233353, 20705.0, 20721.75669459837, 958.1376760915093, 1001.6594357918198, 1011.726833754882, 1031.9432431216205, 1045.7751583409604, 10125.594976201017, 10367.963203679572, 10391.84412233817, 10432.832562662497, 10457.320274182153, 672407.0, 675947.0, 685233.0, 696072.0, 697298.0, 106707.0, 106845.0, 107163.92836071695, 107487.0, 108553.91446085439, 1201.873803250646, 1213.1750409721299, 1221.6396163131897, 1224.7244370016854, 1232.2729589542214, 17238.913805430893, 17520.561985950455, 17553.385631502835, 17562.20970056325, 17818.91090544539, 42754.14491710211, 42898.78550607352, 43329.783351083046, 45442.63672089842, 48422.27366589433, 63446.0, 65733.0, 66378.66810665916, 66888.66555667385, 67274.0, 7319.975203471412, 7554.357879580297, 7668.769936901679, 7712.460127791001, 7821.960890195513, 7547.904191616766, 8418.452800567944, 11478.253913495597, 11913.332133501144, 11974.281543107441, 10055.69832905014, 10251.58993640246, 10340.017698318648, 10373.118284945562, 10478.318909270873, 8571.0, 10348.741281468023, 10395.32430392022, 10482.737931551772, 10607.310524815863, 10427.217958653284, 10737.946310268399, 10899.891001089887, 11059.990708408903, 11166.771655118093, 7683.385329173541, 7685.03937007874, 7733.729319473791, 7739.7678069658, 7770.8834367483405, 6911.195841834533, 10054.798904022025, 10284.897151028694, 10536.420496872746, 10744.677659670222], "unit": "score", "name": "jquery.html", "value": 8899.620943451377}, {"lowerIsBetter": false, "replicates": [1394.3028485757122, 1533.9704084433245, 1548.736714758491, 1784.9732254016192, 1930.9958821412856, 7870.134285228627, 8531.0, 8698.999615044271, 8704.173103555167, 8713.041565427799, 8415.91584084159, 8645.740627781177, 8665.95667021664, 8670.132986701326, 8670.219680228778, 2148.79586439288, 2206.227820262903, 2209.62436385814, 2456.1771806444817, 2479.801615870735, 2227.340631229736, 2236.2955668964305, 2445.4131008557997, 2509.1719732488327, 2510.472800711853, 2439.280412278373, 2460.8646524441147, 2461.1755062054144, 2468.4322605800676, 2473.2703852363506, 2431.0761910474084, 2451.350392146083, 2467.962980555284, 2471.098049212034, 2479.293401380598, 2439.841410308342, 2464.334629650002, 2467.851928884255, 2470.654108424822, 2471.9752802471926, 8550.52972086535, 8722.476651400937, 8753.3872628916, 8776.16626420489, 8807.64769409223, 5332.893342133136, 5473.644213126174, 5476.780928762844, 5482.369527504348, 5488.094464413367, 2760.8619569021466, 3271.5910511186103, 3511.7892926424242, 3575.982120089409, 3651.6713495785243, 1046.832506798916, 1058.6136060338, 1060.4750648429076, 1068.316277582348, 1069.8716154061563, 11726.472308746042, 11746.060315174765, 11791.941040294829, 11872.228305160137, 11974.760504789943, 4864.78108485119, 4900.926486102711, 4942.294908256646, 4954.826581069645, 4968.180250258739, 10085.193184545218, 10095.141912937483, 10104.797904041878, 10116.34243774167, 10116.696499105039, 5448.210009548593, 5450.945490545044, 5451.836444906659, 5462.399136095027, 5469.535089517356, 4883.877903052452, 4940.011997600423, 4945.727984960789, 4947.0, 4948.604111671058, 3201.759868009862, 3649.85400583979, 3723.553173619183, 3950.743201691881, 4000.959990400117, 1211.0372254058045, 1232.06363163996, 1273.6242808371553, 1292.101989117573, 1296.0797833538293, 1312.5012495251742, 1334.6129622409587, 1347.6226656536185, 1368.3021658954005, 1368.904176707621, 7950.0, 7979.72070977513, 8214.014318281845, 8373.995120585569, 8384.0, 1100.5047728522036, 1134.3760931487648, 1195.1740914563693, 1204.2112416367293, 1220.3153063260684, 5411.972940135274, 6257.124002639634, 6385.840353991188, 6391.776287829904, 6427.550071495044, 10329.12202462784, 10832.891671083345, 10976.0, 10979.341239525495, 10980.286281391684, 9922.40465572068, 10828.891711082946, 10840.241183117107, 10848.294860834021, 10850.782984340269, 8163.183681631908, 8278.586070696561, 8281.503109813431, 8306.335493160654, 8394.160583941679, 7996.5601891894175, 8002.159773223728, 8063.435559510778, 8105.594720263845, 8110.06734225548, 9383.436993780395, 9495.0, 9550.188234000188, 9589.904100958902, 9664.420134791935, 9749.80500389974, 9774.364666296668, 9823.919368869561, 10069.89930100719, 10082.747931301483, 7491.138519070377, 7548.094228692373, 7636.160022397643, 7639.121501027453, 7647.388208943383, 8071.636776345196, 8182.713605023796, 8191.959040204761, 8201.097879233399, 8224.876626850722, 6373.458256048288, 7642.235776422313, 7691.653875575501, 7766.728164514215, 7790.454668173174, 7474.887876681745, 7559.3196612305155, 7578.431617628589, 7665.23347665229, 7691.461597688108, 7714.302853372249, 7769.689212431439, 7781.144074151725, 7792.688292468464, 7807.843843123219, 6863.347981941708, 7017.298270173146, 7017.789466316019, 7021.473389495706, 7022.12223472066, 7079.8938015930835, 7149.964250178716, 7159.212486626363, 7166.355028047501, 7167.1757747859665], "unit": "score", "name": "mootools.html", "value": 4944.281753311631}, {"lowerIsBetter": false, "replicates": [313.8258266662002, 322.0981252493019, 324.0941568316556, 327.24406620706185, 331.55074873546346, 5358.160175107195, 6435.935640643598, 6577.4080332770045, 6668.299828518008, 6673.26594074652, 6524.184476940382, 6652.933470665292, 6694.732210711566, 6699.598024118556, 6732.764353247638, 5037.06814239365, 5041.8235361762345, 5046.873828154307, 5053.9241911371355, 5090.872728181788, 4090.5909409059004, 4791.664583479158, 4840.661153719241, 5002.59979201663, 5068.087744206042, 4911.75441227939, 4924.655274130812, 4941.0, 4945.752712364385, 4946.925796113062, 3998.7200895937294, 4921.212605983025, 4930.580900623451, 4943.1102401567705, 4958.776855041532, 4245.660347172219, 4251.171021650779, 4252.957470425287, 4254.170436764832, 4261.062566235423, 5478.479544443271, 5632.5355407594325, 5990.191324171268, 6420.390062944013, 6460.515461340371, 5711.885762284773, 5726.828195154152, 5735.111057786008, 5736.713164341766, 5744.511716504102, 6631.469482441393, 6740.022696708998, 7119.679614417312, 7132.857342853165, 7177.4258059355125, 4451.132029254297, 4553.4991150973365, 4576.084783043405, 4584.129015487047, 4584.793684284182, 7378.40972722181, 7494.962525187339, 7527.096748390229, 7527.849443011164, 7542.208068152875, 4513.187626227311, 4632.62938964882, 4643.141018911512, 4652.62778977681, 4654.557817007379, 4708.293755936568, 4726.740029298421, 4752.7623618818925, 4757.167495688241, 4763.428388593322, 5741.425857414309, 5743.741531631086, 5745.253117094751, 5763.991301522301, 5769.278840144982, 5719.370869204384, 5790.36306006339, 7131.393831524379, 7143.89284160738, 7150.713971441188, 1593.0839767133712, 1622.3997121065045, 1643.2358953086873, 1647.7857878475722, 1650.1666658337463, 1038.2835843268272, 1050.7950949564915, 1061.379093230469, 1061.5965932945585, 1064.499685147979, 6688.230853451818, 6689.866202675919, 6695.832604184934, 6703.832404189837, 6721.798346049626, 7419.035525381773, 7421.0, 7435.814104647319, 7442.218567050381, 7455.217202193691, 6435.163428754232, 6677.09859169006, 6708.2956289589865, 6720.361565651256, 6733.326667333227, 3908.101136738509, 3939.3697008478507, 3943.5464921533817, 3944.1322908959983, 3947.2302900934615, 7756.340711039512, 7756.340711039625, 7760.534367937942, 7784.299413052852, 7790.220977902164, 7398.96300518494, 7619.809504762426, 7627.961860190663, 7634.847303053908, 7664.118626357928, 7046.541974771623, 7177.600367928204, 7854.0, 7856.882146767803, 7864.803379915548, 7194.96402518005, 7362.815929601803, 7382.335589796944, 7393.667284972296, 7397.889031664637, 5635.492805647511, 6440.935590644033, 6621.576361082391, 7190.640467976685, 7293.088363954505, 6343.52423568225, 6432.9678351607945, 7872.134065252703, 7878.684852605831, 7895.973523442146, 4678.555537223959, 4720.315554244684, 4725.29120631908, 4730.432348118248, 4738.763061846963, 7244.275572442713, 7496.137944136494, 7496.25037496246, 7504.774856754306, 7511.812204694707, 7198.424126070006, 7202.819929501804, 7207.459440542085, 7208.135023797178, 7214.96392518034, 6914.619695916773, 7130.607816570138, 7186.461015423969, 7204.423646108404, 7208.35124838767, 6948.922916947881, 6984.40632546219, 6986.336298051677, 6988.126484189476, 6988.825279368057, 7108.857822843411, 7126.8218294540975, 7135.250798666273, 7145.64271786419, 7149.463790215651, 6783.559068660521, 6936.237013928565, 6975.0, 6998.895016574654, 7057.541259818301], "unit": "score", "name": "prototype.html", "value": 5172.956277932475}, {"lowerIsBetter": false, "replicates": [647.8315637934139, 671.1308855032732, 729.4638440746047, 742.5618884857932, 758.6548120605129, 15002.549923502285, 15191.544253672408, 15203.315850786714, 15227.162506062163, 15241.847581524182, 13644.771970522652, 13687.726245475085, 13757.656058598515, 13814.033017688766, 13830.308484575782, 841.8653015517534, 855.9914400855974, 857.6055014693248, 858.120426562775, 859.3898332184126, 695.634791734341, 708.5359089796166, 709.1171491493099, 838.4172999765166, 864.4121997042009, 895.4403497813867, 908.582052255963, 908.8046070094928, 912.2428384440931, 912.5026860361086, 905.3210092430677, 905.3888625178045, 905.9094090590954, 906.0260220263243, 906.0576999920075, 536.4635364635365, 545.0897002006658, 545.6862304175075, 546.3443867359146, 658.1214079204268, 14683.339249733788, 14721.190334531597, 14758.335874885655, 14766.70466590673, 14822.925885370612, 12222.938885305606, 12370.44333005017, 12422.937885310606, 12566.68583285416, 12729.0, 9876.95061524695, 9885.456299903502, 9934.45360505172, 9975.800483990351, 10006.399616022989, 3459.775114617542, 3522.9119272018147, 3530.7881527108457, 3531.1525233943926, 3535.734819888519, 78367.21632783713, 78462.21537784663, 80284.59857700733, 80962.59518702427, 81191.0, 9228.40015398997, 9266.583003764847, 9402.670906518239, 9530.809383812284, 9694.563744631509, 20837.37487875366, 20839.374818755463, 20860.58278834415, 20899.268525601532, 20908.58182836335, 7301.671424785791, 7302.780916572511, 7450.701971921062, 7464.477486575996, 7492.700291988368, 3962.6829853611644, 4034.0, 4091.5090189176894, 4112.773797441169, 4115.36211887158, 3452.896413107611, 3511.3152935177395, 3516.191276006533, 3517.542719446507, 3521.2253304273017, 557.498251573579, 582.2954225387244, 582.5397935630804, 666.5534092158168, 694.4860803005739, 503.7783375314923, 506.02385823425465, 546.7648910968243, 551.4871169812033, 575.4590684756315, 8392.958035209786, 8592.613332400057, 8595.398322117517, 8709.172628600272, 8828.602712877808, 495.96032317414523, 590.4066413254651, 597.4055814464635, 601.8344955137372, 607.419913982146, 3893.7469064510715, 3917.588653191374, 3954.130091379892, 4331.956680433155, 4399.670024748157, 86048.0, 87694.32253291704, 88277.67583486253, 88289.0, 88555.0, 80206.0, 80545.0, 81463.0, 81642.91785410706, 81848.18151818405, 53734.462655373725, 68265.0, 69495.0, 70114.0, 71610.64194679097, 8760.868586971328, 8807.515586642796, 9013.278937684838, 9016.323775716717, 9047.185753282236, 34227.31545369029, 44222.0, 48216.758916205195, 48738.53784386474, 49385.753071234416, 62951.37048629455, 63799.04301435575, 64014.0, 64135.0, 65052.0, 10633.734156646145, 11004.944975275072, 11183.88816111861, 11213.775724485302, 11294.378809165575, 11851.881481185077, 11901.047916166859, 12345.444454999368, 12875.420606072561, 12883.48466061347, 11429.0, 11433.771324573629, 11770.470328835052, 11771.293722376684, 11869.881301187223, 10599.8940010602, 11112.444257804076, 11316.20786544934, 11574.263860421004, 11772.941135294268, 8253.207049514447, 10363.792724145324, 11357.318560886373, 11561.768764624829, 11707.590234341757, 8287.668493260444, 8832.646694132163, 9081.273498120003, 9177.0, 9435.150836424755, 8556.786080347792, 9496.667616633385, 9671.323007389416, 9703.272254581076, 10160.644377446753], "unit": "score", "name": "yui.html", "value": 6732.305119517594}], "name": "dromaeo_css", "value": 7435.978180112715}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 112.0, 111.0, 112.0, 117.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 145.0, 157.0, 122.0, 142.0, 142.0, 123.0, 155.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.2}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 184.0, 185.0, 186.0, 184.0, 185.0, 186.0, 189.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.8}, {"lowerIsBetter": true, "replicates": [103.0, 70.0, 83.0, 77.0, 56.0, 59.0, 59.0, 80.0, 76.0, 58.0], "unit": "score", "name": "audio-fft", "value": 72.1}, {"lowerIsBetter": true, "replicates": [93.0, 100.0, 128.0, 79.0, 81.0, 80.0, 105.0, 77.0, 77.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [119.0, 95.0, 88.0, 95.0, 88.0, 95.0, 88.0, 94.0, 89.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 96.7}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 92.0, 130.0], "unit": "score", "name": "imaging-desaturate", "value": 90.5}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 54.0, 53.0, 54.0, 54.0, 53.0, 64.0, 51.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [62.0, 71.0, 71.0, 74.0, 70.0, 66.0, 65.0, 68.0, 72.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 84.0, 79.0, 83.0, 82.0, 83.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [127.0, 134.0, 123.0, 137.0, 120.0, 119.0, 124.0, 125.0, 122.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [140.0, 126.0, 141.0, 138.0, 140.0, 137.0, 140.0, 137.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 65.0, 66.0, 66.0, 68.0, 65.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1416.8000000000002}]} 04:26:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1416.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7435.98"}}} 04:26:15 INFO - Return code: 0 04:26:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:15 INFO - # TBPL SUCCESS # 04:26:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:15 INFO - 2016-02-12 04:26:15.642 screenresolution[1696:10570] starting screenresolution argv=screenresolution get 04:26:15 INFO - 2016-02-12 04:26:15.645 screenresolution[1696:10570] Display 0: 1600x1200x32@60 04:26:15 INFO - 2016-02-12 04:26:15.651 screenresolution[1697:10573] starting screenresolution argv=screenresolution list 04:26:15 INFO - Available Modes on Display 0 04:26:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:15 INFO - Intel Iris: 04:26:15 INFO - Chipset Model: Intel Iris 04:26:15 INFO - Type: GPU 04:26:15 INFO - Bus: Built-In 04:26:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:15 INFO - Vendor: Intel (0x8086) 04:26:15 INFO - Device ID: 0x0a2e 04:26:15 INFO - Revision ID: 0x0009 04:26:15 INFO - Displays: 04:26:15 INFO - Display: 04:26:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:15 INFO - Display Serial Number: 1600x1200 60 04:26:15 INFO - Main Display: Yes 04:26:15 INFO - Mirror: Off 04:26:15 INFO - Online: Yes 04:26:15 INFO - Rotation: Supported 04:26:15 INFO - Return code: 0 04:26:15 INFO - Running post-action listener: _resource_record_post_action 04:26:15 INFO - Running post-run listener: _resource_record_post_run 04:26:16 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33881600; Write bytes: 708363776; Read time: 354; Write time: 2160 04:26:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 399675904; Write bytes: 393033216; Read time: 31095; Write time: 910 04:26:16 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32083456; Write bytes: 298514432; Read time: 335; Write time: 1195 04:26:16 INFO - Running post-run listener: _upload_blobber_files 04:26:16 INFO - Blob upload gear active. 04:26:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:18 INFO - (blobuploader) - INFO - Done attempting. 04:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:19 INFO - (blobuploader) - INFO - Done attempting. 04:26:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:19 INFO - Return code: 0 04:26:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/362db7f9d9605a8a1c07d2b810da8d249157e5a620c631a8b5da72d9d06892956ef5828ba185bf87d387ff63be285dedc793ef48f58ca261468770e0907ad420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08dd85fdf5d358b57f79dc6d143257abb2b051f0270b7ce7fefe0df78d28b35ee9c56efac3594a74d69a3c968cb48f4ca36729f5cf86dd01820c1d668c8026be"} 04:26:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:19 INFO - Contents: 04:26:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/362db7f9d9605a8a1c07d2b810da8d249157e5a620c631a8b5da72d9d06892956ef5828ba185bf87d387ff63be285dedc793ef48f58ca261468770e0907ad420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08dd85fdf5d358b57f79dc6d143257abb2b051f0270b7ce7fefe0df78d28b35ee9c56efac3594a74d69a3c968cb48f4ca36729f5cf86dd01820c1d668c8026be"} 04:26:19 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:19 INFO - Copying logs to upload dir... 04:26:19 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.458087 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-02-12 04:26:19.528187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 04:26:19.531776) ========= 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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/362db7f9d9605a8a1c07d2b810da8d249157e5a620c631a8b5da72d9d06892956ef5828ba185bf87d387ff63be285dedc793ef48f58ca261468770e0907ad420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08dd85fdf5d358b57f79dc6d143257abb2b051f0270b7ce7fefe0df78d28b35ee9c56efac3594a74d69a3c968cb48f4ca36729f5cf86dd01820c1d668c8026be"} build_url:https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/TzP9fzomQD6LLClrivCwVg/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/362db7f9d9605a8a1c07d2b810da8d249157e5a620c631a8b5da72d9d06892956ef5828ba185bf87d387ff63be285dedc793ef48f58ca261468770e0907ad420", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08dd85fdf5d358b57f79dc6d143257abb2b051f0270b7ce7fefe0df78d28b35ee9c56efac3594a74d69a3c968cb48f4ca36729f5cf86dd01820c1d668c8026be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 04:26:19.557408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 04:26:19.557705) ========= 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.nh3wwTwwaU/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.AZ0yCwoj3q/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.004582 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 04:26:19.605793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 04:26:19.606063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 04:26:19.606382) ========= ========= Total master_lag: 1.07 =========