builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0174 starttime: 1457988023.06 results: success (0) buildid: 20160314114738 builduid: bf286c0d4ba84c44b60450a173ac967f revision: cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.063916) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.064396) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.064698) ========= 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.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005419 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.088827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.089153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.105910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.106243) ========= 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.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005706 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.154683) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.158002) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.158382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.158720) ========= 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.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-14 13:40:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-03-14 13:40:23 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.336497) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.336884) ========= 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.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.028751 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:23.385578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 13:40:23.385919) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-14 13:40:23,466 truncating revision to first 12 chars 2016-03-14 13:40:23,466 Setting DEBUG logging. 2016-03-14 13:40:23,466 attempt 1/10 2016-03-14 13:40:23,466 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cc357481aa2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 13:40:24,748 unpacking tar archive at: mozilla-aurora-cc357481aa2b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.536350 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-14 13:40:24.940316) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:24.940666) ========= echo cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 program finished with exit code 0 elapsedTime=0.005392 script_repo_revision: 'cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:24.989477) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:24.989779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 13:40:25.003130) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-14 13:40:25.003456) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:40:25 INFO - MultiFileLogger online at 20160314 13:40:25 in /builds/slave/test 13:40:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:40:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:40:25 INFO - {'append_to_log': False, 13:40:25 INFO - 'base_work_dir': '/builds/slave/test', 13:40:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:40:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:40:25 INFO - 'branch': 'Mozilla-Aurora', 13:40:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:40:25 INFO - 'config_files': ('talos/mac_config.py',), 13:40:25 INFO - 'default_actions': ('clobber', 13:40:25 INFO - 'read-buildbot-config', 13:40:25 INFO - 'download-and-extract', 13:40:25 INFO - 'populate-webroot', 13:40:25 INFO - 'create-virtualenv', 13:40:25 INFO - 'install', 13:40:25 INFO - 'run-tests'), 13:40:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:40:25 INFO - 'download_minidump_stackwalk': True, 13:40:25 INFO - 'download_symbols': 'ondemand', 13:40:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:40:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:40:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:40:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:40:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:40:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:40:25 INFO - 'installer_path': 'installer.exe', 13:40:25 INFO - 'log_level': 'info', 13:40:25 INFO - 'log_name': 'talos', 13:40:25 INFO - 'log_to_console': True, 13:40:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:40:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:40:25 INFO - 'opt_config_files': (), 13:40:25 INFO - 'pip_index': False, 13:40:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:40:25 INFO - 'cmd': ('bash', 13:40:25 INFO - '-c', 13:40:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:40:25 INFO - 'enabled': True, 13:40:25 INFO - 'halt_on_failure': False, 13:40:25 INFO - 'name': 'check_screen_resolution'},), 13:40:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:40:25 INFO - 'cmd': ('bash', 13:40:25 INFO - '-c', 13:40:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:40:25 INFO - 'enabled': True, 13:40:25 INFO - 'halt_on_failure': False, 13:40:25 INFO - 'name': 'check_screen_resolution'},), 13:40:25 INFO - 'run_cmd_checks_enabled': True, 13:40:25 INFO - 'sps_profile': False, 13:40:25 INFO - 'sps_profile_interval': 0, 13:40:25 INFO - 'suite': 'dromaeojs', 13:40:25 INFO - 'system_bits': '32', 13:40:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:40:25 INFO - 'title': 't-yosemite-r7-0174', 13:40:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:40:25 INFO - 'use_talos_json': True, 13:40:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:40:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:40:25 INFO - 'work_dir': 'build'} 13:40:25 INFO - ##### 13:40:25 INFO - ##### Running clobber step. 13:40:25 INFO - ##### 13:40:25 INFO - Running pre-action listener: _resource_record_pre_action 13:40:25 INFO - Running main action method: clobber 13:40:25 INFO - rmtree: /builds/slave/test/build 13:40:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:40:26 INFO - Running post-action listener: _resource_record_post_action 13:40:26 INFO - ##### 13:40:26 INFO - ##### Running read-buildbot-config step. 13:40:26 INFO - ##### 13:40:26 INFO - Running pre-action listener: _resource_record_pre_action 13:40:26 INFO - Running main action method: read_buildbot_config 13:40:26 INFO - Using buildbot properties: 13:40:26 INFO - { 13:40:26 INFO - "project": "", 13:40:26 INFO - "product": "firefox", 13:40:26 INFO - "script_repo_revision": "production", 13:40:26 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:40:26 INFO - "repository": "", 13:40:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:40:26 INFO - "buildid": "20160314114738", 13:40:26 INFO - "pgo_build": "False", 13:40:26 INFO - "basedir": "/builds/slave/test", 13:40:26 INFO - "buildnumber": 127, 13:40:26 INFO - "slavename": "t-yosemite-r7-0174", 13:40:26 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:40:26 INFO - "platform": "yosemite_r7", 13:40:26 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:40:26 INFO - "branch": "mozilla-aurora", 13:40:26 INFO - "repo_path": "releases/mozilla-aurora", 13:40:26 INFO - "revision": "cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369", 13:40:26 INFO - "stage_platform": "macosx64", 13:40:26 INFO - "builduid": "bf286c0d4ba84c44b60450a173ac967f", 13:40:26 INFO - "slavebuilddir": "test" 13:40:26 INFO - } 13:40:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 13:40:26 INFO - Running post-action listener: _resource_record_post_action 13:40:26 INFO - ##### 13:40:26 INFO - ##### Running download-and-extract step. 13:40:26 INFO - ##### 13:40:26 INFO - Running pre-action listener: _resource_record_pre_action 13:40:26 INFO - Running main action method: download_and_extract 13:40:26 INFO - mkdir: /builds/slave/test/build/tests 13:40:26 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')]} 13:40:26 INFO - https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:40:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:40:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 13:40:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 13:40:28 INFO - Downloaded 1277 bytes. 13:40:28 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 13:40:28 INFO - Using the following test package requirements: 13:40:28 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:40:28 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 13:40:28 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 13:40:28 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'jsshell-mac.zip'], 13:40:28 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 13:40:28 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:40:28 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 13:40:28 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 13:40:28 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 13:40:28 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 13:40:28 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 13:40:28 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 13:40:28 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:40:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:28 INFO - https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:40:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:40:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:40:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:40:29 INFO - Downloaded 17865030 bytes. 13:40:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:40:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:40:32 INFO - Return code: 0 13:40:32 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:32 INFO - https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:40:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:40:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:40:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 13:40:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:40:33 INFO - Downloaded 17865030 bytes. 13:40:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:40:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:40:37 INFO - Return code: 0 13:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:37 INFO - https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 13:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:40:38 INFO - Downloaded 10845161 bytes. 13:40:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:40:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:40:38 INFO - Return code: 0 13:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:38 INFO - https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 13:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 13:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 13:40:41 INFO - Downloaded 115014912 bytes. 13:40:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:40:41 INFO - mkdir: /builds/slave/test/properties 13:40:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:40:41 INFO - Writing to file /builds/slave/test/properties/build_url 13:40:41 INFO - Contents: 13:40:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 13:40:42 INFO - Running post-action listener: _resource_record_post_action 13:40:42 INFO - Running post-action listener: set_extra_try_arguments 13:40:42 INFO - ##### 13:40:42 INFO - ##### Running populate-webroot step. 13:40:42 INFO - ##### 13:40:42 INFO - Running pre-action listener: _resource_record_pre_action 13:40:42 INFO - Running main action method: populate_webroot 13:40:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:40:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:40:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:40:42 INFO - '--tppagecycles', 13:40:42 INFO - '7'], 13:40:42 INFO - 'tests': ['tsvgm']}}, 13:40:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:40:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:40:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:40:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:40:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:40:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:40:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'tests': ['damp', 'tps']}, 13:40:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['damp', 'tps']}, 13:40:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:40:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:40:42 INFO - 'other': {'tests': ['a11yr', 13:40:42 INFO - 'ts_paint', 13:40:42 INFO - 'tpaint', 13:40:42 INFO - 'sessionrestore', 13:40:42 INFO - 'sessionrestore_no_auto_restore', 13:40:42 INFO - 'tabpaint']}, 13:40:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['a11yr', 13:40:42 INFO - 'ts_paint', 13:40:42 INFO - 'tpaint', 13:40:42 INFO - 'sessionrestore', 13:40:42 INFO - 'sessionrestore_no_auto_restore', 13:40:42 INFO - 'tabpaint']}, 13:40:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['a11yr', 13:40:42 INFO - 'ts_paint', 13:40:42 INFO - 'tpaint', 13:40:42 INFO - 'sessionrestore', 13:40:42 INFO - 'sessionrestore_no_auto_restore', 13:40:42 INFO - 'tabpaint']}, 13:40:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['a11yr', 13:40:42 INFO - 'ts_paint', 13:40:42 INFO - 'tpaint', 13:40:42 INFO - 'sessionrestore', 13:40:42 INFO - 'sessionrestore_no_auto_restore', 13:40:42 INFO - 'tabpaint']}, 13:40:42 INFO - 'other_l64': {'tests': ['a11yr', 13:40:42 INFO - 'ts_paint', 13:40:42 INFO - 'tpaint', 13:40:42 INFO - 'sessionrestore', 13:40:42 INFO - 'sessionrestore_no_auto_restore', 13:40:42 INFO - 'tabpaint']}, 13:40:42 INFO - 'other_nol64': {'tests': ['a11yr', 13:40:42 INFO - 'ts_paint', 13:40:42 INFO - 'tpaint', 13:40:42 INFO - 'sessionrestore', 13:40:42 INFO - 'sessionrestore_no_auto_restore', 13:40:42 INFO - 'tabpaint']}, 13:40:42 INFO - 'svgr': {'tests': ['tsvgx', 13:40:42 INFO - 'tsvgr_opacity', 13:40:42 INFO - 'tart', 13:40:42 INFO - 'tscrollx', 13:40:42 INFO - 'cart']}, 13:40:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['tsvgx', 13:40:42 INFO - 'tsvgr_opacity', 13:40:42 INFO - 'tart', 13:40:42 INFO - 'tscrollx', 13:40:42 INFO - 'cart']}, 13:40:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'tests': ['tp5o']}, 13:40:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'talos_options': ['--e10s'], 13:40:42 INFO - 'tests': ['tp5o']}, 13:40:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'talos_options': ['--xperf_path', 13:40:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:40:42 INFO - 'tests': ['tp5n']}, 13:40:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:40:42 INFO - 'talos_options': ['--e10s', 13:40:42 INFO - '--xperf_path', 13:40:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:40:42 INFO - 'tests': ['tp5n']}}, 13:40:42 INFO - 'talos.zip': {'path': '', 13:40:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:40:42 INFO - Running post-action listener: _resource_record_post_action 13:40:42 INFO - ##### 13:40:42 INFO - ##### Running create-virtualenv step. 13:40:42 INFO - ##### 13:40:42 INFO - Running pre-action listener: _resource_record_pre_action 13:40:42 INFO - Running main action method: create_virtualenv 13:40:42 INFO - Creating virtualenv /builds/slave/test/build/venv 13:40:42 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 13:40:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:40:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:40:43 INFO - Using real prefix '/tools/python27' 13:40:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:40:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:40:46 INFO - Installing pip.................done. 13:40:46 INFO - Return code: 0 13:40:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:46 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:40:46 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 13:40:46 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 13:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:46 INFO - 'HOME': '/Users/cltbld', 13:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:46 INFO - 'LOGNAME': 'cltbld', 13:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:46 INFO - 'MOZ_NO_REMOTE': '1', 13:40:46 INFO - 'NO_EM_RESTART': '1', 13:40:46 INFO - 'PAGER': '/bin/cat', 13:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:46 INFO - 'PWD': '/builds/slave/test', 13:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:46 INFO - 'SHELL': '/bin/bash', 13:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:40:46 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:46 INFO - 'USER': 'cltbld', 13:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:46 INFO - 'XPC_FLAGS': '0x0', 13:40:46 INFO - 'XPC_SERVICE_NAME': '0', 13:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:46 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 13:40:46 INFO - Cleaning up... 13:40:46 INFO - Return code: 0 13:40:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:46 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:40:46 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 13:40:46 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 13:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:46 INFO - 'HOME': '/Users/cltbld', 13:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:46 INFO - 'LOGNAME': 'cltbld', 13:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:46 INFO - 'MOZ_NO_REMOTE': '1', 13:40:46 INFO - 'NO_EM_RESTART': '1', 13:40:46 INFO - 'PAGER': '/bin/cat', 13:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:46 INFO - 'PWD': '/builds/slave/test', 13:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:46 INFO - 'SHELL': '/bin/bash', 13:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:40:46 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:46 INFO - 'USER': 'cltbld', 13:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:46 INFO - 'XPC_FLAGS': '0x0', 13:40:46 INFO - 'XPC_SERVICE_NAME': '0', 13:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:47 INFO - Downloading/unpacking psutil>=0.7.1 13:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:40:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:40:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:40:50 INFO - Installing collected packages: psutil 13:40:50 INFO - Running setup.py install for psutil 13:40:50 INFO - building 'psutil._psutil_osx' extension 13:40:50 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 13:40:50 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 13:40:50 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 13:40:50 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 13:40:51 INFO - building 'psutil._psutil_posix' extension 13:40:51 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 13:40:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:40:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:40:51 INFO - ^ 13:40:51 INFO - 1 warning generated. 13:40:51 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 13:40:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:40:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:40:51 INFO - Successfully installed psutil 13:40:51 INFO - Cleaning up... 13:40:51 INFO - Return code: 0 13:40:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:40: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')]} 13:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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')]} 13:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40: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', '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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:40: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:40: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 mozsystemmonitor==0.0.0 13:40:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:40:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:51 INFO - 'HOME': '/Users/cltbld', 13:40:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:51 INFO - 'LOGNAME': 'cltbld', 13:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:51 INFO - 'MOZ_NO_REMOTE': '1', 13:40:51 INFO - 'NO_EM_RESTART': '1', 13:40:51 INFO - 'PAGER': '/bin/cat', 13:40:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:51 INFO - 'PWD': '/builds/slave/test', 13:40:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:51 INFO - 'SHELL': '/bin/bash', 13:40:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:40:51 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:40:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:51 INFO - 'USER': 'cltbld', 13:40:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:51 INFO - 'XPC_FLAGS': '0x0', 13:40:51 INFO - 'XPC_SERVICE_NAME': '0', 13:40:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:40:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:40:53 INFO - Installing collected packages: mozsystemmonitor 13:40:53 INFO - Running setup.py install for mozsystemmonitor 13:40:54 INFO - Successfully installed mozsystemmonitor 13:40:54 INFO - Cleaning up... 13:40:54 INFO - Return code: 0 13:40:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:40:54 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')]} 13:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:54 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')]} 13:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:54 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:40:54 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 13:40:54 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 13:40:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:40:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:54 INFO - 'HOME': '/Users/cltbld', 13:40:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:54 INFO - 'LOGNAME': 'cltbld', 13:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:54 INFO - 'MOZ_NO_REMOTE': '1', 13:40:54 INFO - 'NO_EM_RESTART': '1', 13:40:54 INFO - 'PAGER': '/bin/cat', 13:40:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:54 INFO - 'PWD': '/builds/slave/test', 13:40:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:54 INFO - 'SHELL': '/bin/bash', 13:40:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:40:54 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:40:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:54 INFO - 'USER': 'cltbld', 13:40:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:54 INFO - 'XPC_FLAGS': '0x0', 13:40:54 INFO - 'XPC_SERVICE_NAME': '0', 13:40:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40: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 13:40:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:40:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:40:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:40:57 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 13:40:57 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 13:40:57 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 13:40:57 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 13:40:57 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 13:40:57 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 13:40:57 INFO - Downloading docopt-0.6.1.tar.gz 13:40:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:40:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:40:58 INFO - Running setup.py install for blobuploader 13:40:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:40:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:40:58 INFO - Running setup.py install for requests 13:40:58 INFO - Running setup.py install for docopt 13:40:58 INFO - Successfully installed blobuploader requests docopt 13:40:58 INFO - Cleaning up... 13:40:58 INFO - Return code: 0 13:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:40:58 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:40:58 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 13:40:58 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 13:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:40:58 INFO - 'HOME': '/Users/cltbld', 13:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:40:58 INFO - 'LOGNAME': 'cltbld', 13:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:40:58 INFO - 'MOZ_NO_REMOTE': '1', 13:40:58 INFO - 'NO_EM_RESTART': '1', 13:40:58 INFO - 'PAGER': '/bin/cat', 13:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:40:58 INFO - 'PWD': '/builds/slave/test', 13:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:40:58 INFO - 'SHELL': '/bin/bash', 13:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:40:58 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:40:58 INFO - 'USER': 'cltbld', 13:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:40:58 INFO - 'XPC_FLAGS': '0x0', 13:40:58 INFO - 'XPC_SERVICE_NAME': '0', 13:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:40:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-e2CKha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-v1XvRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-nC_gJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-GbYJ11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-6xzyad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-oj9sS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-sVJkPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:40:59 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-kX69vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-AKc4vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-CKd1jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-uluIeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-zIVP94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-a0FHSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Zg6ZoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ic6zba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gOX71f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:41:00 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-709ohS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:41:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:41:01 INFO - Running setup.py install for manifestparser 13:41:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:41:01 INFO - Running setup.py install for mozcrash 13:41:01 INFO - Running setup.py install for mozdebug 13:41:01 INFO - Running setup.py install for mozdevice 13:41:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:41:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:41:01 INFO - Running setup.py install for mozfile 13:41:01 INFO - Running setup.py install for mozhttpd 13:41:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:41:01 INFO - Running setup.py install for mozinfo 13:41:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Running setup.py install for mozInstall 13:41:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Running setup.py install for mozleak 13:41:02 INFO - Running setup.py install for mozlog 13:41:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Running setup.py install for moznetwork 13:41:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Running setup.py install for mozprocess 13:41:02 INFO - Running setup.py install for mozprofile 13:41:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:41:02 INFO - Running setup.py install for mozrunner 13:41:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:41:03 INFO - Running setup.py install for mozscreenshot 13:41:03 INFO - Running setup.py install for moztest 13:41:03 INFO - Running setup.py install for mozversion 13:41:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:41:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:41:03 INFO - Cleaning up... 13:41:03 INFO - Return code: 0 13:41:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:03 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:41:03 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 13:41:03 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 13:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:03 INFO - 'HOME': '/Users/cltbld', 13:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:03 INFO - 'LOGNAME': 'cltbld', 13:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:03 INFO - 'MOZ_NO_REMOTE': '1', 13:41:03 INFO - 'NO_EM_RESTART': '1', 13:41:03 INFO - 'PAGER': '/bin/cat', 13:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:03 INFO - 'PWD': '/builds/slave/test', 13:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:03 INFO - 'SHELL': '/bin/bash', 13:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:41:03 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:03 INFO - 'USER': 'cltbld', 13:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:03 INFO - 'XPC_FLAGS': '0x0', 13:41:03 INFO - 'XPC_SERVICE_NAME': '0', 13:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:41:03 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ITbc_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-y1m2dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ff3hIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-HDFiKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IbVsoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-QY55SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-mu31xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Cjovau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ZGBEub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-l9bT3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:41:04 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)) 13:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:41:04 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-limfg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:41:05 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)) 13:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:41:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-8LD_qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:41:05 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)) 13:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:41:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ywi4J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:41:05 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)) 13:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:41:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-8QlW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:41:05 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)) 13:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-q3qbrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:41:05 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)) 13:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:41:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Re0zQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:41:05 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)) 13:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:41:05 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-s7ll2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:41:05 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)) 13:41:05 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)) 13:41:05 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)) 13:41:05 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)) 13:41:05 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)) 13:41:05 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)) 13:41:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:08 INFO - Downloading blessings-1.6.tar.gz 13:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:41:08 INFO - Installing collected packages: blessings 13:41:08 INFO - Running setup.py install for blessings 13:41:08 INFO - Successfully installed blessings 13:41:08 INFO - Cleaning up... 13:41:08 INFO - Return code: 0 13:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:41:08 INFO - Reading from file tmpfile_stdout 13:41:08 INFO - Current package versions: 13:41:08 INFO - blessings == 1.6 13:41:08 INFO - blobuploader == 1.2.4 13:41:08 INFO - docopt == 0.6.1 13:41:08 INFO - manifestparser == 1.1 13:41:08 INFO - mozInstall == 1.12 13:41:08 INFO - mozcrash == 0.17 13:41:08 INFO - mozdebug == 0.1 13:41:08 INFO - mozdevice == 0.48 13:41:08 INFO - mozfile == 1.2 13:41:08 INFO - mozhttpd == 0.7 13:41:08 INFO - mozinfo == 0.9 13:41:08 INFO - mozleak == 0.1 13:41:08 INFO - mozlog == 3.1 13:41:08 INFO - moznetwork == 0.27 13:41:08 INFO - mozprocess == 0.22 13:41:08 INFO - mozprofile == 0.28 13:41:08 INFO - mozrunner == 6.11 13:41:08 INFO - mozscreenshot == 0.1 13:41:08 INFO - mozsystemmonitor == 0.0 13:41:08 INFO - moztest == 0.7 13:41:08 INFO - mozversion == 1.4 13:41:08 INFO - psutil == 3.1.1 13:41:08 INFO - requests == 1.2.3 13:41:08 INFO - wsgiref == 0.1.2 13:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:08 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:41:08 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 13:41:08 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 13:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:08 INFO - 'HOME': '/Users/cltbld', 13:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:08 INFO - 'LOGNAME': 'cltbld', 13:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:08 INFO - 'MOZ_NO_REMOTE': '1', 13:41:08 INFO - 'NO_EM_RESTART': '1', 13:41:08 INFO - 'PAGER': '/bin/cat', 13:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:08 INFO - 'PWD': '/builds/slave/test', 13:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:08 INFO - 'SHELL': '/bin/bash', 13:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:41:08 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:08 INFO - 'USER': 'cltbld', 13:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:08 INFO - 'XPC_FLAGS': '0x0', 13:41:08 INFO - 'XPC_SERVICE_NAME': '0', 13:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 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)) 13:41:08 INFO - Cleaning up... 13:41:08 INFO - Return code: 0 13:41:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:08 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:41:08 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 13:41:08 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 13:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:08 INFO - 'HOME': '/Users/cltbld', 13:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:08 INFO - 'LOGNAME': 'cltbld', 13:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:08 INFO - 'MOZ_NO_REMOTE': '1', 13:41:08 INFO - 'NO_EM_RESTART': '1', 13:41:08 INFO - 'PAGER': '/bin/cat', 13:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:08 INFO - 'PWD': '/builds/slave/test', 13:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:08 INFO - 'SHELL': '/bin/bash', 13:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:41:08 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:08 INFO - 'USER': 'cltbld', 13:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:08 INFO - 'XPC_FLAGS': '0x0', 13:41:08 INFO - 'XPC_SERVICE_NAME': '0', 13:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:09 INFO - Downloading/unpacking jsonschema 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:41:11 INFO - Downloading/unpacking functools32 (from jsonschema) 13:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:41:11 INFO - Downloading functools32-3.2.3-2.tar.gz 13:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:41:12 INFO - warning: no files found matching '*.txt' 13:41:12 INFO - no previously-included directories found matching 'build' 13:41:12 INFO - no previously-included directories found matching 'dist' 13:41:12 INFO - no previously-included directories found matching '.git*' 13:41:12 INFO - Installing collected packages: jsonschema, functools32 13:41:12 INFO - Running setup.py install for functools32 13:41:12 INFO - warning: no files found matching '*.txt' 13:41:12 INFO - no previously-included directories found matching 'build' 13:41:12 INFO - no previously-included directories found matching 'dist' 13:41:12 INFO - no previously-included directories found matching '.git*' 13:41:12 INFO - Successfully installed jsonschema functools32 13:41:12 INFO - Cleaning up... 13:41:12 INFO - Return code: 0 13:41:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:41:12 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 0x10acbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9f3da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, '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.sqnv9QF577/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.aCZznOcgDk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 13:41:12 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 13:41:12 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 13:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:12 INFO - 'HOME': '/Users/cltbld', 13:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:12 INFO - 'LOGNAME': 'cltbld', 13:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:12 INFO - 'MOZ_NO_REMOTE': '1', 13:41:12 INFO - 'NO_EM_RESTART': '1', 13:41:12 INFO - 'PAGER': '/bin/cat', 13:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:12 INFO - 'PWD': '/builds/slave/test', 13:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:12 INFO - 'SHELL': '/bin/bash', 13:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:41:12 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:12 INFO - 'USER': 'cltbld', 13:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:12 INFO - 'XPC_FLAGS': '0x0', 13:41:12 INFO - 'XPC_SERVICE_NAME': '0', 13:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:41:12 INFO - Downloading/unpacking flake8 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41: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 13:41:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:41:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:41:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:15 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 13:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:41:16 INFO - no previously-included directories found matching 'docs/_build' 13:41:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:41:16 INFO - Running setup.py install for pep8 13:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:41:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:41:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:41:16 INFO - no previously-included directories found matching 'docs/_build' 13:41:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:41:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:41:16 INFO - Cleaning up... 13:41:16 INFO - Return code: 0 13:41:16 INFO - Running post-action listener: _resource_record_post_action 13:41:16 INFO - Running post-action listener: _start_resource_monitoring 13:41:16 INFO - Starting resource monitoring. 13:41:16 INFO - ##### 13:41:16 INFO - ##### Running install step. 13:41:16 INFO - ##### 13:41:16 INFO - Running pre-action listener: _resource_record_pre_action 13:41:16 INFO - Running main action method: install 13:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:41:16 INFO - Reading from file tmpfile_stdout 13:41:16 INFO - Detecting whether we're running mozinstall >=1.0... 13:41:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:41:17 INFO - Reading from file tmpfile_stdout 13:41:17 INFO - Output received: 13:41:17 INFO - Usage: mozinstall [options] installer 13:41:17 INFO - Options: 13:41:17 INFO - -h, --help show this help message and exit 13:41:17 INFO - -d DEST, --destination=DEST 13:41:17 INFO - Directory to install application into. [default: 13:41:17 INFO - "/builds/slave/test"] 13:41:17 INFO - --app=APP Application being installed. [default: firefox] 13:41:17 INFO - mkdir: /builds/slave/test/build/application 13:41:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:41:48 INFO - Reading from file tmpfile_stdout 13:41:48 INFO - Output received: 13:41:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:41:48 INFO - Running post-action listener: _resource_record_post_action 13:41:48 INFO - ##### 13:41:48 INFO - ##### Running run-tests step. 13:41:48 INFO - ##### 13:41:48 INFO - Running pre-action listener: _resource_record_pre_action 13:41:48 INFO - Running main action method: run_tests 13:41:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:41:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:41:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:41:48 INFO - 2016-03-14 13:41:48.995 screenresolution[1641:7513] starting screenresolution argv=screenresolution get 13:41:48 INFO - 2016-03-14 13:41:48.998 screenresolution[1641:7513] Display 0: 1600x1200x32@60 13:41:49 INFO - 2016-03-14 13:41:49.004 screenresolution[1642:7516] starting screenresolution argv=screenresolution list 13:41:49 INFO - Available Modes on Display 0 13:41:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:41:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:41:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:41:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:41:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:41:49 INFO - Intel Iris: 13:41:49 INFO - Chipset Model: Intel Iris 13:41:49 INFO - Type: GPU 13:41:49 INFO - Bus: Built-In 13:41:49 INFO - VRAM (Dynamic, Max): 1536 MB 13:41:49 INFO - Vendor: Intel (0x8086) 13:41:49 INFO - Device ID: 0x0a2e 13:41:49 INFO - Revision ID: 0x0009 13:41:49 INFO - Displays: 13:41:49 INFO - Display: 13:41:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:41:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:41:49 INFO - Display Serial Number: 1600x1200 60 13:41:49 INFO - Main Display: Yes 13:41:49 INFO - Mirror: Off 13:41:49 INFO - Online: Yes 13:41:49 INFO - Rotation: Supported 13:41:49 INFO - Return code: 0 13:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:41:49 INFO - Python 2.7.3 13:41:49 INFO - Return code: 0 13:41:49 INFO - grabbing minidump binary from tooltool 13:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:41:49 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 0x10ab60d30>, '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 0x10a9c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab57b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:41:49 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 13:41:49 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 13:41:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:41:49 INFO - Return code: 0 13:41:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:41:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:41:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:41:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:41:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:41:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:41:50 INFO - Return code: 0 13:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 13:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --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 13:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sqnv9QF577/Render', 13:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:41:50 INFO - 'HOME': '/Users/cltbld', 13:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:41:50 INFO - 'LOGNAME': 'cltbld', 13:41:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:41:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:41:50 INFO - 'MOZ_NO_REMOTE': '1', 13:41:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:41:50 INFO - 'NO_EM_RESTART': '1', 13:41:50 INFO - 'PAGER': '/bin/cat', 13:41:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:41:50 INFO - 'PWD': '/builds/slave/test', 13:41:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:41:50 INFO - 'SHELL': '/bin/bash', 13:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCZznOcgDk/Listeners', 13:41:50 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 13:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:41:50 INFO - 'USER': 'cltbld', 13:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:41:50 INFO - 'XPC_FLAGS': '0x0', 13:41:50 INFO - 'XPC_SERVICE_NAME': '0', 13:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:41:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 13:41:50 INFO - mozversion application_buildid: 20160314114738 13:41:50 INFO - mozversion application_changeset: cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 13:41:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:41:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:41:50 INFO - mozversion application_name: Firefox 13:41:50 INFO - mozversion application_remotingname: firefox-dev 13:41:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:41:50 INFO - mozversion application_vendor: Mozilla 13:41:50 INFO - mozversion application_version: 47.0a2 13:41:50 INFO - mozversion platform_buildid: 20160314114738 13:41:50 INFO - mozversion platform_changeset: cc357481aa2bfe4eac8ec0c4c9a65e832a6b1369 13:41:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:41:50 INFO - mozversion platform_version: 47.0a2 13:41:50 INFO - using testdate: 1457988110 13:41:50 INFO - actual date: 1457988110 13:41:50 INFO - starting webserver on 'localhost:49270' 13:41:50 INFO - SUITE-START | Running 2 tests 13:41:50 INFO - TEST-START | dromaeo_css 13:41:50 INFO - operating with platform_type : mac_ 13:41:50 INFO - Initialising browser for dromaeo_css test... 13:41:50 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpQOSGqH/profile http://localhost:49270/getInfo.html) 13:41:53 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 13:41:53 INFO - PROCESS | 1660 | colorDepth:24 13:41:53 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 13:41:53 INFO - PROCESS | 1660 | __metrics 13:41:53 INFO - PROCESS | 1660 | 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" 13:41:53 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:41:53 INFO - TEST-INFO | 1660: exit 0 13:41:53 INFO - Browser initialized. 13:41:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:41:53 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpQOSGqH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:42:05 INFO - PROCESS | 1662 | RSS: Main: 210743296 13:42:05 INFO - PROCESS | 1662 | 13:42:57 INFO - PROCESS | 1662 | 1457988177081 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] 13:45:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 13:45:08 INFO - PROCESS | 1662 | RSS: Main: 325967872 13:45:08 INFO - PROCESS | 1662 | 13:48:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 13:48:11 INFO - PROCESS | 1662 | RSS: Main: 342601728 13:48:11 INFO - PROCESS | 1662 | 13:51:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 13:51:14 INFO - PROCESS | 1662 | RSS: Main: 351354880 13:51:14 INFO - PROCESS | 1662 | 13:54:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 13:54:16 INFO - PROCESS | 1662 | RSS: Main: 306356224 13:54:16 INFO - PROCESS | 1662 | 13:57:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 13:57:20 INFO - PROCESS | 1662 | RSS: Main: 308191232 13:57:20 INFO - PROCESS | 1662 | 14:00:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:00:23 INFO - PROCESS | 1662 | RSS: Main: 355573760 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | __start_tp_report 14:00:23 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 14:00:23 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 14:00:23 INFO - PROCESS | 1662 | |i|pagename|runs| 14:00:23 INFO - PROCESS | 1662 | |0;dojo.html;3470.531478250436;3510.666486683764;3517.261375111228;3540.38043342415;3597.622249663785;4406.515283318837;5636.2954630671165;5674.233978412913;5777.220075289834;5800.709964501774;5757.539396848252;5778.855528611787;5792.6524408535515;5819.854503637411;5820.738066786994;5221.190715439104;5221.6083793715625;5253.238280449333;5288.391834938973;5303.946960530384;5338.252644629735;5340.91988620171;5346.304980352549;5353.00969320675;5354.41101478837;5278.736063196844;5315.548178404841;5328.440513746059;5333.333333333333;5355.973220133894;5335.546478549328;5340.839774806723;5355.946440535603;5377.220303056035;5380.273663055476;5059.418166910816;5240.161574148118;5246.134387826004;5259.710715910624;5273.129933560957;5702.743376548024;5711.286089238845;5735.713214339266;5735.856603584902;5741.741621627037;6176.752929882799;6366.076918846741;6387.712552935129;6397.232332120128;6398.872022559569;5289.814856480043;5304.257403963448;6310.716017779165;6334.144890439778;6385.808425747188;4938.506149385069;5877.412258774131;5913.379095195029;5917.14201440793;5958;6290.308066112724;6349.396807303298;6359.141515895388;6388.616682999035;6418.8716225675225;5141.228815677603;6199.845003874849;6213.00591905293;6220.471259942956;6229.0967809668255;6369.7452101915405;6373.7131829066875;6379.138816259839;6387.361263873576;6399.072134540465;6115.909724157157;6263.874722505524;6325.841853953596;6332.4934005279465;6386.521010924199;5244.423113457517;6310.1796766420075;6332.461740752087;6350.968245158837;6352.6823658816875;4944.332515110486;4952.207646776498;4953.43035550909;4957.82647607332;4959.727215003138;4385;4423.181711383404;4463.35281384204;4501.549845015472;4504.774761261924;5774.018416869142;5788.623739456922;5795.594308398372;5798.362180160179;5833.183354330397;6389.073584330246;6395.776147834804;6402;6404.48764098871;6410.935890641033;5668.461496157858;5756.251687280626;5787.508061814793;5796.043652797325;5817.7963771267805;5425.104857698515;5432.565394768488;5449.073657478159;5454.263674403905;5455;6358.841028974312;6381.649009304533;6414.839629009312;6423.29343772194;6426.678666066771;6302.71637776292;6307.653079080695;6364.840878978062;6400.263969643364;6413.134226879311;6391.999999999814;6406.487481001602;6410.743570257324;6417.93582064192;6425.453836423956;6282.685865706788;6286.717097730704;6300.7479700811455;6305.495560355253;6310;6264.31092579825;6321.241451025906;6341.4292713656;6367.299597044229;6415.839604009937;6183.165272688129;6217.129601855653;6217.658028808459;6220.191375121205;6223.875522489616;6082.2701275847185;6174.783882564088;6186.783462578788;6205.627662340274;6228.283747369111;5501.889962200814;5896.528277737856;5899.056151015989;6062.030075187949;6112.26032301701;6187.504999600112;6189.907151392823;6193.225846769154;6202.534809889366;6204.255489341308;5975.103734439869;6029.216201893726;6058.212432383762;6070.605410648293;6075.149479072845 14:00:23 INFO - PROCESS | 1662 | |1;ext.html;476.95707386335243;521.0854949563516;593.8301545954469;631.5452873930769;668.8194187569356;31428.84285578572;38849.223015539676;39009.21981560367;39035.804820975856;39061.60938390615;42066.369004464956;42452;42477.57522424775;42519.57480425195;42650.786746066304;9578.85631715523;9792.755181120458;9813.411195328303;9819.21446284299;9830.016998300185;9359.20446762026;9474.526273686322;9481.857772133424;9486.193673537757;9486.193673537757;9491.52542372882;9586.808263834719;9599.760005999837;9618.903810961905;9649.855252171223;9529.237660987139;9568.09103135201;9572.090651388107;9583.329166958281;9595.520223988773;9612.231021518262;9694.951525242399;9721.17370023549;9721.65974190907;9730.513474326255;40725.389119163236;41342.58657413418;41399;41476.37785433221;41488.37767433491;3502.2470168913806;3525.5240542526685;3765.755225910307;3875.2249550089814;3940.980295098535;28720.569191462146;28833.711662883314;28910.566341504895;28972.710272897213;29233.853830730925;2800.9719902800916;2809.522381195202;2831.830090194595;2843.5876797864194;2887.9133625991253;370196;370644;370891;371334;373599;64049.67975160095;64341.678291608245;64547.35452645413;64643.676781616734;64683.353166468674;69454.30545694579;69813;76711.61644191743;77590.2240977583;77717;17982.910085449752;17997.370092046716;18158.45524634263;18221.271149153887;18229.27082916695;13756;13850.65373365674;13858.4456621734;13886.861131388558;13896.58310250694;21757.347279581638;22038.559228815655;22064.779352206595;22072.2274720384;22094.668579970992;9596.90403095974;9856.852147217798;9864.112229899343;9868.407895526292;9871.371223748001;964.1563631822156;1004.2468148888188;1137.1244142010605;1139.7891390092693;1159.8434211381525;30084.699153008627;30241.848790755907;30313.696863031528;30905.536416953764;30953.071407857802;1123.5674265407877;1152.9596464123715;1156.9710757231137;1193.164784650748;1247.1706315300405;15339;15468.92265538665;15498.765038642312;15611.219439028004;15700.450484232997;559523;565198;565608;566639;566969;57736.422635773946;58088.128678069865;58438;58440;58513.829723405295;1393.1989106263736;1422.9470192057802;1523.2840564934684;1535.155664384584;1556.5563814313093;26324;26785.464290714466;28544.000959966303;28864.855675721486;29894.953676621215;47972.04055918932;48211.75894120507;48213.517864820904;48285;48322.5167748318;319485.6102877976;366949;380157;380472;381380;29289.414211716074;32936.835315823264;33362.16594585155;33945.66054339425;34000.93991540773;41414.58585414107;41598.792006039774;41787.1642567153;42231.577684223994;43696.78151609222;35462.29075418426;36082.8195859019;37013.444798328586;37029.81485092557;37669;29045.41909161847;36556;36579.817100914326;37060;37230.25539489249;36197.63802361942;37478.43782343213;37870.8106459477;37932.86201413962;38009.80995095007;29423.411531769674;32950.340993179525;34480.137996550286;34904.65095349115;35093.64906350904;18299.634007320044;20416.591668166257;24013;24543.877280613484;24915 14:00:23 INFO - PROCESS | 1662 | |2;jquery.html;384.88261080370484;385.16660695091355;387.53689341237214;395.359517581518;396.5499158455153;16755.413560525383;17038.062906540134;19950.90024549877;20849.687254691173;21393.57212855744;20135.49661258469;20387.28644497443;20494.590108197826;20764.584708305825;20807.479813004684;5707.486326230628;5751.367349591542;5792.594518383715;5857.619254748428;5944.464998150165;4366.126774645084;5803.912941305884;5839.270091238595;6189.845253868667;6622.072909792633;6576.934230657704;6581.30896255891;6582.934170658304;6584.045313429549;6589.0775291458995;6372.617642941415;6500.122483464719;6686.465082793365;6691.698873550702;6703.597784132968;5797.246357973479;5802.158686990363;5806.419358064202;5809.738561764689;5813.767449302023;28549.85725071382;28699.713002869914;29509.557356639667;29530;29706.554401683992;2233.3188377544843;2240.339099965514;2319.6288593824906;2548.643189953408;2797.342624483245;13307.401166947511;15604.921975390163;15894.920525397414;16306.295129153099;16431.83568164315;1624.382734560871;1645.3336398758522;1860.48836569943;1989.3733473955801;2077.761057478379;112481;114629;119053.40473297665;120907.395463023;123195.76804231932;20070.09684564198;20622.38132856017;20942.476438088866;21033.78966210349;21231.68152477714;26934.595981060298;27152.86423567909;29455.558166627517;31164;31294.217644559067;9078.81842363149;9243.445393276425;11657.950784429442;11663.125265605113;11744.412779360997;9904.356216846027;9919.553620087114;9923.255755818342;9935.105840474393;10030.946750591229;9383.859242111374;9486.193673537826;9565.569549370295;9584.28117891161;9591.321518734194;3585.820708964541;3723.0506220913494;3731.645493678096;3731.6828069614385;3748.956818533906;908.5411867007251;1008.0776089877826;1024.8667673202585;1061.395004847245;1086.4567716141928;20734.688979665316;21088.05103770334;21118.577628447652;21147.8942605286;21367.93160342008;972.638306371072;981.2346369831542;1053.6154303679102;1089.6730980705756;1108.2353176308322;11136.777264454666;11142.49858756358;11188.992990630883;11196.608118715969;11198.936101070385;667883;683479;688892;699226;710025;120009.9995000264;122327.38836305762;126134.73865261413;126169;129734.35132824276;947.7109481608038;1071.9624813131502;1135.823947288155;1136.653320737183;1138.9886101138882;18057;18179.909100454413;18334.541636459195;18540.56999455105;18809.811901880807;54564.181537277764;54996;55659;56149.438505614424;56318.43681563296;78796;79283.2071679299;79303.60348198222;80526;82342.94142646242;8340.666373344999;8385.413021088465;8392.664293428195;8535.146485351415;8602.956985215034;9547.713568592953;12935.676608084874;13328.800067999182;13615.727685446434;13742.793858092336;11357.261777984404;11732.882671173178;11838.526458941546;11963.820542692041;12135.332556709112;11251.437428128396;11520;11685;11759.647210583697;11885.405729713653;10040.69877903664;11369.602063927723;11964.282143071443;12174.939125304316;12355;8257.307252013203;8280.50316980983;8281.792955176168;8402.705905293285;8680.305575553813;8726.188997888985;11677.357745324089;11786.705332366759;11919.940400297943;11975.940120299343 14:00:23 INFO - PROCESS | 1662 | |3;mootools.html;1508.4267978168295;1639.9918000409996;1660.3773584905657;2005.438477226377;2075.7301550798393;8231.75304740858;8795.956020219897;8956.731298061053;8962.238209752179;8966.372353935227;8755.868661970075;9032.68385606504;9032.68385606504;9034.277257819374;9039.367244292902;2041.8774873507637;2243.2372993182316;2511.6734824472837;2543.885525151373;2554.4380236347974;2469.950600987979;2486.3784053986506;2491.327341617762;2494.1270555305587;2495.8502489850575;2535.6069809179517;2552.3619095226195;2555.7316481769426;2557.4373637799654;2558.3604098975256;2476.8513889166616;2563.0132399026324;2571.112966026727;2571.2029270925977;2572.3311938895836;2528.0772518030785;2559.705633852094;2564.0769323043687;2567.6918769747563;2571.100114959768;8976.147266009719;9050.094990500897;9061.637534498612;9064.682736104205;9077.228435582983;5567.972160139214;5736.598438109334;5765;5767.826965191051;5772.682502462363;3156.3687262547583;3683.37382644951;3693.649103335179;3838.05967537955;3844.692424606025;1084.251866212311;1089.84742136101;1092.470151976291;1095.2825899036145;1108.2020944919645;12508.624741257685;12531.686707832378;12548.247105173628;12561.811572826324;12576.182548134342;5042.369703787027;5045.2432135180015;5119.539241468286;5135.794568217304;5137.922931156036;10493;10547.367157970546;10555.47222638865;10587.735306617396;10588.841167382496;5153.639245252796;5676.602637815313;5687.829365119053;5715.942840571624;5730.36965933747;4097.959020409818;4736.384270044941;5000.099982003201;5062.417821950523;5073.771680274396;4064.4309796628495;4122.9381559276635;4143.835957000322;4165.66674666026;4169.291220492523;1364.0451683821366;1374.202962281874;1374.305975482375;1376.078027721429;1394.3028485757122;1405.416752047909;1437.5040610989192;1442.40140341757;1454.163855782929;1462.6635873749096;8553.61508732096;8609.397342186112;8662.78343041429;8669.436486628349;8695.260902823204;535.2960856473725;549.3490214096308;550.6035654328876;553.7784886045614;554.3763266325384;6379.681015949277;6400;6436.259830119596;6455.419012288917;6462.289148193695;10819.945900270448;11309.604163854226;11327.490262938187;11338.43307834605;11363.602273920373;10491.895081049091;10997.890021099847;11026.44867756609;11054.949779770908;11105.777884442266;8433.831323373499;8595.054544000155;8614.956925215334;8664.306855451674;8671.349648776368;8263;8300.501969881827;8319.168083191633;8401.537915414467;8419.242268195892;9599.32804703664;9688.176504997155;9839.5080245986;9912.752181195528;10118.139958103644;10222.846657299997;10283.672012658693;10331.070203681706;10463.79072418532;10493.370397775852;7096.112985876765;7510.737124200627;7693.4614576979075;7726.42051846125;7840.490368126281;8499.78750531217;8520.70177543783;8534.06125326226;8557.272631826365;8570.48577085377;7422.888656670262;7573.810654733676;7631.771046868603;7644.350230230492;7677.539347639159;7324.816879578053;7370.742024029348;7381;7461.738839140604;7493.4379921505015;7997.8400431992195;8027.956365672425;8070.515769053875;8073.515589064675;8075.192480752113;7270.091238595176;7298.890516642361;7315.48791584584;7316.451266154953;7319.597422141834;7365.484416090822;7376.815579610553;7437.107547094383;7437.107547094383;7480.326770590673 14:00:23 INFO - PROCESS | 1662 | |4;prototype.html;336.26693807499646;338.5953785226654;344.8810160494629;345.1578149315671;350.8736854732296;6160.229971253593;6344.016677415008;6854.417374523159;6872.72509099636;6879.449644028478;5513.669179849212;6735.696893639786;6804.251532331439;6812.62530560819;6816.659167041653;3996.8401263949554;4806.7115973041555;4934.235193545006;4942.085714142895;5077.238414237866;4942.604591632678;4952.752362381884;4958.900821983558;5030.773615187307;5085.211792172219;4960.851174464772;4971.627127965399;5005.749712514378;5010.3737032870895;5021.221710634857;5005.17414626588;5016.749162541895;5024.849254522352;5027.874303142414;5050.343455350818;4164.729292595972;4241.533431322552;4308.590683885026;4327.653787696977;4330.198913201068;6492.545521813475;6545.901811472784;6570.113034740297;6587.242467116295;6607.80176594703;4864.975675121637;4917.237828136645;5989.8203053908455;5997.070454079581;5999.100134979744;7244.203137654854;7267.127944646623;7275.527090739138;7282.890756638654;7291.161516425626;4721.504242054569;4859.781309841065;4861.489543597942;4875.293082503017;4876.097921884428;6737.528373013891;6937.68780404883;7270.345668889772;7629.809254768676;7677.692892284302;5001.89996200074;5002.274670172877;5004.9499505005215;5009.77456014473;5016.523430274118;5091.363579552556;5102.464241254689;5106.004329155853;5116.616253780981;5121.897562048738;5972.701364931736;5975.701214939236;5977.432143946318;5977.880442391128;5990.430909063632;7018.719251229893;7283.5994020328335;7289.125304963438;7298.343149116605;7305.926940730525;1453.3677850135225;1742.9215685294191;1767.460924418065;1774.2636805725479;1774.308019872251;1133.8809425010254;1134.1890548258036;1152.1819508149308;1163.1567113842566;1163.6160067177811;6520.0871877937125;6645.833854153685;6738.372034906391;6763;6784.185897692309;7595.696172153052;7598.392128629696;7609.315161635479;7615.124260709978;7621.352185064332;6109.877802443926;6325.304216536178;6788.389044985975;6807.149106361705;6833.077534532874;3948.368261078214;3985.083430810872;3994.500687414073;3997.5003124609425;4002.679785617202;6383.968080159662;7554.508956917783;7702.1912699166905;7814.53112813233;7957;7806.219378062262;7833.960830195812;7868;7871.763847084597;7877.094134174528;6714.664266786641;6813.897791533131;7708.075030996316;7897.24976127267;7919.762407127795;7577.560263549908;7577.583232922022;7581.241875812375;7581.279778421042;7591.58246296459;7182.450230168215;7437.590932498764;7470.178280389261;7477;7479.513831600929;7836;7870.5671188082915;7872.1340652529325;7895.7236496722335;7906.402586822866;4753.881152971203;4767.332573439652;4796.616270698406;4802.303665968485;4810.5670489656095;6125.326214116532;7507.860259825923;7511.136219334847;7513.849723005618;7519.172890982097;6930.584164950119;7254.274572542704;7265.418766498773;7265.7093716252875;7271.563706177646;7166.390856777232;7240.05879235696;7250.20247772734;7256.2743725627015;7263.818404539928;7089.645517724196;7093.609851458219;7095.113110861143;7103.431725461847;7109.857802844018;7014.614196219053;7253.8186545336785;7260.310270524292;7268.527545709512;7276.927230727625;6774.932250677627;6996.405305549085;7098.609576473344;7108.644567771487;7117.217106118219 14:00:23 INFO - PROCESS | 1662 | |5;yui.html;705.6330708031824;735.9595222262774;761.7067429039818;791.3866753266218;809.9672917030784;15192.392304307828;15393.076415415084;15463.458778942753;15470.381184752596;15534.766978495318;14795;14874.405023799061;14878.55364339069;14894.957352985295;14937.477188298411;797.4696826610298;806.7499075286651;815.4577206157912;1001.0340021878885;1018.5314755212611;969.9951500242489;970.0881171698616;971.2909576009517;973.1679414100948;1014.7361685961629;1031.943243121628;1031.9948400257988;1033.9534720937577;1034.896510348963;1070.0048954472377;816.0696805641544;824.7195953375851;1058.5871510110985;1065.701603551003;1075.424647813424;800.6597196191595;801.8276070644781;804.851102546025;805.1023109233221;807.475141158246;15192.924035379752;15239.314230859527;15244.314005869763;15270.923645381701;15290.694186116216;12795.011288253332;12820.487180512768;12914.612561623166;12940.417681204368;13095.869041309656;10000.299979001473;10076.89923100767;10096.29325947184;10263.384196948207;10418.166546676248;3493.8427770750377;3550.8934731958084;3551.449525323579;3555.520004799345;3577.624349443297;86617;89491;89881.55059224663;89904;91391.54304228436;9791.755206119762;9806.068423499755;9904.851427228597;9955.30312878106;9994.550245238981;22755.7724422757;22807.885960570424;22844.885775571016;22867.313980580275;22881.88559057194;7445.739399121005;7496.175420703718;7524.360429363565;7593.772186834404;7811.375089992787;4087.2642924273323;4117.155983023473;4165.312723400605;4227;4266.338717498793;3689.963100368962;3722.050877026341;3725.9068523287133;3727.9440808387894;3735.533058367704;660.7158921663731;677.891756636859;681.1247546902306;685.1196212866442;685.6708779785631;586.155935452955;591.7632946821305;603.6740160313382;604.9455549000611;611.4252602553586;7757.26306000929;8413.6101637448;8715.869261961076;8974.506402147814;9048.547572621343;597.7698586044404;615.9630422174683;624.5596854217765;626.8714913442733;633.3223450907485;3779.905502362408;3882.7476214045996;3922.627350401707;4012.799360031987;4021.91956160881;96821.03178968262;98929.01070989342;99311.51032734515;99446;99466.50266748764;87159.12840871637;87284.6907296391;87937;88279;88874;70102.64948675224;73731.63134184295;76694.84957725639;76999;77554;8678.696245631372;8689.739307820775;8779.789992350674;8985.550722463982;8989.640414383352;46557.30164047474;49049.75475122601;51631.967360651826;53520;54574.18138728002;59071.40928590659;75814.62092689502;76101.85847212408;77179.61410192912;77720.61139694265;10783.083437907866;11413.486393112164;11426.771464570496;11880.821787673365;12042.939785301018;12063;12143;12404.689882752642;12540.310282934526;13010.21938683682;8988.415752976036;11743.706407339885;11794.646160614851;11813.586524471602;12440.31578263168;11580.942095289469;11615.245009074382;11899.76200476003;12112.818307725214;12171.208871423683;11296.661100167008;11344;11443.313401195956;11779.352135632622;11862.940685296518;9622.47076410804;9678.661246856327;9814.2148628111;10012.44931528773;10350.378977261389;8788.599754630317;9877.40735555869;10000.149987251165;10010.299279050396;10087.747806304607 14:00:23 INFO - PROCESS | 1662 | __end_tp_report 14:00:23 INFO - PROCESS | 1662 | __start_cc_report 14:00:23 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1051 14:00:23 INFO - PROCESS | 1662 | __end_cc_report 14:00:23 INFO - PROCESS | 1662 | __startTimestamp1457989223182__endTimestamp 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | ------- Summary: start ------- 14:00:23 INFO - PROCESS | 1662 | Number of tests: 6 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5796.60 Median:5975.10 stddev:657.93 (11.0%) stddev-sans-first:634.14 14:00:23 INFO - PROCESS | 1662 | Values: 3470.5 3510.7 3517.3 3540.4 3597.6 4406.5 5636.3 5674.2 5777.2 5800.7 5757.5 5778.9 5792.7 5819.9 5820.7 5221.2 5221.6 5253.2 5288.4 5303.9 5338.3 5340.9 5346.3 5353.0 5354.4 5278.7 5315.5 5328.4 5333.3 5356.0 5335.5 5340.8 5355.9 5377.2 5380.3 5059.4 5240.2 5246.1 5259.7 5273.1 5702.7 5711.3 5735.7 5735.9 5741.7 6176.8 6366.1 6387.7 6397.2 6398.9 5289.8 5304.3 6310.7 6334.1 6385.8 4938.5 5877.4 5913.4 5917.1 5958.0 6290.3 6349.4 6359.1 6388.6 6418.9 5141.2 6199.8 6213.0 6220.5 6229.1 6369.7 6373.7 6379.1 6387.4 6399.1 6115.9 6263.9 6325.8 6332.5 6386.5 5244.4 6310.2 6332.5 6351.0 6352.7 4944.3 4952.2 4953.4 4957.8 4959.7 4385.0 4423.2 4463.4 4501.5 4504.8 5774.0 5788.6 5795.6 5798.4 5833.2 6389.1 6395.8 6402.0 6404.5 6410.9 5668.5 5756.3 5787.5 5796.0 5817.8 5425.1 5432.6 5449.1 5454.3 5455.0 6358.8 6381.6 6414.8 6423.3 6426.7 6302.7 6307.7 6364.8 6400.3 6413.1 6392.0 6406.5 6410.7 6417.9 6425.5 6282.7 6286.7 6300.7 6305.5 6310.0 6264.3 6321.2 6341.4 6367.3 6415.8 6183.2 6217.1 6217.7 6220.2 6223.9 6082.3 6174.8 6186.8 6205.6 6228.3 5501.9 5896.5 5899.1 6062.0 6112.3 6187.5 6189.9 6193.2 6202.5 6204.3 5975.1 6029.2 6058.2 6070.6 6075.1 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:59279.07 Median:20717.38 stddev:117926.48 (569.2%) stddev-sans-first:118174.66 14:00:23 INFO - PROCESS | 1662 | Values: 477.0 521.1 593.8 631.5 668.8 31428.8 38849.2 39009.2 39035.8 39061.6 42066.4 42452.0 42477.6 42519.6 42650.8 9578.9 9792.8 9813.4 9819.2 9830.0 9359.2 9474.5 9481.9 9486.2 9486.2 9491.5 9586.8 9599.8 9618.9 9649.9 9529.2 9568.1 9572.1 9583.3 9595.5 9612.2 9695.0 9721.2 9721.7 9730.5 40725.4 41342.6 41399.0 41476.4 41488.4 3502.2 3525.5 3765.8 3875.2 3941.0 28720.6 28833.7 28910.6 28972.7 29233.9 2801.0 2809.5 2831.8 2843.6 2887.9 370196.0 370644.0 370891.0 371334.0 373599.0 64049.7 64341.7 64547.4 64643.7 64683.4 69454.3 69813.0 76711.6 77590.2 77717.0 17982.9 17997.4 18158.5 18221.3 18229.3 13756.0 13850.7 13858.4 13886.9 13896.6 21757.3 22038.6 22064.8 22072.2 22094.7 9596.9 9856.9 9864.1 9868.4 9871.4 964.2 1004.2 1137.1 1139.8 1159.8 30084.7 30241.8 30313.7 30905.5 30953.1 1123.6 1153.0 1157.0 1193.2 1247.2 15339.0 15468.9 15498.8 15611.2 15700.5 559523.0 565198.0 565608.0 566639.0 566969.0 57736.4 58088.1 58438.0 58440.0 58513.8 1393.2 1422.9 1523.3 1535.2 1556.6 26324.0 26785.5 28544.0 28864.9 29895.0 47972.0 48211.8 48213.5 48285.0 48322.5 319485.6 366949.0 380157.0 380472.0 381380.0 29289.4 32936.8 33362.2 33945.7 34000.9 41414.6 41598.8 41787.2 42231.6 43696.8 35462.3 36082.8 37013.4 37029.8 37669.0 29045.4 36556.0 36579.8 37060.0 37230.3 36197.6 37478.4 37870.8 37932.9 38009.8 29423.4 32950.3 34480.1 34904.7 35093.6 18299.6 20416.6 24013.0 24543.9 24915.0 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:38926.76 Median:2434.14 stddev:114104.82 (4687.7%) stddev-sans-first:114388.22 14:00:23 INFO - PROCESS | 1662 | Values: 384.9 385.2 387.5 395.4 396.5 16755.4 17038.1 19950.9 20849.7 21393.6 20135.5 20387.3 20494.6 20764.6 20807.5 5707.5 5751.4 5792.6 5857.6 5944.5 4366.1 5803.9 5839.3 6189.8 6622.1 6576.9 6581.3 6582.9 6584.0 6589.1 6372.6 6500.1 6686.5 6691.7 6703.6 5797.2 5802.2 5806.4 5809.7 5813.8 28549.9 28699.7 29509.6 29530.0 29706.6 2233.3 2240.3 2319.6 2548.6 2797.3 13307.4 15604.9 15894.9 16306.3 16431.8 1624.4 1645.3 1860.5 1989.4 2077.8 112481.0 114629.0 119053.4 120907.4 123195.8 20070.1 20622.4 20942.5 21033.8 21231.7 26934.6 27152.9 29455.6 31164.0 31294.2 9078.8 9243.4 11658.0 11663.1 11744.4 9904.4 9919.6 9923.3 9935.1 10030.9 9383.9 9486.2 9565.6 9584.3 9591.3 3585.8 3723.1 3731.6 3731.7 3749.0 908.5 1008.1 1024.9 1061.4 1086.5 20734.7 21088.1 21118.6 21147.9 21367.9 972.6 981.2 1053.6 1089.7 1108.2 11136.8 11142.5 11189.0 11196.6 11198.9 667883.0 683479.0 688892.0 699226.0 710025.0 120010.0 122327.4 126134.7 126169.0 129734.4 947.7 1072.0 1135.8 1136.7 1139.0 18057.0 18179.9 18334.5 18540.6 18809.8 54564.2 54996.0 55659.0 56149.4 56318.4 78796.0 79283.2 79303.6 80526.0 82342.9 8340.7 8385.4 8392.7 8535.1 8603.0 9547.7 12935.7 13328.8 13615.7 13742.8 11357.3 11732.9 11838.5 11963.8 12135.3 11251.4 11520.0 11685.0 11759.6 11885.4 10040.7 11369.6 11964.3 12174.9 12355.0 8257.3 8280.5 8281.8 8402.7 8680.3 8726.2 11677.4 11786.7 11919.9 11975.9 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6274.78 Median:5145.78 stddev:3342.44 (65.0%) stddev-sans-first:3332.61 14:00:23 INFO - PROCESS | 1662 | Values: 1508.4 1640.0 1660.4 2005.4 2075.7 8231.8 8796.0 8956.7 8962.2 8966.4 8755.9 9032.7 9032.7 9034.3 9039.4 2041.9 2243.2 2511.7 2543.9 2554.4 2470.0 2486.4 2491.3 2494.1 2495.9 2535.6 2552.4 2555.7 2557.4 2558.4 2476.9 2563.0 2571.1 2571.2 2572.3 2528.1 2559.7 2564.1 2567.7 2571.1 8976.1 9050.1 9061.6 9064.7 9077.2 5568.0 5736.6 5765.0 5767.8 5772.7 3156.4 3683.4 3693.6 3838.1 3844.7 1084.3 1089.8 1092.5 1095.3 1108.2 12508.6 12531.7 12548.2 12561.8 12576.2 5042.4 5045.2 5119.5 5135.8 5137.9 10493.0 10547.4 10555.5 10587.7 10588.8 5153.6 5676.6 5687.8 5715.9 5730.4 4098.0 4736.4 5000.1 5062.4 5073.8 4064.4 4122.9 4143.8 4165.7 4169.3 1364.0 1374.2 1374.3 1376.1 1394.3 1405.4 1437.5 1442.4 1454.2 1462.7 8553.6 8609.4 8662.8 8669.4 8695.3 535.3 549.3 550.6 553.8 554.4 6379.7 6400.0 6436.3 6455.4 6462.3 10819.9 11309.6 11327.5 11338.4 11363.6 10491.9 10997.9 11026.4 11054.9 11105.8 8433.8 8595.1 8615.0 8664.3 8671.3 8263.0 8300.5 8319.2 8401.5 8419.2 9599.3 9688.2 9839.5 9912.8 10118.1 10222.8 10283.7 10331.1 10463.8 10493.4 7096.1 7510.7 7693.5 7726.4 7840.5 8499.8 8520.7 8534.1 8557.3 8570.5 7422.9 7573.8 7631.8 7644.4 7677.5 7324.8 7370.7 7381.0 7461.7 7493.4 7997.8 8028.0 8070.5 8073.5 8075.2 7270.1 7298.9 7315.5 7316.5 7319.6 7365.5 7376.8 7437.1 7437.1 7480.3 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5929.36 Median:6736.61 stddev:1869.85 (27.8%) stddev-sans-first:1827.36 14:00:23 INFO - PROCESS | 1662 | Values: 336.3 338.6 344.9 345.2 350.9 6160.2 6344.0 6854.4 6872.7 6879.4 5513.7 6735.7 6804.3 6812.6 6816.7 3996.8 4806.7 4934.2 4942.1 5077.2 4942.6 4952.8 4958.9 5030.8 5085.2 4960.9 4971.6 5005.7 5010.4 5021.2 5005.2 5016.7 5024.8 5027.9 5050.3 4164.7 4241.5 4308.6 4327.7 4330.2 6492.5 6545.9 6570.1 6587.2 6607.8 4865.0 4917.2 5989.8 5997.1 5999.1 7244.2 7267.1 7275.5 7282.9 7291.2 4721.5 4859.8 4861.5 4875.3 4876.1 6737.5 6937.7 7270.3 7629.8 7677.7 5001.9 5002.3 5004.9 5009.8 5016.5 5091.4 5102.5 5106.0 5116.6 5121.9 5972.7 5975.7 5977.4 5977.9 5990.4 7018.7 7283.6 7289.1 7298.3 7305.9 1453.4 1742.9 1767.5 1774.3 1774.3 1133.9 1134.2 1152.2 1163.2 1163.6 6520.1 6645.8 6738.4 6763.0 6784.2 7595.7 7598.4 7609.3 7615.1 7621.4 6109.9 6325.3 6788.4 6807.1 6833.1 3948.4 3985.1 3994.5 3997.5 4002.7 6384.0 7554.5 7702.2 7814.5 7957.0 7806.2 7834.0 7868.0 7871.8 7877.1 6714.7 6813.9 7708.1 7897.2 7919.8 7577.6 7577.6 7581.2 7581.3 7591.6 7182.5 7437.6 7470.2 7477.0 7479.5 7836.0 7870.6 7872.1 7895.7 7906.4 4753.9 4767.3 4796.6 4802.3 4810.6 6125.3 7507.9 7511.1 7513.8 7519.2 6930.6 7254.3 7265.4 7265.7 7271.6 7166.4 7240.1 7250.2 7256.3 7263.8 7089.6 7093.6 7095.1 7103.4 7109.9 7014.6 7253.8 7260.3 7268.5 7276.9 6774.9 6996.4 7098.6 7108.6 7117.2 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19522.50 Median:47803.53 stddev:28051.97 (58.7%) stddev-sans-first:28095.08 14:00:23 INFO - PROCESS | 1662 | Values: 705.6 736.0 761.7 791.4 810.0 15192.4 15393.1 15463.5 15470.4 15534.8 14795.0 14874.4 14878.6 14895.0 14937.5 797.5 806.7 815.5 1001.0 1018.5 970.0 970.1 971.3 973.2 1014.7 1031.9 1032.0 1034.0 1034.9 1070.0 816.1 824.7 1058.6 1065.7 1075.4 800.7 801.8 804.9 805.1 807.5 15192.9 15239.3 15244.3 15270.9 15290.7 12795.0 12820.5 12914.6 12940.4 13095.9 10000.3 10076.9 10096.3 10263.4 10418.2 3493.8 3550.9 3551.4 3555.5 3577.6 86617.0 89491.0 89881.6 89904.0 91391.5 9791.8 9806.1 9904.9 9955.3 9994.6 22755.8 22807.9 22844.9 22867.3 22881.9 7445.7 7496.2 7524.4 7593.8 7811.4 4087.3 4117.2 4165.3 4227.0 4266.3 3690.0 3722.1 3725.9 3727.9 3735.5 660.7 677.9 681.1 685.1 685.7 586.2 591.8 603.7 604.9 611.4 7757.3 8413.6 8715.9 8974.5 9048.5 597.8 616.0 624.6 626.9 633.3 3779.9 3882.7 3922.6 4012.8 4021.9 96821.0 98929.0 99311.5 99446.0 99466.5 87159.1 87284.7 87937.0 88279.0 88874.0 70102.6 73731.6 76694.8 76999.0 77554.0 8678.7 8689.7 8779.8 8985.6 8989.6 46557.3 49049.8 51632.0 53520.0 54574.2 59071.4 75814.6 76101.9 77179.6 77720.6 10783.1 11413.5 11426.8 11880.8 12042.9 12063.0 12143.0 12404.7 12540.3 13010.2 8988.4 11743.7 11794.6 11813.6 12440.3 11580.9 11615.2 11899.8 12112.8 12171.2 11296.7 11344.0 11443.3 11779.4 11862.9 9622.5 9678.7 9814.2 10012.4 10350.4 8788.6 9877.4 10000.1 10010.3 10087.7 14:00:23 INFO - PROCESS | 1662 | -------- Summary: end -------- 14:00:23 INFO - PROCESS | 1662 | 14:00:23 INFO - TEST-INFO | 1662: exit 0 14:00:23 INFO - TEST-OK | dromaeo_css | took 1112987ms 14:00:23 INFO - TEST-START | kraken 14:00:23 INFO - operating with platform_type : mac_ 14:00:23 INFO - Initialising browser for kraken test... 14:00:23 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp_SbFME/profile http://localhost:49270/getInfo.html) 14:00:25 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 14:00:25 INFO - PROCESS | 1671 | colorDepth:24 14:00:25 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 14:00:25 INFO - PROCESS | 1671 | __metrics 14:00:25 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" 14:00:25 INFO - PROCESS | 1671 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:00:26 INFO - TEST-INFO | 1671: exit 0 14:00:26 INFO - Browser initialized. 14:00:26 INFO - Running cycle 1/1 for kraken test... 14:00:26 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp_SbFME/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:00:38 INFO - PROCESS | 1673 | RSS: Main: 210771968 14:00:38 INFO - PROCESS | 1673 | 14:00:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 14:00:41 INFO - PROCESS | 1673 | RSS: Main: 264605696 14:00:41 INFO - PROCESS | 1673 | 14:00:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 14:00:45 INFO - PROCESS | 1673 | RSS: Main: 275668992 14:00:45 INFO - PROCESS | 1673 | 14:00:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 14:00:48 INFO - PROCESS | 1673 | RSS: Main: 264667136 14:00:48 INFO - PROCESS | 1673 | 14:00:50 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 14:00:51 INFO - PROCESS | 1673 | RSS: Main: 266899456 14:00:51 INFO - PROCESS | 1673 | 14:00:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:00:53 INFO - PROCESS | 1673 | RSS: Main: 267059200 14:00:53 INFO - PROCESS | 1673 | 14:00:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 14:00:57 INFO - PROCESS | 1673 | RSS: Main: 267440128 14:00:57 INFO - PROCESS | 1673 | 14:01:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 14:01:00 INFO - PROCESS | 1673 | RSS: Main: 265949184 14:01:00 INFO - PROCESS | 1673 | 14:01:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 14:01:03 INFO - PROCESS | 1673 | RSS: Main: 267583488 14:01:03 INFO - PROCESS | 1673 | 14:01:05 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:01:06 INFO - PROCESS | 1673 | RSS: Main: 301080576 14:01:06 INFO - PROCESS | 1673 | 14:01:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:01:08 INFO - PROCESS | 1673 | RSS: Main: 301223936 14:01:08 INFO - PROCESS | 1673 | 14:01:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:01:11 INFO - PROCESS | 1673 | RSS: Main: 307314688 14:01:11 INFO - PROCESS | 1673 | 14:01:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:01:14 INFO - PROCESS | 1673 | RSS: Main: 310300672 14:01:14 INFO - PROCESS | 1673 | 14:01:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:01:17 INFO - PROCESS | 1673 | RSS: Main: 310284288 14:01:17 INFO - PROCESS | 1673 | 14:01:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 14:01:19 INFO - PROCESS | 1673 | RSS: Main: 369602560 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | __start_tp_report 14:01:19 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 14:01:19 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 14:01:19 INFO - PROCESS | 1673 | |i|pagename|runs| 14:01:19 INFO - PROCESS | 1673 | |0;ai-astar;113;111;113;106;111;113;119;115;158;160 14:01:19 INFO - PROCESS | 1673 | |1;audio-beat-detection;154;118;153;144;116;140;115;148;143;118 14:01:19 INFO - PROCESS | 1673 | |2;audio-dft;184;185;189;187;188;188;183;184;183;185 14:01:19 INFO - PROCESS | 1673 | |3;audio-fft;73;71;74;116;56;57;57;59;121;56 14:01:19 INFO - PROCESS | 1673 | |4;audio-oscillator;92;96;126;81;80;80;116;76;78;117 14:01:19 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;89;85;88;87;90;86;91;87;89;88 14:01:19 INFO - PROCESS | 1673 | |6;imaging-darkroom;94;94;94;94;94;94;94;95;95;95 14:01:19 INFO - PROCESS | 1673 | |7;imaging-desaturate;87;85;85;85;85;86;85;85;84;84 14:01:19 INFO - PROCESS | 1673 | |8;json-parse-financial;56;58;59;58;57;58;59;67;51;51 14:01:19 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;62;62;68;62;67;73;70;66;66;68 14:01:19 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;80;77;80;80;79;78;80;80;81;84 14:01:19 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;119;126;122;104;129;132;129;135;116;128 14:01:19 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;131;121;132;130;130;120;132;132;131;162 14:01:19 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;65;66;64;67;66;66;67;66;66;65 14:01:19 INFO - PROCESS | 1673 | __end_tp_report 14:01:19 INFO - PROCESS | 1673 | __start_cc_report 14:01:19 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1189 14:01:19 INFO - PROCESS | 1673 | __end_cc_report 14:01:19 INFO - PROCESS | 1673 | __startTimestamp1457989279163__endTimestamp 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | ------- Summary: start ------- 14:01:19 INFO - PROCESS | 1673 | Number of tests: 14 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:121.90 Median:114.00 stddev:19.83 (17.4%) stddev-sans-first:20.77 14:01:19 INFO - PROCESS | 1673 | Values: 113.0 111.0 113.0 106.0 111.0 113.0 119.0 115.0 158.0 160.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:143.50 stddev:16.20 (11.3%) stddev-sans-first:15.64 14:01:19 INFO - PROCESS | 1673 | Values: 154.0 118.0 153.0 144.0 116.0 140.0 115.0 148.0 143.0 118.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.00 stddev:2.22 (1.2%) stddev-sans-first:2.28 14:01:19 INFO - PROCESS | 1673 | Values: 184.0 185.0 189.0 187.0 188.0 188.0 183.0 184.0 183.0 185.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:74.00 Median:58.00 stddev:24.57 (42.4%) stddev-sans-first:26.06 14:01:19 INFO - PROCESS | 1673 | Values: 73.0 71.0 74.0 116.0 56.0 57.0 57.0 59.0 121.0 56.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:80.00 stddev:18.81 (23.5%) stddev-sans-first:19.94 14:01:19 INFO - PROCESS | 1673 | Values: 92.0 96.0 126.0 81.0 80.0 80.0 116.0 76.0 78.0 117.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.50 stddev:1.83 (2.1%) stddev-sans-first:1.90 14:01:19 INFO - PROCESS | 1673 | Values: 89.0 85.0 88.0 87.0 90.0 86.0 91.0 87.0 89.0 88.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:01:19 INFO - PROCESS | 1673 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.88 (1.0%) stddev-sans-first:0.60 14:01:19 INFO - PROCESS | 1673 | Values: 87.0 85.0 85.0 85.0 85.0 86.0 85.0 85.0 84.0 84.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:4.50 (7.8%) stddev-sans-first:4.75 14:01:19 INFO - PROCESS | 1673 | Values: 56.0 58.0 59.0 58.0 57.0 58.0 59.0 67.0 51.0 51.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.50 stddev:3.66 (5.4%) stddev-sans-first:3.52 14:01:19 INFO - PROCESS | 1673 | Values: 62.0 62.0 68.0 62.0 67.0 73.0 70.0 66.0 66.0 68.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:1.85 (2.3%) stddev-sans-first:1.96 14:01:19 INFO - PROCESS | 1673 | Values: 80.0 77.0 80.0 80.0 79.0 78.0 80.0 80.0 81.0 84.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:128.50 stddev:9.12 (7.1%) stddev-sans-first:9.49 14:01:19 INFO - PROCESS | 1673 | Values: 119.0 126.0 122.0 104.0 129.0 132.0 129.0 135.0 116.0 128.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.10 Median:131.50 stddev:11.43 (8.7%) stddev-sans-first:12.11 14:01:19 INFO - PROCESS | 1673 | Values: 131.0 121.0 132.0 130.0 130.0 120.0 132.0 132.0 131.0 162.0 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 14:01:19 INFO - PROCESS | 1673 | Values: 65.0 66.0 64.0 67.0 66.0 66.0 67.0 66.0 66.0 65.0 14:01:19 INFO - PROCESS | 1673 | -------- Summary: end -------- 14:01:19 INFO - PROCESS | 1673 | 14:01:19 INFO - TEST-INFO | 1673: exit 0 14:01:19 INFO - TEST-OK | kraken | took 56178ms 14:01:19 INFO - SUITE-END | took 1169s 14:01:20 INFO - Completed test suite (00:19:29) 14:01:20 INFO - javascript benchmark 14:01:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3470.531478250436, 3510.666486683764, 3517.261375111228, 3540.38043342415, 3597.622249663785, 4406.515283318837, 5636.2954630671165, 5674.233978412913, 5777.220075289834, 5800.709964501774, 5757.539396848252, 5778.855528611787, 5792.6524408535515, 5819.854503637411, 5820.738066786994, 5221.190715439104, 5221.6083793715625, 5253.238280449333, 5288.391834938973, 5303.946960530384, 5338.252644629735, 5340.91988620171, 5346.304980352549, 5353.00969320675, 5354.41101478837, 5278.736063196844, 5315.548178404841, 5328.440513746059, 5333.333333333333, 5355.973220133894, 5335.546478549328, 5340.839774806723, 5355.946440535603, 5377.220303056035, 5380.273663055476, 5059.418166910816, 5240.161574148118, 5246.134387826004, 5259.710715910624, 5273.129933560957, 5702.743376548024, 5711.286089238845, 5735.713214339266, 5735.856603584902, 5741.741621627037, 6176.752929882799, 6366.076918846741, 6387.712552935129, 6397.232332120128, 6398.872022559569, 5289.814856480043, 5304.257403963448, 6310.716017779165, 6334.144890439778, 6385.808425747188, 4938.506149385069, 5877.412258774131, 5913.379095195029, 5917.14201440793, 5958.0, 6290.308066112724, 6349.396807303298, 6359.141515895388, 6388.616682999035, 6418.8716225675225, 5141.228815677603, 6199.845003874849, 6213.00591905293, 6220.471259942956, 6229.0967809668255, 6369.7452101915405, 6373.7131829066875, 6379.138816259839, 6387.361263873576, 6399.072134540465, 6115.909724157157, 6263.874722505524, 6325.841853953596, 6332.4934005279465, 6386.521010924199, 5244.423113457517, 6310.1796766420075, 6332.461740752087, 6350.968245158837, 6352.6823658816875, 4944.332515110486, 4952.207646776498, 4953.43035550909, 4957.82647607332, 4959.727215003138, 4385.0, 4423.181711383404, 4463.35281384204, 4501.549845015472, 4504.774761261924, 5774.018416869142, 5788.623739456922, 5795.594308398372, 5798.362180160179, 5833.183354330397, 6389.073584330246, 6395.776147834804, 6402.0, 6404.48764098871, 6410.935890641033, 5668.461496157858, 5756.251687280626, 5787.508061814793, 5796.043652797325, 5817.7963771267805, 5425.104857698515, 5432.565394768488, 5449.073657478159, 5454.263674403905, 5455.0, 6358.841028974312, 6381.649009304533, 6414.839629009312, 6423.29343772194, 6426.678666066771, 6302.71637776292, 6307.653079080695, 6364.840878978062, 6400.263969643364, 6413.134226879311, 6391.999999999814, 6406.487481001602, 6410.743570257324, 6417.93582064192, 6425.453836423956, 6282.685865706788, 6286.717097730704, 6300.7479700811455, 6305.495560355253, 6310.0, 6264.31092579825, 6321.241451025906, 6341.4292713656, 6367.299597044229, 6415.839604009937, 6183.165272688129, 6217.129601855653, 6217.658028808459, 6220.191375121205, 6223.875522489616, 6082.2701275847185, 6174.783882564088, 6186.783462578788, 6205.627662340274, 6228.283747369111, 5501.889962200814, 5896.528277737856, 5899.056151015989, 6062.030075187949, 6112.26032301701, 6187.504999600112, 6189.907151392823, 6193.225846769154, 6202.534809889366, 6204.255489341308, 5975.103734439869, 6029.216201893726, 6058.212432383762, 6070.605410648293, 6075.149479072845], "unit": "score", "name": "dojo.html", "value": 5756.911499060304}, {"lowerIsBetter": false, "replicates": [476.95707386335243, 521.0854949563516, 593.8301545954469, 631.5452873930769, 668.8194187569356, 31428.84285578572, 38849.223015539676, 39009.21981560367, 39035.804820975856, 39061.60938390615, 42066.369004464956, 42452.0, 42477.57522424775, 42519.57480425195, 42650.786746066304, 9578.85631715523, 9792.755181120458, 9813.411195328303, 9819.21446284299, 9830.016998300185, 9359.20446762026, 9474.526273686322, 9481.857772133424, 9486.193673537757, 9486.193673537757, 9491.52542372882, 9586.808263834719, 9599.760005999837, 9618.903810961905, 9649.855252171223, 9529.237660987139, 9568.09103135201, 9572.090651388107, 9583.329166958281, 9595.520223988773, 9612.231021518262, 9694.951525242399, 9721.17370023549, 9721.65974190907, 9730.513474326255, 40725.389119163236, 41342.58657413418, 41399.0, 41476.37785433221, 41488.37767433491, 3502.2470168913806, 3525.5240542526685, 3765.755225910307, 3875.2249550089814, 3940.980295098535, 28720.569191462146, 28833.711662883314, 28910.566341504895, 28972.710272897213, 29233.853830730925, 2800.9719902800916, 2809.522381195202, 2831.830090194595, 2843.5876797864194, 2887.9133625991253, 370196.0, 370644.0, 370891.0, 371334.0, 373599.0, 64049.67975160095, 64341.678291608245, 64547.35452645413, 64643.676781616734, 64683.353166468674, 69454.30545694579, 69813.0, 76711.61644191743, 77590.2240977583, 77717.0, 17982.910085449752, 17997.370092046716, 18158.45524634263, 18221.271149153887, 18229.27082916695, 13756.0, 13850.65373365674, 13858.4456621734, 13886.861131388558, 13896.58310250694, 21757.347279581638, 22038.559228815655, 22064.779352206595, 22072.2274720384, 22094.668579970992, 9596.90403095974, 9856.852147217798, 9864.112229899343, 9868.407895526292, 9871.371223748001, 964.1563631822156, 1004.2468148888188, 1137.1244142010605, 1139.7891390092693, 1159.8434211381525, 30084.699153008627, 30241.848790755907, 30313.696863031528, 30905.536416953764, 30953.071407857802, 1123.5674265407877, 1152.9596464123715, 1156.9710757231137, 1193.164784650748, 1247.1706315300405, 15339.0, 15468.92265538665, 15498.765038642312, 15611.219439028004, 15700.450484232997, 559523.0, 565198.0, 565608.0, 566639.0, 566969.0, 57736.422635773946, 58088.128678069865, 58438.0, 58440.0, 58513.829723405295, 1393.1989106263736, 1422.9470192057802, 1523.2840564934684, 1535.155664384584, 1556.5563814313093, 26324.0, 26785.464290714466, 28544.000959966303, 28864.855675721486, 29894.953676621215, 47972.04055918932, 48211.75894120507, 48213.517864820904, 48285.0, 48322.5167748318, 319485.6102877976, 366949.0, 380157.0, 380472.0, 381380.0, 29289.414211716074, 32936.835315823264, 33362.16594585155, 33945.66054339425, 34000.93991540773, 41414.58585414107, 41598.792006039774, 41787.1642567153, 42231.577684223994, 43696.78151609222, 35462.29075418426, 36082.8195859019, 37013.444798328586, 37029.81485092557, 37669.0, 29045.41909161847, 36556.0, 36579.817100914326, 37060.0, 37230.25539489249, 36197.63802361942, 37478.43782343213, 37870.8106459477, 37932.86201413962, 38009.80995095007, 29423.411531769674, 32950.340993179525, 34480.137996550286, 34904.65095349115, 35093.64906350904, 18299.634007320044, 20416.591668166257, 24013.0, 24543.877280613484, 24915.0], "unit": "score", "name": "ext.html", "value": 19987.028542917476}, {"lowerIsBetter": false, "replicates": [384.88261080370484, 385.16660695091355, 387.53689341237214, 395.359517581518, 396.5499158455153, 16755.413560525383, 17038.062906540134, 19950.90024549877, 20849.687254691173, 21393.57212855744, 20135.49661258469, 20387.28644497443, 20494.590108197826, 20764.584708305825, 20807.479813004684, 5707.486326230628, 5751.367349591542, 5792.594518383715, 5857.619254748428, 5944.464998150165, 4366.126774645084, 5803.912941305884, 5839.270091238595, 6189.845253868667, 6622.072909792633, 6576.934230657704, 6581.30896255891, 6582.934170658304, 6584.045313429549, 6589.0775291458995, 6372.617642941415, 6500.122483464719, 6686.465082793365, 6691.698873550702, 6703.597784132968, 5797.246357973479, 5802.158686990363, 5806.419358064202, 5809.738561764689, 5813.767449302023, 28549.85725071382, 28699.713002869914, 29509.557356639667, 29530.0, 29706.554401683992, 2233.3188377544843, 2240.339099965514, 2319.6288593824906, 2548.643189953408, 2797.342624483245, 13307.401166947511, 15604.921975390163, 15894.920525397414, 16306.295129153099, 16431.83568164315, 1624.382734560871, 1645.3336398758522, 1860.48836569943, 1989.3733473955801, 2077.761057478379, 112481.0, 114629.0, 119053.40473297665, 120907.395463023, 123195.76804231932, 20070.09684564198, 20622.38132856017, 20942.476438088866, 21033.78966210349, 21231.68152477714, 26934.595981060298, 27152.86423567909, 29455.558166627517, 31164.0, 31294.217644559067, 9078.81842363149, 9243.445393276425, 11657.950784429442, 11663.125265605113, 11744.412779360997, 9904.356216846027, 9919.553620087114, 9923.255755818342, 9935.105840474393, 10030.946750591229, 9383.859242111374, 9486.193673537826, 9565.569549370295, 9584.28117891161, 9591.321518734194, 3585.820708964541, 3723.0506220913494, 3731.645493678096, 3731.6828069614385, 3748.956818533906, 908.5411867007251, 1008.0776089877826, 1024.8667673202585, 1061.395004847245, 1086.4567716141928, 20734.688979665316, 21088.05103770334, 21118.577628447652, 21147.8942605286, 21367.93160342008, 972.638306371072, 981.2346369831542, 1053.6154303679102, 1089.6730980705756, 1108.2353176308322, 11136.777264454666, 11142.49858756358, 11188.992990630883, 11196.608118715969, 11198.936101070385, 667883.0, 683479.0, 688892.0, 699226.0, 710025.0, 120009.9995000264, 122327.38836305762, 126134.73865261413, 126169.0, 129734.35132824276, 947.7109481608038, 1071.9624813131502, 1135.823947288155, 1136.653320737183, 1138.9886101138882, 18057.0, 18179.909100454413, 18334.541636459195, 18540.56999455105, 18809.811901880807, 54564.181537277764, 54996.0, 55659.0, 56149.438505614424, 56318.43681563296, 78796.0, 79283.2071679299, 79303.60348198222, 80526.0, 82342.94142646242, 8340.666373344999, 8385.413021088465, 8392.664293428195, 8535.146485351415, 8602.956985215034, 9547.713568592953, 12935.676608084874, 13328.800067999182, 13615.727685446434, 13742.793858092336, 11357.261777984404, 11732.882671173178, 11838.526458941546, 11963.820542692041, 12135.332556709112, 11251.437428128396, 11520.0, 11685.0, 11759.647210583697, 11885.405729713653, 10040.69877903664, 11369.602063927723, 11964.282143071443, 12174.939125304316, 12355.0, 8257.307252013203, 8280.50316980983, 8281.792955176168, 8402.705905293285, 8680.305575553813, 8726.188997888985, 11677.357745324089, 11786.705332366759, 11919.940400297943, 11975.940120299343], "unit": "score", "name": "jquery.html", "value": 10890.048700755484}, {"lowerIsBetter": false, "replicates": [1508.4267978168295, 1639.9918000409996, 1660.3773584905657, 2005.438477226377, 2075.7301550798393, 8231.75304740858, 8795.956020219897, 8956.731298061053, 8962.238209752179, 8966.372353935227, 8755.868661970075, 9032.68385606504, 9032.68385606504, 9034.277257819374, 9039.367244292902, 2041.8774873507637, 2243.2372993182316, 2511.6734824472837, 2543.885525151373, 2554.4380236347974, 2469.950600987979, 2486.3784053986506, 2491.327341617762, 2494.1270555305587, 2495.8502489850575, 2535.6069809179517, 2552.3619095226195, 2555.7316481769426, 2557.4373637799654, 2558.3604098975256, 2476.8513889166616, 2563.0132399026324, 2571.112966026727, 2571.2029270925977, 2572.3311938895836, 2528.0772518030785, 2559.705633852094, 2564.0769323043687, 2567.6918769747563, 2571.100114959768, 8976.147266009719, 9050.094990500897, 9061.637534498612, 9064.682736104205, 9077.228435582983, 5567.972160139214, 5736.598438109334, 5765.0, 5767.826965191051, 5772.682502462363, 3156.3687262547583, 3683.37382644951, 3693.649103335179, 3838.05967537955, 3844.692424606025, 1084.251866212311, 1089.84742136101, 1092.470151976291, 1095.2825899036145, 1108.2020944919645, 12508.624741257685, 12531.686707832378, 12548.247105173628, 12561.811572826324, 12576.182548134342, 5042.369703787027, 5045.2432135180015, 5119.539241468286, 5135.794568217304, 5137.922931156036, 10493.0, 10547.367157970546, 10555.47222638865, 10587.735306617396, 10588.841167382496, 5153.639245252796, 5676.602637815313, 5687.829365119053, 5715.942840571624, 5730.36965933747, 4097.959020409818, 4736.384270044941, 5000.099982003201, 5062.417821950523, 5073.771680274396, 4064.4309796628495, 4122.9381559276635, 4143.835957000322, 4165.66674666026, 4169.291220492523, 1364.0451683821366, 1374.202962281874, 1374.305975482375, 1376.078027721429, 1394.3028485757122, 1405.416752047909, 1437.5040610989192, 1442.40140341757, 1454.163855782929, 1462.6635873749096, 8553.61508732096, 8609.397342186112, 8662.78343041429, 8669.436486628349, 8695.260902823204, 535.2960856473725, 549.3490214096308, 550.6035654328876, 553.7784886045614, 554.3763266325384, 6379.681015949277, 6400.0, 6436.259830119596, 6455.419012288917, 6462.289148193695, 10819.945900270448, 11309.604163854226, 11327.490262938187, 11338.43307834605, 11363.602273920373, 10491.895081049091, 10997.890021099847, 11026.44867756609, 11054.949779770908, 11105.777884442266, 8433.831323373499, 8595.054544000155, 8614.956925215334, 8664.306855451674, 8671.349648776368, 8263.0, 8300.501969881827, 8319.168083191633, 8401.537915414467, 8419.242268195892, 9599.32804703664, 9688.176504997155, 9839.5080245986, 9912.752181195528, 10118.139958103644, 10222.846657299997, 10283.672012658693, 10331.070203681706, 10463.79072418532, 10493.370397775852, 7096.112985876765, 7510.737124200627, 7693.4614576979075, 7726.42051846125, 7840.490368126281, 8499.78750531217, 8520.70177543783, 8534.06125326226, 8557.272631826365, 8570.48577085377, 7422.888656670262, 7573.810654733676, 7631.771046868603, 7644.350230230492, 7677.539347639159, 7324.816879578053, 7370.742024029348, 7381.0, 7461.738839140604, 7493.4379921505015, 7997.8400431992195, 8027.956365672425, 8070.515769053875, 8073.515589064675, 8075.192480752113, 7270.091238595176, 7298.890516642361, 7315.48791584584, 7316.451266154953, 7319.597422141834, 7365.484416090822, 7376.815579610553, 7437.107547094383, 7437.107547094383, 7480.326770590673], "unit": "score", "name": "mootools.html", "value": 5032.410715033681}, {"lowerIsBetter": false, "replicates": [336.26693807499646, 338.5953785226654, 344.8810160494629, 345.1578149315671, 350.8736854732296, 6160.229971253593, 6344.016677415008, 6854.417374523159, 6872.72509099636, 6879.449644028478, 5513.669179849212, 6735.696893639786, 6804.251532331439, 6812.62530560819, 6816.659167041653, 3996.8401263949554, 4806.7115973041555, 4934.235193545006, 4942.085714142895, 5077.238414237866, 4942.604591632678, 4952.752362381884, 4958.900821983558, 5030.773615187307, 5085.211792172219, 4960.851174464772, 4971.627127965399, 5005.749712514378, 5010.3737032870895, 5021.221710634857, 5005.17414626588, 5016.749162541895, 5024.849254522352, 5027.874303142414, 5050.343455350818, 4164.729292595972, 4241.533431322552, 4308.590683885026, 4327.653787696977, 4330.198913201068, 6492.545521813475, 6545.901811472784, 6570.113034740297, 6587.242467116295, 6607.80176594703, 4864.975675121637, 4917.237828136645, 5989.8203053908455, 5997.070454079581, 5999.100134979744, 7244.203137654854, 7267.127944646623, 7275.527090739138, 7282.890756638654, 7291.161516425626, 4721.504242054569, 4859.781309841065, 4861.489543597942, 4875.293082503017, 4876.097921884428, 6737.528373013891, 6937.68780404883, 7270.345668889772, 7629.809254768676, 7677.692892284302, 5001.89996200074, 5002.274670172877, 5004.9499505005215, 5009.77456014473, 5016.523430274118, 5091.363579552556, 5102.464241254689, 5106.004329155853, 5116.616253780981, 5121.897562048738, 5972.701364931736, 5975.701214939236, 5977.432143946318, 5977.880442391128, 5990.430909063632, 7018.719251229893, 7283.5994020328335, 7289.125304963438, 7298.343149116605, 7305.926940730525, 1453.3677850135225, 1742.9215685294191, 1767.460924418065, 1774.2636805725479, 1774.308019872251, 1133.8809425010254, 1134.1890548258036, 1152.1819508149308, 1163.1567113842566, 1163.6160067177811, 6520.0871877937125, 6645.833854153685, 6738.372034906391, 6763.0, 6784.185897692309, 7595.696172153052, 7598.392128629696, 7609.315161635479, 7615.124260709978, 7621.352185064332, 6109.877802443926, 6325.304216536178, 6788.389044985975, 6807.149106361705, 6833.077534532874, 3948.368261078214, 3985.083430810872, 3994.500687414073, 3997.5003124609425, 4002.679785617202, 6383.968080159662, 7554.508956917783, 7702.1912699166905, 7814.53112813233, 7957.0, 7806.219378062262, 7833.960830195812, 7868.0, 7871.763847084597, 7877.094134174528, 6714.664266786641, 6813.897791533131, 7708.075030996316, 7897.24976127267, 7919.762407127795, 7577.560263549908, 7577.583232922022, 7581.241875812375, 7581.279778421042, 7591.58246296459, 7182.450230168215, 7437.590932498764, 7470.178280389261, 7477.0, 7479.513831600929, 7836.0, 7870.5671188082915, 7872.1340652529325, 7895.7236496722335, 7906.402586822866, 4753.881152971203, 4767.332573439652, 4796.616270698406, 4802.303665968485, 4810.5670489656095, 6125.326214116532, 7507.860259825923, 7511.136219334847, 7513.849723005618, 7519.172890982097, 6930.584164950119, 7254.274572542704, 7265.418766498773, 7265.7093716252875, 7271.563706177646, 7166.390856777232, 7240.05879235696, 7250.20247772734, 7256.2743725627015, 7263.818404539928, 7089.645517724196, 7093.609851458219, 7095.113110861143, 7103.431725461847, 7109.857802844018, 7014.614196219053, 7253.8186545336785, 7260.310270524292, 7268.527545709512, 7276.927230727625, 6774.932250677627, 6996.405305549085, 7098.609576473344, 7108.644567771487, 7117.217106118219], "unit": "score", "name": "prototype.html", "value": 5310.302256855296}, {"lowerIsBetter": false, "replicates": [705.6330708031824, 735.9595222262774, 761.7067429039818, 791.3866753266218, 809.9672917030784, 15192.392304307828, 15393.076415415084, 15463.458778942753, 15470.381184752596, 15534.766978495318, 14795.0, 14874.405023799061, 14878.55364339069, 14894.957352985295, 14937.477188298411, 797.4696826610298, 806.7499075286651, 815.4577206157912, 1001.0340021878885, 1018.5314755212611, 969.9951500242489, 970.0881171698616, 971.2909576009517, 973.1679414100948, 1014.7361685961629, 1031.943243121628, 1031.9948400257988, 1033.9534720937577, 1034.896510348963, 1070.0048954472377, 816.0696805641544, 824.7195953375851, 1058.5871510110985, 1065.701603551003, 1075.424647813424, 800.6597196191595, 801.8276070644781, 804.851102546025, 805.1023109233221, 807.475141158246, 15192.924035379752, 15239.314230859527, 15244.314005869763, 15270.923645381701, 15290.694186116216, 12795.011288253332, 12820.487180512768, 12914.612561623166, 12940.417681204368, 13095.869041309656, 10000.299979001473, 10076.89923100767, 10096.29325947184, 10263.384196948207, 10418.166546676248, 3493.8427770750377, 3550.8934731958084, 3551.449525323579, 3555.520004799345, 3577.624349443297, 86617.0, 89491.0, 89881.55059224663, 89904.0, 91391.54304228436, 9791.755206119762, 9806.068423499755, 9904.851427228597, 9955.30312878106, 9994.550245238981, 22755.7724422757, 22807.885960570424, 22844.885775571016, 22867.313980580275, 22881.88559057194, 7445.739399121005, 7496.175420703718, 7524.360429363565, 7593.772186834404, 7811.375089992787, 4087.2642924273323, 4117.155983023473, 4165.312723400605, 4227.0, 4266.338717498793, 3689.963100368962, 3722.050877026341, 3725.9068523287133, 3727.9440808387894, 3735.533058367704, 660.7158921663731, 677.891756636859, 681.1247546902306, 685.1196212866442, 685.6708779785631, 586.155935452955, 591.7632946821305, 603.6740160313382, 604.9455549000611, 611.4252602553586, 7757.26306000929, 8413.6101637448, 8715.869261961076, 8974.506402147814, 9048.547572621343, 597.7698586044404, 615.9630422174683, 624.5596854217765, 626.8714913442733, 633.3223450907485, 3779.905502362408, 3882.7476214045996, 3922.627350401707, 4012.799360031987, 4021.91956160881, 96821.03178968262, 98929.01070989342, 99311.51032734515, 99446.0, 99466.50266748764, 87159.12840871637, 87284.6907296391, 87937.0, 88279.0, 88874.0, 70102.64948675224, 73731.63134184295, 76694.84957725639, 76999.0, 77554.0, 8678.696245631372, 8689.739307820775, 8779.789992350674, 8985.550722463982, 8989.640414383352, 46557.30164047474, 49049.75475122601, 51631.967360651826, 53520.0, 54574.18138728002, 59071.40928590659, 75814.62092689502, 76101.85847212408, 77179.61410192912, 77720.61139694265, 10783.083437907866, 11413.486393112164, 11426.771464570496, 11880.821787673365, 12042.939785301018, 12063.0, 12143.0, 12404.689882752642, 12540.310282934526, 13010.21938683682, 8988.415752976036, 11743.706407339885, 11794.646160614851, 11813.586524471602, 12440.31578263168, 11580.942095289469, 11615.245009074382, 11899.76200476003, 12112.818307725214, 12171.208871423683, 11296.661100167008, 11344.0, 11443.313401195956, 11779.352135632622, 11862.940685296518, 9622.47076410804, 9678.661246856327, 9814.2148628111, 10012.44931528773, 10350.378977261389, 8788.599754630317, 9877.40735555869, 10000.149987251165, 10010.299279050396, 10087.747806304607], "unit": "score", "name": "yui.html", "value": 7222.994347232865}], "name": "dromaeo_css", "value": 7893.492897748939}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 113.0, 106.0, 111.0, 113.0, 119.0, 115.0, 158.0, 160.0], "unit": "score", "name": "ai-astar", "value": 121.9}, {"lowerIsBetter": true, "replicates": [154.0, 118.0, 153.0, 144.0, 116.0, 140.0, 115.0, 148.0, 143.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 134.9}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 189.0, 187.0, 188.0, 188.0, 183.0, 184.0, 183.0, 185.0], "unit": "score", "name": "audio-dft", "value": 185.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 74.0, 116.0, 56.0, 57.0, 57.0, 59.0, 121.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 126.0, 81.0, 80.0, 80.0, 116.0, 76.0, 78.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 88.0, 87.0, 90.0, 86.0, 91.0, 87.0, 89.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.3}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 59.0, 58.0, 57.0, 58.0, 59.0, 67.0, 51.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 68.0, 62.0, 67.0, 73.0, 70.0, 66.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [80.0, 77.0, 80.0, 80.0, 79.0, 78.0, 80.0, 80.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.9}, {"lowerIsBetter": true, "replicates": [119.0, 126.0, 122.0, 104.0, 129.0, 132.0, 129.0, 135.0, 116.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [131.0, 121.0, 132.0, 130.0, 130.0, 120.0, 132.0, 132.0, 131.0, 162.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.1}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1403.6}]} 14:01:20 INFO - Return code: 0 14:01:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:01:20 INFO - # TBPL SUCCESS # 14:01:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:01:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:01:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:01:20 INFO - 2016-03-14 14:01:20.476 screenresolution[1677:9939] starting screenresolution argv=screenresolution get 14:01:20 INFO - 2016-03-14 14:01:20.478 screenresolution[1677:9939] Display 0: 1600x1200x32@60 14:01:20 INFO - 2016-03-14 14:01:20.484 screenresolution[1678:9942] starting screenresolution argv=screenresolution list 14:01:20 INFO - Available Modes on Display 0 14:01:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:01:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:01:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:01:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:01:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:01:20 INFO - Intel Iris: 14:01:20 INFO - Chipset Model: Intel Iris 14:01:20 INFO - Type: GPU 14:01:20 INFO - Bus: Built-In 14:01:20 INFO - VRAM (Dynamic, Max): 1536 MB 14:01:20 INFO - Vendor: Intel (0x8086) 14:01:20 INFO - Device ID: 0x0a2e 14:01:20 INFO - Revision ID: 0x0009 14:01:20 INFO - Displays: 14:01:20 INFO - Display: 14:01:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:01:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:01:20 INFO - Display Serial Number: 1600x1200 60 14:01:20 INFO - Main Display: Yes 14:01:20 INFO - Mirror: Off 14:01:20 INFO - Online: Yes 14:01:20 INFO - Rotation: Supported 14:01:20 INFO - Return code: 0 14:01:20 INFO - Running post-action listener: _resource_record_post_action 14:01:20 INFO - Running post-run listener: _resource_record_post_run 14:01:21 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37201408; Write bytes: 666824192; Read time: 390; Write time: 1994 14:01:21 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 358121984; Write bytes: 357985792; Read time: 27919; Write time: 719 14:01:21 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35419648; Write bytes: 298729472; Read time: 372; Write time: 1240 14:01:21 INFO - Running post-run listener: _upload_blobber_files 14:01:21 INFO - Blob upload gear active. 14:01:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:01:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:01:22 INFO - (blobuploader) - INFO - Open directory for files ... 14:01:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:01:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:01:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:23 INFO - (blobuploader) - INFO - Done attempting. 14:01:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:01:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:01:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:01:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:01:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:01:24 INFO - (blobuploader) - INFO - Done attempting. 14:01:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:01:24 INFO - Return code: 0 14:01:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:01:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:01:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7762a759de957389acb5b5ace530fd09d596b80743a217cfc9ffefc272289451d0d38c42574da4fbf8a3f16e0bfa869a97e6707c18b977a0c1dba279cac16c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c518badbe23d207e71576d81a0fb83564d25b742cc95a3bff4091f9a449e620ccfef01c4eec0ee1a3dba32bcdcf615e2412d05d151a91c46315003e8bef108e"} 14:01:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:01:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:01:24 INFO - Contents: 14:01:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7762a759de957389acb5b5ace530fd09d596b80743a217cfc9ffefc272289451d0d38c42574da4fbf8a3f16e0bfa869a97e6707c18b977a0c1dba279cac16c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c518badbe23d207e71576d81a0fb83564d25b742cc95a3bff4091f9a449e620ccfef01c4eec0ee1a3dba32bcdcf615e2412d05d151a91c46315003e8bef108e"} 14:01:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:01:24 INFO - Copying logs to upload dir... 14:01:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:01:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.595884 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-14 14:01:24.632011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:24.635370) ========= 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.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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/Mozilla-Aurora/sha512/f7762a759de957389acb5b5ace530fd09d596b80743a217cfc9ffefc272289451d0d38c42574da4fbf8a3f16e0bfa869a97e6707c18b977a0c1dba279cac16c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c518badbe23d207e71576d81a0fb83564d25b742cc95a3bff4091f9a449e620ccfef01c4eec0ee1a3dba32bcdcf615e2412d05d151a91c46315003e8bef108e"} build_url:https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/Bzr-NZDoSDWD8HHyIG6O3A/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f7762a759de957389acb5b5ace530fd09d596b80743a217cfc9ffefc272289451d0d38c42574da4fbf8a3f16e0bfa869a97e6707c18b977a0c1dba279cac16c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c518badbe23d207e71576d81a0fb83564d25b742cc95a3bff4091f9a449e620ccfef01c4eec0ee1a3dba32bcdcf615e2412d05d151a91c46315003e8bef108e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:24.663059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:24.663369) ========= 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.sqnv9QF577/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.aCZznOcgDk/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005233 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:01:24.711827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 14:01:24.712129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 14:01:24.712621) ========= ========= Total master_lag: 0.25 =========