builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1460136729.46 results: success (0) buildid: 20160408094259 builduid: 1b6e5a49aaa04377b017f4ec2da0c586 revision: 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.459376) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.459868) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.460151) ========= 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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005659 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.508083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.508368) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.533992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.534276) ========= 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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005824 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.583700) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.583972) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.584323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.584593) ========= 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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-04-08 10:32:09-- 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% 168M=0s 2016-04-08 10:32:09 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196978 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.796103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.796435) ========= 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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.026605 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:09.844926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-08 10:32:09.845246) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a --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 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-04-08 10:32:09,907 truncating revision to first 12 chars 2016-04-08 10:32:09,907 Setting DEBUG logging. 2016-04-08 10:32:09,907 attempt 1/10 2016-04-08 10:32:09,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c492faa4c39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 10:32:11,254 unpacking tar archive at: fx-team-9c492faa4c39/testing/mozharness/ program finished with exit code 0 elapsedTime=1.598612 ========= master_lag: 3.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-08 10:32:14.499863) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:14.500156) ========= echo 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9c492faa4c397c9fd2a9448fce84117d0e2f8a2a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a program finished with exit code 0 elapsedTime=0.005949 script_repo_revision: '9c492faa4c397c9fd2a9448fce84117d0e2f8a2a' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:14.572341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:14.572611) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 10:32:14.611173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-08 10:32:14.611439) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:32:14 INFO - MultiFileLogger online at 20160408 10:32:14 in /builds/slave/test 10:32:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:32:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:32:14 INFO - {'append_to_log': False, 10:32:14 INFO - 'base_work_dir': '/builds/slave/test', 10:32:14 INFO - 'blob_upload_branch': 'Fx-Team', 10:32:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:32:14 INFO - 'branch': 'Fx-Team', 10:32:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:32:14 INFO - 'config_files': ('talos/mac_config.py',), 10:32:14 INFO - 'default_actions': ('clobber', 10:32:14 INFO - 'read-buildbot-config', 10:32:14 INFO - 'download-and-extract', 10:32:14 INFO - 'populate-webroot', 10:32:14 INFO - 'create-virtualenv', 10:32:14 INFO - 'install', 10:32:14 INFO - 'run-tests'), 10:32:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:32:14 INFO - 'download_minidump_stackwalk': True, 10:32:14 INFO - 'download_symbols': 'ondemand', 10:32:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:32:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:32:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:32:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:32:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:32:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:32:14 INFO - 'installer_path': 'installer.exe', 10:32:14 INFO - 'log_level': 'info', 10:32:14 INFO - 'log_name': 'talos', 10:32:14 INFO - 'log_to_console': True, 10:32:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:32:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:32:14 INFO - 'opt_config_files': (), 10:32:14 INFO - 'pip_index': False, 10:32:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:32:14 INFO - 'cmd': ('bash', 10:32:14 INFO - '-c', 10:32:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:32:14 INFO - 'enabled': True, 10:32:14 INFO - 'halt_on_failure': False, 10:32:14 INFO - 'name': 'check_screen_resolution'},), 10:32:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:32:14 INFO - 'cmd': ('bash', 10:32:14 INFO - '-c', 10:32:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:32:14 INFO - 'enabled': True, 10:32:14 INFO - 'halt_on_failure': False, 10:32:14 INFO - 'name': 'check_screen_resolution'},), 10:32:14 INFO - 'run_cmd_checks_enabled': True, 10:32:14 INFO - 'sps_profile': False, 10:32:14 INFO - 'sps_profile_interval': 0, 10:32:14 INFO - 'suite': 'dromaeojs', 10:32:14 INFO - 'system_bits': '32', 10:32:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:32:14 INFO - 'title': 't-yosemite-r7-0084', 10:32:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:32:14 INFO - 'use_talos_json': True, 10:32:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:32:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:32:14 INFO - 'work_dir': 'build'} 10:32:14 INFO - ##### 10:32:14 INFO - ##### Running clobber step. 10:32:14 INFO - ##### 10:32:14 INFO - Running pre-action listener: _resource_record_pre_action 10:32:14 INFO - Running main action method: clobber 10:32:14 INFO - rmtree: /builds/slave/test/build 10:32:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:32:16 INFO - Running post-action listener: _resource_record_post_action 10:32:16 INFO - ##### 10:32:16 INFO - ##### Running read-buildbot-config step. 10:32:16 INFO - ##### 10:32:16 INFO - Running pre-action listener: _resource_record_pre_action 10:32:16 INFO - Running main action method: read_buildbot_config 10:32:16 INFO - Using buildbot properties: 10:32:16 INFO - { 10:32:16 INFO - "project": "", 10:32:16 INFO - "product": "firefox", 10:32:16 INFO - "script_repo_revision": "production", 10:32:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:32:16 INFO - "repository": "", 10:32:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:32:16 INFO - "buildid": "20160408094259", 10:32:16 INFO - "pgo_build": "False", 10:32:16 INFO - "basedir": "/builds/slave/test", 10:32:16 INFO - "buildnumber": 645, 10:32:16 INFO - "slavename": "t-yosemite-r7-0084", 10:32:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:32:16 INFO - "platform": "yosemite_r7", 10:32:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:32:16 INFO - "branch": "fx-team", 10:32:16 INFO - "repo_path": "integration/fx-team", 10:32:16 INFO - "revision": "9c492faa4c397c9fd2a9448fce84117d0e2f8a2a", 10:32:16 INFO - "stage_platform": "macosx64", 10:32:16 INFO - "builduid": "1b6e5a49aaa04377b017f4ec2da0c586", 10:32:16 INFO - "slavebuilddir": "test" 10:32:16 INFO - } 10:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 10:32:16 INFO - Running post-action listener: _resource_record_post_action 10:32:16 INFO - ##### 10:32:16 INFO - ##### Running download-and-extract step. 10:32:16 INFO - ##### 10:32:16 INFO - Running pre-action listener: _resource_record_pre_action 10:32:16 INFO - Running main action method: download_and_extract 10:32:16 INFO - mkdir: /builds/slave/test/build/tests 10:32:16 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')]} 10:32:16 INFO - https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 10:32:18 INFO - Downloaded 1199 bytes. 10:32:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:32:18 INFO - Using the following test package requirements: 10:32:18 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:32:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 10:32:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 10:32:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'jsshell-mac.zip'], 10:32:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 10:32:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:32:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 10:32:18 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 10:32:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 10:32:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:32:18 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 10:32:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:18 INFO - https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:32:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:32:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:32:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:32:19 INFO - Downloaded 18014490 bytes. 10:32:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:32:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:32:22 INFO - Return code: 0 10:32:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:22 INFO - https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:32:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:32:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:32:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:32:24 INFO - Downloaded 18014490 bytes. 10:32:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:32:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:32:27 INFO - Return code: 0 10:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:27 INFO - https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:32:29 INFO - Downloaded 10847693 bytes. 10:32:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:32:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:32:29 INFO - Return code: 0 10:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:29 INFO - https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 10:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 10:32:37 INFO - Downloaded 108785984 bytes. 10:32:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:32:37 INFO - mkdir: /builds/slave/test/properties 10:32:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:32:37 INFO - Writing to file /builds/slave/test/properties/build_url 10:32:37 INFO - Contents: 10:32:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:32:39 INFO - Running post-action listener: _resource_record_post_action 10:32:39 INFO - Running post-action listener: set_extra_try_arguments 10:32:39 INFO - ##### 10:32:39 INFO - ##### Running populate-webroot step. 10:32:39 INFO - ##### 10:32:39 INFO - Running pre-action listener: _resource_record_pre_action 10:32:39 INFO - Running main action method: populate_webroot 10:32:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:32:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:32:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:32:39 INFO - '--tppagecycles', 10:32:39 INFO - '7'], 10:32:39 INFO - 'tests': ['tsvgm']}}, 10:32:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:32:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:32:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:32:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:32:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:32:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['damp', 'tps']}, 10:32:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'tests': ['damp', 'tps']}, 10:32:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['dromaeo_dom']}, 10:32:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:32:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['a11yr', 10:32:39 INFO - 'ts_paint', 10:32:39 INFO - 'tpaint', 10:32:39 INFO - 'sessionrestore', 10:32:39 INFO - 'sessionrestore_no_auto_restore', 10:32:39 INFO - 'tabpaint']}, 10:32:39 INFO - 'other-e10s': {'tests': ['a11yr', 10:32:39 INFO - 'ts_paint', 10:32:39 INFO - 'tpaint', 10:32:39 INFO - 'sessionrestore', 10:32:39 INFO - 'sessionrestore_no_auto_restore', 10:32:39 INFO - 'tabpaint']}, 10:32:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:32:39 INFO - 'ts_paint', 10:32:39 INFO - 'tpaint', 10:32:39 INFO - 'sessionrestore', 10:32:39 INFO - 'sessionrestore_no_auto_restore', 10:32:39 INFO - 'tabpaint']}, 10:32:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:32:39 INFO - 'ts_paint', 10:32:39 INFO - 'tpaint', 10:32:39 INFO - 'sessionrestore', 10:32:39 INFO - 'sessionrestore_no_auto_restore', 10:32:39 INFO - 'tabpaint']}, 10:32:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['a11yr', 10:32:39 INFO - 'ts_paint', 10:32:39 INFO - 'tpaint', 10:32:39 INFO - 'sessionrestore', 10:32:39 INFO - 'sessionrestore_no_auto_restore', 10:32:39 INFO - 'tabpaint']}, 10:32:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['a11yr', 10:32:39 INFO - 'ts_paint', 10:32:39 INFO - 'tpaint', 10:32:39 INFO - 'sessionrestore', 10:32:39 INFO - 'sessionrestore_no_auto_restore', 10:32:39 INFO - 'tabpaint']}, 10:32:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['tsvgx', 10:32:39 INFO - 'tsvgr_opacity', 10:32:39 INFO - 'tart', 10:32:39 INFO - 'tscrollx', 10:32:39 INFO - 'cart']}, 10:32:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:32:39 INFO - 'tsvgr_opacity', 10:32:39 INFO - 'tart', 10:32:39 INFO - 'tscrollx', 10:32:39 INFO - 'cart']}, 10:32:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'talos_options': ['--disable-e10s'], 10:32:39 INFO - 'tests': ['tp5o']}, 10:32:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'tests': ['tp5o']}, 10:32:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'talos_options': ['--disable-e10s', 10:32:39 INFO - '--xperf_path', 10:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:39 INFO - 'tests': ['tp5n']}, 10:32:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:32:39 INFO - 'talos_options': ['--xperf_path', 10:32:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:32:39 INFO - 'tests': ['tp5n']}}, 10:32:39 INFO - 'talos.zip': {'path': '', 10:32:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:32:39 INFO - Running post-action listener: _resource_record_post_action 10:32:39 INFO - ##### 10:32:39 INFO - ##### Running create-virtualenv step. 10:32:39 INFO - ##### 10:32:39 INFO - Running pre-action listener: _resource_record_pre_action 10:32:39 INFO - Running main action method: create_virtualenv 10:32:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:32:39 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 10:32:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:32:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:32:39 INFO - Using real prefix '/tools/python27' 10:32:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:32:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:32:43 INFO - Installing pip.................done. 10:32:43 INFO - Return code: 0 10:32:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:32:43 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 10:32:43 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 10:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:43 INFO - 'HOME': '/Users/cltbld', 10:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:43 INFO - 'LOGNAME': 'cltbld', 10:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:43 INFO - 'MOZ_NO_REMOTE': '1', 10:32:43 INFO - 'NO_EM_RESTART': '1', 10:32:43 INFO - 'PAGER': '/bin/cat', 10:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:43 INFO - 'PWD': '/builds/slave/test', 10:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:43 INFO - 'SHELL': '/bin/bash', 10:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:32:43 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:43 INFO - 'USER': 'cltbld', 10:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:43 INFO - 'XPC_FLAGS': '0x0', 10:32:43 INFO - 'XPC_SERVICE_NAME': '0', 10:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:43 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 10:32:43 INFO - Cleaning up... 10:32:43 INFO - Return code: 0 10:32:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:43 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:32:43 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 10:32:43 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 10:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:43 INFO - 'HOME': '/Users/cltbld', 10:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:43 INFO - 'LOGNAME': 'cltbld', 10:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:43 INFO - 'MOZ_NO_REMOTE': '1', 10:32:43 INFO - 'NO_EM_RESTART': '1', 10:32:43 INFO - 'PAGER': '/bin/cat', 10:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:43 INFO - 'PWD': '/builds/slave/test', 10:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:43 INFO - 'SHELL': '/bin/bash', 10:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:32:43 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:43 INFO - 'USER': 'cltbld', 10:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:43 INFO - 'XPC_FLAGS': '0x0', 10:32:43 INFO - 'XPC_SERVICE_NAME': '0', 10:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:43 INFO - Downloading/unpacking psutil>=0.7.1 10:32:43 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 10:32:43 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 10:32:43 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 10:32:43 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 10:32:43 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 10:32:43 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 10:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:32:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:47 INFO - Installing collected packages: psutil 10:32:47 INFO - Running setup.py install for psutil 10:32:47 INFO - building 'psutil._psutil_osx' extension 10:32:47 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 10:32:47 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 10:32:47 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 10:32:47 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 10:32:47 INFO - building 'psutil._psutil_posix' extension 10:32:47 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 10:32:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:32:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:32:48 INFO - ^ 10:32:48 INFO - 1 warning generated. 10:32:48 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 10:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:32:48 INFO - Successfully installed psutil 10:32:48 INFO - Cleaning up... 10:32:48 INFO - Return code: 0 10:32:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:48 INFO - 'HOME': '/Users/cltbld', 10:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:48 INFO - 'LOGNAME': 'cltbld', 10:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:48 INFO - 'MOZ_NO_REMOTE': '1', 10:32:48 INFO - 'NO_EM_RESTART': '1', 10:32:48 INFO - 'PAGER': '/bin/cat', 10:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:48 INFO - 'PWD': '/builds/slave/test', 10:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:48 INFO - 'SHELL': '/bin/bash', 10:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:32:48 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:48 INFO - 'USER': 'cltbld', 10:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:48 INFO - 'XPC_FLAGS': '0x0', 10:32:48 INFO - 'XPC_SERVICE_NAME': '0', 10:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:32: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 10:32: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 10:32: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 10:32: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 10:32: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 10:32: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 10:32:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:32:51 INFO - Installing collected packages: mozsystemmonitor 10:32:51 INFO - Running setup.py install for mozsystemmonitor 10:32:51 INFO - Successfully installed mozsystemmonitor 10:32:51 INFO - Cleaning up... 10:32:51 INFO - Return code: 0 10:32:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:51 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:32:51 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 10:32:51 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 10:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:51 INFO - 'HOME': '/Users/cltbld', 10:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:51 INFO - 'LOGNAME': 'cltbld', 10:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:51 INFO - 'MOZ_NO_REMOTE': '1', 10:32:51 INFO - 'NO_EM_RESTART': '1', 10:32:51 INFO - 'PAGER': '/bin/cat', 10:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:51 INFO - 'PWD': '/builds/slave/test', 10:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:51 INFO - 'SHELL': '/bin/bash', 10:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:32:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:51 INFO - 'USER': 'cltbld', 10:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:51 INFO - 'XPC_FLAGS': '0x0', 10:32:51 INFO - 'XPC_SERVICE_NAME': '0', 10:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:32:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:32:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:32:53 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 10:32:53 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 10:32:53 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 10:32:53 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 10:32:53 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 10:32:53 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 10:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:32:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:32:54 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 10:32:54 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 10:32:54 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 10:32:54 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 10:32:54 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 10:32:54 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 10:32:55 INFO - Downloading docopt-0.6.1.tar.gz 10:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:32:55 INFO - Installing collected packages: blobuploader, requests, docopt 10:32:55 INFO - Running setup.py install for blobuploader 10:32:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:32:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:32:55 INFO - Running setup.py install for requests 10:32:55 INFO - Running setup.py install for docopt 10:32:56 INFO - Successfully installed blobuploader requests docopt 10:32:56 INFO - Cleaning up... 10:32:56 INFO - Return code: 0 10:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:32:56 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:32:56 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 10:32:56 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 10:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:56 INFO - 'HOME': '/Users/cltbld', 10:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:56 INFO - 'LOGNAME': 'cltbld', 10:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:56 INFO - 'MOZ_NO_REMOTE': '1', 10:32:56 INFO - 'NO_EM_RESTART': '1', 10:32:56 INFO - 'PAGER': '/bin/cat', 10:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:56 INFO - 'PWD': '/builds/slave/test', 10:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:56 INFO - 'SHELL': '/bin/bash', 10:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:32:56 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:56 INFO - 'USER': 'cltbld', 10:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:56 INFO - 'XPC_FLAGS': '0x0', 10:32:56 INFO - 'XPC_SERVICE_NAME': '0', 10:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:32:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uy9_qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:32:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-X6FO10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:32:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QPmQQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:32:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-SblImt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:32:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ibvyxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:32:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wPwTRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-lDMnPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0haFZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-XcJgpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4XMb6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-paootM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tRl4wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Umxfnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mYakFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-d_Lf5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:32:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-8FYZ8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:32:58 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QBmepf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:32:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:32:58 INFO - Running setup.py install for manifestparser 10:32:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:32:58 INFO - Running setup.py install for mozcrash 10:32:58 INFO - Running setup.py install for mozdebug 10:32:58 INFO - Running setup.py install for mozdevice 10:32:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:32:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:32:58 INFO - Running setup.py install for mozfile 10:32:58 INFO - Running setup.py install for mozhttpd 10:32:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Running setup.py install for mozinfo 10:32:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Running setup.py install for mozInstall 10:32:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Running setup.py install for mozleak 10:32:59 INFO - Running setup.py install for mozlog 10:32:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Running setup.py install for moznetwork 10:32:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:32:59 INFO - Running setup.py install for mozprocess 10:32:59 INFO - Running setup.py install for mozprofile 10:33:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:33:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:33:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:33:00 INFO - Running setup.py install for mozrunner 10:33:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:33:00 INFO - Running setup.py install for mozscreenshot 10:33:00 INFO - Running setup.py install for moztest 10:33:00 INFO - Running setup.py install for mozversion 10:33:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:33:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:33:00 INFO - Cleaning up... 10:33:00 INFO - Return code: 0 10:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33: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')]} 10:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33: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')]} 10:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:00 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:33:00 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 10:33:00 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 10:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:00 INFO - 'HOME': '/Users/cltbld', 10:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:00 INFO - 'LOGNAME': 'cltbld', 10:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:00 INFO - 'MOZ_NO_REMOTE': '1', 10:33:00 INFO - 'NO_EM_RESTART': '1', 10:33:00 INFO - 'PAGER': '/bin/cat', 10:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:00 INFO - 'PWD': '/builds/slave/test', 10:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:00 INFO - 'SHELL': '/bin/bash', 10:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:33:00 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:00 INFO - 'USER': 'cltbld', 10:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:00 INFO - 'XPC_FLAGS': '0x0', 10:33:00 INFO - 'XPC_SERVICE_NAME': '0', 10:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AlKLPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-8zRECa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-LbR57P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JhvFSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-qiTMEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-oqKuqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-u5i8BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fjQMwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tPCPDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:01 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)) 10:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-q5ZzUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vUluCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-EJD35v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-wdMHGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OGrOwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-eimuIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-tHDWKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:02 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)) 10:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YKjSiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:02 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)) 10:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:02 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)) 10:33:02 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)) 10:33:02 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)) 10:33:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:05 INFO - Downloading blessings-1.6.tar.gz 10:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:33:05 INFO - Installing collected packages: blessings 10:33:05 INFO - Running setup.py install for blessings 10:33:05 INFO - Successfully installed blessings 10:33:05 INFO - Cleaning up... 10:33:05 INFO - Return code: 0 10:33:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:33:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:05 INFO - Reading from file tmpfile_stdout 10:33:05 INFO - Current package versions: 10:33:05 INFO - blessings == 1.6 10:33:05 INFO - blobuploader == 1.2.4 10:33:05 INFO - docopt == 0.6.1 10:33:05 INFO - manifestparser == 1.1 10:33:05 INFO - mozInstall == 1.12 10:33:05 INFO - mozcrash == 0.17 10:33:05 INFO - mozdebug == 0.1 10:33:05 INFO - mozdevice == 0.48 10:33:05 INFO - mozfile == 1.2 10:33:05 INFO - mozhttpd == 0.7 10:33:05 INFO - mozinfo == 0.9 10:33:05 INFO - mozleak == 0.1 10:33:05 INFO - mozlog == 3.1 10:33:05 INFO - moznetwork == 0.27 10:33:05 INFO - mozprocess == 0.22 10:33:05 INFO - mozprofile == 0.28 10:33:05 INFO - mozrunner == 6.11 10:33:05 INFO - mozscreenshot == 0.1 10:33:05 INFO - mozsystemmonitor == 0.0 10:33:05 INFO - moztest == 0.7 10:33:05 INFO - mozversion == 1.4 10:33:05 INFO - psutil == 3.1.1 10:33:05 INFO - requests == 1.2.3 10:33:05 INFO - wsgiref == 0.1.2 10:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:05 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:33:05 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 10:33:05 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 10:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:05 INFO - 'HOME': '/Users/cltbld', 10:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:05 INFO - 'LOGNAME': 'cltbld', 10:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:05 INFO - 'MOZ_NO_REMOTE': '1', 10:33:05 INFO - 'NO_EM_RESTART': '1', 10:33:05 INFO - 'PAGER': '/bin/cat', 10:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:05 INFO - 'PWD': '/builds/slave/test', 10:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:05 INFO - 'SHELL': '/bin/bash', 10:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:33:05 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:05 INFO - 'USER': 'cltbld', 10:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:05 INFO - 'XPC_FLAGS': '0x0', 10:33:05 INFO - 'XPC_SERVICE_NAME': '0', 10:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 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)) 10:33:06 INFO - Cleaning up... 10:33:06 INFO - Return code: 0 10:33:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:33:06 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')]} 10:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:06 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')]} 10:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:06 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:33:06 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 10:33:06 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 10:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:06 INFO - 'HOME': '/Users/cltbld', 10:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:06 INFO - 'LOGNAME': 'cltbld', 10:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:06 INFO - 'MOZ_NO_REMOTE': '1', 10:33:06 INFO - 'NO_EM_RESTART': '1', 10:33:06 INFO - 'PAGER': '/bin/cat', 10:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:06 INFO - 'PWD': '/builds/slave/test', 10:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:06 INFO - 'SHELL': '/bin/bash', 10:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:33:06 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:06 INFO - 'USER': 'cltbld', 10:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:06 INFO - 'XPC_FLAGS': '0x0', 10:33:06 INFO - 'XPC_SERVICE_NAME': '0', 10:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:06 INFO - Downloading/unpacking jsonschema 10:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:33:08 INFO - Downloading/unpacking functools32 (from jsonschema) 10:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:33:09 INFO - warning: no files found matching '*.txt' 10:33:09 INFO - no previously-included directories found matching 'build' 10:33:09 INFO - no previously-included directories found matching 'dist' 10:33:09 INFO - no previously-included directories found matching '.git*' 10:33:09 INFO - Installing collected packages: jsonschema, functools32 10:33:09 INFO - Running setup.py install for functools32 10:33:09 INFO - warning: no files found matching '*.txt' 10:33:09 INFO - no previously-included directories found matching 'build' 10:33:09 INFO - no previously-included directories found matching 'dist' 10:33:09 INFO - no previously-included directories found matching '.git*' 10:33:09 INFO - Successfully installed jsonschema functools32 10:33:09 INFO - Cleaning up... 10:33:09 INFO - Return code: 0 10:33:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:33:09 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')]} 10:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:09 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')]} 10:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:09 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 0x109e5ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109e6b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9320dc7fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, '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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 10:33:09 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 10:33:09 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 10:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:09 INFO - 'HOME': '/Users/cltbld', 10:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:09 INFO - 'LOGNAME': 'cltbld', 10:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:09 INFO - 'MOZ_NO_REMOTE': '1', 10:33:09 INFO - 'NO_EM_RESTART': '1', 10:33:09 INFO - 'PAGER': '/bin/cat', 10:33:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:09 INFO - 'PWD': '/builds/slave/test', 10:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:09 INFO - 'SHELL': '/bin/bash', 10:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:33:09 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:09 INFO - 'USER': 'cltbld', 10:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:09 INFO - 'XPC_FLAGS': '0x0', 10:33:09 INFO - 'XPC_SERVICE_NAME': '0', 10:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:09 INFO - Downloading/unpacking flake8 10:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:33:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:33:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:12 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 10:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:33:13 INFO - no previously-included directories found matching 'docs/_build' 10:33:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:33:13 INFO - Running setup.py install for pep8 10:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:33:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:33:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:33:13 INFO - no previously-included directories found matching 'docs/_build' 10:33:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:33:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:33:13 INFO - Cleaning up... 10:33:13 INFO - Return code: 0 10:33:13 INFO - Running post-action listener: _resource_record_post_action 10:33:13 INFO - Running post-action listener: _start_resource_monitoring 10:33:13 INFO - Starting resource monitoring. 10:33:13 INFO - ##### 10:33:13 INFO - ##### Running install step. 10:33:13 INFO - ##### 10:33:13 INFO - Running pre-action listener: _resource_record_pre_action 10:33:13 INFO - Running main action method: install 10:33:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:14 INFO - Reading from file tmpfile_stdout 10:33:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:33:14 INFO - Reading from file tmpfile_stdout 10:33:14 INFO - Output received: 10:33:14 INFO - Usage: mozinstall [options] installer 10:33:14 INFO - Options: 10:33:14 INFO - -h, --help show this help message and exit 10:33:14 INFO - -d DEST, --destination=DEST 10:33:14 INFO - Directory to install application into. [default: 10:33:14 INFO - "/builds/slave/test"] 10:33:14 INFO - --app=APP Application being installed. [default: firefox] 10:33:14 INFO - mkdir: /builds/slave/test/build/application 10:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:33:47 INFO - Reading from file tmpfile_stdout 10:33:47 INFO - Output received: 10:33:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:33:47 INFO - Running post-action listener: _resource_record_post_action 10:33:47 INFO - ##### 10:33:47 INFO - ##### Running run-tests step. 10:33:47 INFO - ##### 10:33:47 INFO - Running pre-action listener: _resource_record_pre_action 10:33:47 INFO - Running main action method: run_tests 10:33:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:47 INFO - 2016-04-08 10:33:47.368 screenresolution[1652:8064] starting screenresolution argv=screenresolution get 10:33:47 INFO - 2016-04-08 10:33:47.371 screenresolution[1652:8064] Display 0: 1600x1200x32@60 10:33:47 INFO - 2016-04-08 10:33:47.376 screenresolution[1653:8066] starting screenresolution argv=screenresolution list 10:33:47 INFO - Available Modes on Display 0 10:33:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:47 INFO - Intel Iris: 10:33:47 INFO - Chipset Model: Intel Iris 10:33:47 INFO - Type: GPU 10:33:47 INFO - Bus: Built-In 10:33:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:47 INFO - Vendor: Intel (0x8086) 10:33:47 INFO - Device ID: 0x0a2e 10:33:47 INFO - Revision ID: 0x0009 10:33:47 INFO - Displays: 10:33:47 INFO - Display: 10:33:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:47 INFO - Display Serial Number: 1600x1200 60 10:33:47 INFO - Main Display: Yes 10:33:47 INFO - Mirror: Off 10:33:47 INFO - Online: Yes 10:33:47 INFO - Rotation: Supported 10:33:47 INFO - Return code: 0 10:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:33:47 INFO - Python 2.7.3 10:33:47 INFO - Return code: 0 10:33:47 INFO - grabbing minidump binary from tooltool 10:33:47 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')]} 10:33:47 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 0x109cfae00>, '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 0x109b23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109cf5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:33:47 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 10:33:47 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 10:33:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:33:47 INFO - Return code: 0 10:33:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:33:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:33:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:33:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:33:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:33:48 INFO - Return code: 0 10:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:33:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kjXhOPd8h3/Render', 10:33:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:48 INFO - 'HOME': '/Users/cltbld', 10:33:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:48 INFO - 'LOGNAME': 'cltbld', 10:33:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:33:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:48 INFO - 'MOZ_NO_REMOTE': '1', 10:33:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:33:48 INFO - 'NO_EM_RESTART': '1', 10:33:48 INFO - 'PAGER': '/bin/cat', 10:33:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:48 INFO - 'PWD': '/builds/slave/test', 10:33:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:33:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:48 INFO - 'SHELL': '/bin/bash', 10:33:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mrFTPBWxXB/Listeners', 10:33:48 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 10:33:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:48 INFO - 'USER': 'cltbld', 10:33:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:48 INFO - 'XPC_FLAGS': '0x0', 10:33:48 INFO - 'XPC_SERVICE_NAME': '0', 10:33:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:33:49 INFO - mozversion application_buildid: 20160408094259 10:33:49 INFO - mozversion application_changeset: 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a 10:33:49 INFO - mozversion application_display_name: Nightly 10:33:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:33:49 INFO - mozversion application_name: Firefox 10:33:49 INFO - mozversion application_remotingname: firefox 10:33:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:33:49 INFO - mozversion application_vendor: Mozilla 10:33:49 INFO - mozversion application_version: 48.0a1 10:33:49 INFO - mozversion platform_buildid: 20160408094259 10:33:49 INFO - mozversion platform_changeset: 9c492faa4c397c9fd2a9448fce84117d0e2f8a2a 10:33:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:33:49 INFO - mozversion platform_version: 48.0a1 10:33:49 INFO - using testdate: 1460136829 10:33:49 INFO - actual date: 1460136829 10:33:49 INFO - starting webserver on 'localhost:49278' 10:33:49 INFO - SUITE-START | Running 2 tests 10:33:49 INFO - TEST-START | dromaeo_css 10:33:49 INFO - operating with platform_type : mac_ 10:33:49 INFO - Initialising browser for dromaeo_css test... 10:33:49 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmphMrToD/profile http://localhost:49278/getInfo.html) 10:33:51 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 10:33:51 INFO - PROCESS | 1671 | colorDepth:24 10:33:51 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 10:33:51 INFO - PROCESS | 1671 | __metrics 10:33:51 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:33:51 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:33:52 INFO - TEST-INFO | 1671: exit 0 10:33:52 INFO - Browser initialized. 10:33:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:33:52 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmphMrToD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:04 INFO - PROCESS | 1674 | RSS: Main: 237678592 10:34:04 INFO - PROCESS | 1674 | 10:34:55 INFO - PROCESS | 1674 | 1460136895319 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] 10:37:05 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 10:37:07 INFO - PROCESS | 1674 | RSS: Main: 373538816 10:37:07 INFO - PROCESS | 1674 | 10:40:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 10:40:10 INFO - PROCESS | 1674 | RSS: Main: 383442944 10:40:10 INFO - PROCESS | 1674 | 10:43:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 10:43:13 INFO - PROCESS | 1674 | RSS: Main: 378134528 10:43:13 INFO - PROCESS | 1674 | 10:46:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 10:46:15 INFO - PROCESS | 1674 | RSS: Main: 337018880 10:46:15 INFO - PROCESS | 1674 | 10:49:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 10:49:19 INFO - PROCESS | 1674 | RSS: Main: 337924096 10:49:19 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 10:52:22 INFO - PROCESS | 1674 | RSS: Main: 383942656 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | __start_tp_report 10:52:22 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 10:52:22 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 10:52:22 INFO - PROCESS | 1674 | |i|pagename|runs| 10:52:22 INFO - PROCESS | 1674 | |0;dojo.html;3402.69375756182;3453.792772433656;3485.738569607277;3490.755647104702;3499.877504287349;5599.384067752544;5715.914261286073;5740.225069615601;5743.138529220619;5744.167095771116;5726.31284245891;5734.340550836655;5825.30096388434;5877.9412205877925;5885.470307672309;5086.211637196222;5152.845414637558;5175.896482070356;5191.792328306863;5305.3898801637915;5274.525292723654;5281.392639846428;5306.151015837467;5307.708076055816;5357.785688572452;5110.207917772751;5148.3821941366905;5200.479952004807;5236.345456817898;5280.1815718563685;5138;5141.562967147797;5152.974235128838;5169.327987361657;5205.011047900886;5104.106781313255;5113.1052065888325;5124.795008199668;5160.716160611165;5163.457836927106;5527.778888844441;5549.5837812163845;5591.440855914417;5660.716964151776;5683.318001839764;6205.379462053758;6216.627002379872;6219.782307619257;6228;6232.470240029603;4808.3989501312335;6247.781327653556;6250.281217659982;6250.499960003189;6257.78097766576;5730.656160630334;5794.188813566104;5838.766449342022;5843.795467158629;5878.2064421302575;6274;6288.371162883766;6299.716512756937;6315.936840631627;6332.651704156224;6103.35914728956;6108.08378743192;6137.846553836101;6168.629882207082;6177.62934223948;6139.048447490646;6222.253329600477;6241.157443745127;6246.187995560639;6256.311805701369;6114.023656277693;6184.752609895644;6197.070439434031;6209.627422354673;6213;6181.907271390933;6184.381561843869;6193.287771906288;6193.876122477615;6195.907061393992;4791.928121078186;4926.187179115477;4932.975335123301;4937.753112344369;4989.575886049726;4428;4440.289553671397;4450.910981780346;4457.531959144243;4464.888377790517;5585.944140558624;5625.634333768374;5631.6902570359025;5634.943650563442;5640.379558248589;5184.714840683799;6109.28320792043;6118.923762351576;6121.209103132385;6128.3503509891225;5674.460926212003;5708.828735137952;5712.542996560265;5722.54219662426;5753.194552762533;5382.30030096085;5386.757595908115;5387.973060134675;5403.324584426947;5404.945950540523;6202.534809889276;6258.061290806416;6298.338674439209;6336.524760642878;6358.77744278948;6146.600470969552;6182.567220294536;6183.81448556544;6188.876222475616;6199.721012554356;6249.500039996698;6290.1508296381235;6294.339094395205;6300.968495157678;6303.842403939938;6011.819645410645;6120.477608373184;6168.845778855385;6224.502039836711;6230.127782110418;5503.394626590992;5968.104784282393;6218.595791273553;6269.185005949197;6288.496920246278;5939.376365481735;6114.510839132948;6127.509799216141;6132.9080063799975;6142.9078563820685;6065.6663883486835;6104.48947159306;6120.995732433061;6139.522803442411;6142.744345496893;4446.955530444654;5867.471927526543;5934.43622855828;5954.374790647093;5982.850428739316;5963.075723262901;6011.6994150293185;6058.5153187745755;6078.513718902389;6083.057126145278;5858.677772722541;5867.090600956859;5871.94128058714;5875.148103525051;5911.527077833849 10:52:22 INFO - PROCESS | 1674 | |1;ext.html;507.72582805285145;509.4345276742817;527.9419263880974;563.1243416487362;591.5858898770856;29365.41269174618;29930.25174370642;32589.67410325893;34524.82737586315;37421.81289093551;43079.35380969288;44007.77996110015;44016.77991610045;44062.7796861016;44112.77943610278;8961.372703910696;9024.819503609924;9535.761605959871;9733.951330243339;9746.658866939659;9540.761480962961;9668.903310966905;9680.467574283412;9692.854607180898;9705.320627556039;9690.224782017456;9746.658866939659;9762.316637835354;9771.462569558671;9783.119519243266;9661;9717.805643887083;9717.902820971842;9723.611055557769;9731.12419882214;9575.61697532098;9672.93597704252;9681.951590242004;9683.612655493771;9702.951485242529;40218.19563608711;40487;40534.986625334306;40599;40617.593824061674;3109.9067027989195;3168.984155079233;3383.983080084584;3466.977241713675;3534.9116272093147;24398.26805195847;28381.858090709622;29461.263468413246;30216.24459388511;30399.696003040128;2600.64891239684;2691.9905035611646;2810.8172968756967;2860.4994126027864;2874.1377586723897;341878;342774.28902843856;342853.9999999975;342906;343742;57896.71051644715;58727.18273312221;58838;58842.41157588369;58842.41157588369;60815.08777368343;61851.38148618456;61886.38113618896;61930.071048934304;61959.69020154871;15681;16214.837851621332;16241;16247.350105995863;16310.510684679479;12601.558945436866;12657.367131643381;12669.429875655618;12671.936640316739;12686.936565317113;17532.561685957953;18138.274469021093;18182.818171818377;18218.08909554517;18312;6750.898736518956;6783.898241526381;6901.206361268418;6919.37725604698;6933.895991560131;827.7516744976604;915.7838031962666;1051.222095649214;1072.7823919850869;1153.8557680289964;28824.09010834364;29635.40729185404;29764.702352976194;30186.094417167522;30735.2316192097;1038.8337865941564;1054.5518154784186;1153.0141728821905;1165.988340116588;1223.3760782001066;13293.66765830862;14900.70198596022;15057.397704091933;15250.466233681767;15398.230088495531;554686;558450;561779;561996;562058;60504.78990420167;61012.69493652503;61317.69341153266;61373;61453.69273153606;1309.7576948264411;1355.5391167003265;1357.7013057127417;1486.591187423467;1595.6330044089925;24825.758712064686;28766.568501472913;30075.849620751756;30638.693613063584;32099.839500802347;55902.44097558972;55935.44064559302;56246.71876640591;56445.43554564402;56446.435535644116;446095;449967;450346;450355;450439;35489.64510354863;37448.812755936044;38989.415158773205;39007.219855603296;39012.024699382746;44399;44836.32745508755;44911;45390.773046134556;46232.53767462282;31368.902088426796;32370.676293236767;36732;37156.44265335968;37931.43102853404;36584.45123323205;36614.8169259152;37017.074573135884;37336.81331593324;37489.437658435694;36092.819535902156;36612.63387366199;36970.075748106516;37295.6270437303;37323.440148397254;31027.224319392197;31603.522343184326;32145;32210.83894580512;32248.871289504754;22566.548669026855;23656.29031129069;24197.87901060554;24276;24717.134900278405 10:52:22 INFO - PROCESS | 1674 | |2;jquery.html;331.19519567451096;383.6547107603157;391.53602980468145;398.0288097043214;405.6004835237293;18583.163757630904;20859.582808343825;21497;21952.670709939324;21984;20527.07628156733;21078.473038174052;21544.569108617856;21556.245531406403;21604.675929861063;5391.73041347933;5870.70646467677;6195.504359651217;6206.565540412173;6214.596051256676;6059.697015149247;6108.511319094484;6110.175126357929;6167.04410816322;6186.474149697258;5936.554758393117;6105.32841387447;6165.63006219626;6167.568270221086;6177.845553861167;5625.437456254383;6014.729337179838;6152.907706384385;6154.938450615504;6163.938360616381;5575.080111781551;5778.27771528559;5781.219535362714;5794.188813566104;5795.159701843209;13511;13814.309284535733;14140.363683634261;14165.858341416557;14176.291185440687;1998.510364960594;2000.7499062617173;2103.7159983402353;2294.8393612447135;2685.624012638232;9602.66390676323;9901.960294169152;9953.452560109192;10305.793884122351;11928.821067683992;1737.261663792883;1805.1064722962087;1812.7552780374613;1855.0261112915691;1873.475426880462;115392.42303788428;119220.80779192183;119847;120207.19689204669;122968;11250.943745281222;11429.142814288962;11560.248583842023;11595.188336816342;11667.124965627612;12383.938080309721;15009.024413413093;15130.621734456727;15152.31814568347;15167.772483412758;7166.67416527944;8156.1028286888395;8178.918210817816;8436.873446898302;8518.48889066658;6242.406971337716;8140.226678465537;8200.630971606291;8286;8300.460470069547;4001.359782434855;4458.576435238647;4554.203014472454;4591.655625828076;4612.423447069116;1892.4606487151095;1960.4412742368356;1962.9705554416696;1973.329068116847;1977.317825350252;858.7037472072125;918.7197904639149;955.8375076236917;1010.8635334229784;1045.289203341735;19808.90095549513;20521.589568208554;20593.38219853407;20673.793262067487;20765.58468830615;907.4328544659588;953.0659953245857;962.7352478068588;979.1383582447401;1005.3364779245662;7446.925530744732;10687.83968240477;10879.075278601249;10885;11052.834207486894;546078;609338;611444;628558.7144128592;630839;135062;136672;136724.63275367118;137125;140691;979.5934687104772;996.3025881882711;1008.7125169326706;1009;1009.9091081802673;15172.696546069237;18180.909095454437;18274.451766446495;18332.266709331478;18478.81521184771;50078.24882626691;50876.23685644644;51085;51924.74037629788;52130.436086917456;71169.6441517789;71294.64352678203;72131.63934180296;72324.63837680778;73232.1691957684;6847.21257055425;7587.924120758722;7650.579218142833;7947.443678942419;8049.993750781152;11289.20975531705;12587.68530786701;12626.873731262569;12747.745045099231;13186.274754888573;9366.484843333683;11041.613543525938;11099.056580190774;11183.888161118284;11195.38425386579;5217.843464696065;9640.517974101407;10405.814778896516;10853.186011049362;11078.169137314895;11105.500252488497;11437.714057148638;11483.598074067368;11484.253523520945;11651.359175245443;6726.764563240459;7625.7641746912095;7645.961770191114;7674.884876726742;7878.330341921001;8669.739907802776;8930.955345223232;9459.621615135318;10815.70211574616;11215.71960700989 10:52:22 INFO - PROCESS | 1674 | |3;mootools.html;1387.7710177820657;1396.1343966740621;1598.3446786817408;1793.4350679535946;1982.3953694123295;7872.29149376556;8552.05927347992;8762.21140097392;8797.296216302697;8812.339074569418;8454.746357609267;8704.651813927436;8707.34694897882;8711.520866352364;8712.17234362736;2115.492281852352;2379.5003049359657;2434.0750514804395;2462.9753702462926;2469.5307891500556;2501.3496490912403;2524.3058159006237;2528.317354314334;2529.2665127113114;2532.126416386344;2435.3668046308;2496.2386472125995;2496.475740094573;2496.6005439129744;2503.624456331556;2416.118116887341;2444.963325550118;2450.6691596634405;2453.828232023759;2458.4714286428502;2433.902643894242;2441.865697386643;2448.7061552613623;2460.458699086198;2466.5683505386664;8637.136286371375;8806;8815.030346661862;8815.51514666693;8820.823583528358;5088.669236499616;5285.312909321802;5289.709066001368;5295.867603309909;5305.7877684892555;2872.468593310244;3512.718982481421;3543.7342199335153;3569.8929032129076;3578.4632305154173;1020.4489575629151;1035.1460045462522;1036.6423583863555;1042.4162469017374;1043.2801367056707;11000.174986876016;11019.779604407868;11021.614243501519;11030.117590592814;11041.889581104166;3993.6206060424215;4541.750203738826;4629.444466664022;4732.787024583902;4845.297431872429;9515.33392662507;9516.23870090405;9522.714318570454;9525.523723813782;9542.379745316532;5209.609279304067;5223.895522089537;5226.503482169188;5243.082460569385;5270.973645131827;3715.888523344304;4370.300751879748;4735.952640473552;4880.804767809319;4939.382577177853;3901.902452438712;3949.9012524686536;4042.777647229431;4087.46862907826;4115.238680844053;1306.0922658752265;1314.9408276627576;1317.4269192900927;1333.839939207282;1337.2912356451097;1361.6527785414655;1368.7673095573775;1369.0963963784054;1405.7048019915933;1412.6397768569154;8089.39329550286;8102.918970810334;8162.102168761431;8179.263866252066;8189.1401402853035;505.36071869085634;506.6377540058802;511.1821086261951;514.2004183494702;518.1450606499232;6205.627662340274;6345.619262844152;6351.618902865843;6357.713902874381;6365.363463653597;9734.805303893883;10630.68107956747;10634.255602107933;10752.677419677422;10779.628481734006;10312.484375781181;10583.523741431654;10626.415547144981;10669.146468282519;10684.89315106839;8121.187881211831;8158.959205203936;8183.058948220912;8203.507789532528;8241.340692744567;7932.524048557105;8001.479903806234;8048.476849004796;8071.798205044921;8098.635561399869;9660;9711.854322185032;9820.607175713178;9915.504224788876;10008.249381296286;9804.705858824247;9990.750231243986;10054.597816087567;10163.796724065625;10241.641542545975;6694.163229596301;7193.712251509881;7492.138404083382;7495.88756168647;7554.773356799305;8200.917990820255;8207.794805129919;8250.257476827115;8273.544955027532;8275.420720549744;7213.963930180315;7301.488895777457;7339.009233753375;7439.330460258603;7484.101907771103;7092.468064895257;7095.325944035309;7150.356467917913;7161.248068952893;7175.748848790267;6726.966365168143;7635.740102882962;7714.922850771421;7807;7826.686932522635;6911.827204319932;6953.826154345979;7045.894311585433;7071.71713131469;7106.076210092861;7078.221395646578;7200.747973820891;7234.529755565872;7235.710571577078;7239.348458638748 10:52:22 INFO - PROCESS | 1674 | |4;prototype.html;285.8836244465362;313.87445021991203;316.4635942078177;324.26877391482213;330.44155377412187;5092.694438333702;5625.971870140649;5898.705064746761;5907.911381329272;5931.703414829252;4861.902761944768;5707.857303567413;5726.3414707308675;5810.418958104187;5810.912836307459;3789;4052.9797351013353;4098.692598055143;4160.791960401983;4368.781560921957;3566.6968307693746;4323.357124292765;4335.176316499871;4353.455818022747;4375.606195442409;4299.31211006239;4321.1141715948315;4332.371806088131;4334.891627709317;4371.868843934687;3661.066428060854;4193.391958166079;4240.427542281784;4335.869923902288;4349.782510874459;3567.1795487038125;3787.6023017583307;3788.3370410178386;3808.6000969898314;3832.3485007548784;4794.640401969867;5538.418466061086;5539.556835453194;5540.390557038722;5594.692291923942;3968;4205.87382378526;4750.95249047512;4881.657544175345;5033.144365457881;5524.33707955048;6038.229798459256;6052.757889684407;6105.664188469633;6118.418750218722;3564.6078931317534;4253;4257.914841703179;4259.446271984653;4259.595338442843;5209.453007434203;5415.702136382497;5892.911606325909;6438.742450302029;6439.871202575969;4288.549702281278;4316.762578058174;4320.870373888788;4325.4593175853015;4345.500267469219;4387.254166791653;4402.207602631493;4403.493598236244;4421.40311058003;4427.734335939854;4258.361245813153;4544.931826022612;5037.29477873098;5062.987402519437;5104.259882317043;4862;6120.663363515049;6161;6182.948898687234;6205.317415084337;1280.7118398360294;1494.6487575419767;1524.1388615432245;1529.17424590722;1532.3947040918997;888.595688961521;931.0735817861272;1010.282699283517;1019.6635110413546;1028.285341687535;5657.6039677223025;5684.232628595087;5691.68695721731;5714.714264286769;5741.85645358861;4895.632827537949;6042.154098426224;6307.274663413675;6335.936640633627;6351.714172862232;5189.870253243699;5451.727413629303;5614.550835933115;5705.400932902068;5734.225879506297;2918.664353599363;3335.8832440864453;3339.8497067632015;3351.715104216169;3367.9494807577908;6244;6585.703643335965;6602.570832895846;6603.372679595431;6666.200055993312;5283;5429.511343978982;5721.998650236192;6334.334894836068;6507.772227971998;6273.905891411632;6607.876660967647;6616.533839658211;6641.634710090992;6674.065630811593;5270.631055826056;6441.194850643669;6455.870882582416;6462.838429039311;6493.8701225976165;5825.893080314727;6033.42682445167;6375.6174629522375;6380.457661098859;6401.327860574759;5747.695075331618;5914.556408269311;6643.634600096848;6646.202455705346;6699.196096468455;3852.5569559499895;3891.591382904754;4044.4944381952255;4120.361343991686;4157.750534967911;4990.850274491771;6164.4143806338325;6382.266039405342;6488.124103246001;6503.382178693017;4955.011215971178;5769.53843692512;6144.067796610084;6206.534509911684;6254.405831446005;5397.622166448311;5400.2709634200455;5849.824505264849;5883.499902508334;6199.535034872312;6053.273607167168;6064.332923378513;6071.3625069368845;6093.238345206849;6115.3578874217565;5170.208087632636;6213.1922850029205;6219.968900155471;6236.282827474898;6268.27914789805;5394.838154855203;5654.010548154139;5816.982028145142;6118.847028824137;6140.416660417253 10:52:22 INFO - PROCESS | 1674 | |5;yui.html;692.7402224165937;726.5422783646302;740.2079774641132;763.9770806875796;814.1126172472004;14740.778888316683;14805.851941480596;15320.080795152298;15665;15667.29497172627;14114.012019158663;14134.293285335718;14137.646558836033;14160.645983850409;14163.22102284374;890.9643614255439;900.4867225681364;906.3972458315212;906.5059542549293;908.2869947091534;703.5884007855411;722.7109156337481;875.089906497242;887.3566664168459;888.835565420396;946.5361972633428;949.4066208619613;955.4124213608616;956.1203692602822;958.7698952251479;944.8063147054871;945.0219023310909;945.546137853834;947.0103741589986;947.1191791633778;541.5938046465151;679.5956405938458;703.3283214530112;705.6189657584898;710.3322876496129;14753.336099875423;14809.777853332209;14833.851661483355;14838.33227504765;14864.108153510824;12132;12321.445534950948;12334.5066197352;12467.189632673937;12750.234985900783;9871.555779989845;9919.355241909252;10012.24908131893;10259.384436933808;10456.738581535446;3384.272381437978;3418.8119653419053;3479.878204262864;3541.3625547401457;3745.3071181831447;74445.69428821397;75118;75309.62345188294;76168;78366.43267134682;9307.395019323721;9432.95283523578;9536.475493847765;9551.283653725859;9666.95166524163;21005.264815731374;21012.894935525226;21030.47423814417;21044.473888152614;21052;7480.17718051014;7495.887561686579;7580.886286705704;7589.354904833151;7629.427792915553;4153.813078411418;4188.162367526507;4188.434561334242;4196.265653510623;4209.621134097946;3495.475678648172;3599.136207310279;3605.8197090145386;3616.0959760059986;3617.909552261162;637.7895294552786;640.4972096903908;652.8596351784295;659.2484567592948;664.7108507799123;498.7481321932401;503.7959626351334;548.4351118348108;594.3284088979426;595.7429823073312;7771.4559980800805;7814.804629884185;8047.155048719917;8168.019837619405;8242.2581967622;552.3896094815252;567.140781715701;594.1635090364437;594.3818428833964;599.4694695194784;3747.887563373103;3802.341971699115;3811.542614886176;3813;4044.69664775143;87734.12265877388;89215.10784892198;89504;89660.5516972424;90902.54548727215;75242.24757752461;76015.47969040589;76109.61945190349;76342.2365776335;77528;67358;67989.52115267317;68106.65946670334;68220;68517.97223041658;7451.366633835968;7581.696732130653;7656.349210316963;7689.692412303445;7734.071911370672;42581;42813.785931070146;42926.35610465783;42999.71000869979;43041;56429.43570564242;61698;62446.68776656088;62484.68757656364;62681.373186269375;8703.695370661997;10119.342242754197;10159.796804064024;10162;10246.487675616041;11787;11940.880591193976;12247.938760306142;12255.69360765988;12324.198927069712;11309.943450282695;11362.091032717197;11550.279120955922;11598;11657.825132622847;11088.611898583833;11183.32900026001;11231.606893758679;11252.887471125185;11266.94366528162;11305.491252893804;11415;11482.368469734245;11701.122415818678;11743.706407339543;9394.710248457854;9694.951525242328;9719.708408747749;9736.805263894825;10067.395956242648;9466.52667366615;9714.562844671866;9735.951320243354;9777.560009799434;9788 10:52:22 INFO - PROCESS | 1674 | __end_tp_report 10:52:22 INFO - PROCESS | 1674 | __start_cc_report 10:52:22 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1281 10:52:22 INFO - PROCESS | 1674 | __end_cc_report 10:52:22 INFO - PROCESS | 1674 | __startTimestamp1460137942801__endTimestamp 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | ------- Summary: start ------- 10:52:22 INFO - PROCESS | 1674 | Number of tests: 6 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5707.52 Median:5878.21 stddev:629.24 (10.7%) stddev-sans-first:604.63 10:52:22 INFO - PROCESS | 1674 | Values: 3402.7 3453.8 3485.7 3490.8 3499.9 5599.4 5715.9 5740.2 5743.1 5744.2 5726.3 5734.3 5825.3 5877.9 5885.5 5086.2 5152.8 5175.9 5191.8 5305.4 5274.5 5281.4 5306.2 5307.7 5357.8 5110.2 5148.4 5200.5 5236.3 5280.2 5138.0 5141.6 5153.0 5169.3 5205.0 5104.1 5113.1 5124.8 5160.7 5163.5 5527.8 5549.6 5591.4 5660.7 5683.3 6205.4 6216.6 6219.8 6228.0 6232.5 4808.4 6247.8 6250.3 6250.5 6257.8 5730.7 5794.2 5838.8 5843.8 5878.2 6274.0 6288.4 6299.7 6315.9 6332.7 6103.4 6108.1 6137.8 6168.6 6177.6 6139.0 6222.3 6241.2 6246.2 6256.3 6114.0 6184.8 6197.1 6209.6 6213.0 6181.9 6184.4 6193.3 6193.9 6195.9 4791.9 4926.2 4933.0 4937.8 4989.6 4428.0 4440.3 4450.9 4457.5 4464.9 5585.9 5625.6 5631.7 5634.9 5640.4 5184.7 6109.3 6118.9 6121.2 6128.4 5674.5 5708.8 5712.5 5722.5 5753.2 5382.3 5386.8 5388.0 5403.3 5404.9 6202.5 6258.1 6298.3 6336.5 6358.8 6146.6 6182.6 6183.8 6188.9 6199.7 6249.5 6290.2 6294.3 6301.0 6303.8 6011.8 6120.5 6168.8 6224.5 6230.1 5503.4 5968.1 6218.6 6269.2 6288.5 5939.4 6114.5 6127.5 6132.9 6142.9 6065.7 6104.5 6121.0 6139.5 6142.7 4447.0 5867.5 5934.4 5954.4 5982.9 5963.1 6011.7 6058.5 6078.5 6083.1 5858.7 5867.1 5871.9 5875.1 5911.5 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:60256.82 Median:37379.31 stddev:122143.04 (326.8%) stddev-sans-first:122403.30 10:52:22 INFO - PROCESS | 1674 | Values: 507.7 509.4 527.9 563.1 591.6 29365.4 29930.3 32589.7 34524.8 37421.8 43079.4 44007.8 44016.8 44062.8 44112.8 8961.4 9024.8 9535.8 9734.0 9746.7 9540.8 9668.9 9680.5 9692.9 9705.3 9690.2 9746.7 9762.3 9771.5 9783.1 9661.0 9717.8 9717.9 9723.6 9731.1 9575.6 9672.9 9682.0 9683.6 9703.0 40218.2 40487.0 40535.0 40599.0 40617.6 3109.9 3169.0 3384.0 3467.0 3534.9 24398.3 28381.9 29461.3 30216.2 30399.7 2600.6 2692.0 2810.8 2860.5 2874.1 341878.0 342774.3 342854.0 342906.0 343742.0 57896.7 58727.2 58838.0 58842.4 58842.4 60815.1 61851.4 61886.4 61930.1 61959.7 15681.0 16214.8 16241.0 16247.4 16310.5 12601.6 12657.4 12669.4 12671.9 12686.9 17532.6 18138.3 18182.8 18218.1 18312.0 6750.9 6783.9 6901.2 6919.4 6933.9 827.8 915.8 1051.2 1072.8 1153.9 28824.1 29635.4 29764.7 30186.1 30735.2 1038.8 1054.6 1153.0 1166.0 1223.4 13293.7 14900.7 15057.4 15250.5 15398.2 554686.0 558450.0 561779.0 561996.0 562058.0 60504.8 61012.7 61317.7 61373.0 61453.7 1309.8 1355.5 1357.7 1486.6 1595.6 24825.8 28766.6 30075.8 30638.7 32099.8 55902.4 55935.4 56246.7 56445.4 56446.4 446095.0 449967.0 450346.0 450355.0 450439.0 35489.6 37448.8 38989.4 39007.2 39012.0 44399.0 44836.3 44911.0 45390.8 46232.5 31368.9 32370.7 36732.0 37156.4 37931.4 36584.5 36614.8 37017.1 37336.8 37489.4 36092.8 36612.6 36970.1 37295.6 37323.4 31027.2 31603.5 32145.0 32210.8 32248.9 22566.5 23656.3 24197.9 24276.0 24717.1 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:34860.01 Median:1508.41 stddev:101375.21 (6720.7%) stddev-sans-first:101626.44 10:52:22 INFO - PROCESS | 1674 | Values: 331.2 383.7 391.5 398.0 405.6 18583.2 20859.6 21497.0 21952.7 21984.0 20527.1 21078.5 21544.6 21556.2 21604.7 5391.7 5870.7 6195.5 6206.6 6214.6 6059.7 6108.5 6110.2 6167.0 6186.5 5936.6 6105.3 6165.6 6167.6 6177.8 5625.4 6014.7 6152.9 6154.9 6163.9 5575.1 5778.3 5781.2 5794.2 5795.2 13511.0 13814.3 14140.4 14165.9 14176.3 1998.5 2000.7 2103.7 2294.8 2685.6 9602.7 9902.0 9953.5 10305.8 11928.8 1737.3 1805.1 1812.8 1855.0 1873.5 115392.4 119220.8 119847.0 120207.2 122968.0 11250.9 11429.1 11560.2 11595.2 11667.1 12383.9 15009.0 15130.6 15152.3 15167.8 7166.7 8156.1 8178.9 8436.9 8518.5 6242.4 8140.2 8200.6 8286.0 8300.5 4001.4 4458.6 4554.2 4591.7 4612.4 1892.5 1960.4 1963.0 1973.3 1977.3 858.7 918.7 955.8 1010.9 1045.3 19808.9 20521.6 20593.4 20673.8 20765.6 907.4 953.1 962.7 979.1 1005.3 7446.9 10687.8 10879.1 10885.0 11052.8 546078.0 609338.0 611444.0 628558.7 630839.0 135062.0 136672.0 136724.6 137125.0 140691.0 979.6 996.3 1008.7 1009.0 1009.9 15172.7 18180.9 18274.5 18332.3 18478.8 50078.2 50876.2 51085.0 51924.7 52130.4 71169.6 71294.6 72131.6 72324.6 73232.2 6847.2 7587.9 7650.6 7947.4 8050.0 11289.2 12587.7 12626.9 12747.7 13186.3 9366.5 11041.6 11099.1 11183.9 11195.4 5217.8 9640.5 10405.8 10853.2 11078.2 11105.5 11437.7 11483.6 11484.3 11651.4 6726.8 7625.8 7646.0 7674.9 7878.3 8669.7 8931.0 9459.6 10815.7 11215.7 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5975.48 Median:5225.20 stddev:3155.63 (60.4%) stddev-sans-first:3145.63 10:52:22 INFO - PROCESS | 1674 | Values: 1387.8 1396.1 1598.3 1793.4 1982.4 7872.3 8552.1 8762.2 8797.3 8812.3 8454.7 8704.7 8707.3 8711.5 8712.2 2115.5 2379.5 2434.1 2463.0 2469.5 2501.3 2524.3 2528.3 2529.3 2532.1 2435.4 2496.2 2496.5 2496.6 2503.6 2416.1 2445.0 2450.7 2453.8 2458.5 2433.9 2441.9 2448.7 2460.5 2466.6 8637.1 8806.0 8815.0 8815.5 8820.8 5088.7 5285.3 5289.7 5295.9 5305.8 2872.5 3512.7 3543.7 3569.9 3578.5 1020.4 1035.1 1036.6 1042.4 1043.3 11000.2 11019.8 11021.6 11030.1 11041.9 3993.6 4541.8 4629.4 4732.8 4845.3 9515.3 9516.2 9522.7 9525.5 9542.4 5209.6 5223.9 5226.5 5243.1 5271.0 3715.9 4370.3 4736.0 4880.8 4939.4 3901.9 3949.9 4042.8 4087.5 4115.2 1306.1 1314.9 1317.4 1333.8 1337.3 1361.7 1368.8 1369.1 1405.7 1412.6 8089.4 8102.9 8162.1 8179.3 8189.1 505.4 506.6 511.2 514.2 518.1 6205.6 6345.6 6351.6 6357.7 6365.4 9734.8 10630.7 10634.3 10752.7 10779.6 10312.5 10583.5 10626.4 10669.1 10684.9 8121.2 8159.0 8183.1 8203.5 8241.3 7932.5 8001.5 8048.5 8071.8 8098.6 9660.0 9711.9 9820.6 9915.5 10008.2 9804.7 9990.8 10054.6 10163.8 10241.6 6694.2 7193.7 7492.1 7495.9 7554.8 8200.9 8207.8 8250.3 8273.5 8275.4 7214.0 7301.5 7339.0 7439.3 7484.1 7092.5 7095.3 7150.4 7161.2 7175.7 6727.0 7635.7 7714.9 7807.0 7826.7 6911.8 6953.8 7045.9 7071.7 7106.1 7078.2 7200.7 7234.5 7235.7 7239.3 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:4938.86 Median:5488.03 stddev:1540.26 (28.1%) stddev-sans-first:1504.47 10:52:22 INFO - PROCESS | 1674 | Values: 285.9 313.9 316.5 324.3 330.4 5092.7 5626.0 5898.7 5907.9 5931.7 4861.9 5707.9 5726.3 5810.4 5810.9 3789.0 4053.0 4098.7 4160.8 4368.8 3566.7 4323.4 4335.2 4353.5 4375.6 4299.3 4321.1 4332.4 4334.9 4371.9 3661.1 4193.4 4240.4 4335.9 4349.8 3567.2 3787.6 3788.3 3808.6 3832.3 4794.6 5538.4 5539.6 5540.4 5594.7 3968.0 4205.9 4751.0 4881.7 5033.1 5524.3 6038.2 6052.8 6105.7 6118.4 3564.6 4253.0 4257.9 4259.4 4259.6 5209.5 5415.7 5892.9 6438.7 6439.9 4288.5 4316.8 4320.9 4325.5 4345.5 4387.3 4402.2 4403.5 4421.4 4427.7 4258.4 4544.9 5037.3 5063.0 5104.3 4862.0 6120.7 6161.0 6182.9 6205.3 1280.7 1494.6 1524.1 1529.2 1532.4 888.6 931.1 1010.3 1019.7 1028.3 5657.6 5684.2 5691.7 5714.7 5741.9 4895.6 6042.2 6307.3 6335.9 6351.7 5189.9 5451.7 5614.6 5705.4 5734.2 2918.7 3335.9 3339.8 3351.7 3367.9 6244.0 6585.7 6602.6 6603.4 6666.2 5283.0 5429.5 5722.0 6334.3 6507.8 6273.9 6607.9 6616.5 6641.6 6674.1 5270.6 6441.2 6455.9 6462.8 6493.9 5825.9 6033.4 6375.6 6380.5 6401.3 5747.7 5914.6 6643.6 6646.2 6699.2 3852.6 3891.6 4044.5 4120.4 4157.8 4990.9 6164.4 6382.3 6488.1 6503.4 4955.0 5769.5 6144.1 6206.5 6254.4 5397.6 5400.3 5849.8 5883.5 6199.5 6053.3 6064.3 6071.4 6093.2 6115.4 5170.2 6213.2 6220.0 6236.3 6268.3 5394.8 5654.0 5817.0 6118.8 6140.4 10:52:22 INFO - PROCESS | 1674 | 10:52:22 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:17544.34 Median:62072.34 stddev:24338.18 (39.2%) stddev-sans-first:24373.56 10:52:22 INFO - PROCESS | 1674 | Values: 692.7 726.5 740.2 764.0 814.1 14740.8 14805.9 15320.1 15665.0 15667.3 14114.0 14134.3 14137.6 14160.6 14163.2 891.0 900.5 906.4 906.5 908.3 703.6 722.7 875.1 887.4 888.8 946.5 949.4 955.4 956.1 958.8 944.8 945.0 945.5 947.0 947.1 541.6 679.6 703.3 705.6 710.3 14753.3 14809.8 14833.9 14838.3 14864.1 12132.0 12321.4 12334.5 12467.2 12750.2 9871.6 9919.4 10012.2 10259.4 10456.7 3384.3 3418.8 3479.9 3541.4 3745.3 74445.7 75118.0 75309.6 76168.0 78366.4 9307.4 9433.0 9536.5 9551.3 9667.0 21005.3 21012.9 21030.5 21044.5 21052.0 7480.2 7495.9 7580.9 7589.4 7629.4 4153.8 4188.2 4188.4 4196.3 4209.6 3495.5 3599.1 3605.8 3616.1 3617.9 637.8 640.5 652.9 659.2 664.7 498.7 503.8 548.4 594.3 595.7 7771.5 7814.8 8047.2 8168.0 8242.3 552.4 567.1 594.2 594.4 599.5 3747.9 3802.3 3811.5 3813.0 4044.7 87734.1 89215.1 89504.0 89660.6 90902.5 75242.2 76015.5 76109.6 76342.2 77528.0 67358.0 67989.5 68106.7 68220.0 68518.0 7451.4 7581.7 7656.3 7689.7 7734.1 42581.0 42813.8 42926.4 42999.7 43041.0 56429.4 61698.0 62446.7 62484.7 62681.4 8703.7 10119.3 10159.8 10162.0 10246.5 11787.0 11940.9 12247.9 12255.7 12324.2 11309.9 11362.1 11550.3 11598.0 11657.8 11088.6 11183.3 11231.6 11252.9 11266.9 11305.5 11415.0 11482.4 11701.1 11743.7 9394.7 9695.0 9719.7 9736.8 10067.4 9466.5 9714.6 9736.0 9777.6 9788.0 10:52:22 INFO - PROCESS | 1674 | -------- Summary: end -------- 10:52:22 INFO - PROCESS | 1674 | 10:52:23 INFO - TEST-INFO | 1674: exit 0 10:52:23 INFO - TEST-OK | dromaeo_css | took 1114269ms 10:52:23 INFO - TEST-START | kraken 10:52:23 INFO - operating with platform_type : mac_ 10:52:23 INFO - Initialising browser for kraken test... 10:52:23 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpFdlRmQ/profile http://localhost:49278/getInfo.html) 10:52:25 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 10:52:25 INFO - PROCESS | 1680 | colorDepth:24 10:52:25 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 10:52:25 INFO - PROCESS | 1680 | __metrics 10:52:25 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:52:25 ERROR - PROCESS | 1680 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:52:26 INFO - TEST-INFO | 1680: exit 0 10:52:26 INFO - Browser initialized. 10:52:26 INFO - Running cycle 1/1 for kraken test... 10:52:26 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpFdlRmQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:38 INFO - PROCESS | 1682 | RSS: Main: 237584384 10:52:38 INFO - PROCESS | 1682 | 10:52:40 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 10:52:41 INFO - PROCESS | 1682 | RSS: Main: 283918336 10:52:41 INFO - PROCESS | 1682 | 10:52:44 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 10:52:44 INFO - PROCESS | 1682 | RSS: Main: 293900288 10:52:44 INFO - PROCESS | 1682 | 10:52:48 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 10:52:48 INFO - PROCESS | 1682 | RSS: Main: 280260608 10:52:48 INFO - PROCESS | 1682 | 10:52:50 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 10:52:51 INFO - PROCESS | 1682 | RSS: Main: 283115520 10:52:51 INFO - PROCESS | 1682 | 10:52:53 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:52:54 INFO - PROCESS | 1682 | RSS: Main: 283205632 10:52:54 INFO - PROCESS | 1682 | 10:52:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 10:52:57 INFO - PROCESS | 1682 | RSS: Main: 283115520 10:52:57 INFO - PROCESS | 1682 | 10:53:00 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 10:53:00 INFO - PROCESS | 1682 | RSS: Main: 283275264 10:53:00 INFO - PROCESS | 1682 | 10:53:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 10:53:04 INFO - PROCESS | 1682 | RSS: Main: 283607040 10:53:04 INFO - PROCESS | 1682 | 10:53:05 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:53:06 INFO - PROCESS | 1682 | RSS: Main: 317997056 10:53:06 INFO - PROCESS | 1682 | 10:53:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:09 INFO - PROCESS | 1682 | RSS: Main: 319127552 10:53:09 INFO - PROCESS | 1682 | 10:53:11 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:11 INFO - PROCESS | 1682 | RSS: Main: 324169728 10:53:11 INFO - PROCESS | 1682 | 10:53:14 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:53:15 INFO - PROCESS | 1682 | RSS: Main: 325226496 10:53:15 INFO - PROCESS | 1682 | 10:53:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:53:18 INFO - PROCESS | 1682 | RSS: Main: 325611520 10:53:18 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 10:53:20 INFO - PROCESS | 1682 | RSS: Main: 389685248 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | __start_tp_report 10:53:20 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 10:53:20 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 10:53:20 INFO - PROCESS | 1682 | |i|pagename|runs| 10:53:20 INFO - PROCESS | 1682 | |0;ai-astar;110;109;109;109;110;112;115;111;111;112 10:53:20 INFO - PROCESS | 1682 | |1;audio-beat-detection;158;124;132;196;115;179;132;137;200;102 10:53:20 INFO - PROCESS | 1682 | |2;audio-dft;184;185;182;182;183;200;264;208;179;179 10:53:20 INFO - PROCESS | 1682 | |3;audio-fft;81;76;82;80;57;58;57;78;77;55 10:53:20 INFO - PROCESS | 1682 | |4;audio-oscillator;95;96;134;77;79;80;118;80;78;121 10:53:20 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;87;85;95;131;86;83;88;83;87;84 10:53:20 INFO - PROCESS | 1682 | |6;imaging-darkroom;92;93;94;94;93;93;94;93;94;92 10:53:20 INFO - PROCESS | 1682 | |7;imaging-desaturate;129;145;85;84;86;90;84;85;84;84 10:53:20 INFO - PROCESS | 1682 | |8;json-parse-financial;56;56;56;55;56;54;56;66;55;52 10:53:20 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;64;85;97;111;70;68;66;68;67;68 10:53:20 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;85;83;84;85;88;85;82;106;108;111 10:53:20 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;148;170;130;168;159;154;141;142;142;142 10:53:20 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;170;173;170;170;168;168;168;175;170;200 10:53:20 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;68;67;69;67;69;67;66;68;67;68 10:53:20 INFO - PROCESS | 1682 | __end_tp_report 10:53:20 INFO - PROCESS | 1682 | __start_cc_report 10:53:20 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1300 10:53:20 INFO - PROCESS | 1682 | __end_cc_report 10:53:20 INFO - PROCESS | 1682 | __startTimestamp1460138000837__endTimestamp 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | ------- Summary: start ------- 10:53:20 INFO - PROCESS | 1682 | Number of tests: 14 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.96 10:53:20 INFO - PROCESS | 1682 | Values: 110.0 109.0 109.0 109.0 110.0 112.0 115.0 111.0 111.0 112.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:147.50 stddev:34.12 (23.1%) stddev-sans-first:35.98 10:53:20 INFO - PROCESS | 1682 | Values: 158.0 124.0 132.0 196.0 115.0 179.0 132.0 137.0 200.0 102.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:194.60 Median:184.50 stddev:26.18 (14.2%) stddev-sans-first:27.49 10:53:20 INFO - PROCESS | 1682 | Values: 184.0 185.0 182.0 182.0 183.0 200.0 264.0 208.0 179.0 179.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:70.10 Median:77.50 stddev:11.65 (15.0%) stddev-sans-first:11.67 10:53:20 INFO - PROCESS | 1682 | Values: 81.0 76.0 82.0 80.0 57.0 58.0 57.0 78.0 77.0 55.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.50 stddev:21.19 (26.6%) stddev-sans-first:22.47 10:53:20 INFO - PROCESS | 1682 | Values: 95.0 96.0 134.0 77.0 79.0 80.0 118.0 80.0 78.0 121.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:86.50 stddev:14.51 (16.8%) stddev-sans-first:15.32 10:53:20 INFO - PROCESS | 1682 | Values: 87.0 85.0 95.0 131.0 86.0 83.0 88.0 83.0 87.0 84.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 10:53:20 INFO - PROCESS | 1682 | Values: 92.0 93.0 94.0 94.0 93.0 93.0 94.0 93.0 94.0 92.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:84.50 stddev:22.22 (26.3%) stddev-sans-first:20.01 10:53:20 INFO - PROCESS | 1682 | Values: 129.0 145.0 85.0 84.0 86.0 90.0 84.0 85.0 84.0 84.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.68 (6.6%) stddev-sans-first:3.90 10:53:20 INFO - PROCESS | 1682 | Values: 56.0 56.0 56.0 55.0 56.0 54.0 56.0 66.0 55.0 52.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:68.00 stddev:15.98 (23.5%) stddev-sans-first:16.31 10:53:20 INFO - PROCESS | 1682 | Values: 64.0 85.0 97.0 111.0 70.0 68.0 66.0 68.0 67.0 68.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:84.50 stddev:11.64 (13.8%) stddev-sans-first:12.09 10:53:20 INFO - PROCESS | 1682 | Values: 85.0 83.0 84.0 85.0 88.0 85.0 82.0 106.0 108.0 111.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:151.00 stddev:12.89 (8.5%) stddev-sans-first:13.66 10:53:20 INFO - PROCESS | 1682 | Values: 148.0 170.0 130.0 168.0 159.0 154.0 141.0 142.0 142.0 142.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:170.00 stddev:9.68 (5.7%) stddev-sans-first:10.20 10:53:20 INFO - PROCESS | 1682 | Values: 170.0 173.0 170.0 170.0 168.0 168.0 168.0 175.0 170.0 200.0 10:53:20 INFO - PROCESS | 1682 | 10:53:20 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 10:53:20 INFO - PROCESS | 1682 | Values: 68.0 67.0 69.0 67.0 69.0 67.0 66.0 68.0 67.0 68.0 10:53:20 INFO - PROCESS | 1682 | -------- Summary: end -------- 10:53:20 INFO - PROCESS | 1682 | 10:53:21 INFO - TEST-INFO | 1682: exit 0 10:53:21 INFO - TEST-OK | kraken | took 58222ms 10:53:21 INFO - SUITE-END | took 1172s 10:53:22 INFO - Completed test suite (00:19:32) 10:53:22 INFO - javascript benchmark 10:53:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.69375756182, 3453.792772433656, 3485.738569607277, 3490.755647104702, 3499.877504287349, 5599.384067752544, 5715.914261286073, 5740.225069615601, 5743.138529220619, 5744.167095771116, 5726.31284245891, 5734.340550836655, 5825.30096388434, 5877.9412205877925, 5885.470307672309, 5086.211637196222, 5152.845414637558, 5175.896482070356, 5191.792328306863, 5305.3898801637915, 5274.525292723654, 5281.392639846428, 5306.151015837467, 5307.708076055816, 5357.785688572452, 5110.207917772751, 5148.3821941366905, 5200.479952004807, 5236.345456817898, 5280.1815718563685, 5138.0, 5141.562967147797, 5152.974235128838, 5169.327987361657, 5205.011047900886, 5104.106781313255, 5113.1052065888325, 5124.795008199668, 5160.716160611165, 5163.457836927106, 5527.778888844441, 5549.5837812163845, 5591.440855914417, 5660.716964151776, 5683.318001839764, 6205.379462053758, 6216.627002379872, 6219.782307619257, 6228.0, 6232.470240029603, 4808.3989501312335, 6247.781327653556, 6250.281217659982, 6250.499960003189, 6257.78097766576, 5730.656160630334, 5794.188813566104, 5838.766449342022, 5843.795467158629, 5878.2064421302575, 6274.0, 6288.371162883766, 6299.716512756937, 6315.936840631627, 6332.651704156224, 6103.35914728956, 6108.08378743192, 6137.846553836101, 6168.629882207082, 6177.62934223948, 6139.048447490646, 6222.253329600477, 6241.157443745127, 6246.187995560639, 6256.311805701369, 6114.023656277693, 6184.752609895644, 6197.070439434031, 6209.627422354673, 6213.0, 6181.907271390933, 6184.381561843869, 6193.287771906288, 6193.876122477615, 6195.907061393992, 4791.928121078186, 4926.187179115477, 4932.975335123301, 4937.753112344369, 4989.575886049726, 4428.0, 4440.289553671397, 4450.910981780346, 4457.531959144243, 4464.888377790517, 5585.944140558624, 5625.634333768374, 5631.6902570359025, 5634.943650563442, 5640.379558248589, 5184.714840683799, 6109.28320792043, 6118.923762351576, 6121.209103132385, 6128.3503509891225, 5674.460926212003, 5708.828735137952, 5712.542996560265, 5722.54219662426, 5753.194552762533, 5382.30030096085, 5386.757595908115, 5387.973060134675, 5403.324584426947, 5404.945950540523, 6202.534809889276, 6258.061290806416, 6298.338674439209, 6336.524760642878, 6358.77744278948, 6146.600470969552, 6182.567220294536, 6183.81448556544, 6188.876222475616, 6199.721012554356, 6249.500039996698, 6290.1508296381235, 6294.339094395205, 6300.968495157678, 6303.842403939938, 6011.819645410645, 6120.477608373184, 6168.845778855385, 6224.502039836711, 6230.127782110418, 5503.394626590992, 5968.104784282393, 6218.595791273553, 6269.185005949197, 6288.496920246278, 5939.376365481735, 6114.510839132948, 6127.509799216141, 6132.9080063799975, 6142.9078563820685, 6065.6663883486835, 6104.48947159306, 6120.995732433061, 6139.522803442411, 6142.744345496893, 4446.955530444654, 5867.471927526543, 5934.43622855828, 5954.374790647093, 5982.850428739316, 5963.075723262901, 6011.6994150293185, 6058.5153187745755, 6078.513718902389, 6083.057126145278, 5858.677772722541, 5867.090600956859, 5871.94128058714, 5875.148103525051, 5911.527077833849], "value": 5670.060052952629, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.72582805285145, 509.4345276742817, 527.9419263880974, 563.1243416487362, 591.5858898770856, 29365.41269174618, 29930.25174370642, 32589.67410325893, 34524.82737586315, 37421.81289093551, 43079.35380969288, 44007.77996110015, 44016.77991610045, 44062.7796861016, 44112.77943610278, 8961.372703910696, 9024.819503609924, 9535.761605959871, 9733.951330243339, 9746.658866939659, 9540.761480962961, 9668.903310966905, 9680.467574283412, 9692.854607180898, 9705.320627556039, 9690.224782017456, 9746.658866939659, 9762.316637835354, 9771.462569558671, 9783.119519243266, 9661.0, 9717.805643887083, 9717.902820971842, 9723.611055557769, 9731.12419882214, 9575.61697532098, 9672.93597704252, 9681.951590242004, 9683.612655493771, 9702.951485242529, 40218.19563608711, 40487.0, 40534.986625334306, 40599.0, 40617.593824061674, 3109.9067027989195, 3168.984155079233, 3383.983080084584, 3466.977241713675, 3534.9116272093147, 24398.26805195847, 28381.858090709622, 29461.263468413246, 30216.24459388511, 30399.696003040128, 2600.64891239684, 2691.9905035611646, 2810.8172968756967, 2860.4994126027864, 2874.1377586723897, 341878.0, 342774.28902843856, 342853.9999999975, 342906.0, 343742.0, 57896.71051644715, 58727.18273312221, 58838.0, 58842.41157588369, 58842.41157588369, 60815.08777368343, 61851.38148618456, 61886.38113618896, 61930.071048934304, 61959.69020154871, 15681.0, 16214.837851621332, 16241.0, 16247.350105995863, 16310.510684679479, 12601.558945436866, 12657.367131643381, 12669.429875655618, 12671.936640316739, 12686.936565317113, 17532.561685957953, 18138.274469021093, 18182.818171818377, 18218.08909554517, 18312.0, 6750.898736518956, 6783.898241526381, 6901.206361268418, 6919.37725604698, 6933.895991560131, 827.7516744976604, 915.7838031962666, 1051.222095649214, 1072.7823919850869, 1153.8557680289964, 28824.09010834364, 29635.40729185404, 29764.702352976194, 30186.094417167522, 30735.2316192097, 1038.8337865941564, 1054.5518154784186, 1153.0141728821905, 1165.988340116588, 1223.3760782001066, 13293.66765830862, 14900.70198596022, 15057.397704091933, 15250.466233681767, 15398.230088495531, 554686.0, 558450.0, 561779.0, 561996.0, 562058.0, 60504.78990420167, 61012.69493652503, 61317.69341153266, 61373.0, 61453.69273153606, 1309.7576948264411, 1355.5391167003265, 1357.7013057127417, 1486.591187423467, 1595.6330044089925, 24825.758712064686, 28766.568501472913, 30075.849620751756, 30638.693613063584, 32099.839500802347, 55902.44097558972, 55935.44064559302, 56246.71876640591, 56445.43554564402, 56446.435535644116, 446095.0, 449967.0, 450346.0, 450355.0, 450439.0, 35489.64510354863, 37448.812755936044, 38989.415158773205, 39007.219855603296, 39012.024699382746, 44399.0, 44836.32745508755, 44911.0, 45390.773046134556, 46232.53767462282, 31368.902088426796, 32370.676293236767, 36732.0, 37156.44265335968, 37931.43102853404, 36584.45123323205, 36614.8169259152, 37017.074573135884, 37336.81331593324, 37489.437658435694, 36092.819535902156, 36612.63387366199, 36970.075748106516, 37295.6270437303, 37323.440148397254, 31027.224319392197, 31603.522343184326, 32145.0, 32210.83894580512, 32248.871289504754, 22566.548669026855, 23656.29031129069, 24197.87901060554, 24276.0, 24717.134900278405], "value": 19431.529905871386, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.19519567451096, 383.6547107603157, 391.53602980468145, 398.0288097043214, 405.6004835237293, 18583.163757630904, 20859.582808343825, 21497.0, 21952.670709939324, 21984.0, 20527.07628156733, 21078.473038174052, 21544.569108617856, 21556.245531406403, 21604.675929861063, 5391.73041347933, 5870.70646467677, 6195.504359651217, 6206.565540412173, 6214.596051256676, 6059.697015149247, 6108.511319094484, 6110.175126357929, 6167.04410816322, 6186.474149697258, 5936.554758393117, 6105.32841387447, 6165.63006219626, 6167.568270221086, 6177.845553861167, 5625.437456254383, 6014.729337179838, 6152.907706384385, 6154.938450615504, 6163.938360616381, 5575.080111781551, 5778.27771528559, 5781.219535362714, 5794.188813566104, 5795.159701843209, 13511.0, 13814.309284535733, 14140.363683634261, 14165.858341416557, 14176.291185440687, 1998.510364960594, 2000.7499062617173, 2103.7159983402353, 2294.8393612447135, 2685.624012638232, 9602.66390676323, 9901.960294169152, 9953.452560109192, 10305.793884122351, 11928.821067683992, 1737.261663792883, 1805.1064722962087, 1812.7552780374613, 1855.0261112915691, 1873.475426880462, 115392.42303788428, 119220.80779192183, 119847.0, 120207.19689204669, 122968.0, 11250.943745281222, 11429.142814288962, 11560.248583842023, 11595.188336816342, 11667.124965627612, 12383.938080309721, 15009.024413413093, 15130.621734456727, 15152.31814568347, 15167.772483412758, 7166.67416527944, 8156.1028286888395, 8178.918210817816, 8436.873446898302, 8518.48889066658, 6242.406971337716, 8140.226678465537, 8200.630971606291, 8286.0, 8300.460470069547, 4001.359782434855, 4458.576435238647, 4554.203014472454, 4591.655625828076, 4612.423447069116, 1892.4606487151095, 1960.4412742368356, 1962.9705554416696, 1973.329068116847, 1977.317825350252, 858.7037472072125, 918.7197904639149, 955.8375076236917, 1010.8635334229784, 1045.289203341735, 19808.90095549513, 20521.589568208554, 20593.38219853407, 20673.793262067487, 20765.58468830615, 907.4328544659588, 953.0659953245857, 962.7352478068588, 979.1383582447401, 1005.3364779245662, 7446.925530744732, 10687.83968240477, 10879.075278601249, 10885.0, 11052.834207486894, 546078.0, 609338.0, 611444.0, 628558.7144128592, 630839.0, 135062.0, 136672.0, 136724.63275367118, 137125.0, 140691.0, 979.5934687104772, 996.3025881882711, 1008.7125169326706, 1009.0, 1009.9091081802673, 15172.696546069237, 18180.909095454437, 18274.451766446495, 18332.266709331478, 18478.81521184771, 50078.24882626691, 50876.23685644644, 51085.0, 51924.74037629788, 52130.436086917456, 71169.6441517789, 71294.64352678203, 72131.63934180296, 72324.63837680778, 73232.1691957684, 6847.21257055425, 7587.924120758722, 7650.579218142833, 7947.443678942419, 8049.993750781152, 11289.20975531705, 12587.68530786701, 12626.873731262569, 12747.745045099231, 13186.274754888573, 9366.484843333683, 11041.613543525938, 11099.056580190774, 11183.888161118284, 11195.38425386579, 5217.843464696065, 9640.517974101407, 10405.814778896516, 10853.186011049362, 11078.169137314895, 11105.500252488497, 11437.714057148638, 11483.598074067368, 11484.253523520945, 11651.359175245443, 6726.764563240459, 7625.7641746912095, 7645.961770191114, 7674.884876726742, 7878.330341921001, 8669.739907802776, 8930.955345223232, 9459.621615135318, 10815.70211574616, 11215.71960700989], "value": 9296.082538095457, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.7710177820657, 1396.1343966740621, 1598.3446786817408, 1793.4350679535946, 1982.3953694123295, 7872.29149376556, 8552.05927347992, 8762.21140097392, 8797.296216302697, 8812.339074569418, 8454.746357609267, 8704.651813927436, 8707.34694897882, 8711.520866352364, 8712.17234362736, 2115.492281852352, 2379.5003049359657, 2434.0750514804395, 2462.9753702462926, 2469.5307891500556, 2501.3496490912403, 2524.3058159006237, 2528.317354314334, 2529.2665127113114, 2532.126416386344, 2435.3668046308, 2496.2386472125995, 2496.475740094573, 2496.6005439129744, 2503.624456331556, 2416.118116887341, 2444.963325550118, 2450.6691596634405, 2453.828232023759, 2458.4714286428502, 2433.902643894242, 2441.865697386643, 2448.7061552613623, 2460.458699086198, 2466.5683505386664, 8637.136286371375, 8806.0, 8815.030346661862, 8815.51514666693, 8820.823583528358, 5088.669236499616, 5285.312909321802, 5289.709066001368, 5295.867603309909, 5305.7877684892555, 2872.468593310244, 3512.718982481421, 3543.7342199335153, 3569.8929032129076, 3578.4632305154173, 1020.4489575629151, 1035.1460045462522, 1036.6423583863555, 1042.4162469017374, 1043.2801367056707, 11000.174986876016, 11019.779604407868, 11021.614243501519, 11030.117590592814, 11041.889581104166, 3993.6206060424215, 4541.750203738826, 4629.444466664022, 4732.787024583902, 4845.297431872429, 9515.33392662507, 9516.23870090405, 9522.714318570454, 9525.523723813782, 9542.379745316532, 5209.609279304067, 5223.895522089537, 5226.503482169188, 5243.082460569385, 5270.973645131827, 3715.888523344304, 4370.300751879748, 4735.952640473552, 4880.804767809319, 4939.382577177853, 3901.902452438712, 3949.9012524686536, 4042.777647229431, 4087.46862907826, 4115.238680844053, 1306.0922658752265, 1314.9408276627576, 1317.4269192900927, 1333.839939207282, 1337.2912356451097, 1361.6527785414655, 1368.7673095573775, 1369.0963963784054, 1405.7048019915933, 1412.6397768569154, 8089.39329550286, 8102.918970810334, 8162.102168761431, 8179.263866252066, 8189.1401402853035, 505.36071869085634, 506.6377540058802, 511.1821086261951, 514.2004183494702, 518.1450606499232, 6205.627662340274, 6345.619262844152, 6351.618902865843, 6357.713902874381, 6365.363463653597, 9734.805303893883, 10630.68107956747, 10634.255602107933, 10752.677419677422, 10779.628481734006, 10312.484375781181, 10583.523741431654, 10626.415547144981, 10669.146468282519, 10684.89315106839, 8121.187881211831, 8158.959205203936, 8183.058948220912, 8203.507789532528, 8241.340692744567, 7932.524048557105, 8001.479903806234, 8048.476849004796, 8071.798205044921, 8098.635561399869, 9660.0, 9711.854322185032, 9820.607175713178, 9915.504224788876, 10008.249381296286, 9804.705858824247, 9990.750231243986, 10054.597816087567, 10163.796724065625, 10241.641542545975, 6694.163229596301, 7193.712251509881, 7492.138404083382, 7495.88756168647, 7554.773356799305, 8200.917990820255, 8207.794805129919, 8250.257476827115, 8273.544955027532, 8275.420720549744, 7213.963930180315, 7301.488895777457, 7339.009233753375, 7439.330460258603, 7484.101907771103, 7092.468064895257, 7095.325944035309, 7150.356467917913, 7161.248068952893, 7175.748848790267, 6726.966365168143, 7635.740102882962, 7714.922850771421, 7807.0, 7826.686932522635, 6911.827204319932, 6953.826154345979, 7045.894311585433, 7071.71713131469, 7106.076210092861, 7078.221395646578, 7200.747973820891, 7234.529755565872, 7235.710571577078, 7239.348458638748], "value": 4799.8878191401145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.8836244465362, 313.87445021991203, 316.4635942078177, 324.26877391482213, 330.44155377412187, 5092.694438333702, 5625.971870140649, 5898.705064746761, 5907.911381329272, 5931.703414829252, 4861.902761944768, 5707.857303567413, 5726.3414707308675, 5810.418958104187, 5810.912836307459, 3789.0, 4052.9797351013353, 4098.692598055143, 4160.791960401983, 4368.781560921957, 3566.6968307693746, 4323.357124292765, 4335.176316499871, 4353.455818022747, 4375.606195442409, 4299.31211006239, 4321.1141715948315, 4332.371806088131, 4334.891627709317, 4371.868843934687, 3661.066428060854, 4193.391958166079, 4240.427542281784, 4335.869923902288, 4349.782510874459, 3567.1795487038125, 3787.6023017583307, 3788.3370410178386, 3808.6000969898314, 3832.3485007548784, 4794.640401969867, 5538.418466061086, 5539.556835453194, 5540.390557038722, 5594.692291923942, 3968.0, 4205.87382378526, 4750.95249047512, 4881.657544175345, 5033.144365457881, 5524.33707955048, 6038.229798459256, 6052.757889684407, 6105.664188469633, 6118.418750218722, 3564.6078931317534, 4253.0, 4257.914841703179, 4259.446271984653, 4259.595338442843, 5209.453007434203, 5415.702136382497, 5892.911606325909, 6438.742450302029, 6439.871202575969, 4288.549702281278, 4316.762578058174, 4320.870373888788, 4325.4593175853015, 4345.500267469219, 4387.254166791653, 4402.207602631493, 4403.493598236244, 4421.40311058003, 4427.734335939854, 4258.361245813153, 4544.931826022612, 5037.29477873098, 5062.987402519437, 5104.259882317043, 4862.0, 6120.663363515049, 6161.0, 6182.948898687234, 6205.317415084337, 1280.7118398360294, 1494.6487575419767, 1524.1388615432245, 1529.17424590722, 1532.3947040918997, 888.595688961521, 931.0735817861272, 1010.282699283517, 1019.6635110413546, 1028.285341687535, 5657.6039677223025, 5684.232628595087, 5691.68695721731, 5714.714264286769, 5741.85645358861, 4895.632827537949, 6042.154098426224, 6307.274663413675, 6335.936640633627, 6351.714172862232, 5189.870253243699, 5451.727413629303, 5614.550835933115, 5705.400932902068, 5734.225879506297, 2918.664353599363, 3335.8832440864453, 3339.8497067632015, 3351.715104216169, 3367.9494807577908, 6244.0, 6585.703643335965, 6602.570832895846, 6603.372679595431, 6666.200055993312, 5283.0, 5429.511343978982, 5721.998650236192, 6334.334894836068, 6507.772227971998, 6273.905891411632, 6607.876660967647, 6616.533839658211, 6641.634710090992, 6674.065630811593, 5270.631055826056, 6441.194850643669, 6455.870882582416, 6462.838429039311, 6493.8701225976165, 5825.893080314727, 6033.42682445167, 6375.6174629522375, 6380.457661098859, 6401.327860574759, 5747.695075331618, 5914.556408269311, 6643.634600096848, 6646.202455705346, 6699.196096468455, 3852.5569559499895, 3891.591382904754, 4044.4944381952255, 4120.361343991686, 4157.750534967911, 4990.850274491771, 6164.4143806338325, 6382.266039405342, 6488.124103246001, 6503.382178693017, 4955.011215971178, 5769.53843692512, 6144.067796610084, 6206.534509911684, 6254.405831446005, 5397.622166448311, 5400.2709634200455, 5849.824505264849, 5883.499902508334, 6199.535034872312, 6053.273607167168, 6064.332923378513, 6071.3625069368845, 6093.238345206849, 6115.3578874217565, 5170.208087632636, 6213.1922850029205, 6219.968900155471, 6236.282827474898, 6268.27914789805, 5394.838154855203, 5654.010548154139, 5816.982028145142, 6118.847028824137, 6140.416660417253], "value": 4447.270367333911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.7402224165937, 726.5422783646302, 740.2079774641132, 763.9770806875796, 814.1126172472004, 14740.778888316683, 14805.851941480596, 15320.080795152298, 15665.0, 15667.29497172627, 14114.012019158663, 14134.293285335718, 14137.646558836033, 14160.645983850409, 14163.22102284374, 890.9643614255439, 900.4867225681364, 906.3972458315212, 906.5059542549293, 908.2869947091534, 703.5884007855411, 722.7109156337481, 875.089906497242, 887.3566664168459, 888.835565420396, 946.5361972633428, 949.4066208619613, 955.4124213608616, 956.1203692602822, 958.7698952251479, 944.8063147054871, 945.0219023310909, 945.546137853834, 947.0103741589986, 947.1191791633778, 541.5938046465151, 679.5956405938458, 703.3283214530112, 705.6189657584898, 710.3322876496129, 14753.336099875423, 14809.777853332209, 14833.851661483355, 14838.33227504765, 14864.108153510824, 12132.0, 12321.445534950948, 12334.5066197352, 12467.189632673937, 12750.234985900783, 9871.555779989845, 9919.355241909252, 10012.24908131893, 10259.384436933808, 10456.738581535446, 3384.272381437978, 3418.8119653419053, 3479.878204262864, 3541.3625547401457, 3745.3071181831447, 74445.69428821397, 75118.0, 75309.62345188294, 76168.0, 78366.43267134682, 9307.395019323721, 9432.95283523578, 9536.475493847765, 9551.283653725859, 9666.95166524163, 21005.264815731374, 21012.894935525226, 21030.47423814417, 21044.473888152614, 21052.0, 7480.17718051014, 7495.887561686579, 7580.886286705704, 7589.354904833151, 7629.427792915553, 4153.813078411418, 4188.162367526507, 4188.434561334242, 4196.265653510623, 4209.621134097946, 3495.475678648172, 3599.136207310279, 3605.8197090145386, 3616.0959760059986, 3617.909552261162, 637.7895294552786, 640.4972096903908, 652.8596351784295, 659.2484567592948, 664.7108507799123, 498.7481321932401, 503.7959626351334, 548.4351118348108, 594.3284088979426, 595.7429823073312, 7771.4559980800805, 7814.804629884185, 8047.155048719917, 8168.019837619405, 8242.2581967622, 552.3896094815252, 567.140781715701, 594.1635090364437, 594.3818428833964, 599.4694695194784, 3747.887563373103, 3802.341971699115, 3811.542614886176, 3813.0, 4044.69664775143, 87734.12265877388, 89215.10784892198, 89504.0, 89660.5516972424, 90902.54548727215, 75242.24757752461, 76015.47969040589, 76109.61945190349, 76342.2365776335, 77528.0, 67358.0, 67989.52115267317, 68106.65946670334, 68220.0, 68517.97223041658, 7451.366633835968, 7581.696732130653, 7656.349210316963, 7689.692412303445, 7734.071911370672, 42581.0, 42813.785931070146, 42926.35610465783, 42999.71000869979, 43041.0, 56429.43570564242, 61698.0, 62446.68776656088, 62484.68757656364, 62681.373186269375, 8703.695370661997, 10119.342242754197, 10159.796804064024, 10162.0, 10246.487675616041, 11787.0, 11940.880591193976, 12247.938760306142, 12255.69360765988, 12324.198927069712, 11309.943450282695, 11362.091032717197, 11550.279120955922, 11598.0, 11657.825132622847, 11088.611898583833, 11183.32900026001, 11231.606893758679, 11252.887471125185, 11266.94366528162, 11305.491252893804, 11415.0, 11482.368469734245, 11701.122415818678, 11743.706407339543, 9394.710248457854, 9694.951525242328, 9719.708408747749, 9736.805263894825, 10067.395956242648, 9466.52667366615, 9714.562844671866, 9735.951320243354, 9777.560009799434, 9788.0], "value": 6771.512904888653, "unit": "score"}], "name": "dromaeo_css", "value": 7273.455231139622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 112.0, 115.0, 111.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 132.0, 196.0, 115.0, 179.0, 132.0, 137.0, 200.0, 102.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 182.0, 183.0, 200.0, 264.0, 208.0, 179.0, 179.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 82.0, 80.0, 57.0, 58.0, 57.0, 78.0, 77.0, 55.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 134.0, 77.0, 79.0, 80.0, 118.0, 80.0, 78.0, 121.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 95.0, 131.0, 86.0, 83.0, 88.0, 83.0, 87.0, 84.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 92.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 145.0, 85.0, 84.0, 86.0, 90.0, 84.0, 85.0, 84.0, 84.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 56.0, 54.0, 56.0, 66.0, 55.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 85.0, 97.0, 111.0, 70.0, 68.0, 66.0, 68.0, 67.0, 68.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 85.0, 88.0, 85.0, 82.0, 106.0, 108.0, 111.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 170.0, 130.0, 168.0, 159.0, 154.0, 141.0, 142.0, 142.0, 142.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 170.0, 170.0, 168.0, 168.0, 168.0, 175.0, 170.0, 200.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 67.0, 69.0, 67.0, 66.0, 68.0, 67.0, 68.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1513.2, "alertThreshold": 2.0}]} 10:53:22 INFO - Return code: 0 10:53:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:53:22 ERROR - # TBPL SUCCESS # 10:53:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:53:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:53:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:53:22 INFO - 2016-04-08 10:53:22.156 screenresolution[1686:10312] starting screenresolution argv=screenresolution get 10:53:22 INFO - 2016-04-08 10:53:22.159 screenresolution[1686:10312] Display 0: 1600x1200x32@60 10:53:22 INFO - 2016-04-08 10:53:22.165 screenresolution[1687:10315] starting screenresolution argv=screenresolution list 10:53:22 INFO - Available Modes on Display 0 10:53:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:53:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:53:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:53:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:53:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:53:22 INFO - Intel Iris: 10:53:22 INFO - Chipset Model: Intel Iris 10:53:22 INFO - Type: GPU 10:53:22 INFO - Bus: Built-In 10:53:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:53:22 INFO - Vendor: Intel (0x8086) 10:53:22 INFO - Device ID: 0x0a2e 10:53:22 INFO - Revision ID: 0x0009 10:53:22 INFO - Displays: 10:53:22 INFO - Display: 10:53:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:53:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:53:22 INFO - Display Serial Number: 1600x1200 60 10:53:22 INFO - Main Display: Yes 10:53:22 INFO - Mirror: Off 10:53:22 INFO - Online: Yes 10:53:22 INFO - Rotation: Supported 10:53:22 INFO - Return code: 0 10:53:22 INFO - Running post-action listener: _resource_record_post_action 10:53:22 INFO - Running post-run listener: _resource_record_post_run 10:53:23 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 32411136; Write bytes: 695138816; Read time: 320; Write time: 1867 10:53:23 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381368832; Write bytes: 376129024; Read time: 28228; Write time: 706 10:53:23 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 30629376; Write bytes: 299439104; Read time: 302; Write time: 1119 10:53:23 INFO - Running post-run listener: _upload_blobber_files 10:53:23 INFO - Blob upload gear active. 10:53:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:53:23 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 10:53:23 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'] 10:53:23 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 10:53:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:24 INFO - (blobuploader) - INFO - Done attempting. 10:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:25 INFO - (blobuploader) - INFO - Done attempting. 10:53:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:53:25 INFO - Return code: 0 10:53:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:53:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:53:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f78c5665a23b94695238e1da00cadd5bb670ed7f15ec1cd2973e51d12dcaab1ebb2cbc8f6131c43f9e1480a87ce6b3885b817628aa9292d86f4c8f2f8fe8af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409f98602b2870e68d0c0f466f292010cd7525a8985f82ff6fbf6b4c22b2d2fe81f155e6418c4757837b22f5529392d8b6f2579d2190b3543c526548fa3428f9"} 10:53:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:53:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:53:25 INFO - Contents: 10:53:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f78c5665a23b94695238e1da00cadd5bb670ed7f15ec1cd2973e51d12dcaab1ebb2cbc8f6131c43f9e1480a87ce6b3885b817628aa9292d86f4c8f2f8fe8af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409f98602b2870e68d0c0f466f292010cd7525a8985f82ff6fbf6b4c22b2d2fe81f155e6418c4757837b22f5529392d8b6f2579d2190b3543c526548fa3428f9"} 10:53:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:53:25 INFO - Copying logs to upload dir... 10:53:25 INFO - mkdir: /builds/slave/test/build/upload/logs 10:53:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.182656 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-08 10:53:25.830082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 10:53:25.833668) ========= 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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f78c5665a23b94695238e1da00cadd5bb670ed7f15ec1cd2973e51d12dcaab1ebb2cbc8f6131c43f9e1480a87ce6b3885b817628aa9292d86f4c8f2f8fe8af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409f98602b2870e68d0c0f466f292010cd7525a8985f82ff6fbf6b4c22b2d2fe81f155e6418c4757837b22f5529392d8b6f2579d2190b3543c526548fa3428f9"} build_url:https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/GfrY6ctoRi6sq77p4MvlVA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f78c5665a23b94695238e1da00cadd5bb670ed7f15ec1cd2973e51d12dcaab1ebb2cbc8f6131c43f9e1480a87ce6b3885b817628aa9292d86f4c8f2f8fe8af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/409f98602b2870e68d0c0f466f292010cd7525a8985f82ff6fbf6b4c22b2d2fe81f155e6418c4757837b22f5529392d8b6f2579d2190b3543c526548fa3428f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 10:53:25.867444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:53:25.867768) ========= 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.kjXhOPd8h3/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.mrFTPBWxXB/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005328 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:53:25.917183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 10:53:25.917747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 10:53:25.918613) ========= ========= Total master_lag: 3.35 =========