builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0100 starttime: 1454762318.24 results: success (0) buildid: 20160206043836 builduid: 3abbbabdfede486b8ebb3fdd09da05e9 revision: 46d6d868ba0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.235962) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.236375) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.236709) ========= 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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005571 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.280519) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.280829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.303294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.303619) ========= 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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005466 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.353112) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.353454) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.353870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.354188) ========= 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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-06 04:38:38-- 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% 8.35M=0.001s 2016-02-06 04:38:38 (8.35 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.414832 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:39.010539) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:39.010872) ========= 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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.019409 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:39.047735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-06 04:38:39.048113) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46d6d868ba0f --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 46d6d868ba0f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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-06 04:38:39,129 Setting DEBUG logging. 2016-02-06 04:38:39,129 attempt 1/10 2016-02-06 04:38:39,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46d6d868ba0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:38:39,984 unpacking tar archive at: fx-team-46d6d868ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.104964 ========= master_lag: 3.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-06 04:38:43.367708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.369143) ========= echo 46d6d868ba0f in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'46d6d868ba0f'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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 46d6d868ba0f program finished with exit code 0 elapsedTime=0.005340 script_repo_revision: '46d6d868ba0f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.425558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.425894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.755024) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-02-06 04:38:43.755316) ========= /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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:38:43 INFO - MultiFileLogger online at 20160206 04:38:43 in /builds/slave/test 04:38:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:38:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:38:43 INFO - {'append_to_log': False, 04:38:43 INFO - 'base_work_dir': '/builds/slave/test', 04:38:43 INFO - 'blob_upload_branch': 'Fx-Team', 04:38:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:38:43 INFO - 'branch': 'Fx-Team', 04:38:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:38:43 INFO - 'config_files': ('talos/mac_config.py',), 04:38:43 INFO - 'default_actions': ('clobber', 04:38:43 INFO - 'read-buildbot-config', 04:38:43 INFO - 'download-and-extract', 04:38:43 INFO - 'populate-webroot', 04:38:43 INFO - 'create-virtualenv', 04:38:43 INFO - 'install', 04:38:43 INFO - 'run-tests'), 04:38:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:38:43 INFO - 'download_minidump_stackwalk': True, 04:38:43 INFO - 'download_symbols': 'ondemand', 04:38:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:38:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:38:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:38:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:38:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:38:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:38:43 INFO - 'installer_path': 'installer.exe', 04:38:43 INFO - 'log_level': 'info', 04:38:43 INFO - 'log_name': 'talos', 04:38:43 INFO - 'log_to_console': True, 04:38:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:38:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:38:43 INFO - 'opt_config_files': (), 04:38:43 INFO - 'pip_index': False, 04:38:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:43 INFO - 'cmd': ('bash', 04:38:43 INFO - '-c', 04:38:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:43 INFO - 'enabled': True, 04:38:43 INFO - 'halt_on_failure': False, 04:38:43 INFO - 'name': 'check_screen_resolution'},), 04:38:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:38:43 INFO - 'cmd': ('bash', 04:38:43 INFO - '-c', 04:38:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:38:43 INFO - 'enabled': True, 04:38:43 INFO - 'halt_on_failure': False, 04:38:43 INFO - 'name': 'check_screen_resolution'},), 04:38:43 INFO - 'run_cmd_checks_enabled': True, 04:38:43 INFO - 'sps_profile': False, 04:38:43 INFO - 'sps_profile_interval': 0, 04:38:43 INFO - 'suite': 'dromaeojs', 04:38:43 INFO - 'system_bits': '32', 04:38:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:38:43 INFO - 'title': 't-yosemite-r7-0100', 04:38:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:38:43 INFO - 'use_talos_json': True, 04:38:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:38:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:38:43 INFO - 'work_dir': 'build'} 04:38:43 INFO - ##### 04:38:43 INFO - ##### Running clobber step. 04:38:43 INFO - ##### 04:38:43 INFO - Running pre-action listener: _resource_record_pre_action 04:38:43 INFO - Running main action method: clobber 04:38:43 INFO - rmtree: /builds/slave/test/build 04:38:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:38:45 INFO - Running post-action listener: _resource_record_post_action 04:38:45 INFO - ##### 04:38:45 INFO - ##### Running read-buildbot-config step. 04:38:45 INFO - ##### 04:38:45 INFO - Running pre-action listener: _resource_record_pre_action 04:38:45 INFO - Running main action method: read_buildbot_config 04:38:45 INFO - Using buildbot properties: 04:38:45 INFO - { 04:38:45 INFO - "project": "", 04:38:45 INFO - "product": "firefox", 04:38:45 INFO - "script_repo_revision": "production", 04:38:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:38:45 INFO - "repository": "", 04:38:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:38:45 INFO - "buildid": "20160206043836", 04:38:45 INFO - "stage_platform": "macosx64", 04:38:45 INFO - "basedir": "/builds/slave/test", 04:38:45 INFO - "buildnumber": 299, 04:38:45 INFO - "platform": "yosemite_r7", 04:38:45 INFO - "mozci_request": { 04:38:45 INFO - "priority": -1, 04:38:45 INFO - "type": "trigger_all_talos_jobs", 04:38:45 INFO - "times": 6 04:38:45 INFO - }, 04:38:45 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:38:45 INFO - "slavebuilddir": "test", 04:38:45 INFO - "branch": "fx-team", 04:38:45 INFO - "revision": "46d6d868ba0f", 04:38:45 INFO - "slavename": "t-yosemite-r7-0100", 04:38:45 INFO - "builduid": "3abbbabdfede486b8ebb3fdd09da05e9", 04:38:45 INFO - "repo_path": "integration/fx-team" 04:38:45 INFO - } 04:38:45 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg. 04:38:45 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json. 04:38:45 INFO - Running post-action listener: _resource_record_post_action 04:38:45 INFO - ##### 04:38:45 INFO - ##### Running download-and-extract step. 04:38:45 INFO - ##### 04:38:45 INFO - Running pre-action listener: _resource_record_pre_action 04:38:45 INFO - Running main action method: download_and_extract 04:38:45 INFO - mkdir: /builds/slave/test/build/tests 04:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json 04:38:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json to /builds/slave/test/build/test_packages.json 04:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:38:45 INFO - Downloaded 1277 bytes. 04:38:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:38:45 INFO - Using the following test package requirements: 04:38:45 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:45 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:38:45 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:38:45 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'jsshell-mac.zip'], 04:38:45 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:38:45 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:45 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:38:45 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:38:45 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:38:45 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:38:45 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:38:45 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:38:45 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:45 INFO - Downloaded 17118689 bytes. 04:38:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:49 INFO - Return code: 0 04:38:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:49 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:38:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:38:49 INFO - Downloaded 17118689 bytes. 04:38:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:38:53 INFO - Return code: 0 04:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip 04:38:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:38:53 INFO - Downloaded 10706582 bytes. 04:38:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:38:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:38:53 INFO - Return code: 0 04:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:38:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:39:07 INFO - Downloaded 111104284 bytes. 04:39:07 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:07 INFO - mkdir: /builds/slave/test/properties 04:39:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:07 INFO - Contents: 04:39:07 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:07 INFO - Running post-action listener: _resource_record_post_action 04:39:07 INFO - Running post-action listener: set_extra_try_arguments 04:39:07 INFO - ##### 04:39:07 INFO - ##### Running populate-webroot step. 04:39:07 INFO - ##### 04:39:07 INFO - Running pre-action listener: _resource_record_pre_action 04:39:07 INFO - Running main action method: populate_webroot 04:39:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:07 INFO - '--tppagecycles', 04:39:07 INFO - '7'], 04:39:07 INFO - 'tests': ['tsvgm']}}, 04:39:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'tests': ['damp', 'tps']}, 04:39:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['damp', 'tps']}, 04:39:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:07 INFO - 'other': {'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other_l64': {'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:07 INFO - 'ts_paint', 04:39:07 INFO - 'tpaint', 04:39:07 INFO - 'sessionrestore', 04:39:07 INFO - 'sessionrestore_no_auto_restore']}, 04:39:07 INFO - 'svgr': {'tests': ['tsvgx', 04:39:07 INFO - 'tsvgr_opacity', 04:39:07 INFO - 'tart', 04:39:07 INFO - 'tscrollx', 04:39:07 INFO - 'cart']}, 04:39:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tsvgx', 04:39:07 INFO - 'tsvgr_opacity', 04:39:07 INFO - 'tart', 04:39:07 INFO - 'tscrollx', 04:39:07 INFO - 'cart']}, 04:39:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'tests': ['tp5o']}, 04:39:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s'], 04:39:07 INFO - 'tests': ['tp5o']}, 04:39:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--xperf_path', 04:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:07 INFO - 'tests': ['tp5n']}, 04:39:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:07 INFO - 'talos_options': ['--e10s', 04:39:07 INFO - '--xperf_path', 04:39:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:07 INFO - 'tests': ['tp5n']}}, 04:39:07 INFO - 'talos.zip': {'path': '', 04:39:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:07 INFO - Running post-action listener: _resource_record_post_action 04:39:07 INFO - ##### 04:39:07 INFO - ##### Running create-virtualenv step. 04:39:07 INFO - ##### 04:39:07 INFO - Running pre-action listener: _resource_record_pre_action 04:39:07 INFO - Running main action method: create_virtualenv 04:39:07 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:39:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:07 INFO - Using real prefix '/tools/python27' 04:39:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:11 INFO - Installing pip.................done. 04:39:11 INFO - Return code: 0 04:39:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:11 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:11 INFO - 'HOME': '/Users/cltbld', 04:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:11 INFO - 'LOGNAME': 'cltbld', 04:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:11 INFO - 'MOZ_NO_REMOTE': '1', 04:39:11 INFO - 'NO_EM_RESTART': '1', 04:39:11 INFO - 'PAGER': '/bin/cat', 04:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:11 INFO - 'PWD': '/builds/slave/test', 04:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:11 INFO - 'SHELL': '/bin/bash', 04:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:11 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:11 INFO - 'USER': 'cltbld', 04:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:11 INFO - 'XPC_FLAGS': '0x0', 04:39:11 INFO - 'XPC_SERVICE_NAME': '0', 04:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:39:11 INFO - Cleaning up... 04:39:11 INFO - Return code: 0 04:39:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:11 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:11 INFO - 'HOME': '/Users/cltbld', 04:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:11 INFO - 'LOGNAME': 'cltbld', 04:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:11 INFO - 'MOZ_NO_REMOTE': '1', 04:39:11 INFO - 'NO_EM_RESTART': '1', 04:39:11 INFO - 'PAGER': '/bin/cat', 04:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:11 INFO - 'PWD': '/builds/slave/test', 04:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:11 INFO - 'SHELL': '/bin/bash', 04:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:11 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:11 INFO - 'USER': 'cltbld', 04:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:11 INFO - 'XPC_FLAGS': '0x0', 04:39:11 INFO - 'XPC_SERVICE_NAME': '0', 04:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:11 INFO - Downloading/unpacking psutil>=0.7.1 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:15 INFO - Installing collected packages: psutil 04:39:15 INFO - Running setup.py install for psutil 04:39:15 INFO - building 'psutil._psutil_osx' extension 04:39:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:39:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:39:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:39:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:39:16 INFO - building 'psutil._psutil_posix' extension 04:39:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:39:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:16 INFO - ^ 04:39:16 INFO - 1 warning generated. 04:39:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:39:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:16 INFO - Successfully installed psutil 04:39:16 INFO - Cleaning up... 04:39:16 INFO - Return code: 0 04:39:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:16 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:16 INFO - 'HOME': '/Users/cltbld', 04:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:16 INFO - 'LOGNAME': 'cltbld', 04:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:16 INFO - 'MOZ_NO_REMOTE': '1', 04:39:16 INFO - 'NO_EM_RESTART': '1', 04:39:16 INFO - 'PAGER': '/bin/cat', 04:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:16 INFO - 'PWD': '/builds/slave/test', 04:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:16 INFO - 'SHELL': '/bin/bash', 04:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:16 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:16 INFO - 'USER': 'cltbld', 04:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:16 INFO - 'XPC_FLAGS': '0x0', 04:39:16 INFO - 'XPC_SERVICE_NAME': '0', 04:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:39:19 INFO - Installing collected packages: mozsystemmonitor 04:39:19 INFO - Running setup.py install for mozsystemmonitor 04:39:19 INFO - Successfully installed mozsystemmonitor 04:39:19 INFO - Cleaning up... 04:39:19 INFO - Return code: 0 04:39:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:19 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:19 INFO - 'HOME': '/Users/cltbld', 04:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:19 INFO - 'LOGNAME': 'cltbld', 04:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:19 INFO - 'MOZ_NO_REMOTE': '1', 04:39:19 INFO - 'NO_EM_RESTART': '1', 04:39:19 INFO - 'PAGER': '/bin/cat', 04:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:19 INFO - 'PWD': '/builds/slave/test', 04:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:19 INFO - 'SHELL': '/bin/bash', 04:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:19 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:19 INFO - 'USER': 'cltbld', 04:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:19 INFO - 'XPC_FLAGS': '0x0', 04:39:19 INFO - 'XPC_SERVICE_NAME': '0', 04:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:19 INFO - Downloading/unpacking blobuploader==1.2.4 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:22 INFO - Downloading docopt-0.6.1.tar.gz 04:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:23 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:23 INFO - Running setup.py install for blobuploader 04:39:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:23 INFO - Running setup.py install for requests 04:39:23 INFO - Running setup.py install for docopt 04:39:23 INFO - Successfully installed blobuploader requests docopt 04:39:23 INFO - Cleaning up... 04:39:23 INFO - Return code: 0 04:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:23 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:23 INFO - 'HOME': '/Users/cltbld', 04:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:23 INFO - 'LOGNAME': 'cltbld', 04:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:23 INFO - 'MOZ_NO_REMOTE': '1', 04:39:23 INFO - 'NO_EM_RESTART': '1', 04:39:23 INFO - 'PAGER': '/bin/cat', 04:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:23 INFO - 'PWD': '/builds/slave/test', 04:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:23 INFO - 'SHELL': '/bin/bash', 04:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:23 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:23 INFO - 'USER': 'cltbld', 04:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:23 INFO - 'XPC_FLAGS': '0x0', 04:39:23 INFO - 'XPC_SERVICE_NAME': '0', 04:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-wLd0ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-ft7jG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-8gWehm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-E45K9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-xamIuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-n5iog5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nadp4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:24 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-esz4Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-flxWvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-iSuU6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-LAxOp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-uCmoYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-tm5Xut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-SdQbhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-WWbwiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Uc5hEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:25 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-qaqK0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:26 INFO - Running setup.py install for manifestparser 04:39:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozcrash 04:39:26 INFO - Running setup.py install for mozdebug 04:39:26 INFO - Running setup.py install for mozdevice 04:39:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozfile 04:39:26 INFO - Running setup.py install for mozhttpd 04:39:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:26 INFO - Running setup.py install for mozinfo 04:39:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozInstall 04:39:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozleak 04:39:27 INFO - Running setup.py install for mozlog 04:39:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for moznetwork 04:39:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Running setup.py install for mozprocess 04:39:27 INFO - Running setup.py install for mozprofile 04:39:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for mozrunner 04:39:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Running setup.py install for mozscreenshot 04:39:28 INFO - Running setup.py install for moztest 04:39:28 INFO - Running setup.py install for mozversion 04:39:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:28 INFO - Cleaning up... 04:39:28 INFO - Return code: 0 04:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:28 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:28 INFO - 'HOME': '/Users/cltbld', 04:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:28 INFO - 'LOGNAME': 'cltbld', 04:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:28 INFO - 'MOZ_NO_REMOTE': '1', 04:39:28 INFO - 'NO_EM_RESTART': '1', 04:39:28 INFO - 'PAGER': '/bin/cat', 04:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:28 INFO - 'PWD': '/builds/slave/test', 04:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:28 INFO - 'SHELL': '/bin/bash', 04:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:28 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:28 INFO - 'USER': 'cltbld', 04:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:28 INFO - 'XPC_FLAGS': '0x0', 04:39:28 INFO - 'XPC_SERVICE_NAME': '0', 04:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:28 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-TxvzSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nrkiKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-cWEC07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-RbOhLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-nmT1jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-u_TCH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-d1NMhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-JQ0ukr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Qkl6Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-uWDN7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:29 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-7w2BOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-Y3ckaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-aGeOS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-KHeHge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-XlUKqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-avS2pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:39:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:30 INFO - Running setup.py (path:/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/pip-hb5OqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:39:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39: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 04:39:32 INFO - Downloading blessings-1.6.tar.gz 04:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:33 INFO - Installing collected packages: blessings 04:39:33 INFO - Running setup.py install for blessings 04:39:33 INFO - Successfully installed blessings 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:33 INFO - Reading from file tmpfile_stdout 04:39:33 INFO - Current package versions: 04:39:33 INFO - blessings == 1.6 04:39:33 INFO - blobuploader == 1.2.4 04:39:33 INFO - docopt == 0.6.1 04:39:33 INFO - manifestparser == 1.1 04:39:33 INFO - mozInstall == 1.12 04:39:33 INFO - mozcrash == 0.16 04:39:33 INFO - mozdebug == 0.1 04:39:33 INFO - mozdevice == 0.48 04:39:33 INFO - mozfile == 1.2 04:39:33 INFO - mozhttpd == 0.7 04:39:33 INFO - mozinfo == 0.9 04:39:33 INFO - mozleak == 0.1 04:39:33 INFO - mozlog == 3.1 04:39:33 INFO - moznetwork == 0.27 04:39:33 INFO - mozprocess == 0.22 04:39:33 INFO - mozprofile == 0.28 04:39:33 INFO - mozrunner == 6.11 04:39:33 INFO - mozscreenshot == 0.1 04:39:33 INFO - mozsystemmonitor == 0.0 04:39:33 INFO - moztest == 0.7 04:39:33 INFO - mozversion == 1.4 04:39:33 INFO - psutil == 3.1.1 04:39:33 INFO - requests == 1.2.3 04:39:33 INFO - wsgiref == 0.1.2 04:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:33 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 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:39:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:33 INFO - 'HOME': '/Users/cltbld', 04:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:33 INFO - 'LOGNAME': 'cltbld', 04:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:33 INFO - 'MOZ_NO_REMOTE': '1', 04:39:33 INFO - 'NO_EM_RESTART': '1', 04:39:33 INFO - 'PAGER': '/bin/cat', 04:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:33 INFO - 'PWD': '/builds/slave/test', 04:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:33 INFO - 'SHELL': '/bin/bash', 04:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:33 INFO - 'USER': 'cltbld', 04:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:33 INFO - 'XPC_FLAGS': '0x0', 04:39:33 INFO - 'XPC_SERVICE_NAME': '0', 04:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:34 INFO - Downloading/unpacking jsonschema 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:36 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:36 INFO - warning: no files found matching '*.txt' 04:39:36 INFO - no previously-included directories found matching 'build' 04:39:36 INFO - no previously-included directories found matching 'dist' 04:39:36 INFO - no previously-included directories found matching '.git*' 04:39:36 INFO - Installing collected packages: jsonschema, functools32 04:39:36 INFO - Running setup.py install for functools32 04:39:37 INFO - warning: no files found matching '*.txt' 04:39:37 INFO - no previously-included directories found matching 'build' 04:39:37 INFO - no previously-included directories found matching 'dist' 04:39:37 INFO - no previously-included directories found matching '.git*' 04:39:37 INFO - Successfully installed jsonschema functools32 04:39:37 INFO - Cleaning up... 04:39:37 INFO - Return code: 0 04:39:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e093a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e09a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f920b578e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, '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.P0UpZfK4LL/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.vfr8onxcEm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:39:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:39:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:37 INFO - 'HOME': '/Users/cltbld', 04:39:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:37 INFO - 'LOGNAME': 'cltbld', 04:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:37 INFO - 'MOZ_NO_REMOTE': '1', 04:39:37 INFO - 'NO_EM_RESTART': '1', 04:39:37 INFO - 'PAGER': '/bin/cat', 04:39:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:37 INFO - 'PWD': '/builds/slave/test', 04:39:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:37 INFO - 'SHELL': '/bin/bash', 04:39:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:39:37 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:39:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:37 INFO - 'USER': 'cltbld', 04:39:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:37 INFO - 'XPC_FLAGS': '0x0', 04:39:37 INFO - 'XPC_SERVICE_NAME': '0', 04:39:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:37 INFO - Downloading/unpacking flake8 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:39:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:39:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:41 INFO - no previously-included directories found matching 'docs/_build' 04:39:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:41 INFO - Running setup.py install for pep8 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:41 INFO - no previously-included directories found matching 'docs/_build' 04:39:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:41 INFO - Cleaning up... 04:39:41 INFO - Return code: 0 04:39:41 INFO - Running post-action listener: _resource_record_post_action 04:39:41 INFO - Running post-action listener: _start_resource_monitoring 04:39:41 INFO - Starting resource monitoring. 04:39:41 INFO - ##### 04:39:41 INFO - ##### Running install step. 04:39:41 INFO - ##### 04:39:41 INFO - Running pre-action listener: _resource_record_pre_action 04:39:41 INFO - Running main action method: install 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:41 INFO - Reading from file tmpfile_stdout 04:39:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:41 INFO - Reading from file tmpfile_stdout 04:39:41 INFO - Output received: 04:39:41 INFO - Usage: mozinstall [options] installer 04:39:41 INFO - Options: 04:39:41 INFO - -h, --help show this help message and exit 04:39:41 INFO - -d DEST, --destination=DEST 04:39:41 INFO - Directory to install application into. [default: 04:39:41 INFO - "/builds/slave/test"] 04:39:41 INFO - --app=APP Application being installed. [default: firefox] 04:39:41 INFO - mkdir: /builds/slave/test/build/application 04:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:40:15 INFO - Reading from file tmpfile_stdout 04:40:15 INFO - Output received: 04:40:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:15 INFO - Running post-action listener: _resource_record_post_action 04:40:15 INFO - ##### 04:40:15 INFO - ##### Running run-tests step. 04:40:15 INFO - ##### 04:40:15 INFO - Running pre-action listener: _resource_record_pre_action 04:40:15 INFO - Running main action method: run_tests 04:40:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:15 INFO - 2016-02-06 04:40:15.518 screenresolution[2334:22799] starting screenresolution argv=screenresolution get 04:40:15 INFO - 2016-02-06 04:40:15.521 screenresolution[2334:22799] Display 0: 1600x1200x32@60 04:40:15 INFO - 2016-02-06 04:40:15.527 screenresolution[2335:22801] starting screenresolution argv=screenresolution list 04:40:15 INFO - Available Modes on Display 0 04:40:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:15 INFO - Intel Iris: 04:40:15 INFO - Chipset Model: Intel Iris 04:40:15 INFO - Type: GPU 04:40:15 INFO - Bus: Built-In 04:40:15 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:15 INFO - Vendor: Intel (0x8086) 04:40:15 INFO - Device ID: 0x0a2e 04:40:15 INFO - Revision ID: 0x0009 04:40:15 INFO - Displays: 04:40:15 INFO - Display: 04:40:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:15 INFO - Display Serial Number: 1600x1200 60 04:40:15 INFO - Main Display: Yes 04:40:15 INFO - Mirror: Off 04:40:15 INFO - Online: Yes 04:40:15 INFO - Rotation: Supported 04:40:15 INFO - Return code: 0 04:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:15 INFO - Python 2.7.3 04:40:15 INFO - Return code: 0 04:40:15 INFO - grabbing minidump binary from tooltool 04:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:15 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 0x10df38d30>, '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 0x10dd5bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:40:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:40:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:15 INFO - Return code: 0 04:40:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:40:17 INFO - Return code: 0 04:40:17 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:40:17 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0100 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:40:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0UpZfK4LL/Render', 04:40:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:17 INFO - 'HOME': '/Users/cltbld', 04:40:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:17 INFO - 'LOGNAME': 'cltbld', 04:40:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:17 INFO - 'MOZ_NO_REMOTE': '1', 04:40:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:17 INFO - 'NO_EM_RESTART': '1', 04:40:17 INFO - 'PAGER': '/bin/cat', 04:40:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:17 INFO - 'PWD': '/builds/slave/test', 04:40:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:17 INFO - 'SHELL': '/bin/bash', 04:40:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vfr8onxcEm/Listeners', 04:40:17 INFO - 'TMPDIR': '/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/', 04:40:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:17 INFO - 'USER': 'cltbld', 04:40:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:17 INFO - 'XPC_FLAGS': '0x0', 04:40:17 INFO - 'XPC_SERVICE_NAME': '0', 04:40:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:17 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0100', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:40:17 INFO - mozversion application_buildid: 20160203075343 04:40:17 INFO - mozversion application_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:17 INFO - mozversion application_display_name: Nightly 04:40:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:17 INFO - mozversion application_name: Firefox 04:40:17 INFO - mozversion application_remotingname: firefox 04:40:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:40:17 INFO - mozversion application_vendor: Mozilla 04:40:17 INFO - mozversion application_version: 47.0a1 04:40:17 INFO - mozversion platform_buildid: 20160203075343 04:40:17 INFO - mozversion platform_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:40:17 INFO - mozversion platform_version: 47.0a1 04:40:17 INFO - using testdate: 1454762417 04:40:17 INFO - actual date: 1454762417 04:40:17 INFO - starting webserver on 'localhost:49823' 04:40:17 INFO - SUITE-START | Running 2 tests 04:40:17 INFO - TEST-START | dromaeo_css 04:40:17 INFO - operating with platform_type : mac_ 04:40:17 INFO - Initialising browser for dromaeo_css test... 04:40:17 INFO - TEST-INFO | started process 2353 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp6aOagP/profile http://localhost:49823/getInfo.html) 04:40:18 INFO - PROCESS | 2353 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:40:20 INFO - PROCESS | 2353 | __metrics Screen width/height:1600/1200 04:40:20 INFO - PROCESS | 2353 | colorDepth:24 04:40:20 INFO - PROCESS | 2353 | Browser inner width/height: 1024/689 04:40:20 INFO - PROCESS | 2353 | __metrics 04:40:20 INFO - PROCESS | 2353 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:40:20 INFO - PROCESS | 2353 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:20 INFO - TEST-INFO | 2353: exit 0 04:40:20 INFO - Browser initialized. 04:40:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:20 INFO - TEST-INFO | started process 2356 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmp6aOagP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:32 INFO - PROCESS | 2356 | RSS: Main: 242401280 04:40:32 INFO - PROCESS | 2356 | 04:41:28 INFO - PROCESS | 2356 | 1454762488005 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:43:34 INFO - PROCESS | 2356 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49823/tests/dromaeo/cssquery-ext.html) 04:43:36 INFO - PROCESS | 2356 | RSS: Main: 406069248 04:43:36 INFO - PROCESS | 2356 | 04:46:38 INFO - PROCESS | 2356 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-ext.html (next: http://localhost:49823/tests/dromaeo/cssquery-jquery.html) 04:46:39 INFO - PROCESS | 2356 | RSS: Main: 380858368 04:46:39 INFO - PROCESS | 2356 | 04:49:41 INFO - PROCESS | 2356 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49823/tests/dromaeo/cssquery-mootools.html) 04:49:42 INFO - PROCESS | 2356 | RSS: Main: 375771136 04:49:42 INFO - PROCESS | 2356 | 04:52:44 INFO - PROCESS | 2356 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49823/tests/dromaeo/cssquery-prototype.html) 04:52:45 INFO - PROCESS | 2356 | RSS: Main: 340549632 04:52:45 INFO - PROCESS | 2356 | 04:55:48 INFO - PROCESS | 2356 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49823/tests/dromaeo/cssquery-yui.html) 04:55:48 INFO - PROCESS | 2356 | RSS: Main: 340918272 04:55:48 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | Cycle 1(1): loaded http://localhost:49823/tests/dromaeo/cssquery-yui.html (next: http://localhost:49823/tests/dromaeo/cssquery-dojo.html) 04:58:51 INFO - PROCESS | 2356 | RSS: Main: 392839168 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | __start_tp_report 04:58:51 INFO - PROCESS | 2356 | _x_x_mozilla_page_load 04:58:51 INFO - PROCESS | 2356 | _x_x_mozilla_page_load_details 04:58:51 INFO - PROCESS | 2356 | |i|pagename|runs| 04:58:51 INFO - PROCESS | 2356 | |0;dojo.html;3365.276465559904;3422.5550678411787;3444.7933124012575;3468.7225021998233;3494.720422366211;5567.331920169585;5637.492625663689;5649;5677.659340439572;5685.033544297469;5573.052581061219;5620.016497113009;5636.4927156555905;5638.295213098363;5641.435856414357;5104.489551044893;5122.615803814729;5139.460356662553;5142.691438513682;5210.270562121306;5214.087534681435;5216.061109000379;5227.21591761237;5230.790768369279;5236.607254455912;5184.922226166592;5199.350081239845;5216.087184742674;5219.112750832349;5228.947710522903;5194.428612852565;5203.03743807393;5210.947890521084;5211.869703257411;5225.242339860737;5006.899862002776;5074.441811400743;5170.37955445349;5179.352580927384;5205.635605507616;5649.180868774046;5711.571632127607;5716.999525083135;5735.569832262597;5743.396943320933;6164.4143806338325;6182.412670796312;6189.845253868644;6193.1639228704;6206.751729930797;4583.152116858359;5725.3988331225455;6126.17296664949;6181.320054793969;6204.720787564525;5719.3136823581435;5733.512651424634;5764.13537969308;5807.738651760681;5824.650520968713;6235.469985051322;6237.532185086136;6238.781642642486;6257.43683068526;6259.937400626027;5863.413658634103;6023.548233882477;6042.093685947143;6044.7582096716515;6075.908861367083;6085.148079268906;6110.327863934964;6123.069106197231;6222.533310001768;6224.346443623445;6138.355472675394;6140.109684095781;6174.783882564088;6179.5056395488255;6183.443490085824;5682.516986056149;6178.41305076017;6180.8763824723255;6186.505079593621;6187.628742275388;4828.130936431476;4844.878878028077;4850.393700787402;4861.586765125004;4904.485029071968;4323.373110898902;4355.194289056535;4370.278903980808;4375.190589740908;4384.12317536494;5556.194351819045;5642.23829782974;5693.914591281134;5700.7719691212715;5747.8563035924435;6111.43980788641;6119.593952096689;6144.15675297409;6152.969235153795;6164.445199932027;5665.716714164275;5671.347795003545;5674;5676.829695109071;5709.800156994485;4619.584237418649;5252.290940722954;5294.12646913255;5299.6025298102795;5301.257823904656;6161.291451483047;6215.65813880241;6243.406876346739;6247.5939063960695;6257.405546473078;6120.416658368064;6212.689365531795;6234.220722409699;6239.407256310643;6248.781292654735;6169;6169.753209871555;6219.875602488016;6244.906326405198;6266.874662506815;6021.668808215591;6099.359567245553;6114.236541168587;6115.544587951936;6125.632462052291;6098.976888191913;6212.9068063979985;6217.09852071438;6232.594881332699;6235.781747638811;5996.430339117776;6041.18444010053;6058.273007238983;6059.338284000984;6084.178635884099;5825.70871456417;5918.496927761188;5975.671338076274;6029.668368239613;6056.121862330026;5844.970775146097;5859.824205273678;5912.142739302863;5926.348101708722;5958.6424814511265;6018.36807135262;6033.54748393881;6033.879322413615;6045.516358691206;6118.969405152946;5753.165790960371;5827.358990511125;5875.764969401176;5898.3216930053595;5904.645721256738 04:58:51 INFO - PROCESS | 2356 | |1;ext.html;470.289862307915;528.2762615217154;538.6453070527622;581.9495810062838;614.4469977020682;29436.558451623216;29807;36720.081997950096;37142.257154856954;37195.25609487809;40243.798781006124;40687;40702.59297407025;40734.59265407345;40843.183136337255;9341.11259430353;9544.475053872035;9545.618175273015;9547.23622110233;9564.378315409476;8578.828423431527;9246.26029917605;9375.437473751563;9473.526323683822;9511.524423778817;9564.80870382592;9648.421094734304;9668.226541876667;9677.467739274338;9678.75803104921;9535.38020028696;9639.951800241024;9641.228701703916;9645;9652.469114198717;9485.098915603006;9638.373505722177;9639.373440726331;9639.614415423375;9648.421094734338;38792.80603596992;39024.80487597544;39052;39103.60896391028;39175;3160.952585711216;3169.1443310306317;3300.372929143455;3320.00399880035;3564.679178873888;27369.589456157973;28351.574726378916;28945.565816512768;28955.855220723974;29127.854360728274;2582.793376529873;2695.4204845958016;2737.575675770259;2837.886484540616;2890.4508143452676;475063.2493675088;476093.6195319001;476732;477736;478289.9999999965;61107.694461527404;61685.38314616886;61698.69150654218;61815.76368472605;61826;65310;65330.02004969929;65391.67304163449;65409.34590654032;65491.017634735515;15881.364745410054;16379.91810040966;16380.508584742476;16407.671846563;16422.1788910554;12455.003599712001;12498.187617804995;12507.249565026128;12522.937385313015;12547.874521254671;18710.51543957015;19213;19262.903685481764;19278.807211927982;19444.319448819224;8405.70580029696;8623.31013518917;8629.093945135795;8642.95678521616;8679.17547832955;948.8054948735493;983.8130755156498;986.5166068626321;1034.234666346898;1039.0648416425279;28742.425151496853;29134.7086529132;29563.704362956527;29717.55423668647;29849.850750746107;948.5921053946869;997.9700608981742;1050.406520316019;1053.1311667874033;1070.9303895246785;13157.210567365797;15887.602809929844;16053.876228664116;16112.952658077187;16648.417305394254;514450;523795;525377;526226;526333;54945;55461.61345966383;62228;62523.6873815628;63602;1413.922234277104;1437.1664434627892;1455.52695374006;1456.3373664982407;1457.4097490516358;26245.504113019673;29546.688449795274;30769.153860766382;31212.219694507818;32101.197470063435;47694.761526192146;48354.274685880446;50354.244686330465;55312.44687553073;55966.440335596126;416348;421569;423801;425336;425548;32557.348853022333;32815.01554953355;32836;32856.83571582127;32949.67050329466;41135.58864411317;41716.95707607334;42312.78843605762;42767.572324276356;43782.56217437785;36001;36483.08792280108;37448.251034979694;37604.435933461566;38070.0482487929;36242.27515449729;36417.67188631674;36868.709595164044;37193.628063719014;37234.813825930694;36167.27665446729;37045.259094818495;37300.253994920495;37413.064673383386;37443.81278093592;31906.840465797522;32036;32160.35679286448;32255;33719.4942075874;21613.567728645023;24047.51904961926;24195.032198712557;24269.150579729623;24578.631320530563 04:58:51 INFO - PROCESS | 2356 | |2;jquery.html;329.2328873724223;358.731882794322;363.54375259049897;368.4068649474346;374.7320665724007;14527.418903243857;14924.403023879058;18489.630207395843;18526;19330.613387732235;15450.381984720625;18661.533461663465;18749.812501874978;19402.320918767848;19428.222871085174;5204.557612602924;5560.610757246995;5609.411011843759;5737.655740655574;5760.4815566599;4030.1133750574827;4275.572442755731;4282.978585107086;5084.957583695334;5626.127950167731;5855.860354107794;5940.316863560681;6198.907016394758;6201.720922558473;6205.689715514229;5406.91889621656;6254.3745625437095;6258.655773932432;6270.153529273535;6275.529335299825;5180.274761533388;5399.433059528771;5400.405955344909;5402.567794576425;5437.34751829779;23930;23961.88019059911;24019.039238430443;24243.7878106094;24371;2494.588392915167;2528.1783420388447;2655.123809142978;2900.1589539033866;2903.332233586287;14263.928680356636;14325.848313371042;14445.49440769568;14727.631809204748;14764;1619.6193894434798;1693.2211182855901;1703.2675949341779;1708.1544635405553;1712.3236321653003;88682.18438703043;88854;89264;90560;91563.62654560187;9573.90426095744;9630.951845240728;10098.495075246208;10300.433476158732;10495.527701253463;10533.157347412189;12603.117781755373;12679.619611411672;12714.300713460849;12719.300438475973;8304.96187976503;8310.54292013945;8326.750197494084;8390.496570205807;8410.411271211078;8490.066092729918;8501.489910605384;8510.021347544987;8581.65673373058;8611.784705382415;5150.304708864331;5995.190649262294;6104.420080092473;6114.694265286718;6119.2350956130485;1655.1724137931035;1730.1781653714636;1767.3195819609543;1773.219783295346;1819.6360727854483;411.42811492026107;411.9773412462283;893.5101116887562;1015.3451024089569;1022.3405903192399;9898.80202395948;10843.728906777395;11595.420228988516;11736.530538778354;11828.704282392837;389.94930659014716;414.5605658002527;446.941897553316;447.1548772819374;453.5487190245727;4677.859664210079;6100.267967843798;6104.511639068953;6142.877142457215;10538.789224215472;677322;714194;727301.7509766193;734516;736381;110240;112078.87921120848;113555.29667055001;113635;114454;1108.4568561405015;1146.2091157101572;1164.598213616301;1175.4064197580337;1177.8704342522315;17371.652566948338;17414.564635883697;17921.37275195414;17952.730709039635;17970.820291796914;45101;45626.77186614046;45719.77140114278;46424.767876160404;47666.52333476621;61217.38782612117;61452.385476144664;61690.38309617026;61991.76016479736;62073.758524830155;7465.4027677786735;7490.250974902466;7612.58130802789;7636.694532218871;7657.88513172314;4639.118567472169;9420.717378478383;10477.604033922384;11705.775902578484;12012.879871201525;9478.38390504615;9538.523073846418;10019.899801001897;10060.547275372479;10112.24158188124;9917.30578859473;9932.652357167464;10075.899241007495;10100.89899101029;10379.844302335621;7026;10061.496925153566;10075.848862266925;10165.695029149138;10377.792444151226;7304.744333948286;7405.185429602847;7485.288897554724;7506.624668766431;7515.549067055994;8480.703175389079;8647.697330593399;9635.036496350309;9968.900310997087;10288.176945844465 04:58:51 INFO - PROCESS | 2356 | |3;mootools.html;1405.3184205660248;1470.3530446603497;1543.6295289130608;1741.8780685352021;1947.7760057593373;8135.186481351861;8325.042620098682;8700.869486957692;8879.023307436193;8892.333075019367;8648.702694595813;8761.167689069543;8868.29053675706;8914;8975.551222438884;2186.5954798362272;2250.8311876609237;2510.8242423030397;2517.8615176165304;2546.0706842002674;2276.2943487518924;2278.8063014643694;2281.6007198740235;2283.942901427469;2422.2975337152207;2446.54738873309;2486.9005239790386;2487.452760392711;2490.8256422050463;2491.788198003172;2102.568973360457;2464.728879823227;2498.900043998238;2503;2514.911978080758;2420.165043060141;2469.715982661999;2484.7515248475006;2487.253823852837;2491.7757401833924;8767.386282960195;8925;8954.37319387643;8955.507447090407;8959.73120806377;5466.535344495723;5588.21764952907;5599.860003499904;5606.55147588192;5608.635438696512;3073.784835061547;3653.451982202664;3687.078230442389;3754.3617585010343;3763.9837243944257;1044.3577200022007;1052.2108418685987;1065.2383545764815;1078;1083.2471432354516;12382.690432739253;12384.938075309656;12411.93794031033;12414.937925310316;12434.937825310815;4933.432655244621;4974.552290293891;5058.064258112261;5074.949250507448;5084.313617661643;9239.891213054341;10258.333208341433;10482.580696772196;10496.895031049591;10504.317219380715;5586.497215250647;5621.887562248732;5622.57830662702;5629.831105066854;5630.042892708249;4963.677360971597;5087.440381558025;5091.719955402488;5102.795888164432;5162.638615296968;4013.2776100302226;4037.5356833963883;4049;4078.1028173801715;4079.347304431336;1202.4168278384977;1232.624049664843;1240.206267988488;1285.8328417305877;1307.9215247085206;1123.4326665034105;1135.3528488761326;1315.1254415813378;1362.9931850340686;1367.2616786935143;8222.301104406193;8272.503649781032;8338.207870252316;8343.332533397313;8350.123237060143;1196.36592605919;1203.434385838672;1205.4515195585986;1212.9575464858865;1230.889219970189;6310.558260921784;6317.842053948596;6382.266039405527;6388.297287298394;6389.8722025560155;10554.577816887391;11205.60780372683;11225.989660930556;11229.831552526719;11258.155638326994;10708.1433485321;11101;11102.777944441066;11120.22158448917;11191.44042797873;8227.71203007892;8327.750167494985;8343.998720153499;8438.57807109642;8451.492910425393;6835.965820170867;7944.086430060386;7989.041315042232;8227.547484888388;8229.218224268685;9259.53702314895;9480.099390557885;9617.663381781604;9638.518074096408;9672.419654820733;9729;10013.649522266685;10068.194544436281;10103.191744660262;10104.646337378157;7569.8107547309555;7570.318671319387;7617.923820761722;7670.117936437158;7716.614169291625;8355.832883342178;8407.285380742705;8427.620757065824;8446.915530844613;8450.915490845258;6531.216254049355;7701.075870895304;7748.147703752696;7784.805379865548;7857.057153141431;7566.167721550515;7599.316061554487;7685.884711729217;7755.806104847424;7840.803979900548;7755.72854950074;7800.804979875548;7876.448648594544;7879.606019698877;7880.448368614142;7081.468889833386;7111.7866464006165;7140.642967851482;7154.463415243774;7239.8914016290855;7280.67236974348;7335.816604584715;7340.376068034277;7348.338649521569;7351.70593176267 04:58:51 INFO - PROCESS | 2356 | |4;prototype.html;325.1448689945443;329.34131736526945;333.75635785876295;335.75657648205055;339.13858798651427;6516.511261655377;6526.934730652692;6588.538802283836;6653.902106152479;6749.426298764611;6545.574537655061;6554.41010309072;6743.393094621483;6751.662416879161;6765.357291057354;4932.383452068491;4941.184704523767;4943.431505376882;4947.752612369385;4953.851384458472;4684.36761037259;4703.541902010371;4800.231962885939;4953.6037117030555;4974.676646017997;4564.1328147652;4768.23708206687;4772.689775164603;4881;4928.97535512322;4664.930026049612;4861.319415281846;4867.51324867514;4868.975655121737;4876.97561512192;3666.2850744104912;4206.852760153411;4212.368144778277;4212.4523811904255;4219.725717828362;6088.269407671063;6282.434580887696;6296.055591661242;6303.464205542535;6325.0828629848875;5675;5683.374828768832;5736.713164341808;5740.425957404268;5748.683822389767;6998.510104292702;7006.509544331899;7013.47398945076;7028.683709233045;7043.7534686285735;4431.224535706238;4550.49944506104;4576.4508259009135;4674.182018146845;4696.225122854725;7254.310840470147;7358.852822943565;7385.852282954311;7451.254874512614;7477.140128885139;4768.3085952536685;4778.331033655291;4781.784819683123;4792.233242681224;4796.784144713496;4522.683412161117;4824.879378015507;4828.203346447867;4843.128236917389;4851.345068415719;5586;5589;5593.776248950077;5597.6641401516035;5606.299212598426;5717.942820571824;6409.391107844841;6709.530332876652;7075.080239568823;7093.255208203168;1604.2219523531078;1625.057466669329;1626.2763070433543;1629.0063061532455;1629.722947098996;1018.4500369800373;1034.2139973619953;1041.635427600349;1049.5959055763433;1061.7823346214007;6642.535022548375;6644.103046088716;6670.533062685566;6694.430973367221;6695.230048544479;5920.940790592039;7282.854342913218;7285.526440781332;7288.08898887639;7290.890636640454;6440.806775796734;6630.53586248958;6671.966640166768;6678.165229346332;6685.6322902240845;3855.9178043856564;3890.144168282973;3890.2025084857537;3892.4939757831867;3898.785566793797;7644.464887457936;7658.808529786688;7669.501482403626;7671.6164191790185;7675.15573286938;7285.744998925013;7536.924630753732;7547.471676982558;7575.128860181039;7596.126445458733;7672.539647621161;7675.347595454337;7677.11910581911;7677.347425468898;7678.040244969379;5887.646741195542;6458.741650334122;7268.818279543054;7291.781246562611;7291.817704557428;6452.451541619015;6796.592204467748;6878.825091106102;7172.246914074156;7177;6857.559912418248;7745;7763.223677632417;7768.844623107393;7794.649240784065;4368.301071828492;4633.791479383369;4633.976830115827;4645.001324715203;4660.46404663468;6661.300563440769;6954.374106330454;7226.963865180641;7231.4937954342695;7329.267073292842;7037.648117593997;7053.365197132078;7054.365107140382;7070.505064645426;7078.646067696697;7032.5077244592385;7037.437005039482;7052.717891284291;7054.717811287491;7064.894026589708;6600.306967768315;6922.273161317989;6926.445884329342;6927.965360173167;6946.6179360135675;7081.539699919489;7084.22073571917;7088.716451341888;7093.609851458219;7115.430765538848;6692.397684208445;6935.653217339213;6944.618046007518;6951;6955.652217389212 04:58:51 INFO - PROCESS | 2356 | |5;yui.html;658.1214079204262;670.1957650819019;731.8682637125319;750.962451877406;784.878343856702;14682;14693.485727999521;14844.109353438775;14857.182854942987;14877.925610371947;13523.729525409486;13702.794458083112;13708.040437169402;13717.108387954777;13751.793723094162;707.6780065070407;724.0008787872729;867.397158974513;887.2414085956511;891.3493150000503;728.5155371677828;749.5540153608595;870.7561882672861;893.530896279452;896.1979028769248;906.7461110888962;926.147943891618;926.8239034583441;929.502716046915;930.8743319651862;732.0446816903965;744.8622004929106;747.8055705516605;916.2074805293406;920.3281604428771;672.4250765595394;682.1847891769338;682.3517658224706;682.7166725808784;685.396850771323;14482.927585362111;14520.273986300643;14522.419103235858;14555.78166327506;14590.70818583633;12409.875901240963;12525.686857828627;12634.747305053848;12649.93675031619;12687.365631718469;10053.396796192252;10090.69727908164;10103.989601039912;10253.33353332031;10273;3527.6119626841028;3547.6452354764574;3554.306910152521;3562.9109272268142;3563.6970857477145;79160;80313.39373212503;80475.5976220121;81170;81231;9532.90467095334;9541.761455963517;9577.569009394594;9787.16809071237;9834.213262938947;21203.89398053;21216.469588260417;21228.150873964867;21241.893790530947;21261.574768504543;7305.5981920994855;7430.256974302634;7584.317411432998;7686.654100565376;7725.227477252342;4063.22798668258;4152.563980781974;4198.328267477189;4216.135692183095;4370.300751879684;3465.462853257749;3534.752567320263;3536.45184996326;3541.486484459739;3542.5040494330815;614.8800983808114;629.6536904702486;631.2393565753256;638.2755572425331;647.7927063339686;593.3769541980903;602.6600166251014;608.528390497368;623.0778447897137;624.2664868779166;8181.95909020463;8250.876236856451;8327.625256863455;8359.289460395934;8435.92955419926;497.6914313125885;551.931008623922;609.1958614628647;621.1521273461692;628.5819929746758;3966.603339666068;3971.940420893689;3982.4424580558743;4023.7183397162503;4035.3480100509087;87547.56226218956;87817.56091219503;88576.557117214;88634.55682721545;94377;70052.94920576195;80546.59726701329;81098.18901811025;81508.59245703853;82242;66763.33091672845;67510.32489675138;72037.79622037859;72158.55682886313;72885.2711472889;8215.383846211678;8574.957125214334;8695.521746304014;8783.429077109968;8789.516576588348;36642.63357366392;47941.56175314746;50718.23922641237;50719.74640126776;51190.97618047544;70115.94826077715;70489.29510705032;71665.6250781183;72021.27978720146;72457;10839.458027098455;10978.560857565608;11184.496697648463;11266.774664506827;11492;11991.580294689644;12091.81862272049;12254.193535526852;12416.255024698547;12660.683482913;11379.886201137882;11674.70813229676;11778;11987.820182697093;12022.63932082039;11105.111591072533;11292.719167905021;11441.542338306375;11710.4730287139;12395.93802030984;10990.725231869268;11139.665810025712;11389;11641.941790291334;12174.695632609255;9072.546372681207;9149.77125571866;9208.677696280598;9421.246300295823;9577.377470464398;8741.91258087411;9370.390924590152;9797.31418800677;9812.264080194156;9841.606335746776 04:58:51 INFO - PROCESS | 2356 | __end_tp_report 04:58:51 INFO - PROCESS | 2356 | __start_cc_report 04:58:51 INFO - PROCESS | 2356 | _x_x_mozilla_cycle_collect,1067 04:58:51 INFO - PROCESS | 2356 | __end_cc_report 04:58:51 INFO - PROCESS | 2356 | __startTimestamp1454763531949__endTimestamp 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | ------- Summary: start ------- 04:58:51 INFO - PROCESS | 2356 | Number of tests: 6 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | [#0] dojo.html Cycles:165 Average:5676.45 Median:5859.82 stddev:624.02 (10.6%) stddev-sans-first:599.02 04:58:51 INFO - PROCESS | 2356 | Values: 3365.3 3422.6 3444.8 3468.7 3494.7 5567.3 5637.5 5649.0 5677.7 5685.0 5573.1 5620.0 5636.5 5638.3 5641.4 5104.5 5122.6 5139.5 5142.7 5210.3 5214.1 5216.1 5227.2 5230.8 5236.6 5184.9 5199.4 5216.1 5219.1 5228.9 5194.4 5203.0 5210.9 5211.9 5225.2 5006.9 5074.4 5170.4 5179.4 5205.6 5649.2 5711.6 5717.0 5735.6 5743.4 6164.4 6182.4 6189.8 6193.2 6206.8 4583.2 5725.4 6126.2 6181.3 6204.7 5719.3 5733.5 5764.1 5807.7 5824.7 6235.5 6237.5 6238.8 6257.4 6259.9 5863.4 6023.5 6042.1 6044.8 6075.9 6085.1 6110.3 6123.1 6222.5 6224.3 6138.4 6140.1 6174.8 6179.5 6183.4 5682.5 6178.4 6180.9 6186.5 6187.6 4828.1 4844.9 4850.4 4861.6 4904.5 4323.4 4355.2 4370.3 4375.2 4384.1 5556.2 5642.2 5693.9 5700.8 5747.9 6111.4 6119.6 6144.2 6153.0 6164.4 5665.7 5671.3 5674.0 5676.8 5709.8 4619.6 5252.3 5294.1 5299.6 5301.3 6161.3 6215.7 6243.4 6247.6 6257.4 6120.4 6212.7 6234.2 6239.4 6248.8 6169.0 6169.8 6219.9 6244.9 6266.9 6021.7 6099.4 6114.2 6115.5 6125.6 6099.0 6212.9 6217.1 6232.6 6235.8 5996.4 6041.2 6058.3 6059.3 6084.2 5825.7 5918.5 5975.7 6029.7 6056.1 5845.0 5859.8 5912.1 5926.3 5958.6 6018.4 6033.5 6033.9 6045.5 6119.0 5753.2 5827.4 5875.8 5898.3 5904.6 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | [#1] ext.html Cycles:180 Average:62073.09 Median:38908.81 stddev:126444.57 (325.0%) stddev-sans-first:126714.69 04:58:51 INFO - PROCESS | 2356 | Values: 470.3 528.3 538.6 581.9 614.4 29436.6 29807.0 36720.1 37142.3 37195.3 40243.8 40687.0 40702.6 40734.6 40843.2 9341.1 9544.5 9545.6 9547.2 9564.4 8578.8 9246.3 9375.4 9473.5 9511.5 9564.8 9648.4 9668.2 9677.5 9678.8 9535.4 9640.0 9641.2 9645.0 9652.5 9485.1 9638.4 9639.4 9639.6 9648.4 38792.8 39024.8 39052.0 39103.6 39175.0 3161.0 3169.1 3300.4 3320.0 3564.7 27369.6 28351.6 28945.6 28955.9 29127.9 2582.8 2695.4 2737.6 2837.9 2890.5 475063.2 476093.6 476732.0 477736.0 478290.0 61107.7 61685.4 61698.7 61815.8 61826.0 65310.0 65330.0 65391.7 65409.3 65491.0 15881.4 16379.9 16380.5 16407.7 16422.2 12455.0 12498.2 12507.2 12522.9 12547.9 18710.5 19213.0 19262.9 19278.8 19444.3 8405.7 8623.3 8629.1 8643.0 8679.2 948.8 983.8 986.5 1034.2 1039.1 28742.4 29134.7 29563.7 29717.6 29849.9 948.6 998.0 1050.4 1053.1 1070.9 13157.2 15887.6 16053.9 16113.0 16648.4 514450.0 523795.0 525377.0 526226.0 526333.0 54945.0 55461.6 62228.0 62523.7 63602.0 1413.9 1437.2 1455.5 1456.3 1457.4 26245.5 29546.7 30769.2 31212.2 32101.2 47694.8 48354.3 50354.2 55312.4 55966.4 416348.0 421569.0 423801.0 425336.0 425548.0 32557.3 32815.0 32836.0 32856.8 32949.7 41135.6 41717.0 42312.8 42767.6 43782.6 36001.0 36483.1 37448.3 37604.4 38070.0 36242.3 36417.7 36868.7 37193.6 37234.8 36167.3 37045.3 37300.3 37413.1 37443.8 31906.8 32036.0 32160.4 32255.0 33719.5 21613.6 24047.5 24195.0 24269.2 24578.6 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | [#2] jquery.html Cycles:180 Average:35645.31 Median:2364.96 stddev:118180.35 (4997.1%) stddev-sans-first:118482.13 04:58:51 INFO - PROCESS | 2356 | Values: 329.2 358.7 363.5 368.4 374.7 14527.4 14924.4 18489.6 18526.0 19330.6 15450.4 18661.5 18749.8 19402.3 19428.2 5204.6 5560.6 5609.4 5737.7 5760.5 4030.1 4275.6 4283.0 5085.0 5626.1 5855.9 5940.3 6198.9 6201.7 6205.7 5406.9 6254.4 6258.7 6270.2 6275.5 5180.3 5399.4 5400.4 5402.6 5437.3 23930.0 23961.9 24019.0 24243.8 24371.0 2494.6 2528.2 2655.1 2900.2 2903.3 14263.9 14325.8 14445.5 14727.6 14764.0 1619.6 1693.2 1703.3 1708.2 1712.3 88682.2 88854.0 89264.0 90560.0 91563.6 9573.9 9631.0 10098.5 10300.4 10495.5 10533.2 12603.1 12679.6 12714.3 12719.3 8305.0 8310.5 8326.8 8390.5 8410.4 8490.1 8501.5 8510.0 8581.7 8611.8 5150.3 5995.2 6104.4 6114.7 6119.2 1655.2 1730.2 1767.3 1773.2 1819.6 411.4 412.0 893.5 1015.3 1022.3 9898.8 10843.7 11595.4 11736.5 11828.7 389.9 414.6 446.9 447.2 453.5 4677.9 6100.3 6104.5 6142.9 10538.8 677322.0 714194.0 727301.8 734516.0 736381.0 110240.0 112078.9 113555.3 113635.0 114454.0 1108.5 1146.2 1164.6 1175.4 1177.9 17371.7 17414.6 17921.4 17952.7 17970.8 45101.0 45626.8 45719.8 46424.8 47666.5 61217.4 61452.4 61690.4 61991.8 62073.8 7465.4 7490.3 7612.6 7636.7 7657.9 4639.1 9420.7 10477.6 11705.8 12012.9 9478.4 9538.5 10019.9 10060.5 10112.2 9917.3 9932.7 10075.9 10100.9 10379.8 7026.0 10061.5 10075.8 10165.7 10377.8 7304.7 7405.2 7485.3 7506.6 7515.5 8480.7 8647.7 9635.0 9968.9 10288.2 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | [#3] mootools.html Cycles:180 Average:6180.03 Median:5097.26 stddev:3274.38 (64.2%) stddev-sans-first:3263.89 04:58:51 INFO - PROCESS | 2356 | Values: 1405.3 1470.4 1543.6 1741.9 1947.8 8135.2 8325.0 8700.9 8879.0 8892.3 8648.7 8761.2 8868.3 8914.0 8975.6 2186.6 2250.8 2510.8 2517.9 2546.1 2276.3 2278.8 2281.6 2283.9 2422.3 2446.5 2486.9 2487.5 2490.8 2491.8 2102.6 2464.7 2498.9 2503.0 2514.9 2420.2 2469.7 2484.8 2487.3 2491.8 8767.4 8925.0 8954.4 8955.5 8959.7 5466.5 5588.2 5599.9 5606.6 5608.6 3073.8 3653.5 3687.1 3754.4 3764.0 1044.4 1052.2 1065.2 1078.0 1083.2 12382.7 12384.9 12411.9 12414.9 12434.9 4933.4 4974.6 5058.1 5074.9 5084.3 9239.9 10258.3 10482.6 10496.9 10504.3 5586.5 5621.9 5622.6 5629.8 5630.0 4963.7 5087.4 5091.7 5102.8 5162.6 4013.3 4037.5 4049.0 4078.1 4079.3 1202.4 1232.6 1240.2 1285.8 1307.9 1123.4 1135.4 1315.1 1363.0 1367.3 8222.3 8272.5 8338.2 8343.3 8350.1 1196.4 1203.4 1205.5 1213.0 1230.9 6310.6 6317.8 6382.3 6388.3 6389.9 10554.6 11205.6 11226.0 11229.8 11258.2 10708.1 11101.0 11102.8 11120.2 11191.4 8227.7 8327.8 8344.0 8438.6 8451.5 6836.0 7944.1 7989.0 8227.5 8229.2 9259.5 9480.1 9617.7 9638.5 9672.4 9729.0 10013.6 10068.2 10103.2 10104.6 7569.8 7570.3 7617.9 7670.1 7716.6 8355.8 8407.3 8427.6 8446.9 8450.9 6531.2 7701.1 7748.1 7784.8 7857.1 7566.2 7599.3 7685.9 7755.8 7840.8 7755.7 7800.8 7876.4 7879.6 7880.4 7081.5 7111.8 7140.6 7154.5 7239.9 7280.7 7335.8 7340.4 7348.3 7351.7 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | [#4] prototype.html Cycles:180 Average:5762.90 Median:6571.47 stddev:1830.22 (27.9%) stddev-sans-first:1789.27 04:58:51 INFO - PROCESS | 2356 | Values: 325.1 329.3 333.8 335.8 339.1 6516.5 6526.9 6588.5 6653.9 6749.4 6545.6 6554.4 6743.4 6751.7 6765.4 4932.4 4941.2 4943.4 4947.8 4953.9 4684.4 4703.5 4800.2 4953.6 4974.7 4564.1 4768.2 4772.7 4881.0 4929.0 4664.9 4861.3 4867.5 4869.0 4877.0 3666.3 4206.9 4212.4 4212.5 4219.7 6088.3 6282.4 6296.1 6303.5 6325.1 5675.0 5683.4 5736.7 5740.4 5748.7 6998.5 7006.5 7013.5 7028.7 7043.8 4431.2 4550.5 4576.5 4674.2 4696.2 7254.3 7358.9 7385.9 7451.3 7477.1 4768.3 4778.3 4781.8 4792.2 4796.8 4522.7 4824.9 4828.2 4843.1 4851.3 5586.0 5589.0 5593.8 5597.7 5606.3 5717.9 6409.4 6709.5 7075.1 7093.3 1604.2 1625.1 1626.3 1629.0 1629.7 1018.5 1034.2 1041.6 1049.6 1061.8 6642.5 6644.1 6670.5 6694.4 6695.2 5920.9 7282.9 7285.5 7288.1 7290.9 6440.8 6630.5 6672.0 6678.2 6685.6 3855.9 3890.1 3890.2 3892.5 3898.8 7644.5 7658.8 7669.5 7671.6 7675.2 7285.7 7536.9 7547.5 7575.1 7596.1 7672.5 7675.3 7677.1 7677.3 7678.0 5887.6 6458.7 7268.8 7291.8 7291.8 6452.5 6796.6 6878.8 7172.2 7177.0 6857.6 7745.0 7763.2 7768.8 7794.6 4368.3 4633.8 4634.0 4645.0 4660.5 6661.3 6954.4 7227.0 7231.5 7329.3 7037.6 7053.4 7054.4 7070.5 7078.6 7032.5 7037.4 7052.7 7054.7 7064.9 6600.3 6922.3 6926.4 6928.0 6946.6 7081.5 7084.2 7088.7 7093.6 7115.4 6692.4 6935.7 6944.6 6951.0 6955.7 04:58:51 INFO - PROCESS | 2356 | 04:58:51 INFO - PROCESS | 2356 | [#5] yui.html Cycles:180 Average:18279.03 Median:629.12 stddev:25665.25 (4079.6%) stddev-sans-first:25703.14 04:58:51 INFO - PROCESS | 2356 | Values: 658.1 670.2 731.9 751.0 784.9 14682.0 14693.5 14844.1 14857.2 14877.9 13523.7 13702.8 13708.0 13717.1 13751.8 707.7 724.0 867.4 887.2 891.3 728.5 749.6 870.8 893.5 896.2 906.7 926.1 926.8 929.5 930.9 732.0 744.9 747.8 916.2 920.3 672.4 682.2 682.4 682.7 685.4 14482.9 14520.3 14522.4 14555.8 14590.7 12409.9 12525.7 12634.7 12649.9 12687.4 10053.4 10090.7 10104.0 10253.3 10273.0 3527.6 3547.6 3554.3 3562.9 3563.7 79160.0 80313.4 80475.6 81170.0 81231.0 9532.9 9541.8 9577.6 9787.2 9834.2 21203.9 21216.5 21228.2 21241.9 21261.6 7305.6 7430.3 7584.3 7686.7 7725.2 4063.2 4152.6 4198.3 4216.1 4370.3 3465.5 3534.8 3536.5 3541.5 3542.5 614.9 629.7 631.2 638.3 647.8 593.4 602.7 608.5 623.1 624.3 8182.0 8250.9 8327.6 8359.3 8435.9 497.7 551.9 609.2 621.2 628.6 3966.6 3971.9 3982.4 4023.7 4035.3 87547.6 87817.6 88576.6 88634.6 94377.0 70052.9 80546.6 81098.2 81508.6 82242.0 66763.3 67510.3 72037.8 72158.6 72885.3 8215.4 8575.0 8695.5 8783.4 8789.5 36642.6 47941.6 50718.2 50719.7 51191.0 70115.9 70489.3 71665.6 72021.3 72457.0 10839.5 10978.6 11184.5 11266.8 11492.0 11991.6 12091.8 12254.2 12416.3 12660.7 11379.9 11674.7 11778.0 11987.8 12022.6 11105.1 11292.7 11441.5 11710.5 12395.9 10990.7 11139.7 11389.0 11641.9 12174.7 9072.5 9149.8 9208.7 9421.2 9577.4 8741.9 9370.4 9797.3 9812.3 9841.6 04:58:51 INFO - PROCESS | 2356 | -------- Summary: end -------- 04:58:51 INFO - PROCESS | 2356 | 04:58:52 INFO - TEST-INFO | 2356: exit 0 04:58:52 INFO - TEST-OK | dromaeo_css | took 1114594ms 04:58:52 INFO - TEST-START | kraken 04:58:52 INFO - operating with platform_type : mac_ 04:58:52 INFO - Initialising browser for kraken test... 04:58:52 INFO - TEST-INFO | started process 2360 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpgnwslX/profile http://localhost:49823/getInfo.html) 04:58:52 INFO - PROCESS | 2360 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:58:54 INFO - PROCESS | 2360 | __metrics Screen width/height:1600/1200 04:58:54 INFO - PROCESS | 2360 | colorDepth:24 04:58:54 INFO - PROCESS | 2360 | Browser inner width/height: 1024/689 04:58:54 INFO - PROCESS | 2360 | __metrics 04:58:54 INFO - PROCESS | 2360 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:58:54 INFO - PROCESS | 2360 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:55 INFO - TEST-INFO | 2360: exit 0 04:58:55 INFO - Browser initialized. 04:58:55 INFO - Running cycle 1/1 for kraken test... 04:58:55 INFO - TEST-INFO | started process 2362 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/T/tmpgnwslX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:07 INFO - PROCESS | 2362 | RSS: Main: 242724864 04:59:07 INFO - PROCESS | 2362 | 04:59:09 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:10 INFO - PROCESS | 2362 | RSS: Main: 290664448 04:59:10 INFO - PROCESS | 2362 | 04:59:12 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-dft) 04:59:13 INFO - PROCESS | 2362 | RSS: Main: 301178880 04:59:13 INFO - PROCESS | 2362 | 04:59:16 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-fft) 04:59:17 INFO - PROCESS | 2362 | RSS: Main: 287608832 04:59:17 INFO - PROCESS | 2362 | 04:59:19 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49823/tests/kraken/driver.html?testName=audio-oscillator) 04:59:19 INFO - PROCESS | 2362 | RSS: Main: 291110912 04:59:19 INFO - PROCESS | 2362 | 04:59:22 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:22 INFO - PROCESS | 2362 | RSS: Main: 291581952 04:59:22 INFO - PROCESS | 2362 | 04:59:25 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49823/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:26 INFO - PROCESS | 2362 | RSS: Main: 291696640 04:59:26 INFO - PROCESS | 2362 | 04:59:29 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49823/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:29 INFO - PROCESS | 2362 | RSS: Main: 293732352 04:59:29 INFO - PROCESS | 2362 | 04:59:32 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49823/tests/kraken/driver.html?testName=json-parse-financial) 04:59:33 INFO - PROCESS | 2362 | RSS: Main: 293527552 04:59:33 INFO - PROCESS | 2362 | 04:59:34 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:35 INFO - PROCESS | 2362 | RSS: Main: 325840896 04:59:35 INFO - PROCESS | 2362 | 04:59:36 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:37 INFO - PROCESS | 2362 | RSS: Main: 327049216 04:59:37 INFO - PROCESS | 2362 | 04:59:39 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:40 INFO - PROCESS | 2362 | RSS: Main: 332595200 04:59:40 INFO - PROCESS | 2362 | 04:59:42 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:43 INFO - PROCESS | 2362 | RSS: Main: 332836864 04:59:43 INFO - PROCESS | 2362 | 04:59:45 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:46 INFO - PROCESS | 2362 | RSS: Main: 333496320 04:59:46 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | Cycle 1(1): loaded http://localhost:49823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49823/tests/kraken/driver.html?testName=ai-astar) 04:59:48 INFO - PROCESS | 2362 | RSS: Main: 394678272 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | __start_tp_report 04:59:48 INFO - PROCESS | 2362 | _x_x_mozilla_page_load 04:59:48 INFO - PROCESS | 2362 | _x_x_mozilla_page_load_details 04:59:48 INFO - PROCESS | 2362 | |i|pagename|runs| 04:59:48 INFO - PROCESS | 2362 | |0;ai-astar;110;108;111;112;111;111;116;112;111;111 04:59:48 INFO - PROCESS | 2362 | |1;audio-beat-detection;162;122;147;156;122;144;141;120;157;119 04:59:48 INFO - PROCESS | 2362 | |2;audio-dft;190;185;188;188;195;184;185;186;182;183 04:59:48 INFO - PROCESS | 2362 | |3;audio-fft;70;75;83;79;58;56;57;82;79;56 04:59:48 INFO - PROCESS | 2362 | |4;audio-oscillator;95;92;125;79;80;84;137;112;114;112 04:59:48 INFO - PROCESS | 2362 | |5;imaging-gaussian-blur;83;92;83;91;92;112;131;140;83;90 04:59:48 INFO - PROCESS | 2362 | |6;imaging-darkroom;93;94;94;94;129;96;93;94;94;93 04:59:48 INFO - PROCESS | 2362 | |7;imaging-desaturate;126;142;86;86;85;84;87;86;84;85 04:59:48 INFO - PROCESS | 2362 | |8;json-parse-financial;54;57;53;52;54;53;52;62;49;52 04:59:48 INFO - PROCESS | 2362 | |9;json-stringify-tinderbox;65;72;62;71;69;65;66;69;69;68 04:59:48 INFO - PROCESS | 2362 | |10;stanford-crypto-aes;83;84;82;83;83;82;81;83;81;82 04:59:48 INFO - PROCESS | 2362 | |11;stanford-crypto-ccm;126;130;129;124;133;121;123;117;120;120 04:59:48 INFO - PROCESS | 2362 | |12;stanford-crypto-pbkdf2;133;127;137;168;173;130;138;146;123;171 04:59:48 INFO - PROCESS | 2362 | |13;stanford-crypto-sha256-iterative;68;65;65;79;94;95;72;66;67;66 04:59:48 INFO - PROCESS | 2362 | __end_tp_report 04:59:48 INFO - PROCESS | 2362 | __start_cc_report 04:59:48 INFO - PROCESS | 2362 | _x_x_mozilla_cycle_collect,1134 04:59:48 INFO - PROCESS | 2362 | __end_cc_report 04:59:48 INFO - PROCESS | 2362 | __startTimestamp1454763588665__endTimestamp 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | ------- Summary: start ------- 04:59:48 INFO - PROCESS | 2362 | Number of tests: 14 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.00 (1.8%) stddev-sans-first:2.07 04:59:48 INFO - PROCESS | 2362 | Values: 110.0 108.0 111.0 112.0 111.0 111.0 116.0 112.0 111.0 111.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:145.50 stddev:16.91 (11.6%) stddev-sans-first:15.76 04:59:48 INFO - PROCESS | 2362 | Values: 162.0 122.0 147.0 156.0 122.0 144.0 141.0 120.0 157.0 119.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#2] audio-dft Cycles:10 Average:186.60 Median:187.00 stddev:3.84 (2.1%) stddev-sans-first:3.87 04:59:48 INFO - PROCESS | 2362 | Values: 190.0 185.0 188.0 188.0 195.0 184.0 185.0 186.0 182.0 183.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#3] audio-fft Cycles:10 Average:69.50 Median:77.00 stddev:11.56 (15.0%) stddev-sans-first:12.26 04:59:48 INFO - PROCESS | 2362 | Values: 70.0 75.0 83.0 79.0 58.0 56.0 57.0 82.0 79.0 56.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:79.50 stddev:19.93 (25.1%) stddev-sans-first:20.93 04:59:48 INFO - PROCESS | 2362 | Values: 95.0 92.0 125.0 79.0 80.0 84.0 137.0 112.0 114.0 112.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:86.50 stddev:20.76 (24.0%) stddev-sans-first:21.13 04:59:48 INFO - PROCESS | 2362 | Values: 83.0 92.0 83.0 91.0 92.0 112.0 131.0 140.0 83.0 90.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:94.00 stddev:11.14 (11.8%) stddev-sans-first:11.70 04:59:48 INFO - PROCESS | 2362 | Values: 93.0 94.0 94.0 94.0 129.0 96.0 93.0 94.0 94.0 93.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:85.50 stddev:20.87 (24.4%) stddev-sans-first:18.90 04:59:48 INFO - PROCESS | 2362 | Values: 126.0 142.0 86.0 86.0 85.0 84.0 87.0 86.0 84.0 85.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:3.52 (6.6%) stddev-sans-first:3.73 04:59:48 INFO - PROCESS | 2362 | Values: 54.0 57.0 53.0 52.0 54.0 53.0 52.0 62.0 49.0 52.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:69.00 stddev:3.06 (4.4%) stddev-sans-first:3.10 04:59:48 INFO - PROCESS | 2362 | Values: 65.0 72.0 62.0 71.0 69.0 65.0 66.0 69.0 69.0 68.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 04:59:48 INFO - PROCESS | 2362 | Values: 83.0 84.0 82.0 83.0 83.0 82.0 81.0 83.0 81.0 82.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.00 stddev:5.12 (4.1%) stddev-sans-first:5.40 04:59:48 INFO - PROCESS | 2362 | Values: 126.0 130.0 129.0 124.0 133.0 121.0 123.0 117.0 120.0 120.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:142.00 stddev:19.09 (13.4%) stddev-sans-first:19.78 04:59:48 INFO - PROCESS | 2362 | Values: 133.0 127.0 137.0 168.0 173.0 130.0 138.0 146.0 123.0 171.0 04:59:48 INFO - PROCESS | 2362 | 04:59:48 INFO - PROCESS | 2362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:70.00 stddev:11.76 (16.8%) stddev-sans-first:12.29 04:59:48 INFO - PROCESS | 2362 | Values: 68.0 65.0 65.0 79.0 94.0 95.0 72.0 66.0 67.0 66.0 04:59:48 INFO - PROCESS | 2362 | -------- Summary: end -------- 04:59:48 INFO - PROCESS | 2362 | 04:59:49 INFO - TEST-INFO | 2362: exit 0 04:59:49 INFO - TEST-OK | kraken | took 56863ms 04:59:49 INFO - SUITE-END | took 1171s 04:59:49 INFO - Completed test suite (00:19:31) 04:59:49 INFO - Working with test: dromaeo_css 04:59:49 INFO - Generating results file: dromaeo_css 04:59:49 INFO - Working with test: kraken 04:59:49 INFO - Generating results file: kraken 04:59:49 INFO - javascript benchmark 04:59:49 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:59:50 INFO - process_Request line: dromaeo_css 7424.89 graph.html#tests=[[72,64,59]] 04:59:50 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:50 INFO - process_Request line: kraken 1448.00 graph.html#tests=[[232,64,59]] 04:59:50 INFO - RETURN: dromaeo_css: 7424.89 04:59:50 INFO - RETURN: kraken: 1448.00 04:59:50 INFO - javascript benchmark 04:59:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3365.276465559904, 3422.5550678411787, 3444.7933124012575, 3468.7225021998233, 3494.720422366211, 5567.331920169585, 5637.492625663689, 5649.0, 5677.659340439572, 5685.033544297469, 5573.052581061219, 5620.016497113009, 5636.4927156555905, 5638.295213098363, 5641.435856414357, 5104.489551044893, 5122.615803814729, 5139.460356662553, 5142.691438513682, 5210.270562121306, 5214.087534681435, 5216.061109000379, 5227.21591761237, 5230.790768369279, 5236.607254455912, 5184.922226166592, 5199.350081239845, 5216.087184742674, 5219.112750832349, 5228.947710522903, 5194.428612852565, 5203.03743807393, 5210.947890521084, 5211.869703257411, 5225.242339860737, 5006.899862002776, 5074.441811400743, 5170.37955445349, 5179.352580927384, 5205.635605507616, 5649.180868774046, 5711.571632127607, 5716.999525083135, 5735.569832262597, 5743.396943320933, 6164.4143806338325, 6182.412670796312, 6189.845253868644, 6193.1639228704, 6206.751729930797, 4583.152116858359, 5725.3988331225455, 6126.17296664949, 6181.320054793969, 6204.720787564525, 5719.3136823581435, 5733.512651424634, 5764.13537969308, 5807.738651760681, 5824.650520968713, 6235.469985051322, 6237.532185086136, 6238.781642642486, 6257.43683068526, 6259.937400626027, 5863.413658634103, 6023.548233882477, 6042.093685947143, 6044.7582096716515, 6075.908861367083, 6085.148079268906, 6110.327863934964, 6123.069106197231, 6222.533310001768, 6224.346443623445, 6138.355472675394, 6140.109684095781, 6174.783882564088, 6179.5056395488255, 6183.443490085824, 5682.516986056149, 6178.41305076017, 6180.8763824723255, 6186.505079593621, 6187.628742275388, 4828.130936431476, 4844.878878028077, 4850.393700787402, 4861.586765125004, 4904.485029071968, 4323.373110898902, 4355.194289056535, 4370.278903980808, 4375.190589740908, 4384.12317536494, 5556.194351819045, 5642.23829782974, 5693.914591281134, 5700.7719691212715, 5747.8563035924435, 6111.43980788641, 6119.593952096689, 6144.15675297409, 6152.969235153795, 6164.445199932027, 5665.716714164275, 5671.347795003545, 5674.0, 5676.829695109071, 5709.800156994485, 4619.584237418649, 5252.290940722954, 5294.12646913255, 5299.6025298102795, 5301.257823904656, 6161.291451483047, 6215.65813880241, 6243.406876346739, 6247.5939063960695, 6257.405546473078, 6120.416658368064, 6212.689365531795, 6234.220722409699, 6239.407256310643, 6248.781292654735, 6169.0, 6169.753209871555, 6219.875602488016, 6244.906326405198, 6266.874662506815, 6021.668808215591, 6099.359567245553, 6114.236541168587, 6115.544587951936, 6125.632462052291, 6098.976888191913, 6212.9068063979985, 6217.09852071438, 6232.594881332699, 6235.781747638811, 5996.430339117776, 6041.18444010053, 6058.273007238983, 6059.338284000984, 6084.178635884099, 5825.70871456417, 5918.496927761188, 5975.671338076274, 6029.668368239613, 6056.121862330026, 5844.970775146097, 5859.824205273678, 5912.142739302863, 5926.348101708722, 5958.6424814511265, 6018.36807135262, 6033.54748393881, 6033.879322413615, 6045.516358691206, 6118.969405152946, 5753.165790960371, 5827.358990511125, 5875.764969401176, 5898.3216930053595, 5904.645721256738], "unit": "score", "name": "dojo.html", "value": 5638.0624190024355}, {"lowerIsBetter": false, "replicates": [470.289862307915, 528.2762615217154, 538.6453070527622, 581.9495810062838, 614.4469977020682, 29436.558451623216, 29807.0, 36720.081997950096, 37142.257154856954, 37195.25609487809, 40243.798781006124, 40687.0, 40702.59297407025, 40734.59265407345, 40843.183136337255, 9341.11259430353, 9544.475053872035, 9545.618175273015, 9547.23622110233, 9564.378315409476, 8578.828423431527, 9246.26029917605, 9375.437473751563, 9473.526323683822, 9511.524423778817, 9564.80870382592, 9648.421094734304, 9668.226541876667, 9677.467739274338, 9678.75803104921, 9535.38020028696, 9639.951800241024, 9641.228701703916, 9645.0, 9652.469114198717, 9485.098915603006, 9638.373505722177, 9639.373440726331, 9639.614415423375, 9648.421094734338, 38792.80603596992, 39024.80487597544, 39052.0, 39103.60896391028, 39175.0, 3160.952585711216, 3169.1443310306317, 3300.372929143455, 3320.00399880035, 3564.679178873888, 27369.589456157973, 28351.574726378916, 28945.565816512768, 28955.855220723974, 29127.854360728274, 2582.793376529873, 2695.4204845958016, 2737.575675770259, 2837.886484540616, 2890.4508143452676, 475063.2493675088, 476093.6195319001, 476732.0, 477736.0, 478289.9999999965, 61107.694461527404, 61685.38314616886, 61698.69150654218, 61815.76368472605, 61826.0, 65310.0, 65330.02004969929, 65391.67304163449, 65409.34590654032, 65491.017634735515, 15881.364745410054, 16379.91810040966, 16380.508584742476, 16407.671846563, 16422.1788910554, 12455.003599712001, 12498.187617804995, 12507.249565026128, 12522.937385313015, 12547.874521254671, 18710.51543957015, 19213.0, 19262.903685481764, 19278.807211927982, 19444.319448819224, 8405.70580029696, 8623.31013518917, 8629.093945135795, 8642.95678521616, 8679.17547832955, 948.8054948735493, 983.8130755156498, 986.5166068626321, 1034.234666346898, 1039.0648416425279, 28742.425151496853, 29134.7086529132, 29563.704362956527, 29717.55423668647, 29849.850750746107, 948.5921053946869, 997.9700608981742, 1050.406520316019, 1053.1311667874033, 1070.9303895246785, 13157.210567365797, 15887.602809929844, 16053.876228664116, 16112.952658077187, 16648.417305394254, 514450.0, 523795.0, 525377.0, 526226.0, 526333.0, 54945.0, 55461.61345966383, 62228.0, 62523.6873815628, 63602.0, 1413.922234277104, 1437.1664434627892, 1455.52695374006, 1456.3373664982407, 1457.4097490516358, 26245.504113019673, 29546.688449795274, 30769.153860766382, 31212.219694507818, 32101.197470063435, 47694.761526192146, 48354.274685880446, 50354.244686330465, 55312.44687553073, 55966.440335596126, 416348.0, 421569.0, 423801.0, 425336.0, 425548.0, 32557.348853022333, 32815.01554953355, 32836.0, 32856.83571582127, 32949.67050329466, 41135.58864411317, 41716.95707607334, 42312.78843605762, 42767.572324276356, 43782.56217437785, 36001.0, 36483.08792280108, 37448.251034979694, 37604.435933461566, 38070.0482487929, 36242.27515449729, 36417.67188631674, 36868.709595164044, 37193.628063719014, 37234.813825930694, 36167.27665446729, 37045.259094818495, 37300.253994920495, 37413.064673383386, 37443.81278093592, 31906.840465797522, 32036.0, 32160.35679286448, 32255.0, 33719.4942075874, 21613.567728645023, 24047.51904961926, 24195.032198712557, 24269.150579729623, 24578.631320530563], "unit": "score", "name": "ext.html", "value": 19527.536721722077}, {"lowerIsBetter": false, "replicates": [329.2328873724223, 358.731882794322, 363.54375259049897, 368.4068649474346, 374.7320665724007, 14527.418903243857, 14924.403023879058, 18489.630207395843, 18526.0, 19330.613387732235, 15450.381984720625, 18661.533461663465, 18749.812501874978, 19402.320918767848, 19428.222871085174, 5204.557612602924, 5560.610757246995, 5609.411011843759, 5737.655740655574, 5760.4815566599, 4030.1133750574827, 4275.572442755731, 4282.978585107086, 5084.957583695334, 5626.127950167731, 5855.860354107794, 5940.316863560681, 6198.907016394758, 6201.720922558473, 6205.689715514229, 5406.91889621656, 6254.3745625437095, 6258.655773932432, 6270.153529273535, 6275.529335299825, 5180.274761533388, 5399.433059528771, 5400.405955344909, 5402.567794576425, 5437.34751829779, 23930.0, 23961.88019059911, 24019.039238430443, 24243.7878106094, 24371.0, 2494.588392915167, 2528.1783420388447, 2655.123809142978, 2900.1589539033866, 2903.332233586287, 14263.928680356636, 14325.848313371042, 14445.49440769568, 14727.631809204748, 14764.0, 1619.6193894434798, 1693.2211182855901, 1703.2675949341779, 1708.1544635405553, 1712.3236321653003, 88682.18438703043, 88854.0, 89264.0, 90560.0, 91563.62654560187, 9573.90426095744, 9630.951845240728, 10098.495075246208, 10300.433476158732, 10495.527701253463, 10533.157347412189, 12603.117781755373, 12679.619611411672, 12714.300713460849, 12719.300438475973, 8304.96187976503, 8310.54292013945, 8326.750197494084, 8390.496570205807, 8410.411271211078, 8490.066092729918, 8501.489910605384, 8510.021347544987, 8581.65673373058, 8611.784705382415, 5150.304708864331, 5995.190649262294, 6104.420080092473, 6114.694265286718, 6119.2350956130485, 1655.1724137931035, 1730.1781653714636, 1767.3195819609543, 1773.219783295346, 1819.6360727854483, 411.42811492026107, 411.9773412462283, 893.5101116887562, 1015.3451024089569, 1022.3405903192399, 9898.80202395948, 10843.728906777395, 11595.420228988516, 11736.530538778354, 11828.704282392837, 389.94930659014716, 414.5605658002527, 446.941897553316, 447.1548772819374, 453.5487190245727, 4677.859664210079, 6100.267967843798, 6104.511639068953, 6142.877142457215, 10538.789224215472, 677322.0, 714194.0, 727301.7509766193, 734516.0, 736381.0, 110240.0, 112078.87921120848, 113555.29667055001, 113635.0, 114454.0, 1108.4568561405015, 1146.2091157101572, 1164.598213616301, 1175.4064197580337, 1177.8704342522315, 17371.652566948338, 17414.564635883697, 17921.37275195414, 17952.730709039635, 17970.820291796914, 45101.0, 45626.77186614046, 45719.77140114278, 46424.767876160404, 47666.52333476621, 61217.38782612117, 61452.385476144664, 61690.38309617026, 61991.76016479736, 62073.758524830155, 7465.4027677786735, 7490.250974902466, 7612.58130802789, 7636.694532218871, 7657.88513172314, 4639.118567472169, 9420.717378478383, 10477.604033922384, 11705.775902578484, 12012.879871201525, 9478.38390504615, 9538.523073846418, 10019.899801001897, 10060.547275372479, 10112.24158188124, 9917.30578859473, 9932.652357167464, 10075.899241007495, 10100.89899101029, 10379.844302335621, 7026.0, 10061.496925153566, 10075.848862266925, 10165.695029149138, 10377.792444151226, 7304.744333948286, 7405.185429602847, 7485.288897554724, 7506.624668766431, 7515.549067055994, 8480.703175389079, 8647.697330593399, 9635.036496350309, 9968.900310997087, 10288.176945844465], "unit": "score", "name": "jquery.html", "value": 8589.355808531405}, {"lowerIsBetter": false, "replicates": [1405.3184205660248, 1470.3530446603497, 1543.6295289130608, 1741.8780685352021, 1947.7760057593373, 8135.186481351861, 8325.042620098682, 8700.869486957692, 8879.023307436193, 8892.333075019367, 8648.702694595813, 8761.167689069543, 8868.29053675706, 8914.0, 8975.551222438884, 2186.5954798362272, 2250.8311876609237, 2510.8242423030397, 2517.8615176165304, 2546.0706842002674, 2276.2943487518924, 2278.8063014643694, 2281.6007198740235, 2283.942901427469, 2422.2975337152207, 2446.54738873309, 2486.9005239790386, 2487.452760392711, 2490.8256422050463, 2491.788198003172, 2102.568973360457, 2464.728879823227, 2498.900043998238, 2503.0, 2514.911978080758, 2420.165043060141, 2469.715982661999, 2484.7515248475006, 2487.253823852837, 2491.7757401833924, 8767.386282960195, 8925.0, 8954.37319387643, 8955.507447090407, 8959.73120806377, 5466.535344495723, 5588.21764952907, 5599.860003499904, 5606.55147588192, 5608.635438696512, 3073.784835061547, 3653.451982202664, 3687.078230442389, 3754.3617585010343, 3763.9837243944257, 1044.3577200022007, 1052.2108418685987, 1065.2383545764815, 1078.0, 1083.2471432354516, 12382.690432739253, 12384.938075309656, 12411.93794031033, 12414.937925310316, 12434.937825310815, 4933.432655244621, 4974.552290293891, 5058.064258112261, 5074.949250507448, 5084.313617661643, 9239.891213054341, 10258.333208341433, 10482.580696772196, 10496.895031049591, 10504.317219380715, 5586.497215250647, 5621.887562248732, 5622.57830662702, 5629.831105066854, 5630.042892708249, 4963.677360971597, 5087.440381558025, 5091.719955402488, 5102.795888164432, 5162.638615296968, 4013.2776100302226, 4037.5356833963883, 4049.0, 4078.1028173801715, 4079.347304431336, 1202.4168278384977, 1232.624049664843, 1240.206267988488, 1285.8328417305877, 1307.9215247085206, 1123.4326665034105, 1135.3528488761326, 1315.1254415813378, 1362.9931850340686, 1367.2616786935143, 8222.301104406193, 8272.503649781032, 8338.207870252316, 8343.332533397313, 8350.123237060143, 1196.36592605919, 1203.434385838672, 1205.4515195585986, 1212.9575464858865, 1230.889219970189, 6310.558260921784, 6317.842053948596, 6382.266039405527, 6388.297287298394, 6389.8722025560155, 10554.577816887391, 11205.60780372683, 11225.989660930556, 11229.831552526719, 11258.155638326994, 10708.1433485321, 11101.0, 11102.777944441066, 11120.22158448917, 11191.44042797873, 8227.71203007892, 8327.750167494985, 8343.998720153499, 8438.57807109642, 8451.492910425393, 6835.965820170867, 7944.086430060386, 7989.041315042232, 8227.547484888388, 8229.218224268685, 9259.53702314895, 9480.099390557885, 9617.663381781604, 9638.518074096408, 9672.419654820733, 9729.0, 10013.649522266685, 10068.194544436281, 10103.191744660262, 10104.646337378157, 7569.8107547309555, 7570.318671319387, 7617.923820761722, 7670.117936437158, 7716.614169291625, 8355.832883342178, 8407.285380742705, 8427.620757065824, 8446.915530844613, 8450.915490845258, 6531.216254049355, 7701.075870895304, 7748.147703752696, 7784.805379865548, 7857.057153141431, 7566.167721550515, 7599.316061554487, 7685.884711729217, 7755.806104847424, 7840.803979900548, 7755.72854950074, 7800.804979875548, 7876.448648594544, 7879.606019698877, 7880.448368614142, 7081.468889833386, 7111.7866464006165, 7140.642967851482, 7154.463415243774, 7239.8914016290855, 7280.67236974348, 7335.816604584715, 7340.376068034277, 7348.338649521569, 7351.70593176267], "unit": "score", "name": "mootools.html", "value": 5019.02338230689}, {"lowerIsBetter": false, "replicates": [325.1448689945443, 329.34131736526945, 333.75635785876295, 335.75657648205055, 339.13858798651427, 6516.511261655377, 6526.934730652692, 6588.538802283836, 6653.902106152479, 6749.426298764611, 6545.574537655061, 6554.41010309072, 6743.393094621483, 6751.662416879161, 6765.357291057354, 4932.383452068491, 4941.184704523767, 4943.431505376882, 4947.752612369385, 4953.851384458472, 4684.36761037259, 4703.541902010371, 4800.231962885939, 4953.6037117030555, 4974.676646017997, 4564.1328147652, 4768.23708206687, 4772.689775164603, 4881.0, 4928.97535512322, 4664.930026049612, 4861.319415281846, 4867.51324867514, 4868.975655121737, 4876.97561512192, 3666.2850744104912, 4206.852760153411, 4212.368144778277, 4212.4523811904255, 4219.725717828362, 6088.269407671063, 6282.434580887696, 6296.055591661242, 6303.464205542535, 6325.0828629848875, 5675.0, 5683.374828768832, 5736.713164341808, 5740.425957404268, 5748.683822389767, 6998.510104292702, 7006.509544331899, 7013.47398945076, 7028.683709233045, 7043.7534686285735, 4431.224535706238, 4550.49944506104, 4576.4508259009135, 4674.182018146845, 4696.225122854725, 7254.310840470147, 7358.852822943565, 7385.852282954311, 7451.254874512614, 7477.140128885139, 4768.3085952536685, 4778.331033655291, 4781.784819683123, 4792.233242681224, 4796.784144713496, 4522.683412161117, 4824.879378015507, 4828.203346447867, 4843.128236917389, 4851.345068415719, 5586.0, 5589.0, 5593.776248950077, 5597.6641401516035, 5606.299212598426, 5717.942820571824, 6409.391107844841, 6709.530332876652, 7075.080239568823, 7093.255208203168, 1604.2219523531078, 1625.057466669329, 1626.2763070433543, 1629.0063061532455, 1629.722947098996, 1018.4500369800373, 1034.2139973619953, 1041.635427600349, 1049.5959055763433, 1061.7823346214007, 6642.535022548375, 6644.103046088716, 6670.533062685566, 6694.430973367221, 6695.230048544479, 5920.940790592039, 7282.854342913218, 7285.526440781332, 7288.08898887639, 7290.890636640454, 6440.806775796734, 6630.53586248958, 6671.966640166768, 6678.165229346332, 6685.6322902240845, 3855.9178043856564, 3890.144168282973, 3890.2025084857537, 3892.4939757831867, 3898.785566793797, 7644.464887457936, 7658.808529786688, 7669.501482403626, 7671.6164191790185, 7675.15573286938, 7285.744998925013, 7536.924630753732, 7547.471676982558, 7575.128860181039, 7596.126445458733, 7672.539647621161, 7675.347595454337, 7677.11910581911, 7677.347425468898, 7678.040244969379, 5887.646741195542, 6458.741650334122, 7268.818279543054, 7291.781246562611, 7291.817704557428, 6452.451541619015, 6796.592204467748, 6878.825091106102, 7172.246914074156, 7177.0, 6857.559912418248, 7745.0, 7763.223677632417, 7768.844623107393, 7794.649240784065, 4368.301071828492, 4633.791479383369, 4633.976830115827, 4645.001324715203, 4660.46404663468, 6661.300563440769, 6954.374106330454, 7226.963865180641, 7231.4937954342695, 7329.267073292842, 7037.648117593997, 7053.365197132078, 7054.365107140382, 7070.505064645426, 7078.646067696697, 7032.5077244592385, 7037.437005039482, 7052.717891284291, 7054.717811287491, 7064.894026589708, 6600.306967768315, 6922.273161317989, 6926.445884329342, 6927.965360173167, 6946.6179360135675, 7081.539699919489, 7084.22073571917, 7088.716451341888, 7093.609851458219, 7115.430765538848, 6692.397684208445, 6935.653217339213, 6944.618046007518, 6951.0, 6955.652217389212], "unit": "score", "name": "prototype.html", "value": 5147.946238539175}, {"lowerIsBetter": false, "replicates": [658.1214079204262, 670.1957650819019, 731.8682637125319, 750.962451877406, 784.878343856702, 14682.0, 14693.485727999521, 14844.109353438775, 14857.182854942987, 14877.925610371947, 13523.729525409486, 13702.794458083112, 13708.040437169402, 13717.108387954777, 13751.793723094162, 707.6780065070407, 724.0008787872729, 867.397158974513, 887.2414085956511, 891.3493150000503, 728.5155371677828, 749.5540153608595, 870.7561882672861, 893.530896279452, 896.1979028769248, 906.7461110888962, 926.147943891618, 926.8239034583441, 929.502716046915, 930.8743319651862, 732.0446816903965, 744.8622004929106, 747.8055705516605, 916.2074805293406, 920.3281604428771, 672.4250765595394, 682.1847891769338, 682.3517658224706, 682.7166725808784, 685.396850771323, 14482.927585362111, 14520.273986300643, 14522.419103235858, 14555.78166327506, 14590.70818583633, 12409.875901240963, 12525.686857828627, 12634.747305053848, 12649.93675031619, 12687.365631718469, 10053.396796192252, 10090.69727908164, 10103.989601039912, 10253.33353332031, 10273.0, 3527.6119626841028, 3547.6452354764574, 3554.306910152521, 3562.9109272268142, 3563.6970857477145, 79160.0, 80313.39373212503, 80475.5976220121, 81170.0, 81231.0, 9532.90467095334, 9541.761455963517, 9577.569009394594, 9787.16809071237, 9834.213262938947, 21203.89398053, 21216.469588260417, 21228.150873964867, 21241.893790530947, 21261.574768504543, 7305.5981920994855, 7430.256974302634, 7584.317411432998, 7686.654100565376, 7725.227477252342, 4063.22798668258, 4152.563980781974, 4198.328267477189, 4216.135692183095, 4370.300751879684, 3465.462853257749, 3534.752567320263, 3536.45184996326, 3541.486484459739, 3542.5040494330815, 614.8800983808114, 629.6536904702486, 631.2393565753256, 638.2755572425331, 647.7927063339686, 593.3769541980903, 602.6600166251014, 608.528390497368, 623.0778447897137, 624.2664868779166, 8181.95909020463, 8250.876236856451, 8327.625256863455, 8359.289460395934, 8435.92955419926, 497.6914313125885, 551.931008623922, 609.1958614628647, 621.1521273461692, 628.5819929746758, 3966.603339666068, 3971.940420893689, 3982.4424580558743, 4023.7183397162503, 4035.3480100509087, 87547.56226218956, 87817.56091219503, 88576.557117214, 88634.55682721545, 94377.0, 70052.94920576195, 80546.59726701329, 81098.18901811025, 81508.59245703853, 82242.0, 66763.33091672845, 67510.32489675138, 72037.79622037859, 72158.55682886313, 72885.2711472889, 8215.383846211678, 8574.957125214334, 8695.521746304014, 8783.429077109968, 8789.516576588348, 36642.63357366392, 47941.56175314746, 50718.23922641237, 50719.74640126776, 51190.97618047544, 70115.94826077715, 70489.29510705032, 71665.6250781183, 72021.27978720146, 72457.0, 10839.458027098455, 10978.560857565608, 11184.496697648463, 11266.774664506827, 11492.0, 11991.580294689644, 12091.81862272049, 12254.193535526852, 12416.255024698547, 12660.683482913, 11379.886201137882, 11674.70813229676, 11778.0, 11987.820182697093, 12022.63932082039, 11105.111591072533, 11292.719167905021, 11441.542338306375, 11710.4730287139, 12395.93802030984, 10990.725231869268, 11139.665810025712, 11389.0, 11641.941790291334, 12174.695632609255, 9072.546372681207, 9149.77125571866, 9208.677696280598, 9421.246300295823, 9577.377470464398, 8741.91258087411, 9370.390924590152, 9797.31418800677, 9812.264080194156, 9841.606335746776], "unit": "score", "name": "yui.html", "value": 6856.698502098243}], "name": "dromaeo_css", "value": 7424.887638952888}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 111.0, 112.0, 111.0, 111.0, 116.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [162.0, 122.0, 147.0, 156.0, 122.0, 144.0, 141.0, 120.0, 157.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 139.0}, {"lowerIsBetter": true, "replicates": [190.0, 185.0, 188.0, 188.0, 195.0, 184.0, 185.0, 186.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 186.6}, {"lowerIsBetter": true, "replicates": [70.0, 75.0, 83.0, 79.0, 58.0, 56.0, 57.0, 82.0, 79.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.5}, {"lowerIsBetter": true, "replicates": [95.0, 92.0, 125.0, 79.0, 80.0, 84.0, 137.0, 112.0, 114.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 103.0}, {"lowerIsBetter": true, "replicates": [83.0, 92.0, 83.0, 91.0, 92.0, 112.0, 131.0, 140.0, 83.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 129.0, 96.0, 93.0, 94.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 97.4}, {"lowerIsBetter": true, "replicates": [126.0, 142.0, 86.0, 86.0, 85.0, 84.0, 87.0, 86.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 53.0, 52.0, 54.0, 53.0, 52.0, 62.0, 49.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 62.0, 71.0, 69.0, 65.0, 66.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 82.0, 83.0, 83.0, 82.0, 81.0, 83.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [126.0, 130.0, 129.0, 124.0, 133.0, 121.0, 123.0, 117.0, 120.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [133.0, 127.0, 137.0, 168.0, 173.0, 130.0, 138.0, 146.0, 123.0, 171.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 65.0, 79.0, 94.0, 95.0, 72.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.7}], "name": "kraken", "value": 1448.0}]} 04:59:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1448.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7424.89"}}} 04:59:50 INFO - Return code: 0 04:59:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:50 INFO - # TBPL SUCCESS # 04:59:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:50 INFO - 2016-02-06 04:59:50.414 screenresolution[2366:24926] starting screenresolution argv=screenresolution get 04:59:50 INFO - 2016-02-06 04:59:50.416 screenresolution[2366:24926] Display 0: 1600x1200x32@60 04:59:50 INFO - 2016-02-06 04:59:50.422 screenresolution[2367:24929] starting screenresolution argv=screenresolution list 04:59:50 INFO - Available Modes on Display 0 04:59:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:50 INFO - Intel Iris: 04:59:50 INFO - Chipset Model: Intel Iris 04:59:50 INFO - Type: GPU 04:59:50 INFO - Bus: Built-In 04:59:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:50 INFO - Vendor: Intel (0x8086) 04:59:50 INFO - Device ID: 0x0a2e 04:59:50 INFO - Revision ID: 0x0009 04:59:50 INFO - Displays: 04:59:50 INFO - Display: 04:59:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:50 INFO - Display Serial Number: 1600x1200 60 04:59:50 INFO - Main Display: Yes 04:59:50 INFO - Mirror: Off 04:59:50 INFO - Online: Yes 04:59:50 INFO - Rotation: Supported 04:59:50 INFO - Return code: 0 04:59:50 INFO - Running post-action listener: _resource_record_post_action 04:59:50 INFO - Running post-run listener: _resource_record_post_run 04:59:51 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 430080; Write bytes: 708689920; Read time: 5; Write time: 2886 04:59:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404402688; Write bytes: 406685696; Read time: 30363; Write time: 823 04:59:51 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 430080; Write bytes: 301156352; Read time: 5; Write time: 2060 04:59:51 INFO - Running post-run listener: _upload_blobber_files 04:59:51 INFO - Blob upload gear active. 04:59:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:59:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:52 INFO - (blobuploader) - INFO - Done attempting. 04:59:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:53 INFO - (blobuploader) - INFO - Done attempting. 04:59:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:53 INFO - Return code: 0 04:59:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0107231a7d5790f30ec6ea5a316c1941e6af5e82d47ad8cf005c796067102b52383e0e6629dfd7df52941ab699a69449d8aad8c8e07d8572f02613516e91154b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3abd0cd952750ae5c1dc676e038bf7c0396e99251d977a1bd756db96a8b265078bf803a3cacf74bbc3da39bc73d71eab83ccf7a4441708b7f43fdbe7c99d9a73"} 04:59:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:53 INFO - Contents: 04:59:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0107231a7d5790f30ec6ea5a316c1941e6af5e82d47ad8cf005c796067102b52383e0e6629dfd7df52941ab699a69449d8aad8c8e07d8572f02613516e91154b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3abd0cd952750ae5c1dc676e038bf7c0396e99251d977a1bd756db96a8b265078bf803a3cacf74bbc3da39bc73d71eab83ccf7a4441708b7f43fdbe7c99d9a73"} 04:59:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:53 INFO - Copying logs to upload dir... 04:59:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.072988 ========= master_lag: 21.75 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-02-06 05:00:15.575691) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:15.578817) ========= 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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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/0107231a7d5790f30ec6ea5a316c1941e6af5e82d47ad8cf005c796067102b52383e0e6629dfd7df52941ab699a69449d8aad8c8e07d8572f02613516e91154b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3abd0cd952750ae5c1dc676e038bf7c0396e99251d977a1bd756db96a8b265078bf803a3cacf74bbc3da39bc73d71eab83ccf7a4441708b7f43fdbe7c99d9a73"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011441 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0107231a7d5790f30ec6ea5a316c1941e6af5e82d47ad8cf005c796067102b52383e0e6629dfd7df52941ab699a69449d8aad8c8e07d8572f02613516e91154b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3abd0cd952750ae5c1dc676e038bf7c0396e99251d977a1bd756db96a8b265078bf803a3cacf74bbc3da39bc73d71eab83ccf7a4441708b7f43fdbe7c99d9a73"}' ========= master_lag: 8.95 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:24.538882) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:24.539182) ========= 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.P0UpZfK4LL/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.vfr8onxcEm/Listeners TMPDIR=/var/folders/h6/mf44gd353f7dv2g4t9vfyz5w00000w/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.005342 ========= master_lag: 0.61 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:25.155363) ========= ========= Started reboot skipped (results: 3, elapsed: 21 secs) (at 2016-02-06 05:00:25.155867) ========= ========= Finished reboot skipped (results: 3, elapsed: 21 secs) (at 2016-02-06 05:00:46.478725) ========= ========= Total master_lag: 34.91 =========