builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0051 starttime: 1454583165.53 results: success (0) buildid: 20160204015324 builduid: 6856574f90da44fd9eaca322079f254c revision: f09ea27124459acfeb335f3de2d5be13baa61209 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.526863) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.527365) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.527670) ========= 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.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.005358 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.589967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.590249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.750723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.751074) ========= 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.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005332 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.798929) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.799199) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.799539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:45.799832) ========= 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.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-04 02:52:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.0M=0.001s 2016-02-04 02:52:46 (13.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.477289 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:46.461093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:46.461387) ========= 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.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.027146 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:46.697482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 02:52:46.697821) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f09ea27124459acfeb335f3de2d5be13baa61209 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f09ea27124459acfeb335f3de2d5be13baa61209 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-04 02:52:46,824 truncating revision to first 12 chars 2016-02-04 02:52:46,824 Setting DEBUG logging. 2016-02-04 02:52:46,824 attempt 1/10 2016-02-04 02:52:46,824 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f09ea2712445?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 02:52:47,875 unpacking tar archive at: fx-team-f09ea2712445/testing/mozharness/ program finished with exit code 0 elapsedTime=1.294592 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 02:52:48.085456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:48.085774) ========= echo f09ea27124459acfeb335f3de2d5be13baa61209 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f09ea27124459acfeb335f3de2d5be13baa61209'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 f09ea27124459acfeb335f3de2d5be13baa61209 program finished with exit code 0 elapsedTime=0.007562 script_repo_revision: 'f09ea27124459acfeb335f3de2d5be13baa61209' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:48.147345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:48.147642) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 02:52:48.170246) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-04 02:52:48.172138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:52:48 INFO - MultiFileLogger online at 20160204 02:52:48 in /builds/slave/test 02:52:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:52:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:48 INFO - {'append_to_log': False, 02:52:48 INFO - 'base_work_dir': '/builds/slave/test', 02:52:48 INFO - 'blob_upload_branch': 'Fx-Team', 02:52:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:48 INFO - 'branch': 'Fx-Team', 02:52:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:48 INFO - 'config_files': ('talos/mac_config.py',), 02:52:48 INFO - 'default_actions': ('clobber', 02:52:48 INFO - 'read-buildbot-config', 02:52:48 INFO - 'download-and-extract', 02:52:48 INFO - 'populate-webroot', 02:52:48 INFO - 'create-virtualenv', 02:52:48 INFO - 'install', 02:52:48 INFO - 'run-tests'), 02:52:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:48 INFO - 'download_minidump_stackwalk': True, 02:52:48 INFO - 'download_symbols': 'ondemand', 02:52:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:48 INFO - 'installer_path': 'installer.exe', 02:52:48 INFO - 'log_level': 'info', 02:52:48 INFO - 'log_name': 'talos', 02:52:48 INFO - 'log_to_console': True, 02:52:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:52:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:52:48 INFO - 'opt_config_files': (), 02:52:48 INFO - 'pip_index': False, 02:52:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:48 INFO - 'cmd': ('bash', 02:52:48 INFO - '-c', 02:52:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:48 INFO - 'enabled': True, 02:52:48 INFO - 'halt_on_failure': False, 02:52:48 INFO - 'name': 'check_screen_resolution'},), 02:52:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:48 INFO - 'cmd': ('bash', 02:52:48 INFO - '-c', 02:52:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:48 INFO - 'enabled': True, 02:52:48 INFO - 'halt_on_failure': False, 02:52:48 INFO - 'name': 'check_screen_resolution'},), 02:52:48 INFO - 'run_cmd_checks_enabled': True, 02:52:48 INFO - 'sps_profile': False, 02:52:48 INFO - 'sps_profile_interval': 0, 02:52:48 INFO - 'suite': 'dromaeojs', 02:52:48 INFO - 'system_bits': '32', 02:52:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:48 INFO - 'title': 't-yosemite-r7-0051', 02:52:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:48 INFO - 'use_talos_json': True, 02:52:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:48 INFO - 'work_dir': 'build'} 02:52:48 INFO - ##### 02:52:48 INFO - ##### Running clobber step. 02:52:48 INFO - ##### 02:52:48 INFO - Running pre-action listener: _resource_record_pre_action 02:52:48 INFO - Running main action method: clobber 02:52:48 INFO - rmtree: /builds/slave/test/build 02:52:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:49 INFO - Running post-action listener: _resource_record_post_action 02:52:49 INFO - ##### 02:52:49 INFO - ##### Running read-buildbot-config step. 02:52:49 INFO - ##### 02:52:49 INFO - Running pre-action listener: _resource_record_pre_action 02:52:49 INFO - Running main action method: read_buildbot_config 02:52:49 INFO - Using buildbot properties: 02:52:49 INFO - { 02:52:49 INFO - "project": "", 02:52:49 INFO - "product": "firefox", 02:52:49 INFO - "script_repo_revision": "production", 02:52:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:52:49 INFO - "repository": "", 02:52:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:52:49 INFO - "buildid": "20160204015324", 02:52:49 INFO - "pgo_build": "False", 02:52:49 INFO - "basedir": "/builds/slave/test", 02:52:49 INFO - "buildnumber": 279, 02:52:49 INFO - "slavename": "t-yosemite-r7-0051", 02:52:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:52:49 INFO - "platform": "yosemite_r7", 02:52:49 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:52:49 INFO - "branch": "fx-team", 02:52:49 INFO - "repo_path": "integration/fx-team", 02:52:49 INFO - "revision": "f09ea27124459acfeb335f3de2d5be13baa61209", 02:52:49 INFO - "stage_platform": "macosx64", 02:52:49 INFO - "builduid": "6856574f90da44fd9eaca322079f254c", 02:52:49 INFO - "slavebuilddir": "test" 02:52:49 INFO - } 02:52:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 02:52:49 INFO - Running post-action listener: _resource_record_post_action 02:52:49 INFO - ##### 02:52:49 INFO - ##### Running download-and-extract step. 02:52:49 INFO - ##### 02:52:49 INFO - Running pre-action listener: _resource_record_pre_action 02:52:49 INFO - Running main action method: download_and_extract 02:52:49 INFO - mkdir: /builds/slave/test/build/tests 02:52: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')]} 02:52:49 INFO - https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/test_packages.json 02:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/test_packages.json 02:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:52:58 INFO - Downloaded 1277 bytes. 02:52:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:52:58 INFO - Using the following test package requirements: 02:52:58 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:52:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 02:52:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 02:52:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'jsshell-mac.zip'], 02:52:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 02:52:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:52:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 02:52:58 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 02:52:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 02:52:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 02:52:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 02:52:58 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 02:52:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:52: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')]} 02:52:58 INFO - https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:52:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:52:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:52:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:52:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:53:05 INFO - Downloaded 17118730 bytes. 02:53:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:53:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:53:08 INFO - Return code: 0 02:53:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:53: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')]} 02:53:08 INFO - https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:53:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:53:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:53:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 02:53:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:53:09 INFO - Downloaded 17118730 bytes. 02:53:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:53:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:53:13 INFO - Return code: 0 02:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:13 INFO - https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:53:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:53:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:53:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 02:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:53:14 INFO - Downloaded 10706582 bytes. 02:53:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:53:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:53:14 INFO - Return code: 0 02:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:14 INFO - https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:53:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:53:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:53:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 02:53:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 02:53:19 INFO - Downloaded 111121993 bytes. 02:53:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:53:19 INFO - mkdir: /builds/slave/test/properties 02:53:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:53:19 INFO - Writing to file /builds/slave/test/properties/build_url 02:53:19 INFO - Contents: 02:53:19 INFO - build_url:https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 02:53:21 INFO - Running post-action listener: _resource_record_post_action 02:53:21 INFO - Running post-action listener: set_extra_try_arguments 02:53:21 INFO - ##### 02:53:21 INFO - ##### Running populate-webroot step. 02:53:21 INFO - ##### 02:53:21 INFO - Running pre-action listener: _resource_record_pre_action 02:53:21 INFO - Running main action method: populate_webroot 02:53:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:53:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:53:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:53:21 INFO - '--tppagecycles', 02:53:21 INFO - '7'], 02:53:21 INFO - 'tests': ['tsvgm']}}, 02:53:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:53:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:53:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:53:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:53:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'tests': ['damp', 'tps']}, 02:53:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['damp', 'tps']}, 02:53:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:53:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:53:21 INFO - 'other': {'tests': ['a11yr', 02:53:21 INFO - 'ts_paint', 02:53:21 INFO - 'tpaint', 02:53:21 INFO - 'sessionrestore', 02:53:21 INFO - 'sessionrestore_no_auto_restore']}, 02:53:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['a11yr', 02:53:21 INFO - 'ts_paint', 02:53:21 INFO - 'tpaint', 02:53:21 INFO - 'sessionrestore', 02:53:21 INFO - 'sessionrestore_no_auto_restore']}, 02:53:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['a11yr', 02:53:21 INFO - 'ts_paint', 02:53:21 INFO - 'tpaint', 02:53:21 INFO - 'sessionrestore', 02:53:21 INFO - 'sessionrestore_no_auto_restore']}, 02:53:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['a11yr', 02:53:21 INFO - 'ts_paint', 02:53:21 INFO - 'tpaint', 02:53:21 INFO - 'sessionrestore', 02:53:21 INFO - 'sessionrestore_no_auto_restore']}, 02:53:21 INFO - 'other_l64': {'tests': ['a11yr', 02:53:21 INFO - 'ts_paint', 02:53:21 INFO - 'tpaint', 02:53:21 INFO - 'sessionrestore', 02:53:21 INFO - 'sessionrestore_no_auto_restore']}, 02:53:21 INFO - 'other_nol64': {'tests': ['a11yr', 02:53:21 INFO - 'ts_paint', 02:53:21 INFO - 'tpaint', 02:53:21 INFO - 'sessionrestore', 02:53:21 INFO - 'sessionrestore_no_auto_restore']}, 02:53:21 INFO - 'svgr': {'tests': ['tsvgx', 02:53:21 INFO - 'tsvgr_opacity', 02:53:21 INFO - 'tart', 02:53:21 INFO - 'tscrollx', 02:53:21 INFO - 'cart']}, 02:53:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['tsvgx', 02:53:21 INFO - 'tsvgr_opacity', 02:53:21 INFO - 'tart', 02:53:21 INFO - 'tscrollx', 02:53:21 INFO - 'cart']}, 02:53:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'tests': ['tp5o']}, 02:53:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'talos_options': ['--e10s'], 02:53:21 INFO - 'tests': ['tp5o']}, 02:53:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'talos_options': ['--xperf_path', 02:53:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:21 INFO - 'tests': ['tp5n']}, 02:53:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:53:21 INFO - 'talos_options': ['--e10s', 02:53:21 INFO - '--xperf_path', 02:53:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:21 INFO - 'tests': ['tp5n']}}, 02:53:21 INFO - 'talos.zip': {'path': '', 02:53:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:53:21 INFO - Running post-action listener: _resource_record_post_action 02:53:21 INFO - ##### 02:53:21 INFO - ##### Running create-virtualenv step. 02:53:21 INFO - ##### 02:53:21 INFO - Running pre-action listener: _resource_record_pre_action 02:53:21 INFO - Running main action method: create_virtualenv 02:53:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:53:21 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 02:53:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:53:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:53:21 INFO - Using real prefix '/tools/python27' 02:53:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:53:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:24 INFO - Installing pip.................done. 02:53:24 INFO - Return code: 0 02:53:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:24 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:24 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 02:53:24 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 02:53:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:24 INFO - 'HOME': '/Users/cltbld', 02:53:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:24 INFO - 'LOGNAME': 'cltbld', 02:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:24 INFO - 'MOZ_NO_REMOTE': '1', 02:53:24 INFO - 'NO_EM_RESTART': '1', 02:53:24 INFO - 'PAGER': '/bin/cat', 02:53:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:24 INFO - 'PWD': '/builds/slave/test', 02:53:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:24 INFO - 'SHELL': '/bin/bash', 02:53:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:24 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:24 INFO - 'USER': 'cltbld', 02:53:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:24 INFO - 'XPC_FLAGS': '0x0', 02:53:24 INFO - 'XPC_SERVICE_NAME': '0', 02:53:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:25 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 02:53:25 INFO - Cleaning up... 02:53:25 INFO - Return code: 0 02:53:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:53:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:25 INFO - 'HOME': '/Users/cltbld', 02:53:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:25 INFO - 'LOGNAME': 'cltbld', 02:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:25 INFO - 'MOZ_NO_REMOTE': '1', 02:53:25 INFO - 'NO_EM_RESTART': '1', 02:53:25 INFO - 'PAGER': '/bin/cat', 02:53:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:25 INFO - 'PWD': '/builds/slave/test', 02:53:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:25 INFO - 'SHELL': '/bin/bash', 02:53:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:25 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:25 INFO - 'USER': 'cltbld', 02:53:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:25 INFO - 'XPC_FLAGS': '0x0', 02:53:25 INFO - 'XPC_SERVICE_NAME': '0', 02:53:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:25 INFO - Downloading/unpacking psutil>=0.7.1 02:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:28 INFO - Installing collected packages: psutil 02:53:28 INFO - Running setup.py install for psutil 02:53:28 INFO - building 'psutil._psutil_osx' extension 02:53:28 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 02:53:29 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 02:53:29 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 02:53:29 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 02:53:29 INFO - building 'psutil._psutil_posix' extension 02:53:29 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 02:53:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:53:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:53:29 INFO - ^ 02:53:29 INFO - 1 warning generated. 02:53:29 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 02:53:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:29 INFO - Successfully installed psutil 02:53:29 INFO - Cleaning up... 02:53:29 INFO - Return code: 0 02:53:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:29 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:29 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 02:53:29 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 02:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:29 INFO - 'HOME': '/Users/cltbld', 02:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:29 INFO - 'LOGNAME': 'cltbld', 02:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:29 INFO - 'MOZ_NO_REMOTE': '1', 02:53:29 INFO - 'NO_EM_RESTART': '1', 02:53:29 INFO - 'PAGER': '/bin/cat', 02:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:29 INFO - 'PWD': '/builds/slave/test', 02:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:29 INFO - 'SHELL': '/bin/bash', 02:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:29 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:29 INFO - 'USER': 'cltbld', 02:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:29 INFO - 'XPC_FLAGS': '0x0', 02:53:29 INFO - 'XPC_SERVICE_NAME': '0', 02:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:53:32 INFO - Installing collected packages: mozsystemmonitor 02:53:32 INFO - Running setup.py install for mozsystemmonitor 02:53:32 INFO - Successfully installed mozsystemmonitor 02:53:32 INFO - Cleaning up... 02:53:32 INFO - Return code: 0 02:53:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:32 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:32 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 02:53:32 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 02:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:32 INFO - 'HOME': '/Users/cltbld', 02:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:32 INFO - 'LOGNAME': 'cltbld', 02:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:32 INFO - 'MOZ_NO_REMOTE': '1', 02:53:32 INFO - 'NO_EM_RESTART': '1', 02:53:32 INFO - 'PAGER': '/bin/cat', 02:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:32 INFO - 'PWD': '/builds/slave/test', 02:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:32 INFO - 'SHELL': '/bin/bash', 02:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:32 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:32 INFO - 'USER': 'cltbld', 02:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:32 INFO - 'XPC_FLAGS': '0x0', 02:53:32 INFO - 'XPC_SERVICE_NAME': '0', 02:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:32 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:32 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 02:53:32 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 02:53:32 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 02:53:32 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 02:53:32 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 02:53:32 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 02:53:35 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 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 02:53:35 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 02:53:36 INFO - Downloading docopt-0.6.1.tar.gz 02:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:36 INFO - Running setup.py install for blobuploader 02:53:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:36 INFO - Running setup.py install for requests 02:53:37 INFO - Running setup.py install for docopt 02:53:37 INFO - Successfully installed blobuploader requests docopt 02:53:37 INFO - Cleaning up... 02:53:37 INFO - Return code: 0 02:53:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:37 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:37 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 02:53:37 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 02:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:37 INFO - 'HOME': '/Users/cltbld', 02:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:37 INFO - 'LOGNAME': 'cltbld', 02:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:37 INFO - 'MOZ_NO_REMOTE': '1', 02:53:37 INFO - 'NO_EM_RESTART': '1', 02:53:37 INFO - 'PAGER': '/bin/cat', 02:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:37 INFO - 'PWD': '/builds/slave/test', 02:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:37 INFO - 'SHELL': '/bin/bash', 02:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:37 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:37 INFO - 'USER': 'cltbld', 02:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:37 INFO - 'XPC_FLAGS': '0x0', 02:53:37 INFO - 'XPC_SERVICE_NAME': '0', 02:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:37 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MJ4q7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:37 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-SrN5bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:37 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-5dTMhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:37 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-0nrZUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:37 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FFVQc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-2jg0I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-gz1pCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-b501qO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-swHNHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-BX6GQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Zxwg5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-GgNOA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MipfyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:38 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-_ilvL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-1BDNlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-KIdQdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:39 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-LkCDpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:39 INFO - Running setup.py install for manifestparser 02:53:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:39 INFO - Running setup.py install for mozcrash 02:53:39 INFO - Running setup.py install for mozdebug 02:53:39 INFO - Running setup.py install for mozdevice 02:53:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:53:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:39 INFO - Running setup.py install for mozfile 02:53:40 INFO - Running setup.py install for mozhttpd 02:53:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozinfo 02:53:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozInstall 02:53:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozleak 02:53:40 INFO - Running setup.py install for mozlog 02:53:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for moznetwork 02:53:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozprocess 02:53:41 INFO - Running setup.py install for mozprofile 02:53:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Running setup.py install for mozrunner 02:53:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Running setup.py install for mozscreenshot 02:53:41 INFO - Running setup.py install for moztest 02:53:41 INFO - Running setup.py install for mozversion 02:53:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:41 INFO - Cleaning up... 02:53:41 INFO - Return code: 0 02:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:41 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:41 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 02:53:41 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 02:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:41 INFO - 'HOME': '/Users/cltbld', 02:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:41 INFO - 'LOGNAME': 'cltbld', 02:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:41 INFO - 'MOZ_NO_REMOTE': '1', 02:53:41 INFO - 'NO_EM_RESTART': '1', 02:53:41 INFO - 'PAGER': '/bin/cat', 02:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:41 INFO - 'PWD': '/builds/slave/test', 02:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:41 INFO - 'SHELL': '/bin/bash', 02:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:41 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:41 INFO - 'USER': 'cltbld', 02:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:41 INFO - 'XPC_FLAGS': '0x0', 02:53:41 INFO - 'XPC_SERVICE_NAME': '0', 02:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zvxoBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-FlO_MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-zmgD4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Q2d6UA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-Y3h29d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9_IdSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-9SXuf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-3zWtYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:42 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)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:42 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-pj2BcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-MraLca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-oIS3e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-ZInvny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-x29fXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-amjXdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-W_5MfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-7VGCgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:43 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)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:43 INFO - Running setup.py (path:/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/pip-n2OXDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:43 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)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:43 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)) 02:53:43 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)) 02:53:43 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)) 02:53:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:46 INFO - Downloading blessings-1.6.tar.gz 02:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:46 INFO - Installing collected packages: blessings 02:53:46 INFO - Running setup.py install for blessings 02:53:46 INFO - Successfully installed blessings 02:53:46 INFO - Cleaning up... 02:53:46 INFO - Return code: 0 02:53:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:46 INFO - Reading from file tmpfile_stdout 02:53:46 INFO - Current package versions: 02:53:46 INFO - blessings == 1.6 02:53:46 INFO - blobuploader == 1.2.4 02:53:46 INFO - docopt == 0.6.1 02:53:46 INFO - manifestparser == 1.1 02:53:46 INFO - mozInstall == 1.12 02:53:46 INFO - mozcrash == 0.16 02:53:46 INFO - mozdebug == 0.1 02:53:46 INFO - mozdevice == 0.48 02:53:46 INFO - mozfile == 1.2 02:53:46 INFO - mozhttpd == 0.7 02:53:46 INFO - mozinfo == 0.9 02:53:46 INFO - mozleak == 0.1 02:53:46 INFO - mozlog == 3.1 02:53:46 INFO - moznetwork == 0.27 02:53:46 INFO - mozprocess == 0.22 02:53:46 INFO - mozprofile == 0.28 02:53:46 INFO - mozrunner == 6.11 02:53:46 INFO - mozscreenshot == 0.1 02:53:46 INFO - mozsystemmonitor == 0.0 02:53:46 INFO - moztest == 0.7 02:53:46 INFO - mozversion == 1.4 02:53:46 INFO - psutil == 3.1.1 02:53:46 INFO - requests == 1.2.3 02:53:46 INFO - wsgiref == 0.1.2 02:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:46 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:46 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 02:53:46 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 02:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:46 INFO - 'HOME': '/Users/cltbld', 02:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:46 INFO - 'LOGNAME': 'cltbld', 02:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:46 INFO - 'MOZ_NO_REMOTE': '1', 02:53:46 INFO - 'NO_EM_RESTART': '1', 02:53:46 INFO - 'PAGER': '/bin/cat', 02:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:46 INFO - 'PWD': '/builds/slave/test', 02:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:46 INFO - 'SHELL': '/bin/bash', 02:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:46 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:46 INFO - 'USER': 'cltbld', 02:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:46 INFO - 'XPC_FLAGS': '0x0', 02:53:46 INFO - 'XPC_SERVICE_NAME': '0', 02:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 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)) 02:53:47 INFO - Cleaning up... 02:53:47 INFO - Return code: 0 02:53:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:47 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:47 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 02:53:47 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 02:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:47 INFO - 'HOME': '/Users/cltbld', 02:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:47 INFO - 'LOGNAME': 'cltbld', 02:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:47 INFO - 'MOZ_NO_REMOTE': '1', 02:53:47 INFO - 'NO_EM_RESTART': '1', 02:53:47 INFO - 'PAGER': '/bin/cat', 02:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:47 INFO - 'PWD': '/builds/slave/test', 02:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:47 INFO - 'SHELL': '/bin/bash', 02:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:47 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:47 INFO - 'USER': 'cltbld', 02:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:47 INFO - 'XPC_FLAGS': '0x0', 02:53:47 INFO - 'XPC_SERVICE_NAME': '0', 02:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:47 INFO - Downloading/unpacking jsonschema 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:49 INFO - Downloading/unpacking functools32 (from jsonschema) 02:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:49 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:50 INFO - warning: no files found matching '*.txt' 02:53:50 INFO - no previously-included directories found matching 'build' 02:53:50 INFO - no previously-included directories found matching 'dist' 02:53:50 INFO - no previously-included directories found matching '.git*' 02:53:50 INFO - Installing collected packages: jsonschema, functools32 02:53:50 INFO - Running setup.py install for functools32 02:53:50 INFO - warning: no files found matching '*.txt' 02:53:50 INFO - no previously-included directories found matching 'build' 02:53:50 INFO - no previously-included directories found matching 'dist' 02:53:50 INFO - no previously-included directories found matching '.git*' 02:53:50 INFO - Successfully installed jsonschema functools32 02:53:50 INFO - Cleaning up... 02:53:50 INFO - Return code: 0 02:53:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:53:50 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')]} 02:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:50 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')]} 02:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:50 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 0x10c99da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9a44c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f0bc9fa40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, '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.caFaFk9PY5/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.GKPdemXnTQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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 02:53:50 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 02:53:50 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 02:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:50 INFO - 'HOME': '/Users/cltbld', 02:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:50 INFO - 'LOGNAME': 'cltbld', 02:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:50 INFO - 'MOZ_NO_REMOTE': '1', 02:53:50 INFO - 'NO_EM_RESTART': '1', 02:53:50 INFO - 'PAGER': '/bin/cat', 02:53:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:50 INFO - 'PWD': '/builds/slave/test', 02:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:50 INFO - 'SHELL': '/bin/bash', 02:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:53:50 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:50 INFO - 'USER': 'cltbld', 02:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:50 INFO - 'XPC_FLAGS': '0x0', 02:53:50 INFO - 'XPC_SERVICE_NAME': '0', 02:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:50 INFO - Downloading/unpacking flake8 02:53:50 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 02:53:50 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 02:53:50 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 02:53:50 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 02:53:50 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 02:53:50 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 02:53:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:53:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:53:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53: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 02:53:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:53:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:54 INFO - no previously-included directories found matching 'docs/_build' 02:53:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:53:54 INFO - Running setup.py install for pep8 02:53:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:54 INFO - no previously-included directories found matching 'docs/_build' 02:53:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:53:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:53:54 INFO - Cleaning up... 02:53:54 INFO - Return code: 0 02:53:54 INFO - Running post-action listener: _resource_record_post_action 02:53:54 INFO - Running post-action listener: _start_resource_monitoring 02:53:54 INFO - Starting resource monitoring. 02:53:54 INFO - ##### 02:53:54 INFO - ##### Running install step. 02:53:54 INFO - ##### 02:53:54 INFO - Running pre-action listener: _resource_record_pre_action 02:53:54 INFO - Running main action method: install 02:53:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:55 INFO - Reading from file tmpfile_stdout 02:53:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:55 INFO - Reading from file tmpfile_stdout 02:53:55 INFO - Output received: 02:53:55 INFO - Usage: mozinstall [options] installer 02:53:55 INFO - Options: 02:53:55 INFO - -h, --help show this help message and exit 02:53:55 INFO - -d DEST, --destination=DEST 02:53:55 INFO - Directory to install application into. [default: 02:53:55 INFO - "/builds/slave/test"] 02:53:55 INFO - --app=APP Application being installed. [default: firefox] 02:53:55 INFO - mkdir: /builds/slave/test/build/application 02:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:54:29 INFO - Reading from file tmpfile_stdout 02:54:29 INFO - Output received: 02:54:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:54:29 INFO - Running post-action listener: _resource_record_post_action 02:54:29 INFO - ##### 02:54:29 INFO - ##### Running run-tests step. 02:54:29 INFO - ##### 02:54:29 INFO - Running pre-action listener: _resource_record_pre_action 02:54:29 INFO - Running main action method: run_tests 02:54:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:54:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:54:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:54:29 INFO - 2016-02-04 02:54:29.084 screenresolution[1658:8468] starting screenresolution argv=screenresolution get 02:54:29 INFO - 2016-02-04 02:54:29.087 screenresolution[1658:8468] Display 0: 1600x1200x32@60 02:54:29 INFO - 2016-02-04 02:54:29.093 screenresolution[1659:8470] starting screenresolution argv=screenresolution list 02:54:29 INFO - Available Modes on Display 0 02:54:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:54:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:54:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:54:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:29 INFO - Intel Iris: 02:54:29 INFO - Chipset Model: Intel Iris 02:54:29 INFO - Type: GPU 02:54:29 INFO - Bus: Built-In 02:54:29 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:29 INFO - Vendor: Intel (0x8086) 02:54:29 INFO - Device ID: 0x0a2e 02:54:29 INFO - Revision ID: 0x0009 02:54:29 INFO - Displays: 02:54:29 INFO - Display: 02:54:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:29 INFO - Display Serial Number: 1600x1200 60 02:54:29 INFO - Main Display: Yes 02:54:29 INFO - Mirror: Off 02:54:29 INFO - Online: Yes 02:54:29 INFO - Rotation: Supported 02:54:29 INFO - Return code: 0 02:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:29 INFO - Python 2.7.3 02:54:29 INFO - Return code: 0 02:54:29 INFO - grabbing minidump binary from tooltool 02:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:54:29 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 0x10c842d30>, '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 0x10c665db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c838b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:29 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 02:54:29 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 02:54:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:29 INFO - Return code: 0 02:54:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:54:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:54:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:54:30 INFO - Return code: 0 02:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 02:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --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 02:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.caFaFk9PY5/Render', 02:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:30 INFO - 'HOME': '/Users/cltbld', 02:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:30 INFO - 'LOGNAME': 'cltbld', 02:54:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:30 INFO - 'MOZ_NO_REMOTE': '1', 02:54:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:30 INFO - 'NO_EM_RESTART': '1', 02:54:30 INFO - 'PAGER': '/bin/cat', 02:54:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:30 INFO - 'PWD': '/builds/slave/test', 02:54:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:30 INFO - 'SHELL': '/bin/bash', 02:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GKPdemXnTQ/Listeners', 02:54:30 INFO - 'TMPDIR': '/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/', 02:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:30 INFO - 'USER': 'cltbld', 02:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:30 INFO - 'XPC_FLAGS': '0x0', 02:54:30 INFO - 'XPC_SERVICE_NAME': '0', 02:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--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 02:54:30 INFO - mozversion application_buildid: 20160204015324 02:54:30 INFO - mozversion application_changeset: f09ea27124459acfeb335f3de2d5be13baa61209 02:54:30 INFO - mozversion application_display_name: Nightly 02:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:30 INFO - mozversion application_name: Firefox 02:54:30 INFO - mozversion application_remotingname: firefox 02:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:54:30 INFO - mozversion application_vendor: Mozilla 02:54:30 INFO - mozversion application_version: 47.0a1 02:54:30 INFO - mozversion platform_buildid: 20160204015324 02:54:30 INFO - mozversion platform_changeset: f09ea27124459acfeb335f3de2d5be13baa61209 02:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:54:30 INFO - mozversion platform_version: 47.0a1 02:54:30 INFO - using testdate: 1454583270 02:54:30 INFO - actual date: 1454583270 02:54:31 INFO - starting webserver on 'localhost:49279' 02:54:31 INFO - SUITE-START | Running 2 tests 02:54:31 INFO - TEST-START | dromaeo_css 02:54:31 INFO - operating with platform_type : mac_ 02:54:31 INFO - Initialising browser for dromaeo_css test... 02:54:31 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpm6hBym/profile http://localhost:49279/getInfo.html) 02:54:31 INFO - PROCESS | 1677 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 02:54:33 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 02:54:33 INFO - PROCESS | 1677 | colorDepth:24 02:54:33 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 02:54:33 INFO - PROCESS | 1677 | __metrics 02:54:33 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:54:33 INFO - PROCESS | 1677 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:34 INFO - TEST-INFO | 1677: exit 0 02:54:34 INFO - Browser initialized. 02:54:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:34 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmpm6hBym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:46 INFO - PROCESS | 1681 | RSS: Main: 244183040 02:54:46 INFO - PROCESS | 1681 | 02:55:37 INFO - PROCESS | 1681 | 1454583337834 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] 02:57:47 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 02:57:49 INFO - PROCESS | 1681 | RSS: Main: 368283648 02:57:49 INFO - PROCESS | 1681 | 03:00:51 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 03:00:52 INFO - PROCESS | 1681 | RSS: Main: 375840768 03:00:52 INFO - PROCESS | 1681 | 03:03:54 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 03:03:55 INFO - PROCESS | 1681 | RSS: Main: 375644160 03:03:55 INFO - PROCESS | 1681 | 03:06:57 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 03:06:58 INFO - PROCESS | 1681 | RSS: Main: 340279296 03:06:58 INFO - PROCESS | 1681 | 03:10:01 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 03:10:01 INFO - PROCESS | 1681 | RSS: Main: 342384640 03:10:01 INFO - PROCESS | 1681 | 03:13:04 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 03:13:05 INFO - PROCESS | 1681 | RSS: Main: 416620544 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | __start_tp_report 03:13:05 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 03:13:05 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 03:13:05 INFO - PROCESS | 1681 | |i|pagename|runs| 03:13:05 INFO - PROCESS | 1681 | |0;dojo.html;2900.53591425372;3440;3519.7712148710348;3534.151803567144;3578.516900218471;5586.301712285965;5657.547396208303;5668.71656417179;5671.6880571568545;5685.857853553658;4322.82708691652;5642.15367694846;5813.33146688131;5831.329397119322;5846;5148.665336753118;5187.714675692835;5223.477652234765;5233.633645644806;5257.76340064698;5276.973615131919;5324.840254792362;5333.759980800874;5340.465953404648;5370.812021579245;5154.304168937183;5244.606654500928;5278.894422111574;5294.920576191341;5325;5215.765290561933;5244.108501554745;5249.632525723201;5250.081235783722;5266.4733526647415;5148.974255128738;5200.817971370984;5207.062728708831;5215.687058776485;5238.554722848562;5578.30271216098;5587.832365029056;5611.66330020196;5621.887562248732;5625.5218306444;6126.5176737973225;6212.844678883064;6221.440070393686;6221.657808820513;6242.219722534684;4870.853874383774;6313.810585682391;6332.1135041094285;6339.1442155308905;6343.5876668016435;5727.8568035799435;5792.073268277098;5812.854678632983;5850.6782126983;5862.677552734641;6238.750449982041;6254.2807577129215;6342;6343.460805831463;6349.079383489368;6177.62934223948;6212.658303793244;6213.720382582795;6226.62640241587;6227.1282020517165;6290.937090629127;6308.621482711052;6313.242410910629;6313.526485513605;6323.841903952346;6097.237845269341;6125.326214116443;6140.008994153746;6177.660228687465;6227.501799856092;6125.540694081788;6256.968715156395;6269.373062693785;6271.529635277372;6272.874542509125;4886.853394398174;4901.460839307744;4908.263760435963;4910.631702622246;4911.435184953704;4307.440032795779;4316.676249281317;4361.323994780814;4384.605385515319;4409.162259170747;5683.914741278884;5706.857328566819;5723.656580605177;5743.9425605744245;5766.596338256281;6209.223847019122;6237.251529816451;6279.560430769802;6282.811515654537;6327.209098862642;5615.438456154434;5678;5692.800751973661;5694.829155125353;5723.627964182315;5321.73391330432;5344.732763361816;5350.411454739976;5351.973240133852;5361.731913404392;6266.780662676784;6338.778142764981;6348.873022539616;6364.363563643691;6366.427021567988;6256.906146407717;6264.718087686157;6287.30839607652;6301.96849015752;6315.5894866833505;6306.085617585516;6306.590071645328;6308.621482711052;6308.905366419599;6325.146105275729;6036.396360363929;6131.988406491147;6144.938550614436;6214.875702486015;6240.251169859646;6126.731429653625;6263.812085637438;6283;6292.559520833498;6309.9588567885785;4813.95186048135;6085.69571521431;6091.847703807263;6102.786402475892;6110.358412366638;5934.3175534814045;5997.730102145501;6078.513718902565;6092.817215483543;6108.816735497942;4913.877153071202;5855.063189889767;5861.531077513703;5976.073708575178;5983.790567330123;4781.976090119527;6049.395060494091;6083.117947897618;6118.602290851259;6124.234470691164;5906.320773111147;5918.5295578738205;5937.703114844154;5956.970215148896;5970.402959704169 03:13:05 INFO - PROCESS | 1681 | |1;ext.html;484.90786750517424;559.2561892682733;577.7313549199623;599.6462087368452;600.9188759517465;29934;37939.24121517568;38410.847674569806;38411.42382864259;38429.61570384295;40838;41190.794046029805;41295.58704412955;41320.38019429703;41338.96652583687;9454.19639330656;9664.22686185107;9676;9684.56419461126;9694;9556.139947404732;9696.46669433181;9707.271954603397;9708;9825.803483930316;9735.221182305399;9825.213982881352;9833.11501964823;9834.70495885121;9839.163671087967;9717.90282097177;9793.755156121082;9793.804123917553;9799.16707079899;9805.117539421415;9539.18916892065;9714.591384249316;9725.270604704605;9729.464879431629;9730.36752611078;39557.80221098905;39891.41248756401;39914;39939.80180594587;39966.80016599927;3008.909732708022;3017.9547306790414;3018.6981301869637;3072.5083986562267;3076.2770748874223;28165.85917070422;28270.434591308058;28433.857830710713;28726.856365718246;29002.854985725146;2689.4755522673086;2737.630419893309;2765.046059109604;2767.1421859223506;2957.467655821951;476280;481178;481986;482027;482986.5850670759;56238.59403514863;56960.71519642375;57118;65552.67223663851;66599.33400666028;61682.38317616856;62285.06572401417;62406.37593624006;62516.37483625105;62522.68738656278;14562.927185364006;15701.921490392475;15902.363905443885;15939.123348215728;15965.44120955761;10875.945620271848;10922.781544369227;11843.644690659294;12197.32914689683;12213;19997.000149992735;20659.69010464844;20746.377608671763;20771;20815.1673933044;7699.3034249108;8985.371024028254;9253.768655783659;9263.95368023169;9270.860937085949;932.6595792535676;968.7481254873643;978.7357413498315;1011.4083261292227;1109.678193323927;29354.853225733736;29717;29845.701542984727;29927.551086733718;30014.69985300119;913.6436789651908;1093.092733031582;1121.2487633285718;1171.7832201042834;1206.2822620540765;11966.700832479257;14167.929160354131;14247.928760356132;14291.92810539193;14518;652517;656443;658341;660879;660976;56736;57003.85992280131;57016.57458563569;57025;57194;1408.8168538089983;1410.9576712698636;1414.794854746056;1443.0331677775916;1456.9053011554215;27735.861320693268;27852.025179118635;28002.133078161496;28238;28379.148625541267;47764.52235477601;48100.03799924052;48218.75890620524;48247.79380515375;48352.791180220775;501941;502395.9760402495;503337;503667;504357;25738;27510.862445687642;32370.514442282914;32379.51430728494;32410.67589324171;39599.40600891047;40044;40349;40640.39039414352;41173.588264116974;30232.48837558157;31297.374052518368;34792.304153917285;34907;35933.820330898176;28328.00851970171;32897.83551082229;34331.313373731886;35807.82096089607;35916.28167436689;33299.667003329654;34221.65778342185;34356;34539.82730086333;34602.65397345994;29284;31339;31377.19521888458;31384.843075784476;31501.8424907874;19744.210231590576;23496.412589685395;23928.685322490575;24092.87953560291;24301.14945976882 03:13:05 INFO - PROCESS | 1681 | |2;jquery.html;359.4428635614797;362.65185421994875;364.90512466758634;366.9596344402115;373.21624588364455;15226.695466090672;15451.381944722198;18616.720749188757;19491.610167796636;19925.501862453446;15593.53219403417;18568.442946711588;19108.14013369398;19671.606567868635;19787.901060494678;5495.422980587041;5541.8085111701075;5790.449907258825;5796.942030579704;5800.941990580082;3421.367047096283;4236.894077648052;5691.117876729114;5741.397153298906;5808.332041815182;5744.052231381838;6317.399847014549;6322.74709011639;6329.240491141047;6338.271098823625;6119.785807496739;6201.410865967726;6281.780137695205;6307.463865571432;6310.021946598285;5360.571154307646;5434.701091439969;5478.506934375885;5492.697901615409;5515.7242137892945;24773.5045299093;24985.750712464487;25041.62437563438;25059.874700626562;25109.372265693502;1976.318170231268;2167.56648670265;2273.34073118797;2672.9465410691873;2971.227480854972;13715;14204.644883877882;14466.27668616565;14533.563993080224;14887.255637218095;1708.2142214581309;1709.8461138497596;1713.4431309824233;1715.5968347438343;1722.6554689062111;86349;86839;87740;88556;88586;9987.750306242257;10269.178465722724;10462.895371046345;10478.423686697304;10540.841887371696;12595.748085038247;12680.619581412573;12682.936585317198;12707.745845083047;12712.42794074269;8398.202170793766;8418.579071046423;8425.283850872744;8504.23461888433;8518.403711740242;8591.6992905248;8595.82808343842;8621.655133794704;8624.223819856117;8679.826403472021;6136.325004249529;6136.570440069241;6155.507559395327;6179.134921111048;6191.226096737908;1558.9766153507705;1575.558843523815;1718.1409295352323;1738.6870363334467;1740.582260257529;851.1913682001999;916.9633214671338;924.385283786288;926.346925417579;1005.5525291245326;19729;20829.58340833175;21230.893845530984;21243.893780530998;21329.040193191344;842.473454091193;939.6852054561798;939.8637197606446;956.2159029595665;977.750673578233;10026.598936042477;11040.227184097197;11050.889491105147;11052.668419947415;11072.944635276772;677948;706556.4099231093;722366;725111;733417;106843.46578267214;107959;108083;108165.37751933727;108933;968.5205823117602;1156.5662876421343;1170.5727409495644;1177.2230327983489;1177.8468799056068;18090.366837160636;18289.725654115464;18333;18336;18344.449666510027;43115.353269700354;44950.10099798051;45166;45614.31578526258;46462.30306545337;65742.68514629776;66749.33126671873;67013.3298667007;67096.6645166771;67998.66000669965;7162.641867906688;7443.618042226435;7502.962485187539;7602.6198690066385;7661.502002369828;7110.4667149962925;11573.305601663928;11814.645560633195;11922.105842062054;12434.689132771753;7858.528488290721;10039.196864250696;10228.488575571042;10237.385756854612;10465.68602941913;4071.714979951375;9462.858057129011;10028.64899728506;10200.540975655966;10358.223133265186;10651;10657.840132397865;10685.039252485438;10685.8931410688;10766.246362754531;7556.622168891643;7686.269804368576;7698.653560589675;7702.383809295355;7735.613219339123;9585.856212156963;10394.532246049097;10418.68743937683;10565.471726413494;10598.788024239318 03:13:05 INFO - PROCESS | 1681 | |3;mootools.html;1424.9002569820116;1544.7605621128725;1574.9370025198994;1808.6925222712139;1943.6987266973615;7979.521228726273;8169.714060007901;8557.572121393936;8721.127887211276;8730.301575873931;8496.872546911802;8527.95736021319;8685.652573897036;8692.478451292927;8700.564971751402;2176.336217453676;2237.85453945493;2471.098049212038;2498.837575557592;2504.474060447308;2250.5948929192737;2475.418276704982;2527.4060595759984;2530.3168144600945;2531.0382054819142;2090.4669309326177;2442.4016116051503;2489.601663733803;2500.749925007503;2502.3869152057773;2168.490404754881;2227.164813195052;2236.630955892292;2474.505098980202;2482.255323402981;1910.7133929910485;2087.2068613926763;2199.8900054997184;2448.6816713827266;2520.558902192109;8609.311255099577;8685.869711954325;8707.085755995657;8715.825683486295;8809.515476648781;5320.654157479751;5438.265834112383;5453.427390124019;5479.890402191933;5483.917741233885;3165.8602902954917;3569.3575156471825;3639.581448133472;3731.8134093295225;3738;1055.0662663542819;1060.8726952765717;1080.2168427889717;1080.5029686344212;1085.7068591480336;12193.085518586053;12248.693782655504;12264.141510094298;12265.325407102606;12271.202371845802;4827.831025914146;4951.504849515091;5000.62495312853;5037.496250375007;5037.823676171316;10382.792344153075;10393.84409233862;10406.427646479366;10426.478676066166;10429.895701043044;5568.248286481355;5571.526420254243;5579.0515612346;5587;5600.711836277679;4879.780409881564;4982.651214415028;4983.053219888209;4986.4514903360605;5047.823326183566;4010.057636455431;4018.417329487208;4054.2499637567144;4054.9391759123637;4104;1274.9736462147875;1304.478208716521;1308.3523655790445;1311.4688551136805;1325;1210.1952201785714;1302.042998396178;1332.2672530108596;1370.6230786533583;1371;8265.256126948603;8278.793030174294;8280.627371768285;8281.710140145065;8308.6676532938;454.538643277074;511.882267078574;517.712669468441;525.1413938210976;526.9183276592134;4870.439899411542;6190.938090619126;6193.566450348432;6314.589551679126;6393.776217832354;10568.471576421149;10653.360798351969;10682.038616524394;11004.449777511092;11020.393878336768;10697.251192416456;10756.978087081714;10763.246572739834;10779.78440431187;10784;7892.60536973149;8193.426460147852;8223.629936652866;8322.417430779788;8431.915680843236;8005.879911801211;8110;8126.634301456331;8136.796580085545;8146.981627296588;9237.538123093953;9300.488473134043;9370.578323975575;9558.23534117255;9567.425954442755;9479.763005924908;9707.805843883225;9872.210223182272;9897.604095836086;9908.306418550632;7180.281971802987;7310.671019804228;7323.157836848617;7328.743493977685;7331.486795924234;7825.060992680915;8082.757517274491;8083.878741818759;8100.351971842357;8162;7565.735199268;7597.468177227541;7674.117476490275;7697.923020769721;7829.491083079582;7564.810879728051;7599.278068583476;7683.385329173764;7729.227077292226;7735.883961740691;7656.846863062819;7717.2282771722375;7851.332636725942;7852.921470785219;7859.17478664732;7064.364207221375;7095.538789978635;7119.786406407816;7119.82200444993;7138.928610714034;6570.737170513126;7145;7214.855702885808;7221.963890180516;7236.457265705199 03:13:05 INFO - PROCESS | 1681 | |4;prototype.html;319.4633016532226;327.0988426883936;331.5838622528727;333.9532465454835;338.29296769751215;6561.081448597194;6575.6712164391765;6580.1445812044485;6684.4986626003;6706.966465167668;5316.255724198606;6313.210848643919;6332.765110803383;6488.545801793876;6629.105070815439;3881.5536213335404;4508.977455112737;4840.370751802269;4850.9029819403595;4895;4869.756512174395;4870.342503761982;4871.780769865347;4889.951100489003;4896.926546101811;4616.653750968674;4667.649926255527;4725.432948046222;4736.052789442108;4821.686590371614;4475.418195634579;4689.296605509184;4715.669903106784;4750.738709370983;4806.75966201692;4143.606357396073;4145.129522800215;4149.398337241083;4150.086980864236;4157.438745769313;6155.907661385083;6255.499560035186;6269.529785266123;6280.15217945576;6281.842953926189;5607.355154157242;5717.514011309044;5740.425957404226;5744;5747.885042299173;6991.545549539263;7029.297070292981;7049.400800931927;7053.576785392842;7066.434685225169;4664.72011679297;4668.276417155346;4668.276417155346;4683.906321873544;4693.366395536593;6751.25736169021;7437.442191835634;7476.1776204617445;7478;7499.4000479962015;3712.7586706863967;4757.904841903142;4766.428028636586;4769.642276829182;4789.95210047902;4830.2513110467935;4850.223964165716;4852.296417019583;4856.4415092264135;4866.756662166948;4654.185517534418;5701.743421546041;5707.971460142673;5708.57185711065;5714.457126573052;6814.284500127515;7094;7118.608476533736;7121.537100088478;7142.142942846892;1410.964725881861;1665.8167601563819;1688.9071101089312;1689.8225686303008;1690;1007.9848802267971;1085.2403317677656;1085.7448499602588;1098.357460885391;1109.916756243285;5175.741212939338;6474.4496717778575;6502.837429064217;6652.634105124264;6669.966650166718;5970.253718285215;7352.338289553966;7416.295451932057;7419.85160296791;7443.144038435541;6374.458171055512;6586.3742944421165;6617.8014659560295;6633.568818026909;6640.966795165993;3356.278400143981;3782.6973842092566;3872.7095467840027;3898.6686131678557;3902.551206611219;6786.083878676414;7131.89302160468;7724.806879827936;7728.806779830549;7741.767746967487;7259.274072592699;7528.548287102792;7641.312281894656;7645.5794931279315;7647.502912310793;7560.848783024308;7591.696332146763;7865.213478652089;7896.881546776803;7900.525968441912;6410.0705397718;6935.410490108397;7368.152662443673;7372.668229929774;7384.593847338448;7064.187618423947;7259.056322678018;7339.74310899116;7340.889886651597;7354.448416368687;7738.110117336579;7741.612919354123;7751.224877512203;7761.72833950809;7778;4003.279409706281;4618.907621847611;4656.41794775653;4658.068386322817;4673.275642275453;5929.940700593112;7116.323949224816;7328.083989501312;7367.226441223809;7375.704971801068;5745.368009519033;6687.933120668731;7110;7124.25195354501;7125.857482850418;6241.594296370721;6644.700988455627;6815.795526134224;7087.787366379017;7106.786796396116;6621.602703837785;6921.861562768817;6925.376716095374;6935.375816176568;6938.722451101899;6316.368363163647;6426.325235850355;6927;6980.267071957372;7004.754833580801;6831.45348372139;6862.936244882051;6863.313668633096;6872.10662613857;6909 03:13:05 INFO - PROCESS | 1681 | |5;yui.html;722.5195245161964;727.9599622020787;737.8007937856777;744.836136050069;775.7168633448786;17281.913590432046;17513.29946802128;17525.64948701025;17565;17570.29718811246;15771.921140394283;15823.208839558034;15837;15856.445024424147;15890;693.272064332449;702.2766550453042;846.2468403121227;862.1120246146448;865.8398196333699;699.7201119552194;851.8168593752342;864.6887120636566;864.7492227254089;865.8571335729597;897.7620930453403;916.0427353415697;917.1287277086761;918.6509126531942;921.4793641592512;714.6819665248967;720.7585458871284;724.1672077111364;908.6183802802806;910.008091180613;534.0947094674528;536.4796147736689;537.844025232682;653.3727621483382;664.8238216872533;12311;15141.242937853063;15145.242737863064;15150.54548363551;15182.089074655556;12300.938495307555;12336.5065397384;12413.813792793115;12568.434420451102;12613.621591352274;10135.949320253352;10187.745306367326;10199.643012494602;10224.488775561267;10918.1811364148;3424.9143771405666;3473.3053389322235;3473.7915725056578;3532.2935412917263;3663.5970043295215;74217.62891185563;74608.50782984364;75184;80068.19931800666;81013;9256.120668536478;9268.351215414856;9321.580528876217;9586.520673966274;9893.148023612132;20058.699119513218;20305.492362690755;20309.79690203079;20332.186712531333;20350.491237718878;6626.900596491057;7493.138289096714;7622.123455802543;7647.732329368446;7661.080670319598;4005.339119045383;4069.3895915612893;4134.193832202752;4144.5026596808575;4149.937750933738;3499.4051011327624;3553.076200187918;3553.6446355364774;3555.5733312002726;3555.715542756573;647.4011539326199;653.0563335979559;664.2162248546665;671.1275342055407;675.587891386254;526.1292560811862;545.2176127257399;562.7328207973366;609.920710307666;615.6336979497192;8940.73177804667;9213.30900182489;9214.769630759285;9236.72289831306;9257.49083800384;499.41568365013023;528.8523903130217;566.1479473392518;616.5252755378334;635.7425242776683;3803.923921521554;3830.674392676598;3831.214601006787;3922.0783115967724;4076.490438695163;89358.10641893499;91530.62704059311;92076.15847683008;92137;95566.56650150253;55674.443255567734;77647.83528247081;78075;78996;79123.20876791273;49719;69957.65021174963;70152.2984770156;70933.645331773;73864.89202661964;6922.757703480354;7533.660985255567;7897.565633890191;7970.641321140447;8190.877136842833;46884.7655761719;48618.5138148614;49124;49716;49891.75054124851;68935.3106468949;69056.309436907;69421;69791;71286.64356678183;8778.91221087781;10840.67477975662;10877.564897404016;10908.34549927007;11379.658610241706;11716.41417929083;11724.237924534878;12317.445714943029;12344.691382715504;12642.178258413174;10915;11234.932681395254;11592.072634189413;11595.826062609236;12303.69240768988;11143.16426268017;11347.886521135013;11369.54521819118;11729.706757331134;12346.567870124503;10731.356118632906;10736.463176841284;10813.51339189754;10828.458577071273;11315.98156165949;8787.472751634923;9024.097590241186;9093.818123637358;9111.589978451118;9427.104425079606;7480.812979675552;8263.95868020656;8333.541655209021;8660.35047371437;9346.859797102912 03:13:05 INFO - PROCESS | 1681 | __end_tp_report 03:13:05 INFO - PROCESS | 1681 | __start_cc_report 03:13:05 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1150 03:13:05 INFO - PROCESS | 1681 | __end_cc_report 03:13:05 INFO - PROCESS | 1681 | __startTimestamp1454584385103__endTimestamp 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | ------- Summary: start ------- 03:13:05 INFO - PROCESS | 1681 | Number of tests: 6 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5716.89 Median:5918.53 stddev:664.88 (11.2%) stddev-sans-first:629.14 03:13:05 INFO - PROCESS | 1681 | Values: 2900.5 3440.0 3519.8 3534.2 3578.5 5586.3 5657.5 5668.7 5671.7 5685.9 4322.8 5642.2 5813.3 5831.3 5846.0 5148.7 5187.7 5223.5 5233.6 5257.8 5277.0 5324.8 5333.8 5340.5 5370.8 5154.3 5244.6 5278.9 5294.9 5325.0 5215.8 5244.1 5249.6 5250.1 5266.5 5149.0 5200.8 5207.1 5215.7 5238.6 5578.3 5587.8 5611.7 5621.9 5625.5 6126.5 6212.8 6221.4 6221.7 6242.2 4870.9 6313.8 6332.1 6339.1 6343.6 5727.9 5792.1 5812.9 5850.7 5862.7 6238.8 6254.3 6342.0 6343.5 6349.1 6177.6 6212.7 6213.7 6226.6 6227.1 6290.9 6308.6 6313.2 6313.5 6323.8 6097.2 6125.3 6140.0 6177.7 6227.5 6125.5 6257.0 6269.4 6271.5 6272.9 4886.9 4901.5 4908.3 4910.6 4911.4 4307.4 4316.7 4361.3 4384.6 4409.2 5683.9 5706.9 5723.7 5743.9 5766.6 6209.2 6237.3 6279.6 6282.8 6327.2 5615.4 5678.0 5692.8 5694.8 5723.6 5321.7 5344.7 5350.4 5352.0 5361.7 6266.8 6338.8 6348.9 6364.4 6366.4 6256.9 6264.7 6287.3 6302.0 6315.6 6306.1 6306.6 6308.6 6308.9 6325.1 6036.4 6132.0 6144.9 6214.9 6240.3 6126.7 6263.8 6283.0 6292.6 6310.0 4814.0 6085.7 6091.8 6102.8 6110.4 5934.3 5997.7 6078.5 6092.8 6108.8 4913.9 5855.1 5861.5 5976.1 5983.8 4782.0 6049.4 6083.1 6118.6 6124.2 5906.3 5918.5 5937.7 5957.0 5970.4 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:67458.15 Median:38993.71 stddev:147854.51 (379.2%) stddev-sans-first:148183.78 03:13:05 INFO - PROCESS | 1681 | Values: 484.9 559.3 577.7 599.6 600.9 29934.0 37939.2 38410.8 38411.4 38429.6 40838.0 41190.8 41295.6 41320.4 41339.0 9454.2 9664.2 9676.0 9684.6 9694.0 9556.1 9696.5 9707.3 9708.0 9825.8 9735.2 9825.2 9833.1 9834.7 9839.2 9717.9 9793.8 9793.8 9799.2 9805.1 9539.2 9714.6 9725.3 9729.5 9730.4 39557.8 39891.4 39914.0 39939.8 39966.8 3008.9 3018.0 3018.7 3072.5 3076.3 28165.9 28270.4 28433.9 28726.9 29002.9 2689.5 2737.6 2765.0 2767.1 2957.5 476280.0 481178.0 481986.0 482027.0 482986.6 56238.6 56960.7 57118.0 65552.7 66599.3 61682.4 62285.1 62406.4 62516.4 62522.7 14562.9 15701.9 15902.4 15939.1 15965.4 10875.9 10922.8 11843.6 12197.3 12213.0 19997.0 20659.7 20746.4 20771.0 20815.2 7699.3 8985.4 9253.8 9264.0 9270.9 932.7 968.7 978.7 1011.4 1109.7 29354.9 29717.0 29845.7 29927.6 30014.7 913.6 1093.1 1121.2 1171.8 1206.3 11966.7 14167.9 14247.9 14291.9 14518.0 652517.0 656443.0 658341.0 660879.0 660976.0 56736.0 57003.9 57016.6 57025.0 57194.0 1408.8 1411.0 1414.8 1443.0 1456.9 27735.9 27852.0 28002.1 28238.0 28379.1 47764.5 48100.0 48218.8 48247.8 48352.8 501941.0 502396.0 503337.0 503667.0 504357.0 25738.0 27510.9 32370.5 32379.5 32410.7 39599.4 40044.0 40349.0 40640.4 41173.6 30232.5 31297.4 34792.3 34907.0 35933.8 28328.0 32897.8 34331.3 35807.8 35916.3 33299.7 34221.7 34356.0 34539.8 34602.7 29284.0 31339.0 31377.2 31384.8 31501.8 19744.2 23496.4 23928.7 24092.9 24301.1 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:36000.24 Median:361.05 stddev:117196.94 (32460.3%) stddev-sans-first:117495.15 03:13:05 INFO - PROCESS | 1681 | Values: 359.4 362.7 364.9 367.0 373.2 15226.7 15451.4 18616.7 19491.6 19925.5 15593.5 18568.4 19108.1 19671.6 19787.9 5495.4 5541.8 5790.4 5796.9 5800.9 3421.4 4236.9 5691.1 5741.4 5808.3 5744.1 6317.4 6322.7 6329.2 6338.3 6119.8 6201.4 6281.8 6307.5 6310.0 5360.6 5434.7 5478.5 5492.7 5515.7 24773.5 24985.8 25041.6 25059.9 25109.4 1976.3 2167.6 2273.3 2672.9 2971.2 13715.0 14204.6 14466.3 14533.6 14887.3 1708.2 1709.8 1713.4 1715.6 1722.7 86349.0 86839.0 87740.0 88556.0 88586.0 9987.8 10269.2 10462.9 10478.4 10540.8 12595.7 12680.6 12682.9 12707.7 12712.4 8398.2 8418.6 8425.3 8504.2 8518.4 8591.7 8595.8 8621.7 8624.2 8679.8 6136.3 6136.6 6155.5 6179.1 6191.2 1559.0 1575.6 1718.1 1738.7 1740.6 851.2 917.0 924.4 926.3 1005.6 19729.0 20829.6 21230.9 21243.9 21329.0 842.5 939.7 939.9 956.2 977.8 10026.6 11040.2 11050.9 11052.7 11072.9 677948.0 706556.4 722366.0 725111.0 733417.0 106843.5 107959.0 108083.0 108165.4 108933.0 968.5 1156.6 1170.6 1177.2 1177.8 18090.4 18289.7 18333.0 18336.0 18344.4 43115.4 44950.1 45166.0 45614.3 46462.3 65742.7 66749.3 67013.3 67096.7 67998.7 7162.6 7443.6 7503.0 7602.6 7661.5 7110.5 11573.3 11814.6 11922.1 12434.7 7858.5 10039.2 10228.5 10237.4 10465.7 4071.7 9462.9 10028.6 10200.5 10358.2 10651.0 10657.8 10685.0 10685.9 10766.2 7556.6 7686.3 7698.7 7702.4 7735.6 9585.9 10394.5 10418.7 10565.5 10598.8 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:6072.86 Median:2923.79 stddev:3249.74 (111.1%) stddev-sans-first:3240.08 03:13:05 INFO - PROCESS | 1681 | Values: 1424.9 1544.8 1574.9 1808.7 1943.7 7979.5 8169.7 8557.6 8721.1 8730.3 8496.9 8528.0 8685.7 8692.5 8700.6 2176.3 2237.9 2471.1 2498.8 2504.5 2250.6 2475.4 2527.4 2530.3 2531.0 2090.5 2442.4 2489.6 2500.7 2502.4 2168.5 2227.2 2236.6 2474.5 2482.3 1910.7 2087.2 2199.9 2448.7 2520.6 8609.3 8685.9 8707.1 8715.8 8809.5 5320.7 5438.3 5453.4 5479.9 5483.9 3165.9 3569.4 3639.6 3731.8 3738.0 1055.1 1060.9 1080.2 1080.5 1085.7 12193.1 12248.7 12264.1 12265.3 12271.2 4827.8 4951.5 5000.6 5037.5 5037.8 10382.8 10393.8 10406.4 10426.5 10429.9 5568.2 5571.5 5579.1 5587.0 5600.7 4879.8 4982.7 4983.1 4986.5 5047.8 4010.1 4018.4 4054.2 4054.9 4104.0 1275.0 1304.5 1308.4 1311.5 1325.0 1210.2 1302.0 1332.3 1370.6 1371.0 8265.3 8278.8 8280.6 8281.7 8308.7 454.5 511.9 517.7 525.1 526.9 4870.4 6190.9 6193.6 6314.6 6393.8 10568.5 10653.4 10682.0 11004.4 11020.4 10697.3 10757.0 10763.2 10779.8 10784.0 7892.6 8193.4 8223.6 8322.4 8431.9 8005.9 8110.0 8126.6 8136.8 8147.0 9237.5 9300.5 9370.6 9558.2 9567.4 9479.8 9707.8 9872.2 9897.6 9908.3 7180.3 7310.7 7323.2 7328.7 7331.5 7825.1 8082.8 8083.9 8100.4 8162.0 7565.7 7597.5 7674.1 7697.9 7829.5 7564.8 7599.3 7683.4 7729.2 7735.9 7656.8 7717.2 7851.3 7852.9 7859.2 7064.4 7095.5 7119.8 7119.8 7138.9 6570.7 7145.0 7214.9 7222.0 7236.5 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5722.71 Median:6418.20 stddev:1846.16 (28.8%) stddev-sans-first:1806.24 03:13:05 INFO - PROCESS | 1681 | Values: 319.5 327.1 331.6 334.0 338.3 6561.1 6575.7 6580.1 6684.5 6707.0 5316.3 6313.2 6332.8 6488.5 6629.1 3881.6 4509.0 4840.4 4850.9 4895.0 4869.8 4870.3 4871.8 4890.0 4896.9 4616.7 4667.6 4725.4 4736.1 4821.7 4475.4 4689.3 4715.7 4750.7 4806.8 4143.6 4145.1 4149.4 4150.1 4157.4 6155.9 6255.5 6269.5 6280.2 6281.8 5607.4 5717.5 5740.4 5744.0 5747.9 6991.5 7029.3 7049.4 7053.6 7066.4 4664.7 4668.3 4668.3 4683.9 4693.4 6751.3 7437.4 7476.2 7478.0 7499.4 3712.8 4757.9 4766.4 4769.6 4790.0 4830.3 4850.2 4852.3 4856.4 4866.8 4654.2 5701.7 5708.0 5708.6 5714.5 6814.3 7094.0 7118.6 7121.5 7142.1 1411.0 1665.8 1688.9 1689.8 1690.0 1008.0 1085.2 1085.7 1098.4 1109.9 5175.7 6474.4 6502.8 6652.6 6670.0 5970.3 7352.3 7416.3 7419.9 7443.1 6374.5 6586.4 6617.8 6633.6 6641.0 3356.3 3782.7 3872.7 3898.7 3902.6 6786.1 7131.9 7724.8 7728.8 7741.8 7259.3 7528.5 7641.3 7645.6 7647.5 7560.8 7591.7 7865.2 7896.9 7900.5 6410.1 6935.4 7368.2 7372.7 7384.6 7064.2 7259.1 7339.7 7340.9 7354.4 7738.1 7741.6 7751.2 7761.7 7778.0 4003.3 4618.9 4656.4 4658.1 4673.3 5929.9 7116.3 7328.1 7367.2 7375.7 5745.4 6687.9 7110.0 7124.3 7125.9 6241.6 6644.7 6815.8 7087.8 7106.8 6621.6 6921.9 6925.4 6935.4 6938.7 6316.4 6426.3 6927.0 6980.3 7004.8 6831.5 6862.9 6863.3 6872.1 6909.0 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:18026.90 Median:612.78 stddev:25166.13 (4106.9%) stddev-sans-first:25203.18 03:13:05 INFO - PROCESS | 1681 | Values: 722.5 728.0 737.8 744.8 775.7 17281.9 17513.3 17525.6 17565.0 17570.3 15771.9 15823.2 15837.0 15856.4 15890.0 693.3 702.3 846.2 862.1 865.8 699.7 851.8 864.7 864.7 865.9 897.8 916.0 917.1 918.7 921.5 714.7 720.8 724.2 908.6 910.0 534.1 536.5 537.8 653.4 664.8 12311.0 15141.2 15145.2 15150.5 15182.1 12300.9 12336.5 12413.8 12568.4 12613.6 10135.9 10187.7 10199.6 10224.5 10918.2 3424.9 3473.3 3473.8 3532.3 3663.6 74217.6 74608.5 75184.0 80068.2 81013.0 9256.1 9268.4 9321.6 9586.5 9893.1 20058.7 20305.5 20309.8 20332.2 20350.5 6626.9 7493.1 7622.1 7647.7 7661.1 4005.3 4069.4 4134.2 4144.5 4149.9 3499.4 3553.1 3553.6 3555.6 3555.7 647.4 653.1 664.2 671.1 675.6 526.1 545.2 562.7 609.9 615.6 8940.7 9213.3 9214.8 9236.7 9257.5 499.4 528.9 566.1 616.5 635.7 3803.9 3830.7 3831.2 3922.1 4076.5 89358.1 91530.6 92076.2 92137.0 95566.6 55674.4 77647.8 78075.0 78996.0 79123.2 49719.0 69957.7 70152.3 70933.6 73864.9 6922.8 7533.7 7897.6 7970.6 8190.9 46884.8 48618.5 49124.0 49716.0 49891.8 68935.3 69056.3 69421.0 69791.0 71286.6 8778.9 10840.7 10877.6 10908.3 11379.7 11716.4 11724.2 12317.4 12344.7 12642.2 10915.0 11234.9 11592.1 11595.8 12303.7 11143.2 11347.9 11369.5 11729.7 12346.6 10731.4 10736.5 10813.5 10828.5 11316.0 8787.5 9024.1 9093.8 9111.6 9427.1 7480.8 8264.0 8333.5 8660.4 9346.9 03:13:05 INFO - PROCESS | 1681 | -------- Summary: end -------- 03:13:05 INFO - PROCESS | 1681 | 03:13:05 INFO - TEST-INFO | 1681: exit 0 03:13:05 INFO - TEST-OK | dromaeo_css | took 1114381ms 03:13:05 INFO - TEST-START | kraken 03:13:05 INFO - operating with platform_type : mac_ 03:13:05 INFO - Initialising browser for kraken test... 03:13:05 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp58Jf9Z/profile http://localhost:49279/getInfo.html) 03:13:05 INFO - PROCESS | 1689 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 03:13:07 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 03:13:07 INFO - PROCESS | 1689 | colorDepth:24 03:13:07 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 03:13:07 INFO - PROCESS | 1689 | __metrics 03:13:07 INFO - PROCESS | 1689 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:13:07 INFO - PROCESS | 1689 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:13:08 INFO - TEST-INFO | 1689: exit 0 03:13:08 INFO - Browser initialized. 03:13:08 INFO - Running cycle 1/1 for kraken test... 03:13:08 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/tmp58Jf9Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:20 INFO - PROCESS | 1691 | RSS: Main: 243765248 03:13:20 INFO - PROCESS | 1691 | 03:13:23 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 03:13:23 INFO - PROCESS | 1691 | RSS: Main: 291110912 03:13:23 INFO - PROCESS | 1691 | 03:13:26 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 03:13:26 INFO - PROCESS | 1691 | RSS: Main: 301842432 03:13:26 INFO - PROCESS | 1691 | 03:13:30 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 03:13:30 INFO - PROCESS | 1691 | RSS: Main: 287891456 03:13:30 INFO - PROCESS | 1691 | 03:13:32 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 03:13:33 INFO - PROCESS | 1691 | RSS: Main: 289849344 03:13:33 INFO - PROCESS | 1691 | 03:13:35 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:13:35 INFO - PROCESS | 1691 | RSS: Main: 290369536 03:13:35 INFO - PROCESS | 1691 | 03:13:38 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 03:13:39 INFO - PROCESS | 1691 | RSS: Main: 290603008 03:13:39 INFO - PROCESS | 1691 | 03:13:42 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 03:13:42 INFO - PROCESS | 1691 | RSS: Main: 289742848 03:13:42 INFO - PROCESS | 1691 | 03:13:45 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 03:13:45 INFO - PROCESS | 1691 | RSS: Main: 291336192 03:13:45 INFO - PROCESS | 1691 | 03:13:47 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:13:48 INFO - PROCESS | 1691 | RSS: Main: 325636096 03:13:48 INFO - PROCESS | 1691 | 03:13:49 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:50 INFO - PROCESS | 1691 | RSS: Main: 325005312 03:13:50 INFO - PROCESS | 1691 | 03:13:52 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:53 INFO - PROCESS | 1691 | RSS: Main: 331780096 03:13:53 INFO - PROCESS | 1691 | 03:13:55 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:56 INFO - PROCESS | 1691 | RSS: Main: 335245312 03:13:56 INFO - PROCESS | 1691 | 03:13:58 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:59 INFO - PROCESS | 1691 | RSS: Main: 333737984 03:13:59 INFO - PROCESS | 1691 | 03:14:00 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 03:14:01 INFO - PROCESS | 1691 | RSS: Main: 394571776 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | __start_tp_report 03:14:01 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 03:14:01 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 03:14:01 INFO - PROCESS | 1691 | |i|pagename|runs| 03:14:01 INFO - PROCESS | 1691 | |0;ai-astar;111;109;110;110;109;111;114;111;110;110 03:14:01 INFO - PROCESS | 1691 | |1;audio-beat-detection;157;122;145;155;120;149;136;118;168;119 03:14:01 INFO - PROCESS | 1691 | |2;audio-dft;185;184;187;187;186;189;183;186;182;183 03:14:01 INFO - PROCESS | 1691 | |3;audio-fft;79;79;83;76;56;58;57;80;76;59 03:14:01 INFO - PROCESS | 1691 | |4;audio-oscillator;90;94;131;79;80;81;110;76;78;113 03:14:01 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;86;90;84;90;84;88;84;89;84;88 03:14:01 INFO - PROCESS | 1691 | |6;imaging-darkroom;121;94;94;95;94;93;93;93;110;126 03:14:01 INFO - PROCESS | 1691 | |7;imaging-desaturate;88;88;86;86;89;88;86;89;88;87 03:14:01 INFO - PROCESS | 1691 | |8;json-parse-financial;56;54;57;54;55;54;55;65;52;52 03:14:01 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;63;62;79;73;70;67;65;66;67;68 03:14:01 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;82;81;83;81;83;82;82;82;84;83 03:14:01 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;127;121;126;129;120;120;119;123;118;124 03:14:01 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;138;126;139;137;137;127;139;137;136;139 03:14:01 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;69;66;67;67;67;68;67;66;66;65 03:14:01 INFO - PROCESS | 1691 | __end_tp_report 03:14:01 INFO - PROCESS | 1691 | __start_cc_report 03:14:01 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,1139 03:14:01 INFO - PROCESS | 1691 | __end_cc_report 03:14:01 INFO - PROCESS | 1691 | __startTimestamp1454584441170__endTimestamp 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | ------- Summary: start ------- 03:14:01 INFO - PROCESS | 1691 | Number of tests: 14 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:1.43 (1.3%) stddev-sans-first:1.51 03:14:01 INFO - PROCESS | 1691 | Values: 111.0 109.0 110.0 110.0 109.0 111.0 114.0 111.0 110.0 110.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:147.00 stddev:18.43 (12.5%) stddev-sans-first:18.35 03:14:01 INFO - PROCESS | 1691 | Values: 157.0 122.0 145.0 155.0 120.0 149.0 136.0 118.0 168.0 119.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:185.20 Median:186.00 stddev:2.20 (1.2%) stddev-sans-first:2.33 03:14:01 INFO - PROCESS | 1691 | Values: 185.0 184.0 187.0 187.0 186.0 189.0 183.0 186.0 182.0 183.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:70.30 Median:77.50 stddev:11.22 (14.5%) stddev-sans-first:11.45 03:14:01 INFO - PROCESS | 1691 | Values: 79.0 79.0 83.0 76.0 56.0 58.0 57.0 80.0 76.0 59.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:79.50 stddev:18.75 (23.6%) stddev-sans-first:19.86 03:14:01 INFO - PROCESS | 1691 | Values: 90.0 94.0 131.0 79.0 80.0 81.0 110.0 76.0 78.0 113.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:2.58 (2.9%) stddev-sans-first:2.73 03:14:01 INFO - PROCESS | 1691 | Values: 86.0 90.0 84.0 90.0 84.0 88.0 84.0 89.0 84.0 88.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:93.50 stddev:12.82 (13.7%) stddev-sans-first:11.45 03:14:01 INFO - PROCESS | 1691 | Values: 121.0 94.0 94.0 95.0 94.0 93.0 93.0 93.0 110.0 126.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:87.50 Median:88.00 stddev:1.18 (1.3%) stddev-sans-first:1.24 03:14:01 INFO - PROCESS | 1691 | Values: 88.0 88.0 86.0 86.0 89.0 88.0 86.0 89.0 88.0 87.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.72 (6.8%) stddev-sans-first:3.94 03:14:01 INFO - PROCESS | 1691 | Values: 56.0 54.0 57.0 54.0 55.0 54.0 55.0 65.0 52.0 52.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.50 stddev:5.01 (7.4%) stddev-sans-first:4.98 03:14:01 INFO - PROCESS | 1691 | Values: 63.0 62.0 79.0 73.0 70.0 67.0 65.0 66.0 67.0 68.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.95 (1.1%) stddev-sans-first:1.00 03:14:01 INFO - PROCESS | 1691 | Values: 82.0 81.0 83.0 81.0 83.0 82.0 82.0 82.0 84.0 83.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:123.50 stddev:3.71 (3.0%) stddev-sans-first:3.60 03:14:01 INFO - PROCESS | 1691 | Values: 127.0 121.0 126.0 129.0 120.0 120.0 119.0 123.0 118.0 124.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:137.50 stddev:4.86 (3.5%) stddev-sans-first:5.07 03:14:01 INFO - PROCESS | 1691 | Values: 138.0 126.0 139.0 137.0 137.0 127.0 139.0 137.0 136.0 139.0 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:0.88 03:14:01 INFO - PROCESS | 1691 | Values: 69.0 66.0 67.0 67.0 67.0 68.0 67.0 66.0 66.0 65.0 03:14:01 INFO - PROCESS | 1691 | -------- Summary: end -------- 03:14:01 INFO - PROCESS | 1691 | 03:14:01 INFO - TEST-INFO | 1691: exit 0 03:14:01 INFO - TEST-OK | kraken | took 56223ms 03:14:01 INFO - SUITE-END | took 1170s 03:14:02 INFO - Completed test suite (00:19:31) 03:14:02 INFO - Working with test: dromaeo_css 03:14:02 INFO - Generating results file: dromaeo_css 03:14:02 INFO - Working with test: kraken 03:14:02 INFO - Generating results file: kraken 03:14:02 INFO - javascript benchmark 03:14:02 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:14:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 03:14:03 INFO - process_Request line: dromaeo_css 7444.98 graph.html#tests=[[72,64,59]] 03:14:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:14:03 INFO - process_Request line: kraken 1404.30 graph.html#tests=[[232,64,59]] 03:14:03 INFO - RETURN: dromaeo_css: 7444.98 03:14:03 INFO - RETURN: kraken: 1404.30 03:14:03 INFO - javascript benchmark 03:14:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2900.53591425372, 3440.0, 3519.7712148710348, 3534.151803567144, 3578.516900218471, 5586.301712285965, 5657.547396208303, 5668.71656417179, 5671.6880571568545, 5685.857853553658, 4322.82708691652, 5642.15367694846, 5813.33146688131, 5831.329397119322, 5846.0, 5148.665336753118, 5187.714675692835, 5223.477652234765, 5233.633645644806, 5257.76340064698, 5276.973615131919, 5324.840254792362, 5333.759980800874, 5340.465953404648, 5370.812021579245, 5154.304168937183, 5244.606654500928, 5278.894422111574, 5294.920576191341, 5325.0, 5215.765290561933, 5244.108501554745, 5249.632525723201, 5250.081235783722, 5266.4733526647415, 5148.974255128738, 5200.817971370984, 5207.062728708831, 5215.687058776485, 5238.554722848562, 5578.30271216098, 5587.832365029056, 5611.66330020196, 5621.887562248732, 5625.5218306444, 6126.5176737973225, 6212.844678883064, 6221.440070393686, 6221.657808820513, 6242.219722534684, 4870.853874383774, 6313.810585682391, 6332.1135041094285, 6339.1442155308905, 6343.5876668016435, 5727.8568035799435, 5792.073268277098, 5812.854678632983, 5850.6782126983, 5862.677552734641, 6238.750449982041, 6254.2807577129215, 6342.0, 6343.460805831463, 6349.079383489368, 6177.62934223948, 6212.658303793244, 6213.720382582795, 6226.62640241587, 6227.1282020517165, 6290.937090629127, 6308.621482711052, 6313.242410910629, 6313.526485513605, 6323.841903952346, 6097.237845269341, 6125.326214116443, 6140.008994153746, 6177.660228687465, 6227.501799856092, 6125.540694081788, 6256.968715156395, 6269.373062693785, 6271.529635277372, 6272.874542509125, 4886.853394398174, 4901.460839307744, 4908.263760435963, 4910.631702622246, 4911.435184953704, 4307.440032795779, 4316.676249281317, 4361.323994780814, 4384.605385515319, 4409.162259170747, 5683.914741278884, 5706.857328566819, 5723.656580605177, 5743.9425605744245, 5766.596338256281, 6209.223847019122, 6237.251529816451, 6279.560430769802, 6282.811515654537, 6327.209098862642, 5615.438456154434, 5678.0, 5692.800751973661, 5694.829155125353, 5723.627964182315, 5321.73391330432, 5344.732763361816, 5350.411454739976, 5351.973240133852, 5361.731913404392, 6266.780662676784, 6338.778142764981, 6348.873022539616, 6364.363563643691, 6366.427021567988, 6256.906146407717, 6264.718087686157, 6287.30839607652, 6301.96849015752, 6315.5894866833505, 6306.085617585516, 6306.590071645328, 6308.621482711052, 6308.905366419599, 6325.146105275729, 6036.396360363929, 6131.988406491147, 6144.938550614436, 6214.875702486015, 6240.251169859646, 6126.731429653625, 6263.812085637438, 6283.0, 6292.559520833498, 6309.9588567885785, 4813.95186048135, 6085.69571521431, 6091.847703807263, 6102.786402475892, 6110.358412366638, 5934.3175534814045, 5997.730102145501, 6078.513718902565, 6092.817215483543, 6108.816735497942, 4913.877153071202, 5855.063189889767, 5861.531077513703, 5976.073708575178, 5983.790567330123, 4781.976090119527, 6049.395060494091, 6083.117947897618, 6118.602290851259, 6124.234470691164, 5906.320773111147, 5918.5295578738205, 5937.703114844154, 5956.970215148896, 5970.402959704169], "unit": "score", "name": "dojo.html", "value": 5676.197987940848}, {"lowerIsBetter": false, "replicates": [484.90786750517424, 559.2561892682733, 577.7313549199623, 599.6462087368452, 600.9188759517465, 29934.0, 37939.24121517568, 38410.847674569806, 38411.42382864259, 38429.61570384295, 40838.0, 41190.794046029805, 41295.58704412955, 41320.38019429703, 41338.96652583687, 9454.19639330656, 9664.22686185107, 9676.0, 9684.56419461126, 9694.0, 9556.139947404732, 9696.46669433181, 9707.271954603397, 9708.0, 9825.803483930316, 9735.221182305399, 9825.213982881352, 9833.11501964823, 9834.70495885121, 9839.163671087967, 9717.90282097177, 9793.755156121082, 9793.804123917553, 9799.16707079899, 9805.117539421415, 9539.18916892065, 9714.591384249316, 9725.270604704605, 9729.464879431629, 9730.36752611078, 39557.80221098905, 39891.41248756401, 39914.0, 39939.80180594587, 39966.80016599927, 3008.909732708022, 3017.9547306790414, 3018.6981301869637, 3072.5083986562267, 3076.2770748874223, 28165.85917070422, 28270.434591308058, 28433.857830710713, 28726.856365718246, 29002.854985725146, 2689.4755522673086, 2737.630419893309, 2765.046059109604, 2767.1421859223506, 2957.467655821951, 476280.0, 481178.0, 481986.0, 482027.0, 482986.5850670759, 56238.59403514863, 56960.71519642375, 57118.0, 65552.67223663851, 66599.33400666028, 61682.38317616856, 62285.06572401417, 62406.37593624006, 62516.37483625105, 62522.68738656278, 14562.927185364006, 15701.921490392475, 15902.363905443885, 15939.123348215728, 15965.44120955761, 10875.945620271848, 10922.781544369227, 11843.644690659294, 12197.32914689683, 12213.0, 19997.000149992735, 20659.69010464844, 20746.377608671763, 20771.0, 20815.1673933044, 7699.3034249108, 8985.371024028254, 9253.768655783659, 9263.95368023169, 9270.860937085949, 932.6595792535676, 968.7481254873643, 978.7357413498315, 1011.4083261292227, 1109.678193323927, 29354.853225733736, 29717.0, 29845.701542984727, 29927.551086733718, 30014.69985300119, 913.6436789651908, 1093.092733031582, 1121.2487633285718, 1171.7832201042834, 1206.2822620540765, 11966.700832479257, 14167.929160354131, 14247.928760356132, 14291.92810539193, 14518.0, 652517.0, 656443.0, 658341.0, 660879.0, 660976.0, 56736.0, 57003.85992280131, 57016.57458563569, 57025.0, 57194.0, 1408.8168538089983, 1410.9576712698636, 1414.794854746056, 1443.0331677775916, 1456.9053011554215, 27735.861320693268, 27852.025179118635, 28002.133078161496, 28238.0, 28379.148625541267, 47764.52235477601, 48100.03799924052, 48218.75890620524, 48247.79380515375, 48352.791180220775, 501941.0, 502395.9760402495, 503337.0, 503667.0, 504357.0, 25738.0, 27510.862445687642, 32370.514442282914, 32379.51430728494, 32410.67589324171, 39599.40600891047, 40044.0, 40349.0, 40640.39039414352, 41173.588264116974, 30232.48837558157, 31297.374052518368, 34792.304153917285, 34907.0, 35933.820330898176, 28328.00851970171, 32897.83551082229, 34331.313373731886, 35807.82096089607, 35916.28167436689, 33299.667003329654, 34221.65778342185, 34356.0, 34539.82730086333, 34602.65397345994, 29284.0, 31339.0, 31377.19521888458, 31384.843075784476, 31501.8424907874, 19744.210231590576, 23496.412589685395, 23928.685322490575, 24092.87953560291, 24301.14945976882], "unit": "score", "name": "ext.html", "value": 19414.74428929221}, {"lowerIsBetter": false, "replicates": [359.4428635614797, 362.65185421994875, 364.90512466758634, 366.9596344402115, 373.21624588364455, 15226.695466090672, 15451.381944722198, 18616.720749188757, 19491.610167796636, 19925.501862453446, 15593.53219403417, 18568.442946711588, 19108.14013369398, 19671.606567868635, 19787.901060494678, 5495.422980587041, 5541.8085111701075, 5790.449907258825, 5796.942030579704, 5800.941990580082, 3421.367047096283, 4236.894077648052, 5691.117876729114, 5741.397153298906, 5808.332041815182, 5744.052231381838, 6317.399847014549, 6322.74709011639, 6329.240491141047, 6338.271098823625, 6119.785807496739, 6201.410865967726, 6281.780137695205, 6307.463865571432, 6310.021946598285, 5360.571154307646, 5434.701091439969, 5478.506934375885, 5492.697901615409, 5515.7242137892945, 24773.5045299093, 24985.750712464487, 25041.62437563438, 25059.874700626562, 25109.372265693502, 1976.318170231268, 2167.56648670265, 2273.34073118797, 2672.9465410691873, 2971.227480854972, 13715.0, 14204.644883877882, 14466.27668616565, 14533.563993080224, 14887.255637218095, 1708.2142214581309, 1709.8461138497596, 1713.4431309824233, 1715.5968347438343, 1722.6554689062111, 86349.0, 86839.0, 87740.0, 88556.0, 88586.0, 9987.750306242257, 10269.178465722724, 10462.895371046345, 10478.423686697304, 10540.841887371696, 12595.748085038247, 12680.619581412573, 12682.936585317198, 12707.745845083047, 12712.42794074269, 8398.202170793766, 8418.579071046423, 8425.283850872744, 8504.23461888433, 8518.403711740242, 8591.6992905248, 8595.82808343842, 8621.655133794704, 8624.223819856117, 8679.826403472021, 6136.325004249529, 6136.570440069241, 6155.507559395327, 6179.134921111048, 6191.226096737908, 1558.9766153507705, 1575.558843523815, 1718.1409295352323, 1738.6870363334467, 1740.582260257529, 851.1913682001999, 916.9633214671338, 924.385283786288, 926.346925417579, 1005.5525291245326, 19729.0, 20829.58340833175, 21230.893845530984, 21243.893780530998, 21329.040193191344, 842.473454091193, 939.6852054561798, 939.8637197606446, 956.2159029595665, 977.750673578233, 10026.598936042477, 11040.227184097197, 11050.889491105147, 11052.668419947415, 11072.944635276772, 677948.0, 706556.4099231093, 722366.0, 725111.0, 733417.0, 106843.46578267214, 107959.0, 108083.0, 108165.37751933727, 108933.0, 968.5205823117602, 1156.5662876421343, 1170.5727409495644, 1177.2230327983489, 1177.8468799056068, 18090.366837160636, 18289.725654115464, 18333.0, 18336.0, 18344.449666510027, 43115.353269700354, 44950.10099798051, 45166.0, 45614.31578526258, 46462.30306545337, 65742.68514629776, 66749.33126671873, 67013.3298667007, 67096.6645166771, 67998.66000669965, 7162.641867906688, 7443.618042226435, 7502.962485187539, 7602.6198690066385, 7661.502002369828, 7110.4667149962925, 11573.305601663928, 11814.645560633195, 11922.105842062054, 12434.689132771753, 7858.528488290721, 10039.196864250696, 10228.488575571042, 10237.385756854612, 10465.68602941913, 4071.714979951375, 9462.858057129011, 10028.64899728506, 10200.540975655966, 10358.223133265186, 10651.0, 10657.840132397865, 10685.039252485438, 10685.8931410688, 10766.246362754531, 7556.622168891643, 7686.269804368576, 7698.653560589675, 7702.383809295355, 7735.613219339123, 9585.856212156963, 10394.532246049097, 10418.68743937683, 10565.471726413494, 10598.788024239318], "unit": "score", "name": "jquery.html", "value": 9210.261246867009}, {"lowerIsBetter": false, "replicates": [1424.9002569820116, 1544.7605621128725, 1574.9370025198994, 1808.6925222712139, 1943.6987266973615, 7979.521228726273, 8169.714060007901, 8557.572121393936, 8721.127887211276, 8730.301575873931, 8496.872546911802, 8527.95736021319, 8685.652573897036, 8692.478451292927, 8700.564971751402, 2176.336217453676, 2237.85453945493, 2471.098049212038, 2498.837575557592, 2504.474060447308, 2250.5948929192737, 2475.418276704982, 2527.4060595759984, 2530.3168144600945, 2531.0382054819142, 2090.4669309326177, 2442.4016116051503, 2489.601663733803, 2500.749925007503, 2502.3869152057773, 2168.490404754881, 2227.164813195052, 2236.630955892292, 2474.505098980202, 2482.255323402981, 1910.7133929910485, 2087.2068613926763, 2199.8900054997184, 2448.6816713827266, 2520.558902192109, 8609.311255099577, 8685.869711954325, 8707.085755995657, 8715.825683486295, 8809.515476648781, 5320.654157479751, 5438.265834112383, 5453.427390124019, 5479.890402191933, 5483.917741233885, 3165.8602902954917, 3569.3575156471825, 3639.581448133472, 3731.8134093295225, 3738.0, 1055.0662663542819, 1060.8726952765717, 1080.2168427889717, 1080.5029686344212, 1085.7068591480336, 12193.085518586053, 12248.693782655504, 12264.141510094298, 12265.325407102606, 12271.202371845802, 4827.831025914146, 4951.504849515091, 5000.62495312853, 5037.496250375007, 5037.823676171316, 10382.792344153075, 10393.84409233862, 10406.427646479366, 10426.478676066166, 10429.895701043044, 5568.248286481355, 5571.526420254243, 5579.0515612346, 5587.0, 5600.711836277679, 4879.780409881564, 4982.651214415028, 4983.053219888209, 4986.4514903360605, 5047.823326183566, 4010.057636455431, 4018.417329487208, 4054.2499637567144, 4054.9391759123637, 4104.0, 1274.9736462147875, 1304.478208716521, 1308.3523655790445, 1311.4688551136805, 1325.0, 1210.1952201785714, 1302.042998396178, 1332.2672530108596, 1370.6230786533583, 1371.0, 8265.256126948603, 8278.793030174294, 8280.627371768285, 8281.710140145065, 8308.6676532938, 454.538643277074, 511.882267078574, 517.712669468441, 525.1413938210976, 526.9183276592134, 4870.439899411542, 6190.938090619126, 6193.566450348432, 6314.589551679126, 6393.776217832354, 10568.471576421149, 10653.360798351969, 10682.038616524394, 11004.449777511092, 11020.393878336768, 10697.251192416456, 10756.978087081714, 10763.246572739834, 10779.78440431187, 10784.0, 7892.60536973149, 8193.426460147852, 8223.629936652866, 8322.417430779788, 8431.915680843236, 8005.879911801211, 8110.0, 8126.634301456331, 8136.796580085545, 8146.981627296588, 9237.538123093953, 9300.488473134043, 9370.578323975575, 9558.23534117255, 9567.425954442755, 9479.763005924908, 9707.805843883225, 9872.210223182272, 9897.604095836086, 9908.306418550632, 7180.281971802987, 7310.671019804228, 7323.157836848617, 7328.743493977685, 7331.486795924234, 7825.060992680915, 8082.757517274491, 8083.878741818759, 8100.351971842357, 8162.0, 7565.735199268, 7597.468177227541, 7674.117476490275, 7697.923020769721, 7829.491083079582, 7564.810879728051, 7599.278068583476, 7683.385329173764, 7729.227077292226, 7735.883961740691, 7656.846863062819, 7717.2282771722375, 7851.332636725942, 7852.921470785219, 7859.17478664732, 7064.364207221375, 7095.538789978635, 7119.786406407816, 7119.82200444993, 7138.928610714034, 6570.737170513126, 7145.0, 7214.855702885808, 7221.963890180516, 7236.457265705199], "unit": "score", "name": "mootools.html", "value": 4846.404482693076}, {"lowerIsBetter": false, "replicates": [319.4633016532226, 327.0988426883936, 331.5838622528727, 333.9532465454835, 338.29296769751215, 6561.081448597194, 6575.6712164391765, 6580.1445812044485, 6684.4986626003, 6706.966465167668, 5316.255724198606, 6313.210848643919, 6332.765110803383, 6488.545801793876, 6629.105070815439, 3881.5536213335404, 4508.977455112737, 4840.370751802269, 4850.9029819403595, 4895.0, 4869.756512174395, 4870.342503761982, 4871.780769865347, 4889.951100489003, 4896.926546101811, 4616.653750968674, 4667.649926255527, 4725.432948046222, 4736.052789442108, 4821.686590371614, 4475.418195634579, 4689.296605509184, 4715.669903106784, 4750.738709370983, 4806.75966201692, 4143.606357396073, 4145.129522800215, 4149.398337241083, 4150.086980864236, 4157.438745769313, 6155.907661385083, 6255.499560035186, 6269.529785266123, 6280.15217945576, 6281.842953926189, 5607.355154157242, 5717.514011309044, 5740.425957404226, 5744.0, 5747.885042299173, 6991.545549539263, 7029.297070292981, 7049.400800931927, 7053.576785392842, 7066.434685225169, 4664.72011679297, 4668.276417155346, 4668.276417155346, 4683.906321873544, 4693.366395536593, 6751.25736169021, 7437.442191835634, 7476.1776204617445, 7478.0, 7499.4000479962015, 3712.7586706863967, 4757.904841903142, 4766.428028636586, 4769.642276829182, 4789.95210047902, 4830.2513110467935, 4850.223964165716, 4852.296417019583, 4856.4415092264135, 4866.756662166948, 4654.185517534418, 5701.743421546041, 5707.971460142673, 5708.57185711065, 5714.457126573052, 6814.284500127515, 7094.0, 7118.608476533736, 7121.537100088478, 7142.142942846892, 1410.964725881861, 1665.8167601563819, 1688.9071101089312, 1689.8225686303008, 1690.0, 1007.9848802267971, 1085.2403317677656, 1085.7448499602588, 1098.357460885391, 1109.916756243285, 5175.741212939338, 6474.4496717778575, 6502.837429064217, 6652.634105124264, 6669.966650166718, 5970.253718285215, 7352.338289553966, 7416.295451932057, 7419.85160296791, 7443.144038435541, 6374.458171055512, 6586.3742944421165, 6617.8014659560295, 6633.568818026909, 6640.966795165993, 3356.278400143981, 3782.6973842092566, 3872.7095467840027, 3898.6686131678557, 3902.551206611219, 6786.083878676414, 7131.89302160468, 7724.806879827936, 7728.806779830549, 7741.767746967487, 7259.274072592699, 7528.548287102792, 7641.312281894656, 7645.5794931279315, 7647.502912310793, 7560.848783024308, 7591.696332146763, 7865.213478652089, 7896.881546776803, 7900.525968441912, 6410.0705397718, 6935.410490108397, 7368.152662443673, 7372.668229929774, 7384.593847338448, 7064.187618423947, 7259.056322678018, 7339.74310899116, 7340.889886651597, 7354.448416368687, 7738.110117336579, 7741.612919354123, 7751.224877512203, 7761.72833950809, 7778.0, 4003.279409706281, 4618.907621847611, 4656.41794775653, 4658.068386322817, 4673.275642275453, 5929.940700593112, 7116.323949224816, 7328.083989501312, 7367.226441223809, 7375.704971801068, 5745.368009519033, 6687.933120668731, 7110.0, 7124.25195354501, 7125.857482850418, 6241.594296370721, 6644.700988455627, 6815.795526134224, 7087.787366379017, 7106.786796396116, 6621.602703837785, 6921.861562768817, 6925.376716095374, 6935.375816176568, 6938.722451101899, 6316.368363163647, 6426.325235850355, 6927.0, 6980.267071957372, 7004.754833580801, 6831.45348372139, 6862.936244882051, 6863.313668633096, 6872.10662613857, 6909.0], "unit": "score", "name": "prototype.html", "value": 5112.164168950966}, {"lowerIsBetter": false, "replicates": [722.5195245161964, 727.9599622020787, 737.8007937856777, 744.836136050069, 775.7168633448786, 17281.913590432046, 17513.29946802128, 17525.64948701025, 17565.0, 17570.29718811246, 15771.921140394283, 15823.208839558034, 15837.0, 15856.445024424147, 15890.0, 693.272064332449, 702.2766550453042, 846.2468403121227, 862.1120246146448, 865.8398196333699, 699.7201119552194, 851.8168593752342, 864.6887120636566, 864.7492227254089, 865.8571335729597, 897.7620930453403, 916.0427353415697, 917.1287277086761, 918.6509126531942, 921.4793641592512, 714.6819665248967, 720.7585458871284, 724.1672077111364, 908.6183802802806, 910.008091180613, 534.0947094674528, 536.4796147736689, 537.844025232682, 653.3727621483382, 664.8238216872533, 12311.0, 15141.242937853063, 15145.242737863064, 15150.54548363551, 15182.089074655556, 12300.938495307555, 12336.5065397384, 12413.813792793115, 12568.434420451102, 12613.621591352274, 10135.949320253352, 10187.745306367326, 10199.643012494602, 10224.488775561267, 10918.1811364148, 3424.9143771405666, 3473.3053389322235, 3473.7915725056578, 3532.2935412917263, 3663.5970043295215, 74217.62891185563, 74608.50782984364, 75184.0, 80068.19931800666, 81013.0, 9256.120668536478, 9268.351215414856, 9321.580528876217, 9586.520673966274, 9893.148023612132, 20058.699119513218, 20305.492362690755, 20309.79690203079, 20332.186712531333, 20350.491237718878, 6626.900596491057, 7493.138289096714, 7622.123455802543, 7647.732329368446, 7661.080670319598, 4005.339119045383, 4069.3895915612893, 4134.193832202752, 4144.5026596808575, 4149.937750933738, 3499.4051011327624, 3553.076200187918, 3553.6446355364774, 3555.5733312002726, 3555.715542756573, 647.4011539326199, 653.0563335979559, 664.2162248546665, 671.1275342055407, 675.587891386254, 526.1292560811862, 545.2176127257399, 562.7328207973366, 609.920710307666, 615.6336979497192, 8940.73177804667, 9213.30900182489, 9214.769630759285, 9236.72289831306, 9257.49083800384, 499.41568365013023, 528.8523903130217, 566.1479473392518, 616.5252755378334, 635.7425242776683, 3803.923921521554, 3830.674392676598, 3831.214601006787, 3922.0783115967724, 4076.490438695163, 89358.10641893499, 91530.62704059311, 92076.15847683008, 92137.0, 95566.56650150253, 55674.443255567734, 77647.83528247081, 78075.0, 78996.0, 79123.20876791273, 49719.0, 69957.65021174963, 70152.2984770156, 70933.645331773, 73864.89202661964, 6922.757703480354, 7533.660985255567, 7897.565633890191, 7970.641321140447, 8190.877136842833, 46884.7655761719, 48618.5138148614, 49124.0, 49716.0, 49891.75054124851, 68935.3106468949, 69056.309436907, 69421.0, 69791.0, 71286.64356678183, 8778.91221087781, 10840.67477975662, 10877.564897404016, 10908.34549927007, 11379.658610241706, 11716.41417929083, 11724.237924534878, 12317.445714943029, 12344.691382715504, 12642.178258413174, 10915.0, 11234.932681395254, 11592.072634189413, 11595.826062609236, 12303.69240768988, 11143.16426268017, 11347.886521135013, 11369.54521819118, 11729.706757331134, 12346.567870124503, 10731.356118632906, 10736.463176841284, 10813.51339189754, 10828.458577071273, 11315.98156165949, 8787.472751634923, 9024.097590241186, 9093.818123637358, 9111.589978451118, 9427.104425079606, 7480.812979675552, 8263.95868020656, 8333.541655209021, 8660.35047371437, 9346.859797102912], "unit": "score", "name": "yui.html", "value": 6771.144382967173}], "name": "dromaeo_css", "value": 7444.983420879976}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 110.0, 109.0, 111.0, 114.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 145.0, 155.0, 120.0, 149.0, 136.0, 118.0, 168.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.9}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 187.0, 187.0, 186.0, 189.0, 183.0, 186.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [79.0, 79.0, 83.0, 76.0, 56.0, 58.0, 57.0, 80.0, 76.0, 59.0], "unit": "score", "name": "audio-fft", "value": 70.3}, {"lowerIsBetter": true, "replicates": [90.0, 94.0, 131.0, 79.0, 80.0, 81.0, 110.0, 76.0, 78.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [86.0, 90.0, 84.0, 90.0, 84.0, 88.0, 84.0, 89.0, 84.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.7}, {"lowerIsBetter": true, "replicates": [121.0, 94.0, 94.0, 95.0, 94.0, 93.0, 93.0, 93.0, 110.0, 126.0], "unit": "score", "name": "imaging-darkroom", "value": 101.3}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 86.0, 86.0, 89.0, 88.0, 86.0, 89.0, 88.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 87.5}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 57.0, 54.0, 55.0, 54.0, 55.0, 65.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 79.0, 73.0, 70.0, 67.0, 65.0, 66.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 81.0, 83.0, 82.0, 82.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [127.0, 121.0, 126.0, 129.0, 120.0, 120.0, 119.0, 123.0, 118.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.7}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 139.0, 137.0, 137.0, 127.0, 139.0, 137.0, 136.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1404.3}]} 03:14:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1404.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7444.98"}}} 03:14:03 INFO - Return code: 0 03:14:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:14:03 INFO - # TBPL SUCCESS # 03:14:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:14:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:14:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:14:03 INFO - 2016-02-04 03:14:03.316 screenresolution[1695:10765] starting screenresolution argv=screenresolution get 03:14:03 INFO - 2016-02-04 03:14:03.319 screenresolution[1695:10765] Display 0: 1600x1200x32@60 03:14:03 INFO - 2016-02-04 03:14:03.324 screenresolution[1696:10768] starting screenresolution argv=screenresolution list 03:14:03 INFO - Available Modes on Display 0 03:14:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:14:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:14:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:14:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:14:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:14:03 INFO - Intel Iris: 03:14:03 INFO - Chipset Model: Intel Iris 03:14:03 INFO - Type: GPU 03:14:03 INFO - Bus: Built-In 03:14:03 INFO - VRAM (Dynamic, Max): 1536 MB 03:14:03 INFO - Vendor: Intel (0x8086) 03:14:03 INFO - Device ID: 0x0a2e 03:14:03 INFO - Revision ID: 0x0009 03:14:03 INFO - Displays: 03:14:03 INFO - Display: 03:14:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:14:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:14:03 INFO - Display Serial Number: 1600x1200 60 03:14:03 INFO - Main Display: Yes 03:14:03 INFO - Mirror: Off 03:14:03 INFO - Online: Yes 03:14:03 INFO - Rotation: Supported 03:14:03 INFO - Return code: 0 03:14:03 INFO - Running post-action listener: _resource_record_post_action 03:14:03 INFO - Running post-run listener: _resource_record_post_run 03:14:04 INFO - Total resource usage - Wall time: 1208s; CPU: 52.0%; Read bytes: 33824256; Write bytes: 712048640; Read time: 351; Write time: 2241 03:14:04 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403997184; Write bytes: 406771712; Read time: 30435; Write time: 871 03:14:04 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 32042496; Write bytes: 303736832; Read time: 333; Write time: 1367 03:14:04 INFO - Running post-run listener: _upload_blobber_files 03:14:04 INFO - Blob upload gear active. 03:14:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:14:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:14:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:14:06 INFO - (blobuploader) - INFO - Done attempting. 03:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:14:07 INFO - (blobuploader) - INFO - Done attempting. 03:14:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:14:07 INFO - Return code: 0 03:14:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:14:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:14:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc49b75d1422cd555ef37326677c803b68cb75eb34253ad5788a1282aff620d323e619d516eddec91776bc91083b474d19e4104e2c0344ddb5dd5d60ea602e49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e2dc32539a011f1f6825e6bb924752737e0f9aec54663753fd67dc971171128ed9b52b6e321649f8402ce8fee4e98d40681dc0883f0241e659c09b4f1ea4f86"} 03:14:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:14:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:14:07 INFO - Contents: 03:14:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc49b75d1422cd555ef37326677c803b68cb75eb34253ad5788a1282aff620d323e619d516eddec91776bc91083b474d19e4104e2c0344ddb5dd5d60ea602e49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e2dc32539a011f1f6825e6bb924752737e0f9aec54663753fd67dc971171128ed9b52b6e321649f8402ce8fee4e98d40681dc0883f0241e659c09b4f1ea4f86"} 03:14:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:14:07 INFO - Copying logs to upload dir... 03:14:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:14:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.097490 ========= master_lag: 1.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-02-04 03:14:08.891988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 03:14:08.895816) ========= 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.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc49b75d1422cd555ef37326677c803b68cb75eb34253ad5788a1282aff620d323e619d516eddec91776bc91083b474d19e4104e2c0344ddb5dd5d60ea602e49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e2dc32539a011f1f6825e6bb924752737e0f9aec54663753fd67dc971171128ed9b52b6e321649f8402ce8fee4e98d40681dc0883f0241e659c09b4f1ea4f86"} build_url:https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011149 build_url: 'https://queue.taskcluster.net/v1/task/dTwLUpdbRRm9Lp45k7FLwA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc49b75d1422cd555ef37326677c803b68cb75eb34253ad5788a1282aff620d323e619d516eddec91776bc91083b474d19e4104e2c0344ddb5dd5d60ea602e49", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e2dc32539a011f1f6825e6bb924752737e0f9aec54663753fd67dc971171128ed9b52b6e321649f8402ce8fee4e98d40681dc0883f0241e659c09b4f1ea4f86"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 03:14:08.928759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 03:14:08.929089) ========= 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.caFaFk9PY5/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.GKPdemXnTQ/Listeners TMPDIR=/var/folders/4t/8gw461qn3ds6ckqrrr1_mkzc00000w/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.004808 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 03:14:08.977239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 03:14:08.980606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 03:14:08.981228) ========= ========= Total master_lag: 2.33 =========