builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0177 starttime: 1456139695.38 results: success (0) buildid: 20160222013857 builduid: 79c3428ed98945aeaad7126bfcf28760 revision: 758daaf1723f377d853d2547b072d49559d8b494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.384501) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.384914) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.385229) ========= 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.97xOhiCDrF/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.73bHlpYrDm/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.005578 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.428238) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.428926) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.550084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.550377) ========= 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.97xOhiCDrF/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.73bHlpYrDm/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.005078 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.582577) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.582930) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.583342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.583858) ========= 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.97xOhiCDrF/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.73bHlpYrDm/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-22 03:14:55-- 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% 14.8M=0.001s 2016-02-22 03:14:55 (14.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212121 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.832449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.832798) ========= 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.97xOhiCDrF/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.73bHlpYrDm/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.027177 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.883614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:55.884002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 758daaf1723f377d853d2547b072d49559d8b494 --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 758daaf1723f377d853d2547b072d49559d8b494 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.97xOhiCDrF/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.73bHlpYrDm/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-22 03:14:55,966 truncating revision to first 12 chars 2016-02-22 03:14:55,966 Setting DEBUG logging. 2016-02-22 03:14:55,966 attempt 1/10 2016-02-22 03:14:55,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/758daaf1723f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 03:14:56,683 unpacking tar archive at: fx-team-758daaf1723f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.962510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:56.865148) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:56.865596) ========= echo 758daaf1723f377d853d2547b072d49559d8b494 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'758daaf1723f377d853d2547b072d49559d8b494'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.97xOhiCDrF/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.73bHlpYrDm/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 758daaf1723f377d853d2547b072d49559d8b494 program finished with exit code 0 elapsedTime=0.005499 script_repo_revision: '758daaf1723f377d853d2547b072d49559d8b494' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:56.915603) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:56.915953) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 03:14:56.929315) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-22 03:14:56.929782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.97xOhiCDrF/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.73bHlpYrDm/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 03:14:57 INFO - MultiFileLogger online at 20160222 03:14:57 in /builds/slave/test 03:14:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:14:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:14:57 INFO - {'append_to_log': False, 03:14:57 INFO - 'base_work_dir': '/builds/slave/test', 03:14:57 INFO - 'blob_upload_branch': 'Fx-Team', 03:14:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:14:57 INFO - 'branch': 'Fx-Team', 03:14:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:14:57 INFO - 'config_files': ('talos/mac_config.py',), 03:14:57 INFO - 'default_actions': ('clobber', 03:14:57 INFO - 'read-buildbot-config', 03:14:57 INFO - 'download-and-extract', 03:14:57 INFO - 'populate-webroot', 03:14:57 INFO - 'create-virtualenv', 03:14:57 INFO - 'install', 03:14:57 INFO - 'run-tests'), 03:14:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:14:57 INFO - 'download_minidump_stackwalk': True, 03:14:57 INFO - 'download_symbols': 'ondemand', 03:14:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:14:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:14:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:14:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:14:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:14:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:14:57 INFO - 'installer_path': 'installer.exe', 03:14:57 INFO - 'log_level': 'info', 03:14:57 INFO - 'log_name': 'talos', 03:14:57 INFO - 'log_to_console': True, 03:14:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:14:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:14:57 INFO - 'opt_config_files': (), 03:14:57 INFO - 'pip_index': False, 03:14:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:14:57 INFO - 'cmd': ('bash', 03:14:57 INFO - '-c', 03:14:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:14:57 INFO - 'enabled': True, 03:14:57 INFO - 'halt_on_failure': False, 03:14:57 INFO - 'name': 'check_screen_resolution'},), 03:14:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:14:57 INFO - 'cmd': ('bash', 03:14:57 INFO - '-c', 03:14:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:14:57 INFO - 'enabled': True, 03:14:57 INFO - 'halt_on_failure': False, 03:14:57 INFO - 'name': 'check_screen_resolution'},), 03:14:57 INFO - 'run_cmd_checks_enabled': True, 03:14:57 INFO - 'sps_profile': False, 03:14:57 INFO - 'sps_profile_interval': 0, 03:14:57 INFO - 'suite': 'dromaeojs-e10s', 03:14:57 INFO - 'system_bits': '32', 03:14:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:14:57 INFO - 'title': 't-yosemite-r7-0177', 03:14:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:14:57 INFO - 'use_talos_json': True, 03:14:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:14:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:14:57 INFO - 'work_dir': 'build'} 03:14:57 INFO - ##### 03:14:57 INFO - ##### Running clobber step. 03:14:57 INFO - ##### 03:14:57 INFO - Running pre-action listener: _resource_record_pre_action 03:14:57 INFO - Running main action method: clobber 03:14:57 INFO - rmtree: /builds/slave/test/build 03:14:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:14:58 INFO - Running post-action listener: _resource_record_post_action 03:14:58 INFO - ##### 03:14:58 INFO - ##### Running read-buildbot-config step. 03:14:58 INFO - ##### 03:14:58 INFO - Running pre-action listener: _resource_record_pre_action 03:14:58 INFO - Running main action method: read_buildbot_config 03:14:58 INFO - Using buildbot properties: 03:14:58 INFO - { 03:14:58 INFO - "project": "", 03:14:58 INFO - "product": "firefox", 03:14:58 INFO - "script_repo_revision": "production", 03:14:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:14:58 INFO - "repository": "", 03:14:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:14:58 INFO - "buildid": "20160222013857", 03:14:58 INFO - "pgo_build": "False", 03:14:58 INFO - "basedir": "/builds/slave/test", 03:14:58 INFO - "buildnumber": 475, 03:14:58 INFO - "slavename": "t-yosemite-r7-0177", 03:14:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:14:58 INFO - "platform": "yosemite_r7", 03:14:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:14:58 INFO - "branch": "fx-team", 03:14:58 INFO - "repo_path": "integration/fx-team", 03:14:58 INFO - "revision": "758daaf1723f377d853d2547b072d49559d8b494", 03:14:58 INFO - "stage_platform": "macosx64", 03:14:58 INFO - "builduid": "79c3428ed98945aeaad7126bfcf28760", 03:14:58 INFO - "slavebuilddir": "test" 03:14:58 INFO - } 03:14:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:14:58 INFO - Running post-action listener: _resource_record_post_action 03:14:58 INFO - ##### 03:14:58 INFO - ##### Running download-and-extract step. 03:14:58 INFO - ##### 03:14:58 INFO - Running pre-action listener: _resource_record_pre_action 03:14:58 INFO - Running main action method: download_and_extract 03:14:58 INFO - mkdir: /builds/slave/test/build/tests 03:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:14:58 INFO - https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:14:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/test_packages.json 03:14:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/test_packages.json 03:14:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:14:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:15:00 INFO - Downloaded 1277 bytes. 03:15:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:15:00 INFO - Using the following test package requirements: 03:15:00 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:15:00 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:15:00 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:15:00 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'jsshell-mac.zip'], 03:15:00 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:15:00 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:15:00 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:15:00 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:15:00 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:15:00 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:15:00 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:15:00 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:15:00 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:00 INFO - https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:15:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:15:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:15:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:01 INFO - Downloaded 17825407 bytes. 03:15:01 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'] 03:15:01 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 03:15:04 INFO - Return code: 0 03:15:04 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 03:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:04 INFO - https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:15:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:15:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:15:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:06 INFO - Downloaded 17825407 bytes. 03:15:06 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'] 03:15:06 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 03:15:10 INFO - Return code: 0 03:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:10 INFO - https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:12 INFO - Downloaded 10707015 bytes. 03:15:12 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'] 03:15:12 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 03:15:12 INFO - Return code: 0 03:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:12 INFO - https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:15:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:15:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:15:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CAgJGWjdRnClVMjtjHzBVw/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 03:15:15 INFO - Downloaded 111267128 bytes. 03:15:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:15:15 INFO - mkdir: /builds/slave/test/properties 03:15:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:15 INFO - Contents: 03:15:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:15:16 INFO - Running post-action listener: _resource_record_post_action 03:15:16 INFO - Running post-action listener: set_extra_try_arguments 03:15:16 INFO - ##### 03:15:16 INFO - ##### Running populate-webroot step. 03:15:16 INFO - ##### 03:15:16 INFO - Running pre-action listener: _resource_record_pre_action 03:15:16 INFO - Running main action method: populate_webroot 03:15:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:15:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:15:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:15:16 INFO - '--tppagecycles', 03:15:16 INFO - '7'], 03:15:16 INFO - 'tests': ['tsvgm']}}, 03:15:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:15:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:15:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:15:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:15:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'tests': ['damp', 'tps']}, 03:15:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['damp', 'tps']}, 03:15:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:15:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:16 INFO - 'other': {'tests': ['a11yr', 03:15:16 INFO - 'ts_paint', 03:15:16 INFO - 'tpaint', 03:15:16 INFO - 'sessionrestore', 03:15:16 INFO - 'sessionrestore_no_auto_restore']}, 03:15:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['a11yr', 03:15:16 INFO - 'ts_paint', 03:15:16 INFO - 'tpaint', 03:15:16 INFO - 'sessionrestore', 03:15:16 INFO - 'sessionrestore_no_auto_restore']}, 03:15:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['a11yr', 03:15:16 INFO - 'ts_paint', 03:15:16 INFO - 'tpaint', 03:15:16 INFO - 'sessionrestore', 03:15:16 INFO - 'sessionrestore_no_auto_restore']}, 03:15:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['a11yr', 03:15:16 INFO - 'ts_paint', 03:15:16 INFO - 'tpaint', 03:15:16 INFO - 'sessionrestore', 03:15:16 INFO - 'sessionrestore_no_auto_restore']}, 03:15:16 INFO - 'other_l64': {'tests': ['a11yr', 03:15:16 INFO - 'ts_paint', 03:15:16 INFO - 'tpaint', 03:15:16 INFO - 'sessionrestore', 03:15:16 INFO - 'sessionrestore_no_auto_restore']}, 03:15:16 INFO - 'other_nol64': {'tests': ['a11yr', 03:15:16 INFO - 'ts_paint', 03:15:16 INFO - 'tpaint', 03:15:16 INFO - 'sessionrestore', 03:15:16 INFO - 'sessionrestore_no_auto_restore']}, 03:15:16 INFO - 'svgr': {'tests': ['tsvgx', 03:15:16 INFO - 'tsvgr_opacity', 03:15:16 INFO - 'tart', 03:15:16 INFO - 'tscrollx', 03:15:16 INFO - 'cart']}, 03:15:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['tsvgx', 03:15:16 INFO - 'tsvgr_opacity', 03:15:16 INFO - 'tart', 03:15:16 INFO - 'tscrollx', 03:15:16 INFO - 'cart']}, 03:15:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'tests': ['tp5o']}, 03:15:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'talos_options': ['--e10s'], 03:15:16 INFO - 'tests': ['tp5o']}, 03:15:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'talos_options': ['--xperf_path', 03:15:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:16 INFO - 'tests': ['tp5n']}, 03:15:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:15:16 INFO - 'talos_options': ['--e10s', 03:15:16 INFO - '--xperf_path', 03:15:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:16 INFO - 'tests': ['tp5n']}}, 03:15:16 INFO - 'talos.zip': {'path': '', 03:15:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:15:16 INFO - Running post-action listener: _resource_record_post_action 03:15:16 INFO - ##### 03:15:16 INFO - ##### Running create-virtualenv step. 03:15:16 INFO - ##### 03:15:16 INFO - Running pre-action listener: _resource_record_pre_action 03:15:16 INFO - Running main action method: create_virtualenv 03:15:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:15:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:17 INFO - Using real prefix '/tools/python27' 03:15:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:17 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:20 INFO - Installing pip.................done. 03:15:20 INFO - Return code: 0 03:15:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:20 INFO - 'HOME': '/Users/cltbld', 03:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:20 INFO - 'LOGNAME': 'cltbld', 03:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:20 INFO - 'MOZ_NO_REMOTE': '1', 03:15:20 INFO - 'NO_EM_RESTART': '1', 03:15:20 INFO - 'PAGER': '/bin/cat', 03:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:20 INFO - 'PWD': '/builds/slave/test', 03:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:20 INFO - 'SHELL': '/bin/bash', 03:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:20 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:20 INFO - 'USER': 'cltbld', 03:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:20 INFO - 'XPC_FLAGS': '0x0', 03:15:20 INFO - 'XPC_SERVICE_NAME': '0', 03:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:15:20 INFO - Cleaning up... 03:15:20 INFO - Return code: 0 03:15:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:15:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:20 INFO - 'HOME': '/Users/cltbld', 03:15:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:20 INFO - 'LOGNAME': 'cltbld', 03:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:20 INFO - 'MOZ_NO_REMOTE': '1', 03:15:20 INFO - 'NO_EM_RESTART': '1', 03:15:20 INFO - 'PAGER': '/bin/cat', 03:15:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:20 INFO - 'PWD': '/builds/slave/test', 03:15:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:20 INFO - 'SHELL': '/bin/bash', 03:15:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:20 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:20 INFO - 'USER': 'cltbld', 03:15:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:20 INFO - 'XPC_FLAGS': '0x0', 03:15:20 INFO - 'XPC_SERVICE_NAME': '0', 03:15:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:21 INFO - Downloading/unpacking psutil>=0.7.1 03:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:24 INFO - Installing collected packages: psutil 03:15:24 INFO - Running setup.py install for psutil 03:15:24 INFO - building 'psutil._psutil_osx' extension 03:15:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:15:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:15:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:15:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:15:24 INFO - building 'psutil._psutil_posix' extension 03:15:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:15:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:15:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:15:25 INFO - ^ 03:15:25 INFO - 1 warning generated. 03:15:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:15:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:25 INFO - Successfully installed psutil 03:15:25 INFO - Cleaning up... 03:15:25 INFO - Return code: 0 03:15:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:25 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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:25 INFO - 'HOME': '/Users/cltbld', 03:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:25 INFO - 'LOGNAME': 'cltbld', 03:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:25 INFO - 'MOZ_NO_REMOTE': '1', 03:15:25 INFO - 'NO_EM_RESTART': '1', 03:15:25 INFO - 'PAGER': '/bin/cat', 03:15:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:25 INFO - 'PWD': '/builds/slave/test', 03:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:25 INFO - 'SHELL': '/bin/bash', 03:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:25 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:25 INFO - 'USER': 'cltbld', 03:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:25 INFO - 'XPC_FLAGS': '0x0', 03:15:25 INFO - 'XPC_SERVICE_NAME': '0', 03:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:15:27 INFO - Installing collected packages: mozsystemmonitor 03:15:27 INFO - Running setup.py install for mozsystemmonitor 03:15:28 INFO - Successfully installed mozsystemmonitor 03:15:28 INFO - Cleaning up... 03:15:28 INFO - Return code: 0 03:15:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:28 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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:28 INFO - 'HOME': '/Users/cltbld', 03:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:28 INFO - 'LOGNAME': 'cltbld', 03:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:28 INFO - 'MOZ_NO_REMOTE': '1', 03:15:28 INFO - 'NO_EM_RESTART': '1', 03:15:28 INFO - 'PAGER': '/bin/cat', 03:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:28 INFO - 'PWD': '/builds/slave/test', 03:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:28 INFO - 'SHELL': '/bin/bash', 03:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:28 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:28 INFO - 'USER': 'cltbld', 03:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:28 INFO - 'XPC_FLAGS': '0x0', 03:15:28 INFO - 'XPC_SERVICE_NAME': '0', 03:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:28 INFO - Downloading/unpacking blobuploader==1.2.4 03:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:30 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:15:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:31 INFO - Downloading docopt-0.6.1.tar.gz 03:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:15:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:15:31 INFO - Running setup.py install for blobuploader 03:15:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:15:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:15:32 INFO - Running setup.py install for requests 03:15:32 INFO - Running setup.py install for docopt 03:15:32 INFO - Successfully installed blobuploader requests docopt 03:15:32 INFO - Cleaning up... 03:15:32 INFO - Return code: 0 03:15:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:32 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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:15:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:32 INFO - 'HOME': '/Users/cltbld', 03:15:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:32 INFO - 'LOGNAME': 'cltbld', 03:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:32 INFO - 'MOZ_NO_REMOTE': '1', 03:15:32 INFO - 'NO_EM_RESTART': '1', 03:15:32 INFO - 'PAGER': '/bin/cat', 03:15:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:32 INFO - 'PWD': '/builds/slave/test', 03:15:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:32 INFO - 'SHELL': '/bin/bash', 03:15:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:32 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:32 INFO - 'USER': 'cltbld', 03:15:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:32 INFO - 'XPC_FLAGS': '0x0', 03:15:32 INFO - 'XPC_SERVICE_NAME': '0', 03:15:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-KZfw12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0jOrvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8jPB9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-HqVL0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-AHXPDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-BA2aMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-S4DQFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-0FMJ7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:33 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xV5v3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-RrkEif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-CptC3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-6X9DYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-viPSgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xWRKZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-JoEM5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-W3NDSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:34 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-c779Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:15:34 INFO - Running setup.py install for manifestparser 03:15:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:15:34 INFO - Running setup.py install for mozcrash 03:15:35 INFO - Running setup.py install for mozdebug 03:15:35 INFO - Running setup.py install for mozdevice 03:15:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Running setup.py install for mozfile 03:15:35 INFO - Running setup.py install for mozhttpd 03:15:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Running setup.py install for mozinfo 03:15:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Running setup.py install for mozInstall 03:15:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:15:35 INFO - Running setup.py install for mozleak 03:15:36 INFO - Running setup.py install for mozlog 03:15:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for moznetwork 03:15:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for mozprocess 03:15:36 INFO - Running setup.py install for mozprofile 03:15:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for mozrunner 03:15:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:15:36 INFO - Running setup.py install for mozscreenshot 03:15:37 INFO - Running setup.py install for moztest 03:15:37 INFO - Running setup.py install for mozversion 03:15:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:15:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:15:37 INFO - Cleaning up... 03:15:37 INFO - Return code: 0 03:15:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:37 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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:15:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:15:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:37 INFO - 'HOME': '/Users/cltbld', 03:15:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:37 INFO - 'LOGNAME': 'cltbld', 03:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:37 INFO - 'MOZ_NO_REMOTE': '1', 03:15:37 INFO - 'NO_EM_RESTART': '1', 03:15:37 INFO - 'PAGER': '/bin/cat', 03:15:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:37 INFO - 'PWD': '/builds/slave/test', 03:15:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:37 INFO - 'SHELL': '/bin/bash', 03:15:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:37 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:37 INFO - 'USER': 'cltbld', 03:15:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:37 INFO - 'XPC_FLAGS': '0x0', 03:15:37 INFO - 'XPC_SERVICE_NAME': '0', 03:15:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-c_5g5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-5KExRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:37 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)) 03:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:37 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-eVYhOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-eHiaMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-LlXGRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GFdAX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-g_nkHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-cjRxgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-4UsF9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-KZ452G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wALctm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-L5NaiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:38 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-RtV_wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:39 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-M54imD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:39 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-kWiYy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:39 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-FEkgvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:39 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-CShSkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:15:39 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)) 03:15:39 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)) 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:41 INFO - Downloading blessings-1.6.tar.gz 03:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:15:41 INFO - Installing collected packages: blessings 03:15:41 INFO - Running setup.py install for blessings 03:15:42 INFO - Successfully installed blessings 03:15:42 INFO - Cleaning up... 03:15:42 INFO - Return code: 0 03:15:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:15:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:42 INFO - Reading from file tmpfile_stdout 03:15:42 INFO - Current package versions: 03:15:42 INFO - blessings == 1.6 03:15:42 INFO - blobuploader == 1.2.4 03:15:42 INFO - docopt == 0.6.1 03:15:42 INFO - manifestparser == 1.1 03:15:42 INFO - mozInstall == 1.12 03:15:42 INFO - mozcrash == 0.16 03:15:42 INFO - mozdebug == 0.1 03:15:42 INFO - mozdevice == 0.48 03:15:42 INFO - mozfile == 1.2 03:15:42 INFO - mozhttpd == 0.7 03:15:42 INFO - mozinfo == 0.9 03:15:42 INFO - mozleak == 0.1 03:15:42 INFO - mozlog == 3.1 03:15:42 INFO - moznetwork == 0.27 03:15:42 INFO - mozprocess == 0.22 03:15:42 INFO - mozprofile == 0.28 03:15:42 INFO - mozrunner == 6.11 03:15:42 INFO - mozscreenshot == 0.1 03:15:42 INFO - mozsystemmonitor == 0.0 03:15:42 INFO - moztest == 0.7 03:15:42 INFO - mozversion == 1.4 03:15:42 INFO - psutil == 3.1.1 03:15:42 INFO - requests == 1.2.3 03:15:42 INFO - wsgiref == 0.1.2 03:15:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:42 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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:42 INFO - 'HOME': '/Users/cltbld', 03:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:42 INFO - 'LOGNAME': 'cltbld', 03:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:42 INFO - 'MOZ_NO_REMOTE': '1', 03:15:42 INFO - 'NO_EM_RESTART': '1', 03:15:42 INFO - 'PAGER': '/bin/cat', 03:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:42 INFO - 'PWD': '/builds/slave/test', 03:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:42 INFO - 'SHELL': '/bin/bash', 03:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:42 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:42 INFO - 'USER': 'cltbld', 03:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:42 INFO - 'XPC_FLAGS': '0x0', 03:15:42 INFO - 'XPC_SERVICE_NAME': '0', 03:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:15:42 INFO - Cleaning up... 03:15:42 INFO - Return code: 0 03:15:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15: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')]} 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:42 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 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:42 INFO - 'HOME': '/Users/cltbld', 03:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:42 INFO - 'LOGNAME': 'cltbld', 03:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:42 INFO - 'MOZ_NO_REMOTE': '1', 03:15:42 INFO - 'NO_EM_RESTART': '1', 03:15:42 INFO - 'PAGER': '/bin/cat', 03:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:42 INFO - 'PWD': '/builds/slave/test', 03:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:42 INFO - 'SHELL': '/bin/bash', 03:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:42 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:42 INFO - 'USER': 'cltbld', 03:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:42 INFO - 'XPC_FLAGS': '0x0', 03:15:42 INFO - 'XPC_SERVICE_NAME': '0', 03:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:42 INFO - Downloading/unpacking jsonschema 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:45 INFO - Downloading/unpacking functools32 (from jsonschema) 03:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:45 INFO - warning: no files found matching '*.txt' 03:15:45 INFO - no previously-included directories found matching 'build' 03:15:45 INFO - no previously-included directories found matching 'dist' 03:15:45 INFO - no previously-included directories found matching '.git*' 03:15:45 INFO - Installing collected packages: jsonschema, functools32 03:15:45 INFO - Running setup.py install for functools32 03:15:45 INFO - warning: no files found matching '*.txt' 03:15:45 INFO - no previously-included directories found matching 'build' 03:15:45 INFO - no previously-included directories found matching 'dist' 03:15:45 INFO - no previously-included directories found matching '.git*' 03:15:45 INFO - Successfully installed jsonschema functools32 03:15:45 INFO - Cleaning up... 03:15:45 INFO - Return code: 0 03:15:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1046eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f928a49e040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, '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.97xOhiCDrF/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.73bHlpYrDm/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 03:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:15:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:15:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:15:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:15:45 INFO - 'HOME': '/Users/cltbld', 03:15:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:15:45 INFO - 'LOGNAME': 'cltbld', 03:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:45 INFO - 'MOZ_NO_REMOTE': '1', 03:15:45 INFO - 'NO_EM_RESTART': '1', 03:15:45 INFO - 'PAGER': '/bin/cat', 03:15:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:45 INFO - 'PWD': '/builds/slave/test', 03:15:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:15:45 INFO - 'SHELL': '/bin/bash', 03:15:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:15:45 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:15:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:15:45 INFO - 'USER': 'cltbld', 03:15:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:15:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:45 INFO - 'XPC_FLAGS': '0x0', 03:15:45 INFO - 'XPC_SERVICE_NAME': '0', 03:15:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:46 INFO - Downloading/unpacking flake8 03:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:15:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:15:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:15:49 INFO - no previously-included directories found matching 'docs/_build' 03:15:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:15:49 INFO - Running setup.py install for pep8 03:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:15:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:15:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:15:49 INFO - no previously-included directories found matching 'docs/_build' 03:15:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:15:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:15:49 INFO - Cleaning up... 03:15:50 INFO - Return code: 0 03:15:50 INFO - Running post-action listener: _resource_record_post_action 03:15:50 INFO - Running post-action listener: _start_resource_monitoring 03:15:50 INFO - Starting resource monitoring. 03:15:50 INFO - ##### 03:15:50 INFO - ##### Running install step. 03:15:50 INFO - ##### 03:15:50 INFO - Running pre-action listener: _resource_record_pre_action 03:15:50 INFO - Running main action method: install 03:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:50 INFO - Reading from file tmpfile_stdout 03:15:50 INFO - Detecting whether we're running mozinstall >=1.0... 03:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:15:50 INFO - Reading from file tmpfile_stdout 03:15:50 INFO - Output received: 03:15:50 INFO - Usage: mozinstall [options] installer 03:15:50 INFO - Options: 03:15:50 INFO - -h, --help show this help message and exit 03:15:50 INFO - -d DEST, --destination=DEST 03:15:50 INFO - Directory to install application into. [default: 03:15:50 INFO - "/builds/slave/test"] 03:15:50 INFO - --app=APP Application being installed. [default: firefox] 03:15:50 INFO - mkdir: /builds/slave/test/build/application 03:15:50 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'] 03:15:50 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 03:16:24 INFO - Reading from file tmpfile_stdout 03:16:24 INFO - Output received: 03:16:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:16:24 INFO - Running post-action listener: _resource_record_post_action 03:16:24 INFO - ##### 03:16:24 INFO - ##### Running run-tests step. 03:16:24 INFO - ##### 03:16:24 INFO - Running pre-action listener: _resource_record_pre_action 03:16:24 INFO - Running main action method: run_tests 03:16:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:24 INFO - 2016-02-22 03:16:24.049 screenresolution[1662:8195] starting screenresolution argv=screenresolution get 03:16:24 INFO - 2016-02-22 03:16:24.052 screenresolution[1662:8195] Display 0: 1600x1200x32@60 03:16:24 INFO - 2016-02-22 03:16:24.059 screenresolution[1663:8197] starting screenresolution argv=screenresolution list 03:16:24 INFO - Available Modes on Display 0 03:16:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:24 INFO - Intel Iris: 03:16:24 INFO - Chipset Model: Intel Iris 03:16:24 INFO - Type: GPU 03:16:24 INFO - Bus: Built-In 03:16:24 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:24 INFO - Vendor: Intel (0x8086) 03:16:24 INFO - Device ID: 0x0a2e 03:16:24 INFO - Revision ID: 0x0009 03:16:24 INFO - Displays: 03:16:24 INFO - Display: 03:16:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:24 INFO - Display Serial Number: 1600x1200 60 03:16:24 INFO - Main Display: Yes 03:16:24 INFO - Mirror: Off 03:16:24 INFO - Online: Yes 03:16:24 INFO - Rotation: Supported 03:16:24 INFO - Return code: 0 03:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:16:24 INFO - Python 2.7.3 03:16:24 INFO - Return code: 0 03:16:24 INFO - grabbing minidump binary from tooltool 03:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:24 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 0x104591d30>, '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 0x1043b5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104588b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:16:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:16:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:16:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:16:24 INFO - Return code: 0 03:16:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:16:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:16:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:16:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:16:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:16:25 INFO - Return code: 0 03:16:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:16:25 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.97xOhiCDrF/Render', 03:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:16:25 INFO - 'HOME': '/Users/cltbld', 03:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:16:25 INFO - 'LOGNAME': 'cltbld', 03:16:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:25 INFO - 'MOZ_NO_REMOTE': '1', 03:16:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:25 INFO - 'NO_EM_RESTART': '1', 03:16:25 INFO - 'PAGER': '/bin/cat', 03:16:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:25 INFO - 'PWD': '/builds/slave/test', 03:16:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:16:25 INFO - 'SHELL': '/bin/bash', 03:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.73bHlpYrDm/Listeners', 03:16:25 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 03:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:16:25 INFO - 'USER': 'cltbld', 03:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:25 INFO - 'XPC_FLAGS': '0x0', 03:16:25 INFO - 'XPC_SERVICE_NAME': '0', 03:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:16:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:16:25 INFO - mozversion application_buildid: 20160222013857 03:16:25 INFO - mozversion application_changeset: 758daaf1723f377d853d2547b072d49559d8b494 03:16:25 INFO - mozversion application_display_name: Nightly 03:16:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:16:25 INFO - mozversion application_name: Firefox 03:16:25 INFO - mozversion application_remotingname: firefox 03:16:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:16:25 INFO - mozversion application_vendor: Mozilla 03:16:25 INFO - mozversion application_version: 47.0a1 03:16:25 INFO - mozversion platform_buildid: 20160222013857 03:16:25 INFO - mozversion platform_changeset: 758daaf1723f377d853d2547b072d49559d8b494 03:16:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:16:25 INFO - mozversion platform_version: 47.0a1 03:16:25 INFO - using testdate: 1456139785 03:16:25 INFO - actual date: 1456139785 03:16:26 INFO - starting webserver on 'localhost:49284' 03:16:26 INFO - SUITE-START | Running 2 tests 03:16:26 INFO - TEST-START | dromaeo_css 03:16:26 INFO - operating with platform_type : mac_ 03:16:26 INFO - Initialising browser for dromaeo_css test... 03:16:26 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmplktA0j/profile http://localhost:49284/getInfo.html) 03:16:29 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 03:16:29 INFO - PROCESS | 1681 | colorDepth:24 03:16:29 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 03:16:29 INFO - PROCESS | 1681 | __metrics 03:16:29 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 03:16:30 INFO - TEST-INFO | 1681: exit 0 03:16:30 INFO - Browser initialized. 03:16:30 INFO - Running cycle 1/1 for dromaeo_css test... 03:16:30 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmplktA0j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:42 INFO - PROCESS | 1686 | RSS: Main: 256753664 03:16:42 INFO - PROCESS | 1686 | 03:17:31 INFO - PROCESS | 1686 | 1456139851950 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] 03:19:43 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49284/tests/dromaeo/cssquery-ext.html) 03:19:44 INFO - PROCESS | 1686 | RSS: Main: 269320192 03:19:44 INFO - PROCESS | 1686 | 03:22:46 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-ext.html (next: http://localhost:49284/tests/dromaeo/cssquery-jquery.html) 03:22:47 INFO - PROCESS | 1686 | RSS: Main: 279826432 03:22:47 INFO - PROCESS | 1686 | 03:25:48 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49284/tests/dromaeo/cssquery-mootools.html) 03:25:49 INFO - PROCESS | 1686 | RSS: Main: 283369472 03:25:49 INFO - PROCESS | 1686 | 03:28:51 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49284/tests/dromaeo/cssquery-prototype.html) 03:28:51 INFO - PROCESS | 1686 | RSS: Main: 283586560 03:28:51 INFO - PROCESS | 1686 | 03:31:54 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49284/tests/dromaeo/cssquery-yui.html) 03:31:54 INFO - PROCESS | 1686 | RSS: Main: 287440896 03:31:54 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-yui.html (next: http://localhost:49284/tests/dromaeo/cssquery-dojo.html) 03:34:57 INFO - PROCESS | 1686 | RSS: Main: 288047104 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | __start_tp_report 03:34:57 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 03:34:57 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 03:34:57 INFO - PROCESS | 1686 | |i|pagename|runs| 03:34:57 INFO - PROCESS | 1686 | |0;dojo.html;2888.711128887111;3509.315683441728;3517.9094480710964;3548.3967725486664;3560.305740380625;4441.689081764278;5582.330120385549;5741.282339707536;5744.195812586231;5747.770089196427;5640.238567793347;5654.886902261952;5735.684537350455;5807.622504537213;5870.295564532252;5087.694738315695;5113.284140220372;5134.897302053957;5186.948130518703;5204.42751297357;5160.483951604847;5176.844694659167;5229.712365819878;5242.659227150242;5252.868678283055;5031.974840125794;5110.693358398508;5122.487751224885;5150.407703114152;5173.560247378978;5108.974455127738;5144.202648589475;5157.458466860963;5163.225516172567;5215.478452154792;5082.872928176788;5113.360829896263;5121.308623335839;5127.128388173982;5149.510796474329;5423.213634023084;5507.642003269774;5563.944360556424;5582.637128586629;5622.775088996476;6062.272527296708;6107.977837958716;6134.263888333384;6138.94021874843;6211.782587609412;5888.823335299948;6088.726007329681;6243.094751261087;6248.656323902183;6257.124002639634;5793.536517078624;5801.680907550083;5808.59339846211;5809.448102430262;5818.79634212809;6142.253225532421;6173.938260617337;6255.781047663401;6265.906011409833;6268;6147.139400483936;6147.938520614736;6158.137860699506;6159.568830181934;6173.228346456693;6224.719887605069;6242.1261023456755;6242.656653883989;6256.186695729526;6264.718087686065;6004.489618382487;6127.417895299939;6190.164327815777;6223.719932603044;6230.59501132425;6218.036204388327;6244.0321750128805;6247.812565623039;6276.309605943343;6309.33751956038;4793.352897358882;4869.050535145612;4934.383202099738;4941.876453088702;4955.380577427822;4372.322290045048;4396.4064851244675;4397.890052748643;4406.845760398371;4426.933595996063;5018.473060328686;5730.111832665943;5736.1682556029145;5746.281714785652;5751.281089863767;5071.46749591295;6151.630902145886;6205;6217.222847144107;6238.189035425366;5712.400197979236;5742.224799652077;5758.683272420057;5759.85600359986;5766.567507436959;4630.791614377294;5270;5362.168863826113;5369.167778994262;5394.136938089887;6258.3428739982555;6321.620702757666;6329.68351582419;6355.491560675135;6368.203974503187;6137.662428566293;6152.953997820292;6222.0355844844125;6230.50155987529;6236.407541283571;6179.536534759821;6332.620042797447;6344.397282258178;6370.8088757337355;6382.457491113308;6082.543809214415;6123.508043591202;6146.78486252979;6151.96924015377;6168.1056246844855;6146.293176284785;6233.283172435228;6245.469135123565;6258.968705156445;6262.405071518198;5871.412858714094;5990.520758339235;6086.60437071589;6099.939000610115;6113.172264937315;6084.847878803065;6104.969475152596;6105.481034111973;6122.142899993915;6130.816075517563;5874.324452687995;5905.704714764159;5977.193078934462;5991.7902873399225;5996.160537524837;5955.940440595538;5997.490213331916;6041.214642096499;6052.213212282375;6107.786227482017;5201.947980520298;5927.051671732502;5967.791127310524;5982.581219314607;5995.61028533144 03:34:57 INFO - PROCESS | 1686 | |1;ext.html;458.6124724607707;464.68169304026765;507.12774028670685;522.8144008876847;577.9164067373674;36442.817785911066;36481;36808.81595592018;36983;37088.44367334489;38146.8092659537;38445.61554384456;38581.228375432474;38760.61239387605;38770.61229387705;9326.207272381856;9511.857322140173;9512.762180945463;9516.524173791282;9537.666181683642;9380.671676491324;9450.19673327768;9543.952280238589;9555.713328600154;9586.185174260196;9509.429434233933;9568.856467152998;9598.184154346889;9620.470874101922;9674.322797404184;9468.81062378752;9528.761780955463;9550.379225350365;9567.808643827155;9569.234461243153;9454.33819632626;9503.57233924475;9537.523123843781;9620.855687164698;9625.229981601455;29521.70478295211;34650.13374665628;38208.617913821065;38408;38471.230575388334;2973.583698282242;3105.580746599225;3150;3375.9831200843837;3775.9244815103543;28001.29996750077;28519.287017824514;28830.990915318074;29646.40707185844;29712.405751885057;2805.326721586825;2831.6460442444695;2858.1425572328217;2870.5407134858324;2885.480613489571;492371.5381423106;508834;509996;513380;513783;44031.779841100586;44795.55204447979;44829;44842;55227.171592426144;36809.44785828215;43613.691589252376;43817.780911095244;43894.56105438905;43920.3411948821;15139.091654500766;15508.844911550967;15509.844901551065;15599.142047187514;15650.826188035942;12180.208286461351;12501.437435315433;12567.685807854694;12594.81107783384;12665;14550.781738273934;14565.927170364292;14587.41650333996;14605.634859128395;14694.897882658843;6163.19878415812;6261.405166509175;6262.467690246289;6292.182016337847;6315.242170939517;852.5311078906576;979.6962941488019;984.921206303494;994.7165057958447;1066.6053560182781;29433.85283073571;29626.851865740533;31127.68872311248;32390.67609323924;33065.338693226004;1047.3297089862494;1063.962761303366;1111.2554588425774;1134.8524691790014;1149.9252548584316;13439.529616463376;13518.16118615102;13552.796708049387;13666.658333541742;13691.383887725076;523995;526193;531958;534811.3259433756;536934;51341;51507.96984060298;51802.48197518052;51913.702157446365;55278.17082743762;1212.5998420521207;1375.1199232491213;1394.6792237785367;1401.768708163162;1429.7640889253157;26198;27590.172294831187;27667.58498622482;28106.43787124287;28254.717452825207;47292.7635361821;47461.81345466391;47529;47957.60211989456;48148;419455;420883;422595;423897;424868;32000.6799932007;32257.032289031366;32499;32697.019089427355;32956.67043329536;41543.376849347886;42883;42915.71252862419;43026;43145.7842710797;34830;36673.44989825208;36692;36884.446733298486;37208.25583488369;29161.416771664874;35955.46066808948;37521.62478375181;40491.39262911;41123;37974.86075417742;38311.61688383192;39665.80167099146;41087.794561027;41103.58896410998;26656.866715666296;35970;37242.8137859309;37673.811630942764;37680.81159594294;28820.711792881804;29225.269368265963;29333.826646934736;29637.5554366689;29698.554521682625 03:34:57 INFO - PROCESS | 1686 | |2;jquery.html;346.5529466987586;365.4864914794713;366.56561974060736;372.42274474564437;380.6136771177254;15234.695306093872;16622.08578528179;19134.043297835105;19374.321898733546;19687.917164555944;11829.526818927254;12270.386480675976;12350.752984940318;19112.426627201206;19528.609427811436;5222;5254.553362964152;5354.518093371596;5395.7032363220005;5438.320209973754;5236.581073514109;5249.18637611169;5398;5430.266913966623;5435.537979271767;5343.759530821122;5379.193121031837;5383.192521121824;5390.649607775502;5423.566114710814;5288.101022826128;5397.190421436796;5406.59450541211;5466.644668096601;5879.206307148523;5116.386033675983;5165.870853228662;5167.044096842096;5168.586513078944;5206.687598744087;13744.86255137446;13748.93125534376;13749.450021999108;13755.243461609607;21049.7370157791;1670.5072003758798;2117.4388786971313;2190.8575942563684;2333.218371845434;2552.5788244939563;9743.269254805848;9919.90881003089;10181.643642472478;11858.525658973631;14984.325705343286;1739.8434140927377;1754.6402987387555;1788.642271545696;1806.14208251081;1822.954426139344;89246.10753892444;91376;101325;103463.48268258611;104445.47777261141;11071.446427678746;11112.05547528453;11195;11474.655760327203;11486;10388.42863642507;12491.125621206611;13722.108062975874;13976;13980.650483737987;8407.159284071544;8522.65909363631;8553.529555874487;8579.485230886166;8671.783205419915;8744.344174186961;8749.518776467228;8765.561721914006;8806.11938806127;8848.522413724168;4486.910261794811;4518.164139634178;4545.272756358967;4571.017231295287;4578.725276483422;1895;1917.2331067573082;1928.845692344609;1935.9903200483907;1939.8739081959627;321.8477849299502;881.5151666583354;919.8160367926307;977.6773664690635;983.7688143286322;10893;11771.117166212398;11910.523579056913;11947.462364193632;12062.035037197003;443.4899865155033;448.74421579699913;451.4920714196529;454.36615920790314;479.5132940065836;11109.834845707863;11135.053520450852;11526.59656912004;11668.591599294154;11732.178747487595;555525;671013;676216;677639;700760;91410.08589914149;113642.86357136322;116849;117094;117548;909.9272058235325;1040.5317607076845;1042.2443728296923;1063.5214153630743;1069.6844430892904;18412.447626570687;18419.907900460414;18424.539386515444;18448.446546603624;18782.624347513247;50822.237666434296;50839;50994;51227.231591525415;53634.73182634062;54402.63993400196;65687.34312656813;73478;74934;75227.95142345168;6454.838629034311;7500.812479687833;7512.910627958806;8078.030636323679;8142.715004975034;8620.482771033758;8959.462432254086;9046.819063618559;9153.496557689392;9179.541022948959;6899.6205208712;7948.682052717826;8293.751187464386;8323.458975166595;8541.14588541141;8043.919560804551;8302.70940517079;8385;8405.873911891204;8461.280791132822;7079.973403856515;8200.179982001991;8282.917170828214;8397.748067557983;8524.147585241426;11458.598949037078;11667.066634669036;12057.939710301393;12062.035037196827;12107.152499324962;11767.823482647596;11859.466324015613;11904.821427678418;11973.580924667944;11991.280523168638 03:34:57 INFO - PROCESS | 1686 | |3;mootools.html;1592.9044257344556;1603.7594360845876;1855.684533629282;1857.8513718902482;1955.9511012224684;7840.176781437953;8508.957455212716;8644.65421383144;8708.956455217723;8816.823663526733;7447.515911465751;8421.863048488452;8580.613872375743;8707.085755995624;8717.346199035082;2448.3144719478573;2452.1540068676277;2463.88912498938;2464.199135281032;2470.851748895072;2391.80865530758;2444.6455263986713;2528.683914510686;2534.721180670125;2539.3143851160175;2189.8576592521435;2433.756624337561;2485;2499.150288901773;2520.936976575582;2453.852768833876;2455.2511483997373;2486.9005239790386;2492.0654754467073;2495.3262619092834;2458.3362492127203;2492.302155396492;2494.239257026606;2500.237427584586;2504.4490212153296;8742.431741936818;8757.2994160467;8788.033316335199;8809.251213646783;8819.77950551235;5396.83809485716;5485.451454854522;5498.505134537871;5510.366307874606;5529.778808847641;2994.9550756738668;3456.8962931112105;3620.149264922741;3630.5824830144606;3636.1091532574424;1055.3404122423485;1081.0972837680547;1088.8747794003712;1114.4260705736551;1115.9609413670564;11663.650090497298;11701.888320609529;11732.120090993125;11746.88253117475;11793.115516336224;4818.590419814285;4866.9269960949905;4912.459629440758;4936.012797440526;4948.752562371867;10107.29248952581;10109.848352274576;10113.393196408239;10126.139278161292;10133.645322413828;5441.6190866639745;5478.808241711601;5493.945060549423;5494.038543254915;5513.531349835229;4260.233158031584;4962.727050012212;4986.6010719143105;4990.8752281193265;5007.324011258506;3209.8234597096916;3711.979205718449;3744.6068162843053;3783.3000894834545;3792.3173828711097;1023.698009087321;1146.6388087752332;1202.4528839378238;1203.4404002138872;1218.597862705305;1114.5151858941385;1117.3519358771894;1123.7752449509967;1187.631834131422;1381.3369582600208;6832.145981752281;7866.213378662088;7869.960650196713;7949.761507154794;8002.399820013406;1213.7451135261517;1224.1492162946668;1225.6935766058486;1226.7055906582534;1242.9869656230144;6123.938760612336;6167.660778657217;6168.228971378578;6206.379362063757;6229.813105606839;8952.462852228888;10495.947520262502;10501.684949451528;10563.207759418074;10743.78512429747;8196.918030819736;10368;10453.738656533495;10565.577376904992;10565.841512377321;6881.759138430131;8156.877646835303;8310.168983101641;8310.252077313191;8353.791155221168;8069.515829050276;8083.393745469231;8122.7157049502985;8126.512409255463;8209.179082091743;9425.434473931586;9474.099960503741;9652.083052110038;9656.662016829378;9810.65662701802;9526.618935242514;9648.469334186406;9872.605095796374;9947.502624868872;9967.45179015132;7410.184879663125;7447.776566703008;7493.962530187314;7536.547807131589;7543.585102819397;8077.071136819341;8121.79695507617;8142.226488483585;8156.510609363457;8167.183281671785;6778.694958726967;7248.96375518119;7349.816254593464;7474.701011959461;7508.436867235088;6405.295417504164;7231.891521627285;7262.164851042197;7288.599127048064;7313.268673132644;7514.286142816423;7545.622718864144;7596;7632.5038872473115;7669.3864490841715;6832.316768323128;6893.0694356261265;6902.792916212522;6927.3419025192525;6943.409810166192;7006.124234470692;7079.39825114871;7099.325564071405;7114.359707626339;7120.537165084253 03:34:57 INFO - PROCESS | 1686 | |4;prototype.html;332.83673560904634;339.36030582352276;341.69930461194144;344.419652884889;348.237360181203;6717.966410167955;6850.417714494268;6865.382115609594;6901.447884169267;6924;6852.588844669311;6934.058463630192;6964.8258793530185;6974.8256293592685;7036.226015138331;5047.823326183584;5051.570616497602;5064.645474816764;5069.239614057902;5069.2649565812935;5026.170681837492;5053.065182941167;5063.79744810209;5074.492550744914;5090.745462726867;4164.416981622575;4996.9500304996845;5027.0699920514635;5037.722925239111;5068.619853510983;4838.153323168449;5004.624653150991;5015.14742493777;5030.270610761438;5031.245313203012;4233.830646774125;4282.057947251599;4282.122164956208;4299.226139294926;4313.137372525476;6589.077529145923;6617.503687223478;6633.1376920999965;6668;6677.565958212701;5649.576281778883;5930.7924222652;5958.493528050121;5958.523318134538;5968.31364393096;5950.553708471882;5988.7604495820115;7359.521631093961;7374.889376659355;7400.518966267229;4660.3941487606735;4681.321208424793;4681.438227412698;4692.601128904047;4698.154332220199;7767.495112817649;7833.610748721638;7834.960825195838;7846;7847.529148251123;3856.8842934711442;4353.238183317907;4438.400815889878;4561.635069194456;4797.328374027639;4793.760311984456;4795.784189711471;4802.207635740064;4821.566059054702;4825.782839772219;4806.8077276909235;5771.595988280864;5791.160281759121;5795.362510123883;5795.971020144872;7426.9257307427315;7432.85134297311;7453.217412171753;7461.85076298471;7493.55038697669;1427.7435856446261;1653.4708893154075;1678.8740844436716;1685.9831401686072;1692.568395059252;1037.9584816607403;1062.8937106289309;1075.2258373970728;1078.1805827570945;1092.448313601642;6825.078614386995;6935.7225710971;6958.025876377311;6959.82600434983;6972.825679358057;7786.7663970080985;7792.181820908836;7792.259715336557;7795.259450352208;7810.921890781019;6923;6929.1684997800585;6935.549189302679;6946.756863509753;6948.756793512304;2997.895073672411;3706.870259540903;4090.1819636072905;4120.25835349634;4124.649404800625;7924.48490848093;8085.110637829834;8099.514029158269;8111.1888811118415;8117.4317797754775;8051.798705032304;8063.959680201561;8065.435419520694;8073.838523229502;8101.675932962733;8144.75565733029;8145.5927203639585;8146.900168477298;8147.837043258983;8203.425760196847;7548.4716069874585;7776.727814526691;7818.765437036898;7833.334166595903;7843.921560784319;6197.783077592443;7457.179710231761;7640.770776876702;7641.006669132978;7660.080790305199;6579.374959378852;8142.796430089295;8154.673813047411;8156.673733050611;8164.673413063411;4033.899152521093;4772.546608072227;4778.761061946958;4794.952050479451;4796.9760151199025;6288.622682639057;6317.96841015792;7487.176410594721;7781.416393770377;7821.960890195513;7393.482456228013;7447.962760186381;7466.9546263524235;7480.738174163878;7494.3629791466155;7456.291652293024;7462.813429664302;7464;7475.514091584029;7497.512661676974;6975.6163411012885;7271.527350722186;7283.526570772883;7285.490015698851;7302.269773022867;7412.666430010555;7469.701211951461;7485.70057197706;7494.437917156126;7501.512401693873;7324.450666199949;7326.194118647051;7336.826107822722;7340;7355.338019578264 03:34:57 INFO - PROCESS | 1686 | |5;yui.html;625.9499240060793;659.162863163782;691.941184999275;704.0565642039666;732.5275197497614;14138.71722565548;14147.858521414808;14477.5656730298;14669.266536673176;14710.264486775659;15229.69540609187;15810.762838557403;15832.366705331773;15852.682946341067;15855.207239638;719.352582675591;881.8633111867671;885.8006948436615;898.4339865884483;900.2842740021698;889.3729920406098;890.5502721125822;894.0567701075363;894.3247847874878;894.6689724801832;921.5208091792264;939.4879790514152;941.7551436626492;941.9152276295166;944.1455482788087;893.7318804358731;916.6974898283551;917.775145089454;921.3320342751485;935.8783358163463;586.6568057686259;681.6762038031895;700.2367419512756;702.3854127638316;706.0891450029455;15067;15129.394824207018;15301.387944482207;15441.0735355879;15482.458113965957;12490.437930293068;12503.249805011728;12752.681182970407;12987.480500779957;13270.734585308337;10193.490325483695;10385.740356491073;10459.633912813091;10753.247272690915;11066.336019838835;3466.9826650866585;3499.212677147647;3522.594901586325;3530.0468873404293;3543.4153364694794;74526;76638.61680691561;76751.616241919;79078;88127.55936220278;9410.95294523523;9413.294002949806;9419.340646154704;9423;9705;20004.799952000583;20127.798722012594;20159.294424695065;20213.49466263355;20234.089465974066;7310.561366318038;7412.703491860265;7548.471606987568;7690.500117492345;7831.530108193413;3931.5351661190966;3993.9001524961527;4001.3397789365013;4050.9392359114636;4053.574374690674;2969.4061187762536;3433.8626454941523;3467.739919506047;3477.0438129514587;3504.15900183954;647.6211416321505;657.8914479110989;660.6762686283782;681.7102731339161;682.8804959132232;540.3461811208482;545.5908068948289;574.2821473158551;596.4959609130278;599.4005994005994;7680.577568233689;8087.908132402051;8466.195711407407;8690.739277821676;9030.774230644287;495.97520123993655;519.8362515807509;549.3106151779491;595.9970200148972;644.1915396177767;4064.248114098901;4355.651547876162;4385.649148068147;4423.402840616475;4455.420795296591;76878.84681729779;90812.63781043289;92172.69568260713;92282;93493;62212.37787622066;82797.17202827895;82896.58551707203;83317;83379.58310208531;74946.25053749501;75254.4949101015;81642.59178704188;82363.58818205871;82908.17091829125;8094.919050809652;8925.955370223108;8980.928052379704;9100.681476148304;9122.361434699507;50778;51280.974380511434;51989.7400512995;52668.473315266354;53542;66626.66686666536;69102.65448672725;69181.65409172921;69193.65403173154;73547;9703.66037188695;10758.623448179276;10954.945225273823;11233.66299011031;11370.260933039326;11857.466414011218;11874.525018999144;11956.701082473008;12113;12718.427670755023;11151.219414640897;11329.490172942073;11663.24188927751;11694.2983420995;12037.458314375699;11185.049270812073;11351;11648.475818588353;11773.88226117728;12263.448144833683;10897.400642964396;10951.397673128055;11032.44837758125;11049.834252486058;12310.938445307716;9344.813103738023;9513.429194248367;9515.809683806423;9908.207343412654;10153.64462243818;8145.470544414594;9612.51937403141;9978.550965206729;10010.599576016877;10030.49847507607 03:34:57 INFO - PROCESS | 1686 | __end_tp_report 03:34:57 INFO - PROCESS | 1686 | __start_cc_report 03:34:57 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,346 03:34:57 INFO - PROCESS | 1686 | __end_cc_report 03:34:57 INFO - PROCESS | 1686 | __startTimestamp1456140897377__endTimestamp 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | ------- Summary: start ------- 03:34:57 INFO - PROCESS | 1686 | Number of tests: 6 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | [#0] dojo.html Cycles:165 Average:5696.45 Median:5955.94 stddev:654.87 (11.0%) stddev-sans-first:618.73 03:34:57 INFO - PROCESS | 1686 | Values: 2888.7 3509.3 3517.9 3548.4 3560.3 4441.7 5582.3 5741.3 5744.2 5747.8 5640.2 5654.9 5735.7 5807.6 5870.3 5087.7 5113.3 5134.9 5186.9 5204.4 5160.5 5176.8 5229.7 5242.7 5252.9 5032.0 5110.7 5122.5 5150.4 5173.6 5109.0 5144.2 5157.5 5163.2 5215.5 5082.9 5113.4 5121.3 5127.1 5149.5 5423.2 5507.6 5563.9 5582.6 5622.8 6062.3 6108.0 6134.3 6138.9 6211.8 5888.8 6088.7 6243.1 6248.7 6257.1 5793.5 5801.7 5808.6 5809.4 5818.8 6142.3 6173.9 6255.8 6265.9 6268.0 6147.1 6147.9 6158.1 6159.6 6173.2 6224.7 6242.1 6242.7 6256.2 6264.7 6004.5 6127.4 6190.2 6223.7 6230.6 6218.0 6244.0 6247.8 6276.3 6309.3 4793.4 4869.1 4934.4 4941.9 4955.4 4372.3 4396.4 4397.9 4406.8 4426.9 5018.5 5730.1 5736.2 5746.3 5751.3 5071.5 6151.6 6205.0 6217.2 6238.2 5712.4 5742.2 5758.7 5759.9 5766.6 4630.8 5270.0 5362.2 5369.2 5394.1 6258.3 6321.6 6329.7 6355.5 6368.2 6137.7 6153.0 6222.0 6230.5 6236.4 6179.5 6332.6 6344.4 6370.8 6382.5 6082.5 6123.5 6146.8 6152.0 6168.1 6146.3 6233.3 6245.5 6259.0 6262.4 5871.4 5990.5 6086.6 6099.9 6113.2 6084.8 6105.0 6105.5 6122.1 6130.8 5874.3 5905.7 5977.2 5991.8 5996.2 5955.9 5997.5 6041.2 6052.2 6107.8 5201.9 5927.1 5967.8 5982.6 5995.6 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | [#1] ext.html Cycles:180 Average:61706.80 Median:38359.81 stddev:130228.29 (339.5%) stddev-sans-first:130512.42 03:34:57 INFO - PROCESS | 1686 | Values: 458.6 464.7 507.1 522.8 577.9 36442.8 36481.0 36808.8 36983.0 37088.4 38146.8 38445.6 38581.2 38760.6 38770.6 9326.2 9511.9 9512.8 9516.5 9537.7 9380.7 9450.2 9544.0 9555.7 9586.2 9509.4 9568.9 9598.2 9620.5 9674.3 9468.8 9528.8 9550.4 9567.8 9569.2 9454.3 9503.6 9537.5 9620.9 9625.2 29521.7 34650.1 38208.6 38408.0 38471.2 2973.6 3105.6 3150.0 3376.0 3775.9 28001.3 28519.3 28831.0 29646.4 29712.4 2805.3 2831.6 2858.1 2870.5 2885.5 492371.5 508834.0 509996.0 513380.0 513783.0 44031.8 44795.6 44829.0 44842.0 55227.2 36809.4 43613.7 43817.8 43894.6 43920.3 15139.1 15508.8 15509.8 15599.1 15650.8 12180.2 12501.4 12567.7 12594.8 12665.0 14550.8 14565.9 14587.4 14605.6 14694.9 6163.2 6261.4 6262.5 6292.2 6315.2 852.5 979.7 984.9 994.7 1066.6 29433.9 29626.9 31127.7 32390.7 33065.3 1047.3 1064.0 1111.3 1134.9 1149.9 13439.5 13518.2 13552.8 13666.7 13691.4 523995.0 526193.0 531958.0 534811.3 536934.0 51341.0 51508.0 51802.5 51913.7 55278.2 1212.6 1375.1 1394.7 1401.8 1429.8 26198.0 27590.2 27667.6 28106.4 28254.7 47292.8 47461.8 47529.0 47957.6 48148.0 419455.0 420883.0 422595.0 423897.0 424868.0 32000.7 32257.0 32499.0 32697.0 32956.7 41543.4 42883.0 42915.7 43026.0 43145.8 34830.0 36673.4 36692.0 36884.4 37208.3 29161.4 35955.5 37521.6 40491.4 41123.0 37974.9 38311.6 39665.8 41087.8 41103.6 26656.9 35970.0 37242.8 37673.8 37680.8 28820.7 29225.3 29333.8 29637.6 29698.6 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | [#2] jquery.html Cycles:180 Average:34250.40 Median:2499.82 stddev:108752.67 (4350.4%) stddev-sans-first:109027.95 03:34:57 INFO - PROCESS | 1686 | Values: 346.6 365.5 366.6 372.4 380.6 15234.7 16622.1 19134.0 19374.3 19687.9 11829.5 12270.4 12350.8 19112.4 19528.6 5222.0 5254.6 5354.5 5395.7 5438.3 5236.6 5249.2 5398.0 5430.3 5435.5 5343.8 5379.2 5383.2 5390.6 5423.6 5288.1 5397.2 5406.6 5466.6 5879.2 5116.4 5165.9 5167.0 5168.6 5206.7 13744.9 13748.9 13749.5 13755.2 21049.7 1670.5 2117.4 2190.9 2333.2 2552.6 9743.3 9919.9 10181.6 11858.5 14984.3 1739.8 1754.6 1788.6 1806.1 1823.0 89246.1 91376.0 101325.0 103463.5 104445.5 11071.4 11112.1 11195.0 11474.7 11486.0 10388.4 12491.1 13722.1 13976.0 13980.7 8407.2 8522.7 8553.5 8579.5 8671.8 8744.3 8749.5 8765.6 8806.1 8848.5 4486.9 4518.2 4545.3 4571.0 4578.7 1895.0 1917.2 1928.8 1936.0 1939.9 321.8 881.5 919.8 977.7 983.8 10893.0 11771.1 11910.5 11947.5 12062.0 443.5 448.7 451.5 454.4 479.5 11109.8 11135.1 11526.6 11668.6 11732.2 555525.0 671013.0 676216.0 677639.0 700760.0 91410.1 113642.9 116849.0 117094.0 117548.0 909.9 1040.5 1042.2 1063.5 1069.7 18412.4 18419.9 18424.5 18448.4 18782.6 50822.2 50839.0 50994.0 51227.2 53634.7 54402.6 65687.3 73478.0 74934.0 75228.0 6454.8 7500.8 7512.9 8078.0 8142.7 8620.5 8959.5 9046.8 9153.5 9179.5 6899.6 7948.7 8293.8 8323.5 8541.1 8043.9 8302.7 8385.0 8405.9 8461.3 7080.0 8200.2 8282.9 8397.7 8524.1 11458.6 11667.1 12057.9 12062.0 12107.2 11767.8 11859.5 11904.8 11973.6 11991.3 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | [#3] mootools.html Cycles:180 Average:5982.18 Median:5482.13 stddev:3118.14 (56.9%) stddev-sans-first:3109.43 03:34:57 INFO - PROCESS | 1686 | Values: 1592.9 1603.8 1855.7 1857.9 1956.0 7840.2 8509.0 8644.7 8709.0 8816.8 7447.5 8421.9 8580.6 8707.1 8717.3 2448.3 2452.2 2463.9 2464.2 2470.9 2391.8 2444.6 2528.7 2534.7 2539.3 2189.9 2433.8 2485.0 2499.2 2520.9 2453.9 2455.3 2486.9 2492.1 2495.3 2458.3 2492.3 2494.2 2500.2 2504.4 8742.4 8757.3 8788.0 8809.3 8819.8 5396.8 5485.5 5498.5 5510.4 5529.8 2995.0 3456.9 3620.1 3630.6 3636.1 1055.3 1081.1 1088.9 1114.4 1116.0 11663.7 11701.9 11732.1 11746.9 11793.1 4818.6 4866.9 4912.5 4936.0 4948.8 10107.3 10109.8 10113.4 10126.1 10133.6 5441.6 5478.8 5493.9 5494.0 5513.5 4260.2 4962.7 4986.6 4990.9 5007.3 3209.8 3712.0 3744.6 3783.3 3792.3 1023.7 1146.6 1202.5 1203.4 1218.6 1114.5 1117.4 1123.8 1187.6 1381.3 6832.1 7866.2 7870.0 7949.8 8002.4 1213.7 1224.1 1225.7 1226.7 1243.0 6123.9 6167.7 6168.2 6206.4 6229.8 8952.5 10495.9 10501.7 10563.2 10743.8 8196.9 10368.0 10453.7 10565.6 10565.8 6881.8 8156.9 8310.2 8310.3 8353.8 8069.5 8083.4 8122.7 8126.5 8209.2 9425.4 9474.1 9652.1 9656.7 9810.7 9526.6 9648.5 9872.6 9947.5 9967.5 7410.2 7447.8 7494.0 7536.5 7543.6 8077.1 8121.8 8142.2 8156.5 8167.2 6778.7 7249.0 7349.8 7474.7 7508.4 6405.3 7231.9 7262.2 7288.6 7313.3 7514.3 7545.6 7596.0 7632.5 7669.4 6832.3 6893.1 6902.8 6927.3 6943.4 7006.1 7079.4 7099.3 7114.4 7120.5 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | [#4] prototype.html Cycles:180 Average:6017.36 Median:6883.41 stddev:1999.05 (29.0%) stddev-sans-first:1958.59 03:34:57 INFO - PROCESS | 1686 | Values: 332.8 339.4 341.7 344.4 348.2 6718.0 6850.4 6865.4 6901.4 6924.0 6852.6 6934.1 6964.8 6974.8 7036.2 5047.8 5051.6 5064.6 5069.2 5069.3 5026.2 5053.1 5063.8 5074.5 5090.7 4164.4 4997.0 5027.1 5037.7 5068.6 4838.2 5004.6 5015.1 5030.3 5031.2 4233.8 4282.1 4282.1 4299.2 4313.1 6589.1 6617.5 6633.1 6668.0 6677.6 5649.6 5930.8 5958.5 5958.5 5968.3 5950.6 5988.8 7359.5 7374.9 7400.5 4660.4 4681.3 4681.4 4692.6 4698.2 7767.5 7833.6 7835.0 7846.0 7847.5 3856.9 4353.2 4438.4 4561.6 4797.3 4793.8 4795.8 4802.2 4821.6 4825.8 4806.8 5771.6 5791.2 5795.4 5796.0 7426.9 7432.9 7453.2 7461.9 7493.6 1427.7 1653.5 1678.9 1686.0 1692.6 1038.0 1062.9 1075.2 1078.2 1092.4 6825.1 6935.7 6958.0 6959.8 6972.8 7786.8 7792.2 7792.3 7795.3 7810.9 6923.0 6929.2 6935.5 6946.8 6948.8 2997.9 3706.9 4090.2 4120.3 4124.6 7924.5 8085.1 8099.5 8111.2 8117.4 8051.8 8064.0 8065.4 8073.8 8101.7 8144.8 8145.6 8146.9 8147.8 8203.4 7548.5 7776.7 7818.8 7833.3 7843.9 6197.8 7457.2 7640.8 7641.0 7660.1 6579.4 8142.8 8154.7 8156.7 8164.7 4033.9 4772.5 4778.8 4795.0 4797.0 6288.6 6318.0 7487.2 7781.4 7822.0 7393.5 7448.0 7467.0 7480.7 7494.4 7456.3 7462.8 7464.0 7475.5 7497.5 6975.6 7271.5 7283.5 7285.5 7302.3 7412.7 7469.7 7485.7 7494.4 7501.5 7324.5 7326.2 7336.8 7340.0 7355.3 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - PROCESS | 1686 | [#5] yui.html Cycles:180 Average:18608.41 Median:597.95 stddev:26175.80 (4377.6%) stddev-sans-first:26214.41 03:34:57 INFO - PROCESS | 1686 | Values: 625.9 659.2 691.9 704.1 732.5 14138.7 14147.9 14477.6 14669.3 14710.3 15229.7 15810.8 15832.4 15852.7 15855.2 719.4 881.9 885.8 898.4 900.3 889.4 890.6 894.1 894.3 894.7 921.5 939.5 941.8 941.9 944.1 893.7 916.7 917.8 921.3 935.9 586.7 681.7 700.2 702.4 706.1 15067.0 15129.4 15301.4 15441.1 15482.5 12490.4 12503.2 12752.7 12987.5 13270.7 10193.5 10385.7 10459.6 10753.2 11066.3 3467.0 3499.2 3522.6 3530.0 3543.4 74526.0 76638.6 76751.6 79078.0 88127.6 9411.0 9413.3 9419.3 9423.0 9705.0 20004.8 20127.8 20159.3 20213.5 20234.1 7310.6 7412.7 7548.5 7690.5 7831.5 3931.5 3993.9 4001.3 4050.9 4053.6 2969.4 3433.9 3467.7 3477.0 3504.2 647.6 657.9 660.7 681.7 682.9 540.3 545.6 574.3 596.5 599.4 7680.6 8087.9 8466.2 8690.7 9030.8 496.0 519.8 549.3 596.0 644.2 4064.2 4355.7 4385.6 4423.4 4455.4 76878.8 90812.6 92172.7 92282.0 93493.0 62212.4 82797.2 82896.6 83317.0 83379.6 74946.3 75254.5 81642.6 82363.6 82908.2 8094.9 8926.0 8980.9 9100.7 9122.4 50778.0 51281.0 51989.7 52668.5 53542.0 66626.7 69102.7 69181.7 69193.7 73547.0 9703.7 10758.6 10954.9 11233.7 11370.3 11857.5 11874.5 11956.7 12113.0 12718.4 11151.2 11329.5 11663.2 11694.3 12037.5 11185.0 11351.0 11648.5 11773.9 12263.4 10897.4 10951.4 11032.4 11049.8 12310.9 9344.8 9513.4 9515.8 9908.2 10153.6 8145.5 9612.5 9978.6 10010.6 10030.5 03:34:57 INFO - PROCESS | 1686 | -------- Summary: end -------- 03:34:57 INFO - PROCESS | 1686 | 03:34:57 INFO - TEST-INFO | 1686: exit 0 03:34:57 INFO - TEST-OK | dromaeo_css | took 1111573ms 03:34:57 INFO - TEST-START | kraken 03:34:57 INFO - operating with platform_type : mac_ 03:34:57 INFO - Initialising browser for kraken test... 03:34:57 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9Z57Jn/profile http://localhost:49284/getInfo.html) 03:35:00 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 03:35:00 INFO - PROCESS | 1694 | colorDepth:24 03:35:00 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 03:35:00 INFO - PROCESS | 1694 | __metrics 03:35:00 ERROR - PROCESS | 1694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 03:35:01 INFO - TEST-INFO | 1694: exit 0 03:35:01 INFO - Browser initialized. 03:35:01 INFO - Running cycle 1/1 for kraken test... 03:35:01 INFO - TEST-INFO | started process 1719 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmp9Z57Jn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:13 INFO - PROCESS | 1719 | RSS: Main: 256610304 03:35:13 INFO - PROCESS | 1719 | 03:35:15 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection) 03:35:16 INFO - PROCESS | 1719 | RSS: Main: 267886592 03:35:16 INFO - PROCESS | 1719 | 03:35:19 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-dft) 03:35:19 INFO - PROCESS | 1719 | RSS: Main: 277106688 03:35:19 INFO - PROCESS | 1719 | 03:35:23 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-fft) 03:35:23 INFO - PROCESS | 1719 | RSS: Main: 279924736 03:35:23 INFO - PROCESS | 1719 | 03:35:25 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator) 03:35:26 INFO - PROCESS | 1719 | RSS: Main: 281739264 03:35:26 INFO - PROCESS | 1719 | 03:35:28 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:35:29 INFO - PROCESS | 1719 | RSS: Main: 283254784 03:35:29 INFO - PROCESS | 1719 | 03:35:32 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom) 03:35:32 INFO - PROCESS | 1719 | RSS: Main: 282763264 03:35:32 INFO - PROCESS | 1719 | 03:35:35 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:36 INFO - PROCESS | 1719 | RSS: Main: 282525696 03:35:36 INFO - PROCESS | 1719 | 03:35:39 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial) 03:35:39 INFO - PROCESS | 1719 | RSS: Main: 282779648 03:35:39 INFO - PROCESS | 1719 | 03:35:41 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:42 INFO - PROCESS | 1719 | RSS: Main: 282034176 03:35:42 INFO - PROCESS | 1719 | 03:35:43 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:44 INFO - PROCESS | 1719 | RSS: Main: 283521024 03:35:44 INFO - PROCESS | 1719 | 03:35:46 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:47 INFO - PROCESS | 1719 | RSS: Main: 283443200 03:35:47 INFO - PROCESS | 1719 | 03:35:49 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:50 INFO - PROCESS | 1719 | RSS: Main: 282935296 03:35:50 INFO - PROCESS | 1719 | 03:35:53 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:35:53 INFO - PROCESS | 1719 | RSS: Main: 283713536 03:35:53 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49284/tests/kraken/driver.html?testName=ai-astar) 03:35:55 INFO - PROCESS | 1719 | RSS: Main: 284508160 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | __start_tp_report 03:35:55 INFO - PROCESS | 1719 | _x_x_mozilla_page_load 03:35:55 INFO - PROCESS | 1719 | _x_x_mozilla_page_load_details 03:35:55 INFO - PROCESS | 1719 | |i|pagename|runs| 03:35:55 INFO - PROCESS | 1719 | |0;ai-astar;115;109;114;113;115;126;115;116;115;114 03:35:55 INFO - PROCESS | 1719 | |1;audio-beat-detection;163;129;145;160;127;145;142;125;162;123 03:35:55 INFO - PROCESS | 1719 | |2;audio-dft;197;199;199;207;195;239;267;207;202;203 03:35:55 INFO - PROCESS | 1719 | |3;audio-fft;50;96;111;87;130;59;78;86;86;75 03:35:55 INFO - PROCESS | 1719 | |4;audio-oscillator;82;85;115;94;122;68;153;120;121;145 03:35:55 INFO - PROCESS | 1719 | |5;imaging-gaussian-blur;95;123;86;108;111;91;87;91;102;91 03:35:55 INFO - PROCESS | 1719 | |6;imaging-darkroom;116;125;95;95;95;120;131;105;150;152 03:35:55 INFO - PROCESS | 1719 | |7;imaging-desaturate;92;94;91;91;96;90;95;154;148;91 03:35:55 INFO - PROCESS | 1719 | |8;json-parse-financial;58;57;55;58;56;55;59;64;56;54 03:35:55 INFO - PROCESS | 1719 | |9;json-stringify-tinderbox;66;62;66;59;110;105;99;68;68;77 03:35:55 INFO - PROCESS | 1719 | |10;stanford-crypto-aes;99;78;74;75;110;111;110;111;86;85 03:35:55 INFO - PROCESS | 1719 | |11;stanford-crypto-ccm;135;129;125;140;127;131;124;123;126;121 03:35:55 INFO - PROCESS | 1719 | |12;stanford-crypto-pbkdf2;151;140;147;137;146;146;142;140;146;172 03:35:55 INFO - PROCESS | 1719 | |13;stanford-crypto-sha256-iterative;69;67;70;67;68;67;67;71;75;57 03:35:55 INFO - PROCESS | 1719 | __end_tp_report 03:35:55 INFO - PROCESS | 1719 | __start_cc_report 03:35:55 INFO - PROCESS | 1719 | _x_x_mozilla_cycle_collect,892 03:35:55 INFO - PROCESS | 1719 | __end_cc_report 03:35:55 INFO - PROCESS | 1719 | __startTimestamp1456140955666__endTimestamp 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | ------- Summary: start ------- 03:35:55 INFO - PROCESS | 1719 | Number of tests: 14 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:4.26 (3.7%) stddev-sans-first:4.52 03:35:55 INFO - PROCESS | 1719 | Values: 115.0 109.0 114.0 113.0 115.0 126.0 115.0 116.0 115.0 114.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:145.00 stddev:15.73 (10.8%) stddev-sans-first:14.75 03:35:55 INFO - PROCESS | 1719 | Values: 163.0 129.0 145.0 160.0 127.0 145.0 142.0 125.0 162.0 123.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#2] audio-dft Cycles:10 Average:211.50 Median:205.00 stddev:23.18 (11.3%) stddev-sans-first:23.98 03:35:55 INFO - PROCESS | 1719 | Values: 197.0 199.0 199.0 207.0 195.0 239.0 267.0 207.0 202.0 203.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#3] audio-fft Cycles:10 Average:85.80 Median:82.00 stddev:23.27 (28.4%) stddev-sans-first:20.76 03:35:55 INFO - PROCESS | 1719 | Values: 50.0 96.0 111.0 87.0 130.0 59.0 78.0 86.0 86.0 75.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:110.50 stddev:27.67 (25.0%) stddev-sans-first:27.36 03:35:55 INFO - PROCESS | 1719 | Values: 82.0 85.0 115.0 94.0 122.0 68.0 153.0 120.0 121.0 145.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:89.00 stddev:12.15 (13.7%) stddev-sans-first:12.82 03:35:55 INFO - PROCESS | 1719 | Values: 95.0 123.0 86.0 108.0 111.0 91.0 87.0 91.0 102.0 91.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#6] imaging-darkroom Cycles:10 Average:118.40 Median:151.00 stddev:21.50 (14.2%) stddev-sans-first:22.79 03:35:55 INFO - PROCESS | 1719 | Values: 116.0 125.0 95.0 95.0 95.0 120.0 131.0 105.0 150.0 152.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#7] imaging-desaturate Cycles:10 Average:104.20 Median:91.50 stddev:24.78 (27.1%) stddev-sans-first:25.89 03:35:55 INFO - PROCESS | 1719 | Values: 92.0 94.0 91.0 91.0 96.0 90.0 95.0 154.0 148.0 91.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:2.86 (5.0%) stddev-sans-first:3.02 03:35:55 INFO - PROCESS | 1719 | Values: 58.0 57.0 55.0 58.0 56.0 55.0 59.0 64.0 56.0 54.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#9] json-stringify-tinderbox Cycles:10 Average:78.00 Median:67.00 stddev:19.15 (28.6%) stddev-sans-first:19.81 03:35:55 INFO - PROCESS | 1719 | Values: 66.0 62.0 66.0 59.0 110.0 105.0 99.0 68.0 68.0 77.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:76.50 stddev:15.91 (20.8%) stddev-sans-first:16.76 03:35:55 INFO - PROCESS | 1719 | Values: 99.0 78.0 74.0 75.0 110.0 111.0 110.0 111.0 86.0 85.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:128.00 stddev:5.84 (4.6%) stddev-sans-first:5.63 03:35:55 INFO - PROCESS | 1719 | Values: 135.0 129.0 125.0 140.0 127.0 131.0 124.0 123.0 126.0 121.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:146.00 stddev:9.81 (6.7%) stddev-sans-first:10.28 03:35:55 INFO - PROCESS | 1719 | Values: 151.0 140.0 147.0 137.0 146.0 146.0 142.0 140.0 146.0 172.0 03:35:55 INFO - PROCESS | 1719 | 03:35:55 INFO - PROCESS | 1719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:4.57 (6.7%) stddev-sans-first:4.82 03:35:55 INFO - PROCESS | 1719 | Values: 69.0 67.0 70.0 67.0 68.0 67.0 67.0 71.0 75.0 57.0 03:35:55 INFO - PROCESS | 1719 | -------- Summary: end -------- 03:35:55 INFO - PROCESS | 1719 | 03:35:56 INFO - TEST-INFO | 1719: exit 0 03:35:56 INFO - TEST-OK | kraken | took 58522ms 03:35:56 INFO - SUITE-END | took 1170s 03:35:56 INFO - Completed test suite (00:19:30) 03:35:56 INFO - Working with test: dromaeo_css 03:35:56 INFO - Generating results file: dromaeo_css 03:35:56 INFO - Working with test: kraken 03:35:56 INFO - Generating results file: kraken 03:35:56 INFO - javascript benchmark 03:35:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:35:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 03:35:56 INFO - process_Request line: dromaeo_css 7405.30 graph.html#tests=[[72,64,61]] 03:35:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:35:57 INFO - process_Request line: kraken 1557.90 graph.html#tests=[[232,64,61]] 03:35:57 INFO - RETURN: dromaeo_css: 7405.30 03:35:57 INFO - RETURN: kraken: 1557.90 03:35:57 INFO - javascript benchmark 03:35:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2888.711128887111, 3509.315683441728, 3517.9094480710964, 3548.3967725486664, 3560.305740380625, 4441.689081764278, 5582.330120385549, 5741.282339707536, 5744.195812586231, 5747.770089196427, 5640.238567793347, 5654.886902261952, 5735.684537350455, 5807.622504537213, 5870.295564532252, 5087.694738315695, 5113.284140220372, 5134.897302053957, 5186.948130518703, 5204.42751297357, 5160.483951604847, 5176.844694659167, 5229.712365819878, 5242.659227150242, 5252.868678283055, 5031.974840125794, 5110.693358398508, 5122.487751224885, 5150.407703114152, 5173.560247378978, 5108.974455127738, 5144.202648589475, 5157.458466860963, 5163.225516172567, 5215.478452154792, 5082.872928176788, 5113.360829896263, 5121.308623335839, 5127.128388173982, 5149.510796474329, 5423.213634023084, 5507.642003269774, 5563.944360556424, 5582.637128586629, 5622.775088996476, 6062.272527296708, 6107.977837958716, 6134.263888333384, 6138.94021874843, 6211.782587609412, 5888.823335299948, 6088.726007329681, 6243.094751261087, 6248.656323902183, 6257.124002639634, 5793.536517078624, 5801.680907550083, 5808.59339846211, 5809.448102430262, 5818.79634212809, 6142.253225532421, 6173.938260617337, 6255.781047663401, 6265.906011409833, 6268.0, 6147.139400483936, 6147.938520614736, 6158.137860699506, 6159.568830181934, 6173.228346456693, 6224.719887605069, 6242.1261023456755, 6242.656653883989, 6256.186695729526, 6264.718087686065, 6004.489618382487, 6127.417895299939, 6190.164327815777, 6223.719932603044, 6230.59501132425, 6218.036204388327, 6244.0321750128805, 6247.812565623039, 6276.309605943343, 6309.33751956038, 4793.352897358882, 4869.050535145612, 4934.383202099738, 4941.876453088702, 4955.380577427822, 4372.322290045048, 4396.4064851244675, 4397.890052748643, 4406.845760398371, 4426.933595996063, 5018.473060328686, 5730.111832665943, 5736.1682556029145, 5746.281714785652, 5751.281089863767, 5071.46749591295, 6151.630902145886, 6205.0, 6217.222847144107, 6238.189035425366, 5712.400197979236, 5742.224799652077, 5758.683272420057, 5759.85600359986, 5766.567507436959, 4630.791614377294, 5270.0, 5362.168863826113, 5369.167778994262, 5394.136938089887, 6258.3428739982555, 6321.620702757666, 6329.68351582419, 6355.491560675135, 6368.203974503187, 6137.662428566293, 6152.953997820292, 6222.0355844844125, 6230.50155987529, 6236.407541283571, 6179.536534759821, 6332.620042797447, 6344.397282258178, 6370.8088757337355, 6382.457491113308, 6082.543809214415, 6123.508043591202, 6146.78486252979, 6151.96924015377, 6168.1056246844855, 6146.293176284785, 6233.283172435228, 6245.469135123565, 6258.968705156445, 6262.405071518198, 5871.412858714094, 5990.520758339235, 6086.60437071589, 6099.939000610115, 6113.172264937315, 6084.847878803065, 6104.969475152596, 6105.481034111973, 6122.142899993915, 6130.816075517563, 5874.324452687995, 5905.704714764159, 5977.193078934462, 5991.7902873399225, 5996.160537524837, 5955.940440595538, 5997.490213331916, 6041.214642096499, 6052.213212282375, 6107.786227482017, 5201.947980520298, 5927.051671732502, 5967.791127310524, 5982.581219314607, 5995.61028533144], "unit": "score", "name": "dojo.html", "value": 5655.334088644922}, {"lowerIsBetter": false, "replicates": [458.6124724607707, 464.68169304026765, 507.12774028670685, 522.8144008876847, 577.9164067373674, 36442.817785911066, 36481.0, 36808.81595592018, 36983.0, 37088.44367334489, 38146.8092659537, 38445.61554384456, 38581.228375432474, 38760.61239387605, 38770.61229387705, 9326.207272381856, 9511.857322140173, 9512.762180945463, 9516.524173791282, 9537.666181683642, 9380.671676491324, 9450.19673327768, 9543.952280238589, 9555.713328600154, 9586.185174260196, 9509.429434233933, 9568.856467152998, 9598.184154346889, 9620.470874101922, 9674.322797404184, 9468.81062378752, 9528.761780955463, 9550.379225350365, 9567.808643827155, 9569.234461243153, 9454.33819632626, 9503.57233924475, 9537.523123843781, 9620.855687164698, 9625.229981601455, 29521.70478295211, 34650.13374665628, 38208.617913821065, 38408.0, 38471.230575388334, 2973.583698282242, 3105.580746599225, 3150.0, 3375.9831200843837, 3775.9244815103543, 28001.29996750077, 28519.287017824514, 28830.990915318074, 29646.40707185844, 29712.405751885057, 2805.326721586825, 2831.6460442444695, 2858.1425572328217, 2870.5407134858324, 2885.480613489571, 492371.5381423106, 508834.0, 509996.0, 513380.0, 513783.0, 44031.779841100586, 44795.55204447979, 44829.0, 44842.0, 55227.171592426144, 36809.44785828215, 43613.691589252376, 43817.780911095244, 43894.56105438905, 43920.3411948821, 15139.091654500766, 15508.844911550967, 15509.844901551065, 15599.142047187514, 15650.826188035942, 12180.208286461351, 12501.437435315433, 12567.685807854694, 12594.81107783384, 12665.0, 14550.781738273934, 14565.927170364292, 14587.41650333996, 14605.634859128395, 14694.897882658843, 6163.19878415812, 6261.405166509175, 6262.467690246289, 6292.182016337847, 6315.242170939517, 852.5311078906576, 979.6962941488019, 984.921206303494, 994.7165057958447, 1066.6053560182781, 29433.85283073571, 29626.851865740533, 31127.68872311248, 32390.67609323924, 33065.338693226004, 1047.3297089862494, 1063.962761303366, 1111.2554588425774, 1134.8524691790014, 1149.9252548584316, 13439.529616463376, 13518.16118615102, 13552.796708049387, 13666.658333541742, 13691.383887725076, 523995.0, 526193.0, 531958.0, 534811.3259433756, 536934.0, 51341.0, 51507.96984060298, 51802.48197518052, 51913.702157446365, 55278.17082743762, 1212.5998420521207, 1375.1199232491213, 1394.6792237785367, 1401.768708163162, 1429.7640889253157, 26198.0, 27590.172294831187, 27667.58498622482, 28106.43787124287, 28254.717452825207, 47292.7635361821, 47461.81345466391, 47529.0, 47957.60211989456, 48148.0, 419455.0, 420883.0, 422595.0, 423897.0, 424868.0, 32000.6799932007, 32257.032289031366, 32499.0, 32697.019089427355, 32956.67043329536, 41543.376849347886, 42883.0, 42915.71252862419, 43026.0, 43145.7842710797, 34830.0, 36673.44989825208, 36692.0, 36884.446733298486, 37208.25583488369, 29161.416771664874, 35955.46066808948, 37521.62478375181, 40491.39262911, 41123.0, 37974.86075417742, 38311.61688383192, 39665.80167099146, 41087.794561027, 41103.58896410998, 26656.866715666296, 35970.0, 37242.8137859309, 37673.811630942764, 37680.81159594294, 28820.711792881804, 29225.269368265963, 29333.826646934736, 29637.5554366689, 29698.554521682625], "unit": "score", "name": "ext.html", "value": 18777.469790051633}, {"lowerIsBetter": false, "replicates": [346.5529466987586, 365.4864914794713, 366.56561974060736, 372.42274474564437, 380.6136771177254, 15234.695306093872, 16622.08578528179, 19134.043297835105, 19374.321898733546, 19687.917164555944, 11829.526818927254, 12270.386480675976, 12350.752984940318, 19112.426627201206, 19528.609427811436, 5222.0, 5254.553362964152, 5354.518093371596, 5395.7032363220005, 5438.320209973754, 5236.581073514109, 5249.18637611169, 5398.0, 5430.266913966623, 5435.537979271767, 5343.759530821122, 5379.193121031837, 5383.192521121824, 5390.649607775502, 5423.566114710814, 5288.101022826128, 5397.190421436796, 5406.59450541211, 5466.644668096601, 5879.206307148523, 5116.386033675983, 5165.870853228662, 5167.044096842096, 5168.586513078944, 5206.687598744087, 13744.86255137446, 13748.93125534376, 13749.450021999108, 13755.243461609607, 21049.7370157791, 1670.5072003758798, 2117.4388786971313, 2190.8575942563684, 2333.218371845434, 2552.5788244939563, 9743.269254805848, 9919.90881003089, 10181.643642472478, 11858.525658973631, 14984.325705343286, 1739.8434140927377, 1754.6402987387555, 1788.642271545696, 1806.14208251081, 1822.954426139344, 89246.10753892444, 91376.0, 101325.0, 103463.48268258611, 104445.47777261141, 11071.446427678746, 11112.05547528453, 11195.0, 11474.655760327203, 11486.0, 10388.42863642507, 12491.125621206611, 13722.108062975874, 13976.0, 13980.650483737987, 8407.159284071544, 8522.65909363631, 8553.529555874487, 8579.485230886166, 8671.783205419915, 8744.344174186961, 8749.518776467228, 8765.561721914006, 8806.11938806127, 8848.522413724168, 4486.910261794811, 4518.164139634178, 4545.272756358967, 4571.017231295287, 4578.725276483422, 1895.0, 1917.2331067573082, 1928.845692344609, 1935.9903200483907, 1939.8739081959627, 321.8477849299502, 881.5151666583354, 919.8160367926307, 977.6773664690635, 983.7688143286322, 10893.0, 11771.117166212398, 11910.523579056913, 11947.462364193632, 12062.035037197003, 443.4899865155033, 448.74421579699913, 451.4920714196529, 454.36615920790314, 479.5132940065836, 11109.834845707863, 11135.053520450852, 11526.59656912004, 11668.591599294154, 11732.178747487595, 555525.0, 671013.0, 676216.0, 677639.0, 700760.0, 91410.08589914149, 113642.86357136322, 116849.0, 117094.0, 117548.0, 909.9272058235325, 1040.5317607076845, 1042.2443728296923, 1063.5214153630743, 1069.6844430892904, 18412.447626570687, 18419.907900460414, 18424.539386515444, 18448.446546603624, 18782.624347513247, 50822.237666434296, 50839.0, 50994.0, 51227.231591525415, 53634.73182634062, 54402.63993400196, 65687.34312656813, 73478.0, 74934.0, 75227.95142345168, 6454.838629034311, 7500.812479687833, 7512.910627958806, 8078.030636323679, 8142.715004975034, 8620.482771033758, 8959.462432254086, 9046.819063618559, 9153.496557689392, 9179.541022948959, 6899.6205208712, 7948.682052717826, 8293.751187464386, 8323.458975166595, 8541.14588541141, 8043.919560804551, 8302.70940517079, 8385.0, 8405.873911891204, 8461.280791132822, 7079.973403856515, 8200.179982001991, 8282.917170828214, 8397.748067557983, 8524.147585241426, 11458.598949037078, 11667.066634669036, 12057.939710301393, 12062.035037196827, 12107.152499324962, 11767.823482647596, 11859.466324015613, 11904.821427678418, 11973.580924667944, 11991.280523168638], "unit": "score", "name": "jquery.html", "value": 8540.971732870763}, {"lowerIsBetter": false, "replicates": [1592.9044257344556, 1603.7594360845876, 1855.684533629282, 1857.8513718902482, 1955.9511012224684, 7840.176781437953, 8508.957455212716, 8644.65421383144, 8708.956455217723, 8816.823663526733, 7447.515911465751, 8421.863048488452, 8580.613872375743, 8707.085755995624, 8717.346199035082, 2448.3144719478573, 2452.1540068676277, 2463.88912498938, 2464.199135281032, 2470.851748895072, 2391.80865530758, 2444.6455263986713, 2528.683914510686, 2534.721180670125, 2539.3143851160175, 2189.8576592521435, 2433.756624337561, 2485.0, 2499.150288901773, 2520.936976575582, 2453.852768833876, 2455.2511483997373, 2486.9005239790386, 2492.0654754467073, 2495.3262619092834, 2458.3362492127203, 2492.302155396492, 2494.239257026606, 2500.237427584586, 2504.4490212153296, 8742.431741936818, 8757.2994160467, 8788.033316335199, 8809.251213646783, 8819.77950551235, 5396.83809485716, 5485.451454854522, 5498.505134537871, 5510.366307874606, 5529.778808847641, 2994.9550756738668, 3456.8962931112105, 3620.149264922741, 3630.5824830144606, 3636.1091532574424, 1055.3404122423485, 1081.0972837680547, 1088.8747794003712, 1114.4260705736551, 1115.9609413670564, 11663.650090497298, 11701.888320609529, 11732.120090993125, 11746.88253117475, 11793.115516336224, 4818.590419814285, 4866.9269960949905, 4912.459629440758, 4936.012797440526, 4948.752562371867, 10107.29248952581, 10109.848352274576, 10113.393196408239, 10126.139278161292, 10133.645322413828, 5441.6190866639745, 5478.808241711601, 5493.945060549423, 5494.038543254915, 5513.531349835229, 4260.233158031584, 4962.727050012212, 4986.6010719143105, 4990.8752281193265, 5007.324011258506, 3209.8234597096916, 3711.979205718449, 3744.6068162843053, 3783.3000894834545, 3792.3173828711097, 1023.698009087321, 1146.6388087752332, 1202.4528839378238, 1203.4404002138872, 1218.597862705305, 1114.5151858941385, 1117.3519358771894, 1123.7752449509967, 1187.631834131422, 1381.3369582600208, 6832.145981752281, 7866.213378662088, 7869.960650196713, 7949.761507154794, 8002.399820013406, 1213.7451135261517, 1224.1492162946668, 1225.6935766058486, 1226.7055906582534, 1242.9869656230144, 6123.938760612336, 6167.660778657217, 6168.228971378578, 6206.379362063757, 6229.813105606839, 8952.462852228888, 10495.947520262502, 10501.684949451528, 10563.207759418074, 10743.78512429747, 8196.918030819736, 10368.0, 10453.738656533495, 10565.577376904992, 10565.841512377321, 6881.759138430131, 8156.877646835303, 8310.168983101641, 8310.252077313191, 8353.791155221168, 8069.515829050276, 8083.393745469231, 8122.7157049502985, 8126.512409255463, 8209.179082091743, 9425.434473931586, 9474.099960503741, 9652.083052110038, 9656.662016829378, 9810.65662701802, 9526.618935242514, 9648.469334186406, 9872.605095796374, 9947.502624868872, 9967.45179015132, 7410.184879663125, 7447.776566703008, 7493.962530187314, 7536.547807131589, 7543.585102819397, 8077.071136819341, 8121.79695507617, 8142.226488483585, 8156.510609363457, 8167.183281671785, 6778.694958726967, 7248.96375518119, 7349.816254593464, 7474.701011959461, 7508.436867235088, 6405.295417504164, 7231.891521627285, 7262.164851042197, 7288.599127048064, 7313.268673132644, 7514.286142816423, 7545.622718864144, 7596.0, 7632.5038872473115, 7669.3864490841715, 6832.316768323128, 6893.0694356261265, 6902.792916212522, 6927.3419025192525, 6943.409810166192, 7006.124234470692, 7079.39825114871, 7099.325564071405, 7114.359707626339, 7120.537165084253], "unit": "score", "name": "mootools.html", "value": 4899.209096801677}, {"lowerIsBetter": false, "replicates": [332.83673560904634, 339.36030582352276, 341.69930461194144, 344.419652884889, 348.237360181203, 6717.966410167955, 6850.417714494268, 6865.382115609594, 6901.447884169267, 6924.0, 6852.588844669311, 6934.058463630192, 6964.8258793530185, 6974.8256293592685, 7036.226015138331, 5047.823326183584, 5051.570616497602, 5064.645474816764, 5069.239614057902, 5069.2649565812935, 5026.170681837492, 5053.065182941167, 5063.79744810209, 5074.492550744914, 5090.745462726867, 4164.416981622575, 4996.9500304996845, 5027.0699920514635, 5037.722925239111, 5068.619853510983, 4838.153323168449, 5004.624653150991, 5015.14742493777, 5030.270610761438, 5031.245313203012, 4233.830646774125, 4282.057947251599, 4282.122164956208, 4299.226139294926, 4313.137372525476, 6589.077529145923, 6617.503687223478, 6633.1376920999965, 6668.0, 6677.565958212701, 5649.576281778883, 5930.7924222652, 5958.493528050121, 5958.523318134538, 5968.31364393096, 5950.553708471882, 5988.7604495820115, 7359.521631093961, 7374.889376659355, 7400.518966267229, 4660.3941487606735, 4681.321208424793, 4681.438227412698, 4692.601128904047, 4698.154332220199, 7767.495112817649, 7833.610748721638, 7834.960825195838, 7846.0, 7847.529148251123, 3856.8842934711442, 4353.238183317907, 4438.400815889878, 4561.635069194456, 4797.328374027639, 4793.760311984456, 4795.784189711471, 4802.207635740064, 4821.566059054702, 4825.782839772219, 4806.8077276909235, 5771.595988280864, 5791.160281759121, 5795.362510123883, 5795.971020144872, 7426.9257307427315, 7432.85134297311, 7453.217412171753, 7461.85076298471, 7493.55038697669, 1427.7435856446261, 1653.4708893154075, 1678.8740844436716, 1685.9831401686072, 1692.568395059252, 1037.9584816607403, 1062.8937106289309, 1075.2258373970728, 1078.1805827570945, 1092.448313601642, 6825.078614386995, 6935.7225710971, 6958.025876377311, 6959.82600434983, 6972.825679358057, 7786.7663970080985, 7792.181820908836, 7792.259715336557, 7795.259450352208, 7810.921890781019, 6923.0, 6929.1684997800585, 6935.549189302679, 6946.756863509753, 6948.756793512304, 2997.895073672411, 3706.870259540903, 4090.1819636072905, 4120.25835349634, 4124.649404800625, 7924.48490848093, 8085.110637829834, 8099.514029158269, 8111.1888811118415, 8117.4317797754775, 8051.798705032304, 8063.959680201561, 8065.435419520694, 8073.838523229502, 8101.675932962733, 8144.75565733029, 8145.5927203639585, 8146.900168477298, 8147.837043258983, 8203.425760196847, 7548.4716069874585, 7776.727814526691, 7818.765437036898, 7833.334166595903, 7843.921560784319, 6197.783077592443, 7457.179710231761, 7640.770776876702, 7641.006669132978, 7660.080790305199, 6579.374959378852, 8142.796430089295, 8154.673813047411, 8156.673733050611, 8164.673413063411, 4033.899152521093, 4772.546608072227, 4778.761061946958, 4794.952050479451, 4796.9760151199025, 6288.622682639057, 6317.96841015792, 7487.176410594721, 7781.416393770377, 7821.960890195513, 7393.482456228013, 7447.962760186381, 7466.9546263524235, 7480.738174163878, 7494.3629791466155, 7456.291652293024, 7462.813429664302, 7464.0, 7475.514091584029, 7497.512661676974, 6975.6163411012885, 7271.527350722186, 7283.526570772883, 7285.490015698851, 7302.269773022867, 7412.666430010555, 7469.701211951461, 7485.70057197706, 7494.437917156126, 7501.512401693873, 7324.450666199949, 7326.194118647051, 7336.826107822722, 7340.0, 7355.338019578264], "unit": "score", "name": "prototype.html", "value": 5344.515280250053}, {"lowerIsBetter": false, "replicates": [625.9499240060793, 659.162863163782, 691.941184999275, 704.0565642039666, 732.5275197497614, 14138.71722565548, 14147.858521414808, 14477.5656730298, 14669.266536673176, 14710.264486775659, 15229.69540609187, 15810.762838557403, 15832.366705331773, 15852.682946341067, 15855.207239638, 719.352582675591, 881.8633111867671, 885.8006948436615, 898.4339865884483, 900.2842740021698, 889.3729920406098, 890.5502721125822, 894.0567701075363, 894.3247847874878, 894.6689724801832, 921.5208091792264, 939.4879790514152, 941.7551436626492, 941.9152276295166, 944.1455482788087, 893.7318804358731, 916.6974898283551, 917.775145089454, 921.3320342751485, 935.8783358163463, 586.6568057686259, 681.6762038031895, 700.2367419512756, 702.3854127638316, 706.0891450029455, 15067.0, 15129.394824207018, 15301.387944482207, 15441.0735355879, 15482.458113965957, 12490.437930293068, 12503.249805011728, 12752.681182970407, 12987.480500779957, 13270.734585308337, 10193.490325483695, 10385.740356491073, 10459.633912813091, 10753.247272690915, 11066.336019838835, 3466.9826650866585, 3499.212677147647, 3522.594901586325, 3530.0468873404293, 3543.4153364694794, 74526.0, 76638.61680691561, 76751.616241919, 79078.0, 88127.55936220278, 9410.95294523523, 9413.294002949806, 9419.340646154704, 9423.0, 9705.0, 20004.799952000583, 20127.798722012594, 20159.294424695065, 20213.49466263355, 20234.089465974066, 7310.561366318038, 7412.703491860265, 7548.471606987568, 7690.500117492345, 7831.530108193413, 3931.5351661190966, 3993.9001524961527, 4001.3397789365013, 4050.9392359114636, 4053.574374690674, 2969.4061187762536, 3433.8626454941523, 3467.739919506047, 3477.0438129514587, 3504.15900183954, 647.6211416321505, 657.8914479110989, 660.6762686283782, 681.7102731339161, 682.8804959132232, 540.3461811208482, 545.5908068948289, 574.2821473158551, 596.4959609130278, 599.4005994005994, 7680.577568233689, 8087.908132402051, 8466.195711407407, 8690.739277821676, 9030.774230644287, 495.97520123993655, 519.8362515807509, 549.3106151779491, 595.9970200148972, 644.1915396177767, 4064.248114098901, 4355.651547876162, 4385.649148068147, 4423.402840616475, 4455.420795296591, 76878.84681729779, 90812.63781043289, 92172.69568260713, 92282.0, 93493.0, 62212.37787622066, 82797.17202827895, 82896.58551707203, 83317.0, 83379.58310208531, 74946.25053749501, 75254.4949101015, 81642.59178704188, 82363.58818205871, 82908.17091829125, 8094.919050809652, 8925.955370223108, 8980.928052379704, 9100.681476148304, 9122.361434699507, 50778.0, 51280.974380511434, 51989.7400512995, 52668.473315266354, 53542.0, 66626.66686666536, 69102.65448672725, 69181.65409172921, 69193.65403173154, 73547.0, 9703.66037188695, 10758.623448179276, 10954.945225273823, 11233.66299011031, 11370.260933039326, 11857.466414011218, 11874.525018999144, 11956.701082473008, 12113.0, 12718.427670755023, 11151.219414640897, 11329.490172942073, 11663.24188927751, 11694.2983420995, 12037.458314375699, 11185.049270812073, 11351.0, 11648.475818588353, 11773.88226117728, 12263.448144833683, 10897.400642964396, 10951.397673128055, 11032.44837758125, 11049.834252486058, 12310.938445307716, 9344.813103738023, 9513.429194248367, 9515.809683806423, 9908.207343412654, 10153.64462243818, 8145.470544414594, 9612.51937403141, 9978.550965206729, 10010.599576016877, 10030.49847507607], "unit": "score", "name": "yui.html", "value": 6943.631510324326}], "name": "dromaeo_css", "value": 7405.297098027706}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 114.0, 113.0, 115.0, 126.0, 115.0, 116.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [163.0, 129.0, 145.0, 160.0, 127.0, 145.0, 142.0, 125.0, 162.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 142.1}, {"lowerIsBetter": true, "replicates": [197.0, 199.0, 199.0, 207.0, 195.0, 239.0, 267.0, 207.0, 202.0, 203.0], "unit": "score", "name": "audio-dft", "value": 211.5}, {"lowerIsBetter": true, "replicates": [50.0, 96.0, 111.0, 87.0, 130.0, 59.0, 78.0, 86.0, 86.0, 75.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 115.0, 94.0, 122.0, 68.0, 153.0, 120.0, 121.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [95.0, 123.0, 86.0, 108.0, 111.0, 91.0, 87.0, 91.0, 102.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [116.0, 125.0, 95.0, 95.0, 95.0, 120.0, 131.0, 105.0, 150.0, 152.0], "unit": "score", "name": "imaging-darkroom", "value": 118.4}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 91.0, 91.0, 96.0, 90.0, 95.0, 154.0, 148.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 104.2}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 55.0, 58.0, 56.0, 55.0, 59.0, 64.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [66.0, 62.0, 66.0, 59.0, 110.0, 105.0, 99.0, 68.0, 68.0, 77.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.0}, {"lowerIsBetter": true, "replicates": [99.0, 78.0, 74.0, 75.0, 110.0, 111.0, 110.0, 111.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 93.9}, {"lowerIsBetter": true, "replicates": [135.0, 129.0, 125.0, 140.0, 127.0, 131.0, 124.0, 123.0, 126.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.1}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 147.0, 137.0, 146.0, 146.0, 142.0, 140.0, 146.0, 172.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 67.0, 68.0, 67.0, 67.0, 71.0, 75.0, 57.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1557.9}]} 03:35:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1557.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7405.30"}}} 03:35:57 INFO - Return code: 0 03:35:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:35:57 ERROR - # TBPL SUCCESS # 03:35:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:35:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:35:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:35:57 INFO - 2016-02-22 03:35:57.241 screenresolution[1724:10988] starting screenresolution argv=screenresolution get 03:35:57 INFO - 2016-02-22 03:35:57.243 screenresolution[1724:10988] Display 0: 1600x1200x32@60 03:35:57 INFO - 2016-02-22 03:35:57.249 screenresolution[1725:10991] starting screenresolution argv=screenresolution list 03:35:57 INFO - Available Modes on Display 0 03:35:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:35:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:35:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:35:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:35:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:35:57 INFO - Intel Iris: 03:35:57 INFO - Chipset Model: Intel Iris 03:35:57 INFO - Type: GPU 03:35:57 INFO - Bus: Built-In 03:35:57 INFO - VRAM (Dynamic, Max): 1536 MB 03:35:57 INFO - Vendor: Intel (0x8086) 03:35:57 INFO - Device ID: 0x0a2e 03:35:57 INFO - Revision ID: 0x0009 03:35:57 INFO - Displays: 03:35:57 INFO - Display: 03:35:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:35:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:35:57 INFO - Display Serial Number: 1600x1200 60 03:35:57 INFO - Main Display: Yes 03:35:57 INFO - Mirror: Off 03:35:57 INFO - Online: Yes 03:35:57 INFO - Rotation: Supported 03:35:57 INFO - Return code: 0 03:35:57 INFO - Running post-action listener: _resource_record_post_action 03:35:57 INFO - Running post-run listener: _resource_record_post_run 03:35:58 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 33766912; Write bytes: 711292928; Read time: 406; Write time: 2691 03:35:58 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 384832000; Write bytes: 379438080; Read time: 28428; Write time: 661 03:35:58 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 32845312; Write bytes: 304354304; Read time: 393; Write time: 1972 03:35:58 INFO - Running post-run listener: _upload_blobber_files 03:35:58 INFO - Blob upload gear active. 03:35:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:35:58 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 03:35:58 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'] 03:35:58 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 03:35:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:00 INFO - (blobuploader) - INFO - Done attempting. 03:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:01 INFO - (blobuploader) - INFO - Done attempting. 03:36:01 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:01 INFO - Return code: 0 03:36:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/342747618305e442f95c2a9a8a9cdab66177f1b08e950b750c8ee94f71602786ca4e58d616ec58b567f50953dda8c2b926f7d509bf1dc60cbca142829fa4235d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca54d531011f8ce883df8cb205fc5653b2a0047b5f907795e54a92731cd01ef3d1128cc5589fd8a88b60a4b9a77867c10fdeed9b34fcd1290646efd096a49055"} 03:36:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:01 INFO - Contents: 03:36:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/342747618305e442f95c2a9a8a9cdab66177f1b08e950b750c8ee94f71602786ca4e58d616ec58b567f50953dda8c2b926f7d509bf1dc60cbca142829fa4235d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca54d531011f8ce883df8cb205fc5653b2a0047b5f907795e54a92731cd01ef3d1128cc5589fd8a88b60a4b9a77867c10fdeed9b34fcd1290646efd096a49055"} 03:36:01 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:01 INFO - Copying logs to upload dir... 03:36:01 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.209722 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-22 03:36:01.171491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 03:36:01.174976) ========= 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.97xOhiCDrF/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.73bHlpYrDm/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/342747618305e442f95c2a9a8a9cdab66177f1b08e950b750c8ee94f71602786ca4e58d616ec58b567f50953dda8c2b926f7d509bf1dc60cbca142829fa4235d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca54d531011f8ce883df8cb205fc5653b2a0047b5f907795e54a92731cd01ef3d1128cc5589fd8a88b60a4b9a77867c10fdeed9b34fcd1290646efd096a49055"} build_url:https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/CAgJGWjdRnClVMjtjHzBVw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/342747618305e442f95c2a9a8a9cdab66177f1b08e950b750c8ee94f71602786ca4e58d616ec58b567f50953dda8c2b926f7d509bf1dc60cbca142829fa4235d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca54d531011f8ce883df8cb205fc5653b2a0047b5f907795e54a92731cd01ef3d1128cc5589fd8a88b60a4b9a77867c10fdeed9b34fcd1290646efd096a49055"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 03:36:01.201492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:36:01.201847) ========= 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.97xOhiCDrF/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.73bHlpYrDm/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.005332 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 03:36:01.250616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 03:36:01.250944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 03:36:01.251320) ========= ========= Total master_lag: 0.28 =========