builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1454762318.23 results: success (0) buildid: 20160206043835 builduid: 5bef06baf17441788870e7bef6aa3b24 revision: 46d6d868ba0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.227527) ========= 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.228080) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.228442) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005874 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.273676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.274015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.297769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.298085) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.004944 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.346456) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.346778) ========= 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.347179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.347515) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.7M=0s 2016-02-06 04:38:38 (29.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.526792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.527178) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.026934 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:38.576705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-06 04:38:38.577121) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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,647 Setting DEBUG logging. 2016-02-06 04:38:38,647 attempt 1/10 2016-02-06 04:38:38,647 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,744 unpacking tar archive at: fx-team-46d6d868ba0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.346201 ========= master_lag: 3.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-02-06 04:38:43.378712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.379142) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005943 script_repo_revision: '46d6d868ba0f' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.416420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.416768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:38:43.758466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-02-06 04:38:43.758754) ========= /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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-0178', 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": "20160206043835", 04:38:45 INFO - "stage_platform": "macosx64", 04:38:45 INFO - "basedir": "/builds/slave/test", 04:38:45 INFO - "buildnumber": 298, 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-0178", 04:38:45 INFO - "builduid": "5bef06baf17441788870e7bef6aa3b24", 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:46 INFO - Downloaded 17118689 bytes. 04:38:46 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:46 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:50 INFO - Downloaded 17118689 bytes. 04:38:50 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:50 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:03 INFO - Downloaded 111104284 bytes. 04:39:03 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:03 INFO - mkdir: /builds/slave/test/properties 04:39:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:39:03 INFO - Writing to file /builds/slave/test/properties/build_url 04:39:03 INFO - Contents: 04:39:03 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454514823/firefox-47.0a1.en-US.mac.dmg 04:39:04 INFO - Running post-action listener: _resource_record_post_action 04:39:04 INFO - Running post-action listener: set_extra_try_arguments 04:39:04 INFO - ##### 04:39:04 INFO - ##### Running populate-webroot step. 04:39:04 INFO - ##### 04:39:04 INFO - Running pre-action listener: _resource_record_pre_action 04:39:04 INFO - Running main action method: populate_webroot 04:39:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:39:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:39:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:39:04 INFO - '--tppagecycles', 04:39:04 INFO - '7'], 04:39:04 INFO - 'tests': ['tsvgm']}}, 04:39:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:39:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:39:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:39:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:39:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:39:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'tests': ['damp', 'tps']}, 04:39:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['damp', 'tps']}, 04:39:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:39:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:39:04 INFO - 'other': {'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other_l64': {'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'other_nol64': {'tests': ['a11yr', 04:39:04 INFO - 'ts_paint', 04:39:04 INFO - 'tpaint', 04:39:04 INFO - 'sessionrestore', 04:39:04 INFO - 'sessionrestore_no_auto_restore']}, 04:39:04 INFO - 'svgr': {'tests': ['tsvgx', 04:39:04 INFO - 'tsvgr_opacity', 04:39:04 INFO - 'tart', 04:39:04 INFO - 'tscrollx', 04:39:04 INFO - 'cart']}, 04:39:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tsvgx', 04:39:04 INFO - 'tsvgr_opacity', 04:39:04 INFO - 'tart', 04:39:04 INFO - 'tscrollx', 04:39:04 INFO - 'cart']}, 04:39:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'tests': ['tp5o']}, 04:39:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s'], 04:39:04 INFO - 'tests': ['tp5o']}, 04:39:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--xperf_path', 04:39:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:04 INFO - 'tests': ['tp5n']}, 04:39:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:39:04 INFO - 'talos_options': ['--e10s', 04:39:04 INFO - '--xperf_path', 04:39:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:39:04 INFO - 'tests': ['tp5n']}}, 04:39:04 INFO - 'talos.zip': {'path': '', 04:39:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:39:04 INFO - Running post-action listener: _resource_record_post_action 04:39:04 INFO - ##### 04:39:04 INFO - ##### Running create-virtualenv step. 04:39:04 INFO - ##### 04:39:04 INFO - Running pre-action listener: _resource_record_pre_action 04:39:04 INFO - Running main action method: create_virtualenv 04:39:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:39:04 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:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:39:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:39:04 INFO - Using real prefix '/tools/python27' 04:39:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:39:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:39:07 INFO - Installing pip.................done. 04:39:07 INFO - Return code: 0 04:39:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:39:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:07 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:07 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:07 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:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:07 INFO - 'HOME': '/Users/cltbld', 04:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:07 INFO - 'LOGNAME': 'cltbld', 04:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:07 INFO - 'MOZ_NO_REMOTE': '1', 04:39:07 INFO - 'NO_EM_RESTART': '1', 04:39:07 INFO - 'PAGER': '/bin/cat', 04:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:07 INFO - 'PWD': '/builds/slave/test', 04:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:07 INFO - 'SHELL': '/bin/bash', 04:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:07 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:07 INFO - 'USER': 'cltbld', 04:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:07 INFO - 'XPC_FLAGS': '0x0', 04:39:07 INFO - 'XPC_SERVICE_NAME': '0', 04:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:08 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:08 INFO - Cleaning up... 04:39:08 INFO - Return code: 0 04:39:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:39:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:08 INFO - 'HOME': '/Users/cltbld', 04:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:08 INFO - 'LOGNAME': 'cltbld', 04:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:08 INFO - 'MOZ_NO_REMOTE': '1', 04:39:08 INFO - 'NO_EM_RESTART': '1', 04:39:08 INFO - 'PAGER': '/bin/cat', 04:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:08 INFO - 'PWD': '/builds/slave/test', 04:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:08 INFO - 'SHELL': '/bin/bash', 04:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:08 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:08 INFO - 'USER': 'cltbld', 04:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:08 INFO - 'XPC_FLAGS': '0x0', 04:39:08 INFO - 'XPC_SERVICE_NAME': '0', 04:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:08 INFO - Downloading/unpacking psutil>=0.7.1 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:11 INFO - Installing collected packages: psutil 04:39:11 INFO - Running setup.py install for psutil 04:39:11 INFO - building 'psutil._psutil_osx' extension 04:39:11 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:12 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:12 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:12 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:12 INFO - building 'psutil._psutil_posix' extension 04:39:12 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:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:39:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:39:12 INFO - ^ 04:39:12 INFO - 1 warning generated. 04:39:12 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:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:39:13 INFO - Successfully installed psutil 04:39:13 INFO - Cleaning up... 04:39:13 INFO - Return code: 0 04:39:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:13 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:13 INFO - 'HOME': '/Users/cltbld', 04:39:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:13 INFO - 'LOGNAME': 'cltbld', 04:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:13 INFO - 'MOZ_NO_REMOTE': '1', 04:39:13 INFO - 'NO_EM_RESTART': '1', 04:39:13 INFO - 'PAGER': '/bin/cat', 04:39:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:13 INFO - 'PWD': '/builds/slave/test', 04:39:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:13 INFO - 'SHELL': '/bin/bash', 04:39:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:13 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:13 INFO - 'USER': 'cltbld', 04:39:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:13 INFO - 'XPC_FLAGS': '0x0', 04:39:13 INFO - 'XPC_SERVICE_NAME': '0', 04:39:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:39:13 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:13 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:13 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:13 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:13 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:13 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 - Downloading mozsystemmonitor-0.0.tar.gz 04:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:39:15 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:15 INFO - Installing collected packages: mozsystemmonitor 04:39:15 INFO - Running setup.py install for mozsystemmonitor 04:39:15 INFO - Successfully installed mozsystemmonitor 04:39:15 INFO - Cleaning up... 04:39:15 INFO - Return code: 0 04:39:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:39: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:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39: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:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:15 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:15 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:15 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:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:15 INFO - 'HOME': '/Users/cltbld', 04:39:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:15 INFO - 'LOGNAME': 'cltbld', 04:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:15 INFO - 'MOZ_NO_REMOTE': '1', 04:39:15 INFO - 'NO_EM_RESTART': '1', 04:39:15 INFO - 'PAGER': '/bin/cat', 04:39:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:15 INFO - 'PWD': '/builds/slave/test', 04:39:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:15 INFO - 'SHELL': '/bin/bash', 04:39:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:15 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:15 INFO - 'USER': 'cltbld', 04:39:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:15 INFO - 'XPC_FLAGS': '0x0', 04:39:15 INFO - 'XPC_SERVICE_NAME': '0', 04:39:15 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 blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 04:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:39:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:39:18 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:18 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 - 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:18 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:18 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:18 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:39:19 INFO - Downloading/unpacking docopt==0.6.1 (from 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:19 INFO - Downloading docopt-0.6.1.tar.gz 04:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:39:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:39:19 INFO - Running setup.py install for blobuploader 04:39:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:39:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:39:19 INFO - Running setup.py install for requests 04:39:20 INFO - Running setup.py install for docopt 04:39:20 INFO - Successfully installed blobuploader requests docopt 04:39:20 INFO - Cleaning up... 04:39:20 INFO - Return code: 0 04:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:20 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:20 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:20 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:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:20 INFO - 'HOME': '/Users/cltbld', 04:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:20 INFO - 'LOGNAME': 'cltbld', 04:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:20 INFO - 'MOZ_NO_REMOTE': '1', 04:39:20 INFO - 'NO_EM_RESTART': '1', 04:39:20 INFO - 'PAGER': '/bin/cat', 04:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:20 INFO - 'PWD': '/builds/slave/test', 04:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:20 INFO - 'SHELL': '/bin/bash', 04:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:20 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:20 INFO - 'USER': 'cltbld', 04:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:20 INFO - 'XPC_FLAGS': '0x0', 04:39:20 INFO - 'XPC_SERVICE_NAME': '0', 04:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:20 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-r7tLcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4KlYG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Px2Pm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-24mUmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BZLHeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-fD0m2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-_fQQrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pVxO3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zdCYrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Rdkjyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:21 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-XZXQVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cq18k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-NG7P96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-TO5UVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yAIU3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Bd8_Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:22 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-GaVrSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:39:22 INFO - Running setup.py install for manifestparser 04:39:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:39:22 INFO - Running setup.py install for mozcrash 04:39:22 INFO - Running setup.py install for mozdebug 04:39:23 INFO - Running setup.py install for mozdevice 04:39:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozfile 04:39:23 INFO - Running setup.py install for mozhttpd 04:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozinfo 04:39:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozInstall 04:39:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:39:23 INFO - Running setup.py install for mozleak 04:39:23 INFO - Running setup.py install for mozlog 04:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for moznetwork 04:39:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozprocess 04:39:24 INFO - Running setup.py install for mozprofile 04:39:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozrunner 04:39:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:39:24 INFO - Running setup.py install for mozscreenshot 04:39:24 INFO - Running setup.py install for moztest 04:39:25 INFO - Running setup.py install for mozversion 04:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:39:25 INFO - Cleaning up... 04:39:25 INFO - Return code: 0 04:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:25 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:25 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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:25 INFO - 'HOME': '/Users/cltbld', 04:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:25 INFO - 'LOGNAME': 'cltbld', 04:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:25 INFO - 'MOZ_NO_REMOTE': '1', 04:39:25 INFO - 'NO_EM_RESTART': '1', 04:39:25 INFO - 'PAGER': '/bin/cat', 04:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:25 INFO - 'PWD': '/builds/slave/test', 04:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:25 INFO - 'SHELL': '/bin/bash', 04:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:25 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:25 INFO - 'USER': 'cltbld', 04:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:25 INFO - 'XPC_FLAGS': '0x0', 04:39:25 INFO - 'XPC_SERVICE_NAME': '0', 04:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:39:25 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Wa8Cy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:39:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:39:25 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-y2QwZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:39:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:39:25 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-czPxTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:39:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:39:25 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-HmJZEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:39:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:39:25 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wgcgv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ud9dXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pBI699-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-7QS8YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-FulD4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-L5tEzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-XSURSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-YtKyOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-vFoViu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:39:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:39:26 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-sCiyYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:39:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Nr3LD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:39:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:39:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-FCDtrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:39:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:39:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-806G75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:39:27 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:27 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:27 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:27 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:27 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:27 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:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:39:27 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:27 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:27 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:27 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:27 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:27 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:29 INFO - Downloading blessings-1.6.tar.gz 04:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:39:29 INFO - Installing collected packages: blessings 04:39:29 INFO - Running setup.py install for blessings 04:39:29 INFO - Successfully installed blessings 04:39:29 INFO - Cleaning up... 04:39:29 INFO - Return code: 0 04:39:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:30 INFO - Reading from file tmpfile_stdout 04:39:30 INFO - Current package versions: 04:39:30 INFO - blessings == 1.6 04:39:30 INFO - blobuploader == 1.2.4 04:39:30 INFO - docopt == 0.6.1 04:39:30 INFO - manifestparser == 1.1 04:39:30 INFO - mozInstall == 1.12 04:39:30 INFO - mozcrash == 0.16 04:39:30 INFO - mozdebug == 0.1 04:39:30 INFO - mozdevice == 0.48 04:39:30 INFO - mozfile == 1.2 04:39:30 INFO - mozhttpd == 0.7 04:39:30 INFO - mozinfo == 0.9 04:39:30 INFO - mozleak == 0.1 04:39:30 INFO - mozlog == 3.1 04:39:30 INFO - moznetwork == 0.27 04:39:30 INFO - mozprocess == 0.22 04:39:30 INFO - mozprofile == 0.28 04:39:30 INFO - mozrunner == 6.11 04:39:30 INFO - mozscreenshot == 0.1 04:39:30 INFO - mozsystemmonitor == 0.0 04:39:30 INFO - moztest == 0.7 04:39:30 INFO - mozversion == 1.4 04:39:30 INFO - psutil == 3.1.1 04:39:30 INFO - requests == 1.2.3 04:39:30 INFO - wsgiref == 0.1.2 04:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:39:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:30 INFO - 'HOME': '/Users/cltbld', 04:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:30 INFO - 'LOGNAME': 'cltbld', 04:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:30 INFO - 'MOZ_NO_REMOTE': '1', 04:39:30 INFO - 'NO_EM_RESTART': '1', 04:39:30 INFO - 'PAGER': '/bin/cat', 04:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:30 INFO - 'PWD': '/builds/slave/test', 04:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:30 INFO - 'SHELL': '/bin/bash', 04:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:30 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:30 INFO - 'USER': 'cltbld', 04:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:30 INFO - 'XPC_FLAGS': '0x0', 04:39:30 INFO - 'XPC_SERVICE_NAME': '0', 04:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 INFO - Cleaning up... 04:39:30 INFO - Return code: 0 04:39:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:39:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:39:30 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 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:30 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:30 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:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:30 INFO - 'HOME': '/Users/cltbld', 04:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:30 INFO - 'LOGNAME': 'cltbld', 04:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:30 INFO - 'MOZ_NO_REMOTE': '1', 04:39:30 INFO - 'NO_EM_RESTART': '1', 04:39:30 INFO - 'PAGER': '/bin/cat', 04:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:30 INFO - 'PWD': '/builds/slave/test', 04:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:30 INFO - 'SHELL': '/bin/bash', 04:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:39:30 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:30 INFO - 'USER': 'cltbld', 04:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:30 INFO - 'XPC_FLAGS': '0x0', 04:39:30 INFO - 'XPC_SERVICE_NAME': '0', 04:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:39:30 INFO - Downloading/unpacking jsonschema 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:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:39:33 INFO - Downloading/unpacking functools32 (from jsonschema) 04:39:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:39:33 INFO - warning: no files found matching '*.txt' 04:39:33 INFO - no previously-included directories found matching 'build' 04:39:33 INFO - no previously-included directories found matching 'dist' 04:39:33 INFO - no previously-included directories found matching '.git*' 04:39:33 INFO - Installing collected packages: jsonschema, functools32 04:39:33 INFO - Running setup.py install for functools32 04:39:33 INFO - warning: no files found matching '*.txt' 04:39:33 INFO - no previously-included directories found matching 'build' 04:39:33 INFO - no previously-included directories found matching 'dist' 04:39:33 INFO - no previously-included directories found matching '.git*' 04:39:33 INFO - Successfully installed jsonschema functools32 04:39:33 INFO - Cleaning up... 04:39:33 INFO - Return code: 0 04:39:33 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fd1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fd84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c9add13a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, '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.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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', 'flake8'] 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 flake8 04:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/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.6kHzn1ximb/Listeners', 04:39:33 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 flake8 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 flake8-2.5.0-py2.py3-none-any.whl 04:39:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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 mccabe-0.3.1-py2.py3-none-any.whl 04:39:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from 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:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:37 INFO - no previously-included directories found matching 'docs/_build' 04:39:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:39:37 INFO - Running setup.py install for pep8 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:39:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:39:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:39:37 INFO - no previously-included directories found matching 'docs/_build' 04:39:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:39:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:39:37 INFO - Cleaning up... 04:39:37 INFO - Return code: 0 04:39:37 INFO - Running post-action listener: _resource_record_post_action 04:39:37 INFO - Running post-action listener: _start_resource_monitoring 04:39:37 INFO - Starting resource monitoring. 04:39:38 INFO - ##### 04:39:38 INFO - ##### Running install step. 04:39:38 INFO - ##### 04:39:38 INFO - Running pre-action listener: _resource_record_pre_action 04:39:38 INFO - Running main action method: install 04:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:39:38 INFO - Reading from file tmpfile_stdout 04:39:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:39:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:39:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:39:38 INFO - Reading from file tmpfile_stdout 04:39:38 INFO - Output received: 04:39:38 INFO - Usage: mozinstall [options] installer 04:39:38 INFO - Options: 04:39:38 INFO - -h, --help show this help message and exit 04:39:38 INFO - -d DEST, --destination=DEST 04:39:38 INFO - Directory to install application into. [default: 04:39:38 INFO - "/builds/slave/test"] 04:39:38 INFO - --app=APP Application being installed. [default: firefox] 04:39:38 INFO - mkdir: /builds/slave/test/build/application 04:39:38 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:38 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:12 INFO - Reading from file tmpfile_stdout 04:40:12 INFO - Output received: 04:40:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:40:12 INFO - Running post-action listener: _resource_record_post_action 04:40:12 INFO - ##### 04:40:12 INFO - ##### Running run-tests step. 04:40:12 INFO - ##### 04:40:12 INFO - Running pre-action listener: _resource_record_pre_action 04:40:12 INFO - Running main action method: run_tests 04:40:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:40:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:40:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:40:12 INFO - 2016-02-06 04:40:12.333 screenresolution[1767:15615] starting screenresolution argv=screenresolution get 04:40:12 INFO - 2016-02-06 04:40:12.336 screenresolution[1767:15615] Display 0: 1600x1200x32@60 04:40:12 INFO - 2016-02-06 04:40:12.342 screenresolution[1768:15618] starting screenresolution argv=screenresolution list 04:40:12 INFO - Available Modes on Display 0 04:40:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:40:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:40:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:40:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:40:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:40:12 INFO - Intel Iris: 04:40:12 INFO - Chipset Model: Intel Iris 04:40:12 INFO - Type: GPU 04:40:12 INFO - Bus: Built-In 04:40:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:40:12 INFO - Vendor: Intel (0x8086) 04:40:12 INFO - Device ID: 0x0a2e 04:40:12 INFO - Revision ID: 0x0009 04:40:12 INFO - Displays: 04:40:12 INFO - Display: 04:40:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:40:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:40:12 INFO - Display Serial Number: 1600x1200 60 04:40:12 INFO - Main Display: Yes 04:40:12 INFO - Mirror: Off 04:40:12 INFO - Online: Yes 04:40:12 INFO - Rotation: Supported 04:40:12 INFO - Return code: 0 04:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:40:12 INFO - Python 2.7.3 04:40:12 INFO - Return code: 0 04:40:12 INFO - grabbing minidump binary from tooltool 04:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:12 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 0x100e76d30>, '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 0x100c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e6cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:40:12 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:12 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:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:40:12 INFO - Return code: 0 04:40:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:40:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:40:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:40:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:40:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:40:13 INFO - Return code: 0 04:40:13 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-0178', '--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:13 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-0178 --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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3Wr7qnBe77/Render', 04:40:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:40:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:40:13 INFO - 'HOME': '/Users/cltbld', 04:40:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:40:13 INFO - 'LOGNAME': 'cltbld', 04:40:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:40:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:13 INFO - 'MOZ_NO_REMOTE': '1', 04:40:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:40:13 INFO - 'NO_EM_RESTART': '1', 04:40:13 INFO - 'PAGER': '/bin/cat', 04:40:13 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:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:40:13 INFO - 'PWD': '/builds/slave/test', 04:40:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:40:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:40:13 INFO - 'SHELL': '/bin/bash', 04:40:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6kHzn1ximb/Listeners', 04:40:13 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 04:40:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:40:13 INFO - 'USER': 'cltbld', 04:40:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:40:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:13 INFO - 'XPC_FLAGS': '0x0', 04:40:13 INFO - 'XPC_SERVICE_NAME': '0', 04:40:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:40:13 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-0178', '--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:14 INFO - mozversion application_buildid: 20160203075343 04:40:14 INFO - mozversion application_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:14 INFO - mozversion application_display_name: Nightly 04:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:40:14 INFO - mozversion application_name: Firefox 04:40:14 INFO - mozversion application_remotingname: firefox 04:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:40:14 INFO - mozversion application_vendor: Mozilla 04:40:14 INFO - mozversion application_version: 47.0a1 04:40:14 INFO - mozversion platform_buildid: 20160203075343 04:40:14 INFO - mozversion platform_changeset: 46d6d868ba0f8ae089da8882b594fe359eba2978 04:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:40:14 INFO - mozversion platform_version: 47.0a1 04:40:14 INFO - using testdate: 1454762414 04:40:14 INFO - actual date: 1454762414 04:40:14 INFO - starting webserver on 'localhost:49272' 04:40:14 INFO - SUITE-START | Running 2 tests 04:40:14 INFO - TEST-START | dromaeo_css 04:40:14 INFO - operating with platform_type : mac_ 04:40:14 INFO - Initialising browser for dromaeo_css test... 04:40:14 INFO - TEST-INFO | started process 1786 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpxC8j9N/profile http://localhost:49272/getInfo.html) 04:40:14 INFO - PROCESS | 1786 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:40:17 INFO - PROCESS | 1786 | __metrics Screen width/height:1600/1200 04:40:17 INFO - PROCESS | 1786 | colorDepth:24 04:40:17 INFO - PROCESS | 1786 | Browser inner width/height: 1024/689 04:40:17 INFO - PROCESS | 1786 | __metrics 04:40:17 INFO - PROCESS | 1786 | 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:17 INFO - PROCESS | 1786 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:40:17 INFO - TEST-INFO | 1786: exit 0 04:40:17 INFO - Browser initialized. 04:40:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:40:17 INFO - TEST-INFO | started process 1790 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpxC8j9N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:29 INFO - PROCESS | 1790 | RSS: Main: 242626560 04:40:29 INFO - PROCESS | 1790 | 04:41:20 INFO - PROCESS | 1790 | 1454762480803 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:32 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 04:43:33 INFO - PROCESS | 1790 | RSS: Main: 380657664 04:43:33 INFO - PROCESS | 1790 | 04:46:35 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 04:46:36 INFO - PROCESS | 1790 | RSS: Main: 379908096 04:46:36 INFO - PROCESS | 1790 | 04:49:38 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 04:49:39 INFO - PROCESS | 1790 | RSS: Main: 380047360 04:49:39 INFO - PROCESS | 1790 | 04:52:41 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 04:52:42 INFO - PROCESS | 1790 | RSS: Main: 345862144 04:52:42 INFO - PROCESS | 1790 | 04:55:45 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 04:55:45 INFO - PROCESS | 1790 | RSS: Main: 341856256 04:55:45 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 04:58:48 INFO - PROCESS | 1790 | RSS: Main: 393662464 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | __start_tp_report 04:58:48 INFO - PROCESS | 1790 | _x_x_mozilla_page_load 04:58:48 INFO - PROCESS | 1790 | _x_x_mozilla_page_load_details 04:58:48 INFO - PROCESS | 1790 | |i|pagename|runs| 04:58:48 INFO - PROCESS | 1790 | |0;dojo.html;2979.3296508285634;3307.2393349529607;3426.1943528851125;3430.5540279763613;3512.2799826035666;5442;5537.501624853762;5554.000279949608;5557.110862262034;5631.09902415613;5513.448655134484;5579.442055794429;5594.468525490082;5597.496225339719;5600.103983362663;5047.798088076473;5052.26742122392;5070.670406423589;5117.795288188468;5145.919356935029;5069.898602027957;5157.948420515784;5166.43169251382;5167.250748641445;5169.767360468769;4317.676174286926;5142.997115562467;5150.1759718445055;5152.716600586966;5158.252053452247;5103.030424219405;5128.717920514388;5142.151544995071;5148.124818780816;5151.995360904625;4679.953200467986;4920.8031678732805;5146.356705411824;5147.794088236466;5155.7679904404395;5518.751656175482;5542.806001789918;5552.194931734876;5552.944470555323;5589.524890384322;5226.588821018342;5928.992071347881;6068.089786532011;6120;6122.295935967376;5193.8961220775755;6042.063480160582;6085.868280789563;6092.208012958287;6118.375534461864;5618.578606604521;5639.661620302795;5664.716764161775;5665.291838520185;5665.773369065274;6159.538034647419;6170.50635949123;6176.505879529627;6180.949238629444;6183.3816618337805;5864.736086876101;5925.288965324103;5930.673812940329;5988.251468566429;6039.78860739872;5099.6685215460875;6038.758449662052;6101.60339577926;6140.986737188314;6152.200213972155;6079.240094988127;6088.4215999479975;6102.877942441126;6110.083487476825;6113.144159817629;5971.8231578111445;6000.369961154016;6059.545534084961;6097.585173720644;6129.63387754696;4784.186688263004;4800.4719480857075;4805.1590971579835;4807.831725889577;4816.397950256218;4324.091940692427;4326.805293761789;4345.196138714348;4359.629431498295;4361.978190109029;5528.281323427928;5560.082586373284;5567.387587365387;5568.248286481355;5585.106382978704;6097.766665674493;6110.541709371815;6133.754649814046;6138.948294125945;6162.044883043135;5598.4961353477565;5603.635763675429;5613.326400831927;5620.690862002629;5631.605787594911;5234.476552344811;5250.18622113573;5250.842474725764;5255.658382205144;5304.469553044664;6097.82716539334;6144.986077297374;6173.166622505904;6185.628862268279;6272.341404152589;6089.969550152398;6131.724072416663;6145;6153.107799369156;6159.19930409044;6147.907032133833;6172.475339596184;6192.225971753531;6193.442590166726;6201.3178550358525;5874.441928016831;5969.313528944227;5969.701514924323;6005.90991135142;6010.669413182317;6098;6122.703114648804;6138.416850399205;6164.321924588381;6166.260048794174;5966.731497082728;5968.253968253968;5968.46283834457;5971.790987315423;5978.312494063239;5781.624194427349;5866.2960444745195;5911.438413350725;5920.79277225295;5965.403459654;4644.838790302424;5562.5549956002615;5724.169995350568;5736.110902810071;5774.682392468287;5922.703864806828;5927.881442371042;5959.91060134107;5972.402759724167;6017.699115044143;5683.914741278802;5756.107803290497;5784.363719990882;5796.594238403271;5796.62321949072 04:58:48 INFO - PROCESS | 1790 | |1;ext.html;490.06642346330256;490.76443307212537;504.7425812835455;582.8517819894809;582.8950788858006;25064.74935250647;31025.844870775643;38310.61689383102;38522.807385963104;38551.614483855155;41631.583684163146;41950.370744438784;42067.57932420675;42133.78933105338;42161.36757948626;8112.5943702814775;9735.464549449778;9739.318247722627;9742.756431089208;9743.123118919295;9585.712428627152;9754.219662426989;9759.999999999964;9768.902310976906;9889.06053924876;9801.803963920718;9874.555644995957;9901.10890019898;9907.405555666683;9919;9805.754856128582;9883.950580247125;9886.505674716236;9910.702678919644;9924.106830385228;9616.374935629161;9785.315027948047;9789.755256118582;9789.951050244774;9804.215662746963;39630.009249768984;39949.60050399488;40008.79973600797;40065.39901901474;40150.59849401498;3140.98429507851;3143.3713257348622;3257.990023092849;3300.6204286506877;3509.5788505379264;28931.855340723374;29010.41979160405;29331.266718331997;29639.962601309067;29985.70014299851;2764.834109953409;2784.568391899259;2784.763295119917;2795.7344052314997;2976.0179140883456;482179;487313;489360.5531972353;489927;490696.5465172687;56671;57985.420145798;58179;62158.37841621526;65581;53111.73444132755;65217;65411.34588654053;65442;65454;16362.754558681629;16546.58633534171;16574;16593.253303601366;16607.667846643;11630.418479076012;11843.940780296216;11862.940685296518;11865.584704535473;11993.520259189709;20620.381388558366;21264.78735212628;21328.36014919555;21332.78667213308;21362.038708258166;7850.332721718718;8802.603882825288;8890.666400040045;8999.415038022638;9042.050584688644;800.9559474228973;809.9473534220375;919.7884486568126;942.1097063275276;1020.0411613083678;27731.168064958085;28163.859180703967;28421.57367639487;28464.85767571149;28633.713662863105;1074.4198133008244;1080.448971024783;1081.983770243447;1089.6785448292774;1189.7858385490695;14659.58116910719;14783;14791.630209244855;15111.848881511263;15128.697426051418;663495;670743;671401;671764;676096;52104.73947630238;53124.93750124976;59576.70211648914;60635.69682151649;61597;1391.2209162868826;1402.235781499065;1432.5702289313372;1434.5839706485003;1436.4182506085053;27838.642201652758;29920.700792991793;30231.093067208018;30288.69711302859;30608.84695576508;54709;54924.90150197053;55316.72341638266;55333.1700024508;55454.168187478026;516043;516517.51342379366;516889;517709;519593;33095.50356744699;33294.33411331808;33438.83280583582;33452.498212527316;33529.994100177035;43345.78327108344;44416.44542440999;44656.33015504835;44718.55281447144;45021.77489112534;36342.818285908405;36958.52165913441;37028.44457333196;37218.8139059303;37491.81254093712;36912.44631330478;37808.810955945046;37833.054173645876;38503.61496385113;38606.2278754429;34791.78228761981;34988.30023399569;35539.82230088833;35874;36081.81959090293;31163;32422.027339179862;32642.836785815918;32740;33010.33979320352;24786.884590193124;24827.87586062058;25141.74858251394;25226.99092036298;25402.983880645308 04:58:48 INFO - PROCESS | 1790 | |2;jquery.html;363.52378384316546;366.39910546703413;366.48142877827877;372.3390981008709;373.432382778177;12675.936620316908;15449.653731727476;18556.62886742266;19548.804511954877;20408.489787755294;11732.648020559376;11933.331667457953;12054.276743395381;12067.4569644366;19319.903400483014;3936.8031598419966;5192.818251361203;5377.542908852753;5383.838484845461;5389.622726409153;4035.132446523997;4089.5297040840237;4724.952750472486;5929.525637948954;5941.465268125868;5658.122990936391;5906.05503119501;5921.555883308748;5928.1404196391495;5929.28848538176;5809.622374545641;5881.588288819784;5882.911756323637;5897.498712609433;5900.97049514754;5416.566674666056;5575.637583557096;5583.469570390806;5584.246126772874;5588.832335029955;13347.998900082534;22012.449688757748;23644.881775591184;24507.774611269364;24560.140395086088;2078.688196770481;2080.8543401961715;2098.223657246813;2144.4960434297927;2147.667111597689;9497.857532137023;9663.855042174373;9929.156021738161;10779.461026948622;14638.341274642667;1682.116888633465;1717.4160785333047;1723.3451288510412;1729.688656041912;1742.6950283700303;95388.04611953862;96290.51854740751;96648.0335196646;97134.51432742862;98367;10989.06592939593;11065;11091.168162387854;11109.500072496758;11219.046381057702;11686.415679216005;13003.674908127372;13225.412950445816;13426.932865335806;13445;8355.331573474108;8368.288695460955;8382.455140415854;8445.619947102396;8478.364122690822;8418.663253469915;8424.073351931283;8447.113053129457;8524.914750852537;8534.829303413897;3676.540432445944;3969.166475040216;4148.62662360389;4159.875203743893;4321.092570560155;1557.5093845438878;1590.8965917215344;1750.3173762232739;1761.9164214008292;1840.3834715370233;411.4096271849905;879.9296056315479;921.1801496667971;945.9432434053979;995.3082607587658;9897.070071336164;11302.039326657326;11355.205135640426;11522.251053681652;11931.522739090513;400.9615096899046;404.27432758199103;441.17500274486275;453.08929052604503;458.13412650091357;6020.096985452217;6120.234970628671;10888.029735337526;11370.658880233606;11376.089912806956;589287.0535647294;590702;596904;600898;777928;72024.63987680028;90176;111755.85342806224;113748.43125784319;114845;943.6932996776076;1149.827525871126;1177.3230392524333;1181.3030312115893;1193.964181074569;17393.652126957644;17773.822261777215;18223.271069157614;18279;18544.721829172304;47003.52996470128;48037.27210534446;49862.750686246334;50729.98540029253;52926.73536632292;69592.6520367395;70130;70582;70783.64608176926;72200;7551.320381165721;7704.499207551491;7772.494787838772;7795.961020194863;7827.686892524235;10859.402732849454;11948.76102477963;12052.457639406422;12156.24906555576;12236.510539578318;10149.746256343651;10284.485775711335;10302.896971030494;10476.057154855795;10578.038149318203;5292.814751483679;7839.764807055797;7904.288614024766;10193.74515637115;10434.530446130095;9999.30004899679;10269.537870795682;10275.794484110127;10447.05976462122;10529.736756581147;6839.487038472035;7111.466640001917;7576.431767617561;7610.9238907610215;7612.961935190288;8607.526586037828;9881.752956176153;10228.795424091328;10514.737131571772;10554.261201715806 04:58:48 INFO - PROCESS | 1790 | |3;mootools.html;1390.2145287912335;1505.5633866178805;1540.2375823967138;1769.363029309449;1936.051334845926;7845.215478452152;8036.156203598625;8498.872516912252;8706;8711.346649001334;8445.49327040378;8511.829763404729;8627.051024387312;8630.95684521578;8649.437786543871;2073.8237249833783;2167.4798048468333;2219.533897881439;2495.3761559610098;2499;2258.7176602924633;2265.286434773041;2266.444721043347;2267.7278726552754;2401.5797235483806;2436.622323539845;2464.605663093905;2474.134053081425;2475.1337032038823;2477.417806815397;2040.6224848403092;2257.3115199864037;2301.838871279011;2482.0196022571163;2484.2795589279085;2413.9758602414104;2459.4589190378088;2462.5444292805887;2470.518248941457;2471.7404672509306;8665.523396213206;8763.430377025474;8765.123487651248;8770;8782.60478278479;5337.412884582693;5513.724313784335;5513.972430137824;5516.475934786189;5517.586181036439;3606.549181352331;3608.5308909841815;3641.107928557494;3714.405695088773;3724.9570120366343;1048.234788604323;1060.7560261139904;1064.2816099133054;1087.374759513283;1091.2148793035187;11846.822297665456;11872.287662740177;11880.821787673192;11891.94054029733;11920.701982450508;4849.636277279218;4860.4896485869185;4963.677360971526;4977.9751101244265;4988.426330971912;10125.746856328504;10127.746806329753;10147.543360548792;10164.695059148238;10201.13290370312;5454.836354909359;5506.944930550723;5513.476219759116;5513.669179849222;5517.503424691797;4950.2079667253065;4968.652194346361;5003.049420610072;5011.874703132451;5017.648764586517;3917.334053210961;3923.843046278117;3950.644442000234;3957.1887763008513;4007.699422543321;1096.6435908329825;1194.9522019119138;1225.136278923357;1225.2036176485178;1225.969350766238;1100.2848148703406;1103.542030057533;1118.5693507999315;1130.4178348150708;1178.4991378664033;7920.841583168304;7957.323627491613;8010.79973000668;8040.67837286502;8045.5574943377505;1110.1396417776289;1129.6498085593328;1179.1097721220424;1185.585045234161;1220.2922305063041;6215.098810672427;6270.7491700331475;6279.717412716439;6280.403361680633;6290.402411770874;10010.299279050396;10736.08743256832;10747.892521074846;10874.130069594414;10887.618933337295;10401.323913945569;10698.304610200312;10723.83914241287;10740.731481712863;10767.407792571326;8128.431009829255;8276.917230827736;8287;8326.875096873551;8334;7746.070471543451;7783.961080194563;7795.86959890824;7826.139124696393;7869.8819517708425;9370;9443.763905902408;9480.810383792148;9544.618215271312;9632.95183524078;9657.71026869195;9787.314887958059;9896.851547226654;10021;10023.348482348623;6994.090768200102;7097.183823860322;7097.680604372712;7098.858022839618;7222.458315626244;7844.450888437755;7942.761717148494;7943.364530837634;7943.642536085775;7955.1249362571225;6266;7308.817279568053;7394.149672787698;7483.214262502359;7534.246575342422;7114.110736157981;7220.711171553289;7222.277772222736;7228.385587224934;7302.853942921218;7453.552786832807;7534;7537.736179233701;7542.849143017219;7559.979402780555;6761.763338283136;6775.254721980479;6839.042534045338;6840.897386539106;6846.760363387258;6927.930720692729;6986.406155476841;6994.33553812387;7002.404795592432;7006.369426751617 04:58:48 INFO - PROCESS | 1790 | |4;prototype.html;321.96780321967805;329.09334782673733;331.1043626988995;333.5513734027732;338.8238116179588;6383.936160638392;6678.699458524366;6682.565633233842;6690.76582319619;6714.96642516788;6601.669916504167;6664.633445160514;6665.533412661116;6669.866602667944;6679.398854103129;4505.234110201273;4746;4831.251156070797;4988.251762235657;4989.525995030466;4039.676825853939;4950.356453661019;4982.775775090112;4987.376577927759;4996.200607902736;4911.16510193268;4918.237673160648;4920.876978075541;4928.1129396708575;4933.531314525115;4193.475815523059;4685.953140468586;4754.405699287589;4932.950670493303;4934.1365261079345;4091.509018917719;4117.402976568381;4166.83332666693;4171.10321280923;4181.289180839264;6338.080978258173;6356.2054743157105;6388;6389.616623002588;6396.872062558769;5398.568114550866;5483.506484416382;5775.942240577624;5785.190073389729;5792.82621521355;6907.34380233877;7078.964605176941;7098.36114749675;7116.359527642537;7127.10911136108;3852.768833869977;4658.091672123937;4666.65000124992;4669.766511674403;4674.69614475058;7202.783916482514;7508;7535;7535.246475352421;7536.057992750906;4555.293929440942;4777.235642297216;4784.665073444826;4791.137595232822;4800.927986080212;4374.671899607542;4833.912369716785;4866.46468888422;4869.975650121798;4879.609631229493;5763.077907534858;5793.884122317614;5797.47822695951;5805.419458054161;5818.272715910512;6873.965630171917;7147.606881621561;7187.7843664690145;7189.96405017982;7204.171520275236;1669.74953756935;1694.432365157686;1696.0841145781387;1697.932082716702;1701.4215166843085;1096.8025755363951;1105.4196546812987;1112.0714203639889;1121.3047910295668;1126.4367816091954;6691.665416729242;6706.66466676674;6707.5975441473665;6729.629870357079;6775.085363475966;7417.332440080419;7421.517601355895;7426.925730742623;7450.403967682572;7453;6545.116409284781;6726.3520437493125;6730.831729206711;6766.763163289262;6823.795286141423;3302.6862448067395;3945.3095708251517;3980.5422376426504;3987.481627388479;3987.7407968481957;7627.466077374531;7825.256600622932;7844.646990885424;7858.0963189232825;7887.960560197277;6139.324674285825;7354.2645735427095;7503.0889570401405;7601.429892758065;7692.961450204262;7717.768466946;7721.343685786771;7724.420668449889;7729.729459469004;7730.729424470116;7280.417566594766;7377.188509264084;7397.519161254501;7398.11222653285;7433.922081298289;7100.396466300423;7267.709291628275;7278.163011253773;7293.9635301823155;7330.450216233698;7713.537187768752;7770.300672939463;7832.490888092256;7843.921560784547;7844.137144913941;4595.310703394518;4641.930371044505;4651.348811166507;4662.904217508815;4663.370444989883;6118.694065296806;7194.532355396883;7371.741989030358;7415.962920185365;7467.850642987219;7171.139463264233;7185.317394847481;7186.173590037212;7191.928080719335;7201.243869393638;6884.690188941609;7182.712691492282;7185.964070179824;7193.172785129568;7208.423326133792;7007.649617519001;7011.754588589375;7012.719491220498;7014.2635023323855;7018.613976231152;5817.825465236049;7181.928180718126;7182.640867956686;7196.568205907663;7211.783646490614;6833.214180369321;6974.930250697631;7007.229204787572;7051.435885129074;7054.541454805421 04:58:48 INFO - PROCESS | 1790 | |5;yui.html;716.4197000429649;724.2942869542231;730.3791776989559;735.8381156145648;763.313018283545;14235.572932812007;14363.42546298148;14440.205788681631;16699.74950375745;17259.39592114276;15322.463713770021;15357.539273821803;15400.537983860475;15444.922775386107;15446.150461724601;706.4348521183033;719.0688058963628;719.6150059718052;846.6994217052935;881.2289246908955;872.4721543466206;876.6843936182969;883.2227639677075;883.5935469683953;885.3625389719392;921.7188757428981;923.9722808315728;924.2098006204699;925.3152667026419;926.4580220570974;741.929516695913;753.5591678867814;756.4251169111515;757.3940847322175;930.8743319651828;563.7801257509575;566.0829456280851;678.8506528563709;692.1313751242159;693.3551796828947;14583.854161458356;14944.252787360698;14953.551393458214;14969.251537423086;14993.550193494213;12174.330411827346;12421.627351179479;12511.56209532662;12696.428660710199;12869.871301286961;9964.153046991014;10010.249231307682;10142.594296228215;10163.186945044452;10733.946330268298;3439.8280085995602;3471.288385880888;3472.5138480612736;3473.201163732356;3474.027272363742;75749;76464;78414;79129;79183.60408197979;9183.989761126271;9290.16388525036;9515.714528564155;9532.142107210384;9705.883823360262;19447.8055219446;19477.610447790965;19626.90186549058;19630.312939047064;19656.57727011411;7375;7465.253474652492;7577.734779282699;7678.385729141655;7801.414893882981;4038.0914294283552;4092.8362865485046;4113.465249517543;4190.434291370687;4325.675574331937;3426.9657303427143;3457.3258214647904;3463.290025544757;3464.6708562686504;3472.236108056274;633.1737083106498;646.8382904273932;654.3423859021652;661.8345413646589;664.0205696597577;515.1962937817018;534.7326336831584;554.1991821817435;575.114323941126;625.849796048945;8127.878081828777;8684.522351270614;8698.043215246318;9029.09709029105;9119.08809119096;457.77340216593;478.69124414752986;566.9007923613351;596.3291297290548;646.253577118429;3328.7350806693785;3670.284294562535;3759.3797023491366;3852.3836186210074;3893.396523538856;72925;88127.91552295767;89176.6623500648;91397;92129.5393523028;77833;77871;77992.61654352593;78099.60950195213;78331.21668783353;64482.67758661271;66206.33793662098;66233;66887.33112668908;67036.6648166756;7985.8802117969435;8109.7161599343735;8185.0996390398195;8240.50556966584;8316.334693224648;50235;51139.74430127825;51198.74400627973;51291.974160515834;51777.482225177264;65797;66629.66685166543;66639.66680166568;67863;67902;10768;10802.459877005962;10909.727256818644;11035.227534072537;11436.813513620576;11982.340971246666;12324.630261092181;12325.568605098779;12432.502699891904;12585.056120790794;11202.327860328407;11257;11352.489137988976;11480.483378247833;11892.643220703392;11135.554577816796;11323.716907077389;11332.093432525213;11666.70833229176;11859.70350741204;10100.090991810772;10230.6419275325;10234.976502349706;10275.177985761271;10705.19711021661;9112.817743644957;9514.38156519824;9612.18296444782;9650.565724542272;9958.253131015348;8151.877721834058;9106.950250264701;9262.72211833646;9801.50992450389;9871.40771553709 04:58:48 INFO - PROCESS | 1790 | __end_tp_report 04:58:48 INFO - PROCESS | 1790 | __start_cc_report 04:58:48 INFO - PROCESS | 1790 | _x_x_mozilla_cycle_collect,1076 04:58:48 INFO - PROCESS | 1790 | __end_cc_report 04:58:48 INFO - PROCESS | 1790 | __startTimestamp1454763528917__endTimestamp 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | ------- Summary: start ------- 04:58:48 INFO - PROCESS | 1790 | Number of tests: 6 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | [#0] dojo.html Cycles:165 Average:5587.13 Median:5736.11 stddev:627.80 (10.9%) stddev-sans-first:595.46 04:58:48 INFO - PROCESS | 1790 | Values: 2979.3 3307.2 3426.2 3430.6 3512.3 5442.0 5537.5 5554.0 5557.1 5631.1 5513.4 5579.4 5594.5 5597.5 5600.1 5047.8 5052.3 5070.7 5117.8 5145.9 5069.9 5157.9 5166.4 5167.3 5169.8 4317.7 5143.0 5150.2 5152.7 5158.3 5103.0 5128.7 5142.2 5148.1 5152.0 4680.0 4920.8 5146.4 5147.8 5155.8 5518.8 5542.8 5552.2 5552.9 5589.5 5226.6 5929.0 6068.1 6120.0 6122.3 5193.9 6042.1 6085.9 6092.2 6118.4 5618.6 5639.7 5664.7 5665.3 5665.8 6159.5 6170.5 6176.5 6180.9 6183.4 5864.7 5925.3 5930.7 5988.3 6039.8 5099.7 6038.8 6101.6 6141.0 6152.2 6079.2 6088.4 6102.9 6110.1 6113.1 5971.8 6000.4 6059.5 6097.6 6129.6 4784.2 4800.5 4805.2 4807.8 4816.4 4324.1 4326.8 4345.2 4359.6 4362.0 5528.3 5560.1 5567.4 5568.2 5585.1 6097.8 6110.5 6133.8 6138.9 6162.0 5598.5 5603.6 5613.3 5620.7 5631.6 5234.5 5250.2 5250.8 5255.7 5304.5 6097.8 6145.0 6173.2 6185.6 6272.3 6090.0 6131.7 6145.0 6153.1 6159.2 6147.9 6172.5 6192.2 6193.4 6201.3 5874.4 5969.3 5969.7 6005.9 6010.7 6098.0 6122.7 6138.4 6164.3 6166.3 5966.7 5968.3 5968.5 5971.8 5978.3 5781.6 5866.3 5911.4 5920.8 5965.4 4644.8 5562.6 5724.2 5736.1 5774.7 5922.7 5927.9 5959.9 5972.4 6017.7 5683.9 5756.1 5784.4 5796.6 5796.6 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | [#1] ext.html Cycles:180 Average:69244.18 Median:39118.12 stddev:150837.20 (385.6%) stddev-sans-first:151172.01 04:58:48 INFO - PROCESS | 1790 | Values: 490.1 490.8 504.7 582.9 582.9 25064.7 31025.8 38310.6 38522.8 38551.6 41631.6 41950.4 42067.6 42133.8 42161.4 8112.6 9735.5 9739.3 9742.8 9743.1 9585.7 9754.2 9760.0 9768.9 9889.1 9801.8 9874.6 9901.1 9907.4 9919.0 9805.8 9884.0 9886.5 9910.7 9924.1 9616.4 9785.3 9789.8 9790.0 9804.2 39630.0 39949.6 40008.8 40065.4 40150.6 3141.0 3143.4 3258.0 3300.6 3509.6 28931.9 29010.4 29331.3 29640.0 29985.7 2764.8 2784.6 2784.8 2795.7 2976.0 482179.0 487313.0 489360.6 489927.0 490696.5 56671.0 57985.4 58179.0 62158.4 65581.0 53111.7 65217.0 65411.3 65442.0 65454.0 16362.8 16546.6 16574.0 16593.3 16607.7 11630.4 11843.9 11862.9 11865.6 11993.5 20620.4 21264.8 21328.4 21332.8 21362.0 7850.3 8802.6 8890.7 8999.4 9042.1 801.0 809.9 919.8 942.1 1020.0 27731.2 28163.9 28421.6 28464.9 28633.7 1074.4 1080.4 1082.0 1089.7 1189.8 14659.6 14783.0 14791.6 15111.8 15128.7 663495.0 670743.0 671401.0 671764.0 676096.0 52104.7 53124.9 59576.7 60635.7 61597.0 1391.2 1402.2 1432.6 1434.6 1436.4 27838.6 29920.7 30231.1 30288.7 30608.8 54709.0 54924.9 55316.7 55333.2 55454.2 516043.0 516517.5 516889.0 517709.0 519593.0 33095.5 33294.3 33438.8 33452.5 33530.0 43345.8 44416.4 44656.3 44718.6 45021.8 36342.8 36958.5 37028.4 37218.8 37491.8 36912.4 37808.8 37833.1 38503.6 38606.2 34791.8 34988.3 35539.8 35874.0 36081.8 31163.0 32422.0 32642.8 32740.0 33010.3 24786.9 24827.9 25141.7 25227.0 25403.0 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | [#2] jquery.html Cycles:180 Average:33247.34 Median:2246.90 stddev:104917.47 (4669.4%) stddev-sans-first:105182.73 04:58:48 INFO - PROCESS | 1790 | Values: 363.5 366.4 366.5 372.3 373.4 12675.9 15449.7 18556.6 19548.8 20408.5 11732.6 11933.3 12054.3 12067.5 19319.9 3936.8 5192.8 5377.5 5383.8 5389.6 4035.1 4089.5 4725.0 5929.5 5941.5 5658.1 5906.1 5921.6 5928.1 5929.3 5809.6 5881.6 5882.9 5897.5 5901.0 5416.6 5575.6 5583.5 5584.2 5588.8 13348.0 22012.4 23644.9 24507.8 24560.1 2078.7 2080.9 2098.2 2144.5 2147.7 9497.9 9663.9 9929.2 10779.5 14638.3 1682.1 1717.4 1723.3 1729.7 1742.7 95388.0 96290.5 96648.0 97134.5 98367.0 10989.1 11065.0 11091.2 11109.5 11219.0 11686.4 13003.7 13225.4 13426.9 13445.0 8355.3 8368.3 8382.5 8445.6 8478.4 8418.7 8424.1 8447.1 8524.9 8534.8 3676.5 3969.2 4148.6 4159.9 4321.1 1557.5 1590.9 1750.3 1761.9 1840.4 411.4 879.9 921.2 945.9 995.3 9897.1 11302.0 11355.2 11522.3 11931.5 401.0 404.3 441.2 453.1 458.1 6020.1 6120.2 10888.0 11370.7 11376.1 589287.1 590702.0 596904.0 600898.0 777928.0 72024.6 90176.0 111755.9 113748.4 114845.0 943.7 1149.8 1177.3 1181.3 1194.0 17393.7 17773.8 18223.3 18279.0 18544.7 47003.5 48037.3 49862.8 50730.0 52926.7 69592.7 70130.0 70582.0 70783.6 72200.0 7551.3 7704.5 7772.5 7796.0 7827.7 10859.4 11948.8 12052.5 12156.2 12236.5 10149.7 10284.5 10302.9 10476.1 10578.0 5292.8 7839.8 7904.3 10193.7 10434.5 9999.3 10269.5 10275.8 10447.1 10529.7 6839.5 7111.5 7576.4 7610.9 7613.0 8607.5 9881.8 10228.8 10514.7 10554.3 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | [#3] mootools.html Cycles:180 Average:6000.55 Median:5014.76 stddev:3168.14 (63.2%) stddev-sans-first:3158.07 04:58:48 INFO - PROCESS | 1790 | Values: 1390.2 1505.6 1540.2 1769.4 1936.1 7845.2 8036.2 8498.9 8706.0 8711.3 8445.5 8511.8 8627.1 8631.0 8649.4 2073.8 2167.5 2219.5 2495.4 2499.0 2258.7 2265.3 2266.4 2267.7 2401.6 2436.6 2464.6 2474.1 2475.1 2477.4 2040.6 2257.3 2301.8 2482.0 2484.3 2414.0 2459.5 2462.5 2470.5 2471.7 8665.5 8763.4 8765.1 8770.0 8782.6 5337.4 5513.7 5514.0 5516.5 5517.6 3606.5 3608.5 3641.1 3714.4 3725.0 1048.2 1060.8 1064.3 1087.4 1091.2 11846.8 11872.3 11880.8 11891.9 11920.7 4849.6 4860.5 4963.7 4978.0 4988.4 10125.7 10127.7 10147.5 10164.7 10201.1 5454.8 5506.9 5513.5 5513.7 5517.5 4950.2 4968.7 5003.0 5011.9 5017.6 3917.3 3923.8 3950.6 3957.2 4007.7 1096.6 1195.0 1225.1 1225.2 1226.0 1100.3 1103.5 1118.6 1130.4 1178.5 7920.8 7957.3 8010.8 8040.7 8045.6 1110.1 1129.6 1179.1 1185.6 1220.3 6215.1 6270.7 6279.7 6280.4 6290.4 10010.3 10736.1 10747.9 10874.1 10887.6 10401.3 10698.3 10723.8 10740.7 10767.4 8128.4 8276.9 8287.0 8326.9 8334.0 7746.1 7784.0 7795.9 7826.1 7869.9 9370.0 9443.8 9480.8 9544.6 9633.0 9657.7 9787.3 9896.9 10021.0 10023.3 6994.1 7097.2 7097.7 7098.9 7222.5 7844.5 7942.8 7943.4 7943.6 7955.1 6266.0 7308.8 7394.1 7483.2 7534.2 7114.1 7220.7 7222.3 7228.4 7302.9 7453.6 7534.0 7537.7 7542.8 7560.0 6761.8 6775.3 6839.0 6840.9 6846.8 6927.9 6986.4 6994.3 7002.4 7006.4 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | [#4] prototype.html Cycles:180 Average:5838.90 Median:6680.98 stddev:1877.76 (28.1%) stddev-sans-first:1836.81 04:58:48 INFO - PROCESS | 1790 | Values: 322.0 329.1 331.1 333.6 338.8 6383.9 6678.7 6682.6 6690.8 6715.0 6601.7 6664.6 6665.5 6669.9 6679.4 4505.2 4746.0 4831.3 4988.3 4989.5 4039.7 4950.4 4982.8 4987.4 4996.2 4911.2 4918.2 4920.9 4928.1 4933.5 4193.5 4686.0 4754.4 4933.0 4934.1 4091.5 4117.4 4166.8 4171.1 4181.3 6338.1 6356.2 6388.0 6389.6 6396.9 5398.6 5483.5 5775.9 5785.2 5792.8 6907.3 7079.0 7098.4 7116.4 7127.1 3852.8 4658.1 4666.7 4669.8 4674.7 7202.8 7508.0 7535.0 7535.2 7536.1 4555.3 4777.2 4784.7 4791.1 4800.9 4374.7 4833.9 4866.5 4870.0 4879.6 5763.1 5793.9 5797.5 5805.4 5818.3 6874.0 7147.6 7187.8 7190.0 7204.2 1669.7 1694.4 1696.1 1697.9 1701.4 1096.8 1105.4 1112.1 1121.3 1126.4 6691.7 6706.7 6707.6 6729.6 6775.1 7417.3 7421.5 7426.9 7450.4 7453.0 6545.1 6726.4 6730.8 6766.8 6823.8 3302.7 3945.3 3980.5 3987.5 3987.7 7627.5 7825.3 7844.6 7858.1 7888.0 6139.3 7354.3 7503.1 7601.4 7693.0 7717.8 7721.3 7724.4 7729.7 7730.7 7280.4 7377.2 7397.5 7398.1 7433.9 7100.4 7267.7 7278.2 7294.0 7330.5 7713.5 7770.3 7832.5 7843.9 7844.1 4595.3 4641.9 4651.3 4662.9 4663.4 6118.7 7194.5 7371.7 7416.0 7467.9 7171.1 7185.3 7186.2 7191.9 7201.2 6884.7 7182.7 7186.0 7193.2 7208.4 7007.6 7011.8 7012.7 7014.3 7018.6 5817.8 7181.9 7182.6 7196.6 7211.8 6833.2 6974.9 7007.2 7051.4 7054.5 04:58:48 INFO - PROCESS | 1790 | 04:58:48 INFO - PROCESS | 1790 | [#5] yui.html Cycles:180 Average:17926.63 Median:32557.93 stddev:24866.49 (76.4%) stddev-sans-first:24902.66 04:58:48 INFO - PROCESS | 1790 | Values: 716.4 724.3 730.4 735.8 763.3 14235.6 14363.4 14440.2 16699.7 17259.4 15322.5 15357.5 15400.5 15444.9 15446.2 706.4 719.1 719.6 846.7 881.2 872.5 876.7 883.2 883.6 885.4 921.7 924.0 924.2 925.3 926.5 741.9 753.6 756.4 757.4 930.9 563.8 566.1 678.9 692.1 693.4 14583.9 14944.3 14953.6 14969.3 14993.6 12174.3 12421.6 12511.6 12696.4 12869.9 9964.2 10010.2 10142.6 10163.2 10733.9 3439.8 3471.3 3472.5 3473.2 3474.0 75749.0 76464.0 78414.0 79129.0 79183.6 9184.0 9290.2 9515.7 9532.1 9705.9 19447.8 19477.6 19626.9 19630.3 19656.6 7375.0 7465.3 7577.7 7678.4 7801.4 4038.1 4092.8 4113.5 4190.4 4325.7 3427.0 3457.3 3463.3 3464.7 3472.2 633.2 646.8 654.3 661.8 664.0 515.2 534.7 554.2 575.1 625.8 8127.9 8684.5 8698.0 9029.1 9119.1 457.8 478.7 566.9 596.3 646.3 3328.7 3670.3 3759.4 3852.4 3893.4 72925.0 88127.9 89176.7 91397.0 92129.5 77833.0 77871.0 77992.6 78099.6 78331.2 64482.7 66206.3 66233.0 66887.3 67036.7 7985.9 8109.7 8185.1 8240.5 8316.3 50235.0 51139.7 51198.7 51292.0 51777.5 65797.0 66629.7 66639.7 67863.0 67902.0 10768.0 10802.5 10909.7 11035.2 11436.8 11982.3 12324.6 12325.6 12432.5 12585.1 11202.3 11257.0 11352.5 11480.5 11892.6 11135.6 11323.7 11332.1 11666.7 11859.7 10100.1 10230.6 10235.0 10275.2 10705.2 9112.8 9514.4 9612.2 9650.6 9958.3 8151.9 9107.0 9262.7 9801.5 9871.4 04:58:48 INFO - PROCESS | 1790 | -------- Summary: end -------- 04:58:48 INFO - PROCESS | 1790 | 04:58:49 INFO - TEST-INFO | 1790: exit 0 04:58:49 INFO - TEST-OK | dromaeo_css | took 1114822ms 04:58:49 INFO - TEST-START | kraken 04:58:49 INFO - operating with platform_type : mac_ 04:58:49 INFO - Initialising browser for kraken test... 04:58:49 INFO - TEST-INFO | started process 1796 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp3t96FS/profile http://localhost:49272/getInfo.html) 04:58:49 INFO - PROCESS | 1796 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:58:51 INFO - PROCESS | 1796 | __metrics Screen width/height:1600/1200 04:58:51 INFO - PROCESS | 1796 | colorDepth:24 04:58:51 INFO - PROCESS | 1796 | Browser inner width/height: 1024/689 04:58:51 INFO - PROCESS | 1796 | __metrics 04:58:51 INFO - PROCESS | 1796 | 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:51 INFO - PROCESS | 1796 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:52 INFO - TEST-INFO | 1796: exit 0 04:58:52 INFO - Browser initialized. 04:58:52 INFO - Running cycle 1/1 for kraken test... 04:58:52 INFO - TEST-INFO | started process 1798 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp3t96FS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:04 INFO - PROCESS | 1798 | RSS: Main: 243208192 04:59:04 INFO - PROCESS | 1798 | 04:59:06 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 04:59:07 INFO - PROCESS | 1798 | RSS: Main: 290140160 04:59:07 INFO - PROCESS | 1798 | 04:59:10 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 04:59:10 INFO - PROCESS | 1798 | RSS: Main: 299360256 04:59:10 INFO - PROCESS | 1798 | 04:59:14 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 04:59:14 INFO - PROCESS | 1798 | RSS: Main: 286425088 04:59:14 INFO - PROCESS | 1798 | 04:59:16 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 04:59:17 INFO - PROCESS | 1798 | RSS: Main: 289058816 04:59:17 INFO - PROCESS | 1798 | 04:59:19 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:59:19 INFO - PROCESS | 1798 | RSS: Main: 289173504 04:59:19 INFO - PROCESS | 1798 | 04:59:22 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 04:59:23 INFO - PROCESS | 1798 | RSS: Main: 290545664 04:59:23 INFO - PROCESS | 1798 | 04:59:25 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 04:59:26 INFO - PROCESS | 1798 | RSS: Main: 290713600 04:59:26 INFO - PROCESS | 1798 | 04:59:29 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 04:59:29 INFO - PROCESS | 1798 | RSS: Main: 290009088 04:59:29 INFO - PROCESS | 1798 | 04:59:31 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:59:31 INFO - PROCESS | 1798 | RSS: Main: 324726784 04:59:31 INFO - PROCESS | 1798 | 04:59:33 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:59:34 INFO - PROCESS | 1798 | RSS: Main: 325894144 04:59:34 INFO - PROCESS | 1798 | 04:59:36 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:59:36 INFO - PROCESS | 1798 | RSS: Main: 333082624 04:59:36 INFO - PROCESS | 1798 | 04:59:39 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:59:40 INFO - PROCESS | 1798 | RSS: Main: 333807616 04:59:40 INFO - PROCESS | 1798 | 04:59:42 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:59:43 INFO - PROCESS | 1798 | RSS: Main: 333983744 04:59:43 INFO - PROCESS | 1798 | 04:59:44 INFO - PROCESS | 1798 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 04:59:45 INFO - PROCESS | 1798 | RSS: Main: 394145792 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | __start_tp_report 04:59:45 INFO - PROCESS | 1798 | _x_x_mozilla_page_load 04:59:45 INFO - PROCESS | 1798 | _x_x_mozilla_page_load_details 04:59:45 INFO - PROCESS | 1798 | |i|pagename|runs| 04:59:45 INFO - PROCESS | 1798 | |0;ai-astar;110;111;109;109;112;111;115;110;111;110 04:59:45 INFO - PROCESS | 1798 | |1;audio-beat-detection;155;111;144;141;139;165;163;118;156;120 04:59:45 INFO - PROCESS | 1798 | |2;audio-dft;183;182;196;257;202;183;184;183;182;180 04:59:45 INFO - PROCESS | 1798 | |3;audio-fft;71;75;87;74;57;55;57;77;75;56 04:59:45 INFO - PROCESS | 1798 | |4;audio-oscillator;94;91;128;82;113;118;136;76;77;111 04:59:45 INFO - PROCESS | 1798 | |5;imaging-gaussian-blur;85;89;84;90;83;88;83;89;84;90 04:59:45 INFO - PROCESS | 1798 | |6;imaging-darkroom;94;94;94;93;94;93;94;92;93;94 04:59:45 INFO - PROCESS | 1798 | |7;imaging-desaturate;84;83;84;85;86;85;84;84;84;84 04:59:45 INFO - PROCESS | 1798 | |8;json-parse-financial;53;55;54;54;55;55;55;63;50;52 04:59:45 INFO - PROCESS | 1798 | |9;json-stringify-tinderbox;62;69;64;72;69;66;65;64;66;67 04:59:45 INFO - PROCESS | 1798 | |10;stanford-crypto-aes;83;83;84;82;82;82;84;82;84;83 04:59:45 INFO - PROCESS | 1798 | |11;stanford-crypto-ccm;121;122;122;121;125;126;124;124;118;120 04:59:45 INFO - PROCESS | 1798 | |12;stanford-crypto-pbkdf2;140;138;137;136;137;136;135;134;136;134 04:59:45 INFO - PROCESS | 1798 | |13;stanford-crypto-sha256-iterative;66;66;65;67;66;66;66;68;67;71 04:59:45 INFO - PROCESS | 1798 | __end_tp_report 04:59:45 INFO - PROCESS | 1798 | __start_cc_report 04:59:45 INFO - PROCESS | 1798 | _x_x_mozilla_cycle_collect,1165 04:59:45 INFO - PROCESS | 1798 | __end_cc_report 04:59:45 INFO - PROCESS | 1798 | __startTimestamp1454763585045__endTimestamp 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | ------- Summary: start ------- 04:59:45 INFO - PROCESS | 1798 | Number of tests: 14 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.75 (1.6%) stddev-sans-first:1.83 04:59:45 INFO - PROCESS | 1798 | Values: 110.0 111.0 109.0 109.0 112.0 111.0 115.0 110.0 111.0 110.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:149.50 stddev:19.33 (12.9%) stddev-sans-first:19.85 04:59:45 INFO - PROCESS | 1798 | Values: 155.0 111.0 144.0 141.0 139.0 165.0 163.0 118.0 156.0 120.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#2] audio-dft Cycles:10 Average:193.20 Median:183.50 stddev:23.52 (12.8%) stddev-sans-first:24.65 04:59:45 INFO - PROCESS | 1798 | Values: 183.0 182.0 196.0 257.0 202.0 183.0 184.0 183.0 182.0 180.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#3] audio-fft Cycles:10 Average:68.40 Median:74.50 stddev:11.25 (15.1%) stddev-sans-first:11.89 04:59:45 INFO - PROCESS | 1798 | Values: 71.0 75.0 87.0 74.0 57.0 55.0 57.0 77.0 75.0 56.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:76.50 stddev:21.53 (28.1%) stddev-sans-first:22.61 04:59:45 INFO - PROCESS | 1798 | Values: 94.0 91.0 128.0 82.0 113.0 118.0 136.0 76.0 77.0 111.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:88.50 stddev:2.95 (3.3%) stddev-sans-first:3.08 04:59:45 INFO - PROCESS | 1798 | Values: 85.0 89.0 84.0 90.0 83.0 88.0 83.0 89.0 84.0 90.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.71 (0.8%) stddev-sans-first:0.73 04:59:45 INFO - PROCESS | 1798 | Values: 94.0 94.0 94.0 93.0 94.0 93.0 94.0 92.0 93.0 94.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 04:59:45 INFO - PROCESS | 1798 | Values: 84.0 83.0 84.0 85.0 86.0 85.0 84.0 84.0 84.0 84.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:3.37 (6.1%) stddev-sans-first:3.53 04:59:45 INFO - PROCESS | 1798 | Values: 53.0 55.0 54.0 54.0 55.0 55.0 55.0 63.0 50.0 52.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:2.95 (4.4%) stddev-sans-first:2.67 04:59:45 INFO - PROCESS | 1798 | Values: 62.0 69.0 64.0 72.0 69.0 66.0 65.0 64.0 66.0 67.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 04:59:45 INFO - PROCESS | 1798 | Values: 83.0 83.0 84.0 82.0 82.0 82.0 84.0 82.0 84.0 83.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.00 stddev:2.45 (2.0%) stddev-sans-first:2.55 04:59:45 INFO - PROCESS | 1798 | Values: 121.0 122.0 122.0 121.0 125.0 126.0 124.0 124.0 118.0 120.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:136.50 stddev:1.83 (1.3%) stddev-sans-first:1.36 04:59:45 INFO - PROCESS | 1798 | Values: 140.0 138.0 137.0 136.0 137.0 136.0 135.0 134.0 136.0 134.0 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - PROCESS | 1798 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:1.69 (2.5%) stddev-sans-first:1.76 04:59:45 INFO - PROCESS | 1798 | Values: 66.0 66.0 65.0 67.0 66.0 66.0 66.0 68.0 67.0 71.0 04:59:45 INFO - PROCESS | 1798 | -------- Summary: end -------- 04:59:45 INFO - PROCESS | 1798 | 04:59:45 INFO - TEST-INFO | 1798: exit 0 04:59:45 INFO - TEST-OK | kraken | took 56347ms 04:59:45 INFO - SUITE-END | took 1171s 04:59:46 INFO - Completed test suite (00:19:31) 04:59:46 INFO - Working with test: dromaeo_css 04:59:46 INFO - Generating results file: dromaeo_css 04:59:46 INFO - Working with test: kraken 04:59:46 INFO - Generating results file: kraken 04:59:46 INFO - javascript benchmark 04:59:46 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:59:46 INFO - process_Request line: dromaeo_css 7371.30 graph.html#tests=[[72,64,59]] 04:59:46 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:59:46 INFO - process_Request line: kraken 1409.80 graph.html#tests=[[232,64,59]] 04:59:46 INFO - RETURN: dromaeo_css: 7371.30 04:59:46 INFO - RETURN: kraken: 1409.80 04:59:46 INFO - javascript benchmark 04:59:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2979.3296508285634, 3307.2393349529607, 3426.1943528851125, 3430.5540279763613, 3512.2799826035666, 5442.0, 5537.501624853762, 5554.000279949608, 5557.110862262034, 5631.09902415613, 5513.448655134484, 5579.442055794429, 5594.468525490082, 5597.496225339719, 5600.103983362663, 5047.798088076473, 5052.26742122392, 5070.670406423589, 5117.795288188468, 5145.919356935029, 5069.898602027957, 5157.948420515784, 5166.43169251382, 5167.250748641445, 5169.767360468769, 4317.676174286926, 5142.997115562467, 5150.1759718445055, 5152.716600586966, 5158.252053452247, 5103.030424219405, 5128.717920514388, 5142.151544995071, 5148.124818780816, 5151.995360904625, 4679.953200467986, 4920.8031678732805, 5146.356705411824, 5147.794088236466, 5155.7679904404395, 5518.751656175482, 5542.806001789918, 5552.194931734876, 5552.944470555323, 5589.524890384322, 5226.588821018342, 5928.992071347881, 6068.089786532011, 6120.0, 6122.295935967376, 5193.8961220775755, 6042.063480160582, 6085.868280789563, 6092.208012958287, 6118.375534461864, 5618.578606604521, 5639.661620302795, 5664.716764161775, 5665.291838520185, 5665.773369065274, 6159.538034647419, 6170.50635949123, 6176.505879529627, 6180.949238629444, 6183.3816618337805, 5864.736086876101, 5925.288965324103, 5930.673812940329, 5988.251468566429, 6039.78860739872, 5099.6685215460875, 6038.758449662052, 6101.60339577926, 6140.986737188314, 6152.200213972155, 6079.240094988127, 6088.4215999479975, 6102.877942441126, 6110.083487476825, 6113.144159817629, 5971.8231578111445, 6000.369961154016, 6059.545534084961, 6097.585173720644, 6129.63387754696, 4784.186688263004, 4800.4719480857075, 4805.1590971579835, 4807.831725889577, 4816.397950256218, 4324.091940692427, 4326.805293761789, 4345.196138714348, 4359.629431498295, 4361.978190109029, 5528.281323427928, 5560.082586373284, 5567.387587365387, 5568.248286481355, 5585.106382978704, 6097.766665674493, 6110.541709371815, 6133.754649814046, 6138.948294125945, 6162.044883043135, 5598.4961353477565, 5603.635763675429, 5613.326400831927, 5620.690862002629, 5631.605787594911, 5234.476552344811, 5250.18622113573, 5250.842474725764, 5255.658382205144, 5304.469553044664, 6097.82716539334, 6144.986077297374, 6173.166622505904, 6185.628862268279, 6272.341404152589, 6089.969550152398, 6131.724072416663, 6145.0, 6153.107799369156, 6159.19930409044, 6147.907032133833, 6172.475339596184, 6192.225971753531, 6193.442590166726, 6201.3178550358525, 5874.441928016831, 5969.313528944227, 5969.701514924323, 6005.90991135142, 6010.669413182317, 6098.0, 6122.703114648804, 6138.416850399205, 6164.321924588381, 6166.260048794174, 5966.731497082728, 5968.253968253968, 5968.46283834457, 5971.790987315423, 5978.312494063239, 5781.624194427349, 5866.2960444745195, 5911.438413350725, 5920.79277225295, 5965.403459654, 4644.838790302424, 5562.5549956002615, 5724.169995350568, 5736.110902810071, 5774.682392468287, 5922.703864806828, 5927.881442371042, 5959.91060134107, 5972.402759724167, 6017.699115044143, 5683.914741278802, 5756.107803290497, 5784.363719990882, 5796.594238403271, 5796.62321949072], "unit": "score", "name": "dojo.html", "value": 5548.325682186265}, {"lowerIsBetter": false, "replicates": [490.06642346330256, 490.76443307212537, 504.7425812835455, 582.8517819894809, 582.8950788858006, 25064.74935250647, 31025.844870775643, 38310.61689383102, 38522.807385963104, 38551.614483855155, 41631.583684163146, 41950.370744438784, 42067.57932420675, 42133.78933105338, 42161.36757948626, 8112.5943702814775, 9735.464549449778, 9739.318247722627, 9742.756431089208, 9743.123118919295, 9585.712428627152, 9754.219662426989, 9759.999999999964, 9768.902310976906, 9889.06053924876, 9801.803963920718, 9874.555644995957, 9901.10890019898, 9907.405555666683, 9919.0, 9805.754856128582, 9883.950580247125, 9886.505674716236, 9910.702678919644, 9924.106830385228, 9616.374935629161, 9785.315027948047, 9789.755256118582, 9789.951050244774, 9804.215662746963, 39630.009249768984, 39949.60050399488, 40008.79973600797, 40065.39901901474, 40150.59849401498, 3140.98429507851, 3143.3713257348622, 3257.990023092849, 3300.6204286506877, 3509.5788505379264, 28931.855340723374, 29010.41979160405, 29331.266718331997, 29639.962601309067, 29985.70014299851, 2764.834109953409, 2784.568391899259, 2784.763295119917, 2795.7344052314997, 2976.0179140883456, 482179.0, 487313.0, 489360.5531972353, 489927.0, 490696.5465172687, 56671.0, 57985.420145798, 58179.0, 62158.37841621526, 65581.0, 53111.73444132755, 65217.0, 65411.34588654053, 65442.0, 65454.0, 16362.754558681629, 16546.58633534171, 16574.0, 16593.253303601366, 16607.667846643, 11630.418479076012, 11843.940780296216, 11862.940685296518, 11865.584704535473, 11993.520259189709, 20620.381388558366, 21264.78735212628, 21328.36014919555, 21332.78667213308, 21362.038708258166, 7850.332721718718, 8802.603882825288, 8890.666400040045, 8999.415038022638, 9042.050584688644, 800.9559474228973, 809.9473534220375, 919.7884486568126, 942.1097063275276, 1020.0411613083678, 27731.168064958085, 28163.859180703967, 28421.57367639487, 28464.85767571149, 28633.713662863105, 1074.4198133008244, 1080.448971024783, 1081.983770243447, 1089.6785448292774, 1189.7858385490695, 14659.58116910719, 14783.0, 14791.630209244855, 15111.848881511263, 15128.697426051418, 663495.0, 670743.0, 671401.0, 671764.0, 676096.0, 52104.73947630238, 53124.93750124976, 59576.70211648914, 60635.69682151649, 61597.0, 1391.2209162868826, 1402.235781499065, 1432.5702289313372, 1434.5839706485003, 1436.4182506085053, 27838.642201652758, 29920.700792991793, 30231.093067208018, 30288.69711302859, 30608.84695576508, 54709.0, 54924.90150197053, 55316.72341638266, 55333.1700024508, 55454.168187478026, 516043.0, 516517.51342379366, 516889.0, 517709.0, 519593.0, 33095.50356744699, 33294.33411331808, 33438.83280583582, 33452.498212527316, 33529.994100177035, 43345.78327108344, 44416.44542440999, 44656.33015504835, 44718.55281447144, 45021.77489112534, 36342.818285908405, 36958.52165913441, 37028.44457333196, 37218.8139059303, 37491.81254093712, 36912.44631330478, 37808.810955945046, 37833.054173645876, 38503.61496385113, 38606.2278754429, 34791.78228761981, 34988.30023399569, 35539.82230088833, 35874.0, 36081.81959090293, 31163.0, 32422.027339179862, 32642.836785815918, 32740.0, 33010.33979320352, 24786.884590193124, 24827.87586062058, 25141.74858251394, 25226.99092036298, 25402.983880645308], "unit": "score", "name": "ext.html", "value": 19890.29724728252}, {"lowerIsBetter": false, "replicates": [363.52378384316546, 366.39910546703413, 366.48142877827877, 372.3390981008709, 373.432382778177, 12675.936620316908, 15449.653731727476, 18556.62886742266, 19548.804511954877, 20408.489787755294, 11732.648020559376, 11933.331667457953, 12054.276743395381, 12067.4569644366, 19319.903400483014, 3936.8031598419966, 5192.818251361203, 5377.542908852753, 5383.838484845461, 5389.622726409153, 4035.132446523997, 4089.5297040840237, 4724.952750472486, 5929.525637948954, 5941.465268125868, 5658.122990936391, 5906.05503119501, 5921.555883308748, 5928.1404196391495, 5929.28848538176, 5809.622374545641, 5881.588288819784, 5882.911756323637, 5897.498712609433, 5900.97049514754, 5416.566674666056, 5575.637583557096, 5583.469570390806, 5584.246126772874, 5588.832335029955, 13347.998900082534, 22012.449688757748, 23644.881775591184, 24507.774611269364, 24560.140395086088, 2078.688196770481, 2080.8543401961715, 2098.223657246813, 2144.4960434297927, 2147.667111597689, 9497.857532137023, 9663.855042174373, 9929.156021738161, 10779.461026948622, 14638.341274642667, 1682.116888633465, 1717.4160785333047, 1723.3451288510412, 1729.688656041912, 1742.6950283700303, 95388.04611953862, 96290.51854740751, 96648.0335196646, 97134.51432742862, 98367.0, 10989.06592939593, 11065.0, 11091.168162387854, 11109.500072496758, 11219.046381057702, 11686.415679216005, 13003.674908127372, 13225.412950445816, 13426.932865335806, 13445.0, 8355.331573474108, 8368.288695460955, 8382.455140415854, 8445.619947102396, 8478.364122690822, 8418.663253469915, 8424.073351931283, 8447.113053129457, 8524.914750852537, 8534.829303413897, 3676.540432445944, 3969.166475040216, 4148.62662360389, 4159.875203743893, 4321.092570560155, 1557.5093845438878, 1590.8965917215344, 1750.3173762232739, 1761.9164214008292, 1840.3834715370233, 411.4096271849905, 879.9296056315479, 921.1801496667971, 945.9432434053979, 995.3082607587658, 9897.070071336164, 11302.039326657326, 11355.205135640426, 11522.251053681652, 11931.522739090513, 400.9615096899046, 404.27432758199103, 441.17500274486275, 453.08929052604503, 458.13412650091357, 6020.096985452217, 6120.234970628671, 10888.029735337526, 11370.658880233606, 11376.089912806956, 589287.0535647294, 590702.0, 596904.0, 600898.0, 777928.0, 72024.63987680028, 90176.0, 111755.85342806224, 113748.43125784319, 114845.0, 943.6932996776076, 1149.827525871126, 1177.3230392524333, 1181.3030312115893, 1193.964181074569, 17393.652126957644, 17773.822261777215, 18223.271069157614, 18279.0, 18544.721829172304, 47003.52996470128, 48037.27210534446, 49862.750686246334, 50729.98540029253, 52926.73536632292, 69592.6520367395, 70130.0, 70582.0, 70783.64608176926, 72200.0, 7551.320381165721, 7704.499207551491, 7772.494787838772, 7795.961020194863, 7827.686892524235, 10859.402732849454, 11948.76102477963, 12052.457639406422, 12156.24906555576, 12236.510539578318, 10149.746256343651, 10284.485775711335, 10302.896971030494, 10476.057154855795, 10578.038149318203, 5292.814751483679, 7839.764807055797, 7904.288614024766, 10193.74515637115, 10434.530446130095, 9999.30004899679, 10269.537870795682, 10275.794484110127, 10447.05976462122, 10529.736756581147, 6839.487038472035, 7111.466640001917, 7576.431767617561, 7610.9238907610215, 7612.961935190288, 8607.526586037828, 9881.752956176153, 10228.795424091328, 10514.737131571772, 10554.261201715806], "unit": "score", "name": "jquery.html", "value": 8457.073674430945}, {"lowerIsBetter": false, "replicates": [1390.2145287912335, 1505.5633866178805, 1540.2375823967138, 1769.363029309449, 1936.051334845926, 7845.215478452152, 8036.156203598625, 8498.872516912252, 8706.0, 8711.346649001334, 8445.49327040378, 8511.829763404729, 8627.051024387312, 8630.95684521578, 8649.437786543871, 2073.8237249833783, 2167.4798048468333, 2219.533897881439, 2495.3761559610098, 2499.0, 2258.7176602924633, 2265.286434773041, 2266.444721043347, 2267.7278726552754, 2401.5797235483806, 2436.622323539845, 2464.605663093905, 2474.134053081425, 2475.1337032038823, 2477.417806815397, 2040.6224848403092, 2257.3115199864037, 2301.838871279011, 2482.0196022571163, 2484.2795589279085, 2413.9758602414104, 2459.4589190378088, 2462.5444292805887, 2470.518248941457, 2471.7404672509306, 8665.523396213206, 8763.430377025474, 8765.123487651248, 8770.0, 8782.60478278479, 5337.412884582693, 5513.724313784335, 5513.972430137824, 5516.475934786189, 5517.586181036439, 3606.549181352331, 3608.5308909841815, 3641.107928557494, 3714.405695088773, 3724.9570120366343, 1048.234788604323, 1060.7560261139904, 1064.2816099133054, 1087.374759513283, 1091.2148793035187, 11846.822297665456, 11872.287662740177, 11880.821787673192, 11891.94054029733, 11920.701982450508, 4849.636277279218, 4860.4896485869185, 4963.677360971526, 4977.9751101244265, 4988.426330971912, 10125.746856328504, 10127.746806329753, 10147.543360548792, 10164.695059148238, 10201.13290370312, 5454.836354909359, 5506.944930550723, 5513.476219759116, 5513.669179849222, 5517.503424691797, 4950.2079667253065, 4968.652194346361, 5003.049420610072, 5011.874703132451, 5017.648764586517, 3917.334053210961, 3923.843046278117, 3950.644442000234, 3957.1887763008513, 4007.699422543321, 1096.6435908329825, 1194.9522019119138, 1225.136278923357, 1225.2036176485178, 1225.969350766238, 1100.2848148703406, 1103.542030057533, 1118.5693507999315, 1130.4178348150708, 1178.4991378664033, 7920.841583168304, 7957.323627491613, 8010.79973000668, 8040.67837286502, 8045.5574943377505, 1110.1396417776289, 1129.6498085593328, 1179.1097721220424, 1185.585045234161, 1220.2922305063041, 6215.098810672427, 6270.7491700331475, 6279.717412716439, 6280.403361680633, 6290.402411770874, 10010.299279050396, 10736.08743256832, 10747.892521074846, 10874.130069594414, 10887.618933337295, 10401.323913945569, 10698.304610200312, 10723.83914241287, 10740.731481712863, 10767.407792571326, 8128.431009829255, 8276.917230827736, 8287.0, 8326.875096873551, 8334.0, 7746.070471543451, 7783.961080194563, 7795.86959890824, 7826.139124696393, 7869.8819517708425, 9370.0, 9443.763905902408, 9480.810383792148, 9544.618215271312, 9632.95183524078, 9657.71026869195, 9787.314887958059, 9896.851547226654, 10021.0, 10023.348482348623, 6994.090768200102, 7097.183823860322, 7097.680604372712, 7098.858022839618, 7222.458315626244, 7844.450888437755, 7942.761717148494, 7943.364530837634, 7943.642536085775, 7955.1249362571225, 6266.0, 7308.817279568053, 7394.149672787698, 7483.214262502359, 7534.246575342422, 7114.110736157981, 7220.711171553289, 7222.277772222736, 7228.385587224934, 7302.853942921218, 7453.552786832807, 7534.0, 7537.736179233701, 7542.849143017219, 7559.979402780555, 6761.763338283136, 6775.254721980479, 6839.042534045338, 6840.897386539106, 6846.760363387258, 6927.930720692729, 6986.406155476841, 6994.33553812387, 7002.404795592432, 7006.369426751617], "unit": "score", "name": "mootools.html", "value": 4875.882532318944}, {"lowerIsBetter": false, "replicates": [321.96780321967805, 329.09334782673733, 331.1043626988995, 333.5513734027732, 338.8238116179588, 6383.936160638392, 6678.699458524366, 6682.565633233842, 6690.76582319619, 6714.96642516788, 6601.669916504167, 6664.633445160514, 6665.533412661116, 6669.866602667944, 6679.398854103129, 4505.234110201273, 4746.0, 4831.251156070797, 4988.251762235657, 4989.525995030466, 4039.676825853939, 4950.356453661019, 4982.775775090112, 4987.376577927759, 4996.200607902736, 4911.16510193268, 4918.237673160648, 4920.876978075541, 4928.1129396708575, 4933.531314525115, 4193.475815523059, 4685.953140468586, 4754.405699287589, 4932.950670493303, 4934.1365261079345, 4091.509018917719, 4117.402976568381, 4166.83332666693, 4171.10321280923, 4181.289180839264, 6338.080978258173, 6356.2054743157105, 6388.0, 6389.616623002588, 6396.872062558769, 5398.568114550866, 5483.506484416382, 5775.942240577624, 5785.190073389729, 5792.82621521355, 6907.34380233877, 7078.964605176941, 7098.36114749675, 7116.359527642537, 7127.10911136108, 3852.768833869977, 4658.091672123937, 4666.65000124992, 4669.766511674403, 4674.69614475058, 7202.783916482514, 7508.0, 7535.0, 7535.246475352421, 7536.057992750906, 4555.293929440942, 4777.235642297216, 4784.665073444826, 4791.137595232822, 4800.927986080212, 4374.671899607542, 4833.912369716785, 4866.46468888422, 4869.975650121798, 4879.609631229493, 5763.077907534858, 5793.884122317614, 5797.47822695951, 5805.419458054161, 5818.272715910512, 6873.965630171917, 7147.606881621561, 7187.7843664690145, 7189.96405017982, 7204.171520275236, 1669.74953756935, 1694.432365157686, 1696.0841145781387, 1697.932082716702, 1701.4215166843085, 1096.8025755363951, 1105.4196546812987, 1112.0714203639889, 1121.3047910295668, 1126.4367816091954, 6691.665416729242, 6706.66466676674, 6707.5975441473665, 6729.629870357079, 6775.085363475966, 7417.332440080419, 7421.517601355895, 7426.925730742623, 7450.403967682572, 7453.0, 6545.116409284781, 6726.3520437493125, 6730.831729206711, 6766.763163289262, 6823.795286141423, 3302.6862448067395, 3945.3095708251517, 3980.5422376426504, 3987.481627388479, 3987.7407968481957, 7627.466077374531, 7825.256600622932, 7844.646990885424, 7858.0963189232825, 7887.960560197277, 6139.324674285825, 7354.2645735427095, 7503.0889570401405, 7601.429892758065, 7692.961450204262, 7717.768466946, 7721.343685786771, 7724.420668449889, 7729.729459469004, 7730.729424470116, 7280.417566594766, 7377.188509264084, 7397.519161254501, 7398.11222653285, 7433.922081298289, 7100.396466300423, 7267.709291628275, 7278.163011253773, 7293.9635301823155, 7330.450216233698, 7713.537187768752, 7770.300672939463, 7832.490888092256, 7843.921560784547, 7844.137144913941, 4595.310703394518, 4641.930371044505, 4651.348811166507, 4662.904217508815, 4663.370444989883, 6118.694065296806, 7194.532355396883, 7371.741989030358, 7415.962920185365, 7467.850642987219, 7171.139463264233, 7185.317394847481, 7186.173590037212, 7191.928080719335, 7201.243869393638, 6884.690188941609, 7182.712691492282, 7185.964070179824, 7193.172785129568, 7208.423326133792, 7007.649617519001, 7011.754588589375, 7012.719491220498, 7014.2635023323855, 7018.613976231152, 5817.825465236049, 7181.928180718126, 7182.640867956686, 7196.568205907663, 7211.783646490614, 6833.214180369321, 6974.930250697631, 7007.229204787572, 7051.435885129074, 7054.541454805421], "unit": "score", "name": "prototype.html", "value": 5213.832175560494}, {"lowerIsBetter": false, "replicates": [716.4197000429649, 724.2942869542231, 730.3791776989559, 735.8381156145648, 763.313018283545, 14235.572932812007, 14363.42546298148, 14440.205788681631, 16699.74950375745, 17259.39592114276, 15322.463713770021, 15357.539273821803, 15400.537983860475, 15444.922775386107, 15446.150461724601, 706.4348521183033, 719.0688058963628, 719.6150059718052, 846.6994217052935, 881.2289246908955, 872.4721543466206, 876.6843936182969, 883.2227639677075, 883.5935469683953, 885.3625389719392, 921.7188757428981, 923.9722808315728, 924.2098006204699, 925.3152667026419, 926.4580220570974, 741.929516695913, 753.5591678867814, 756.4251169111515, 757.3940847322175, 930.8743319651828, 563.7801257509575, 566.0829456280851, 678.8506528563709, 692.1313751242159, 693.3551796828947, 14583.854161458356, 14944.252787360698, 14953.551393458214, 14969.251537423086, 14993.550193494213, 12174.330411827346, 12421.627351179479, 12511.56209532662, 12696.428660710199, 12869.871301286961, 9964.153046991014, 10010.249231307682, 10142.594296228215, 10163.186945044452, 10733.946330268298, 3439.8280085995602, 3471.288385880888, 3472.5138480612736, 3473.201163732356, 3474.027272363742, 75749.0, 76464.0, 78414.0, 79129.0, 79183.60408197979, 9183.989761126271, 9290.16388525036, 9515.714528564155, 9532.142107210384, 9705.883823360262, 19447.8055219446, 19477.610447790965, 19626.90186549058, 19630.312939047064, 19656.57727011411, 7375.0, 7465.253474652492, 7577.734779282699, 7678.385729141655, 7801.414893882981, 4038.0914294283552, 4092.8362865485046, 4113.465249517543, 4190.434291370687, 4325.675574331937, 3426.9657303427143, 3457.3258214647904, 3463.290025544757, 3464.6708562686504, 3472.236108056274, 633.1737083106498, 646.8382904273932, 654.3423859021652, 661.8345413646589, 664.0205696597577, 515.1962937817018, 534.7326336831584, 554.1991821817435, 575.114323941126, 625.849796048945, 8127.878081828777, 8684.522351270614, 8698.043215246318, 9029.09709029105, 9119.08809119096, 457.77340216593, 478.69124414752986, 566.9007923613351, 596.3291297290548, 646.253577118429, 3328.7350806693785, 3670.284294562535, 3759.3797023491366, 3852.3836186210074, 3893.396523538856, 72925.0, 88127.91552295767, 89176.6623500648, 91397.0, 92129.5393523028, 77833.0, 77871.0, 77992.61654352593, 78099.60950195213, 78331.21668783353, 64482.67758661271, 66206.33793662098, 66233.0, 66887.33112668908, 67036.6648166756, 7985.8802117969435, 8109.7161599343735, 8185.0996390398195, 8240.50556966584, 8316.334693224648, 50235.0, 51139.74430127825, 51198.74400627973, 51291.974160515834, 51777.482225177264, 65797.0, 66629.66685166543, 66639.66680166568, 67863.0, 67902.0, 10768.0, 10802.459877005962, 10909.727256818644, 11035.227534072537, 11436.813513620576, 11982.340971246666, 12324.630261092181, 12325.568605098779, 12432.502699891904, 12585.056120790794, 11202.327860328407, 11257.0, 11352.489137988976, 11480.483378247833, 11892.643220703392, 11135.554577816796, 11323.716907077389, 11332.093432525213, 11666.70833229176, 11859.70350741204, 10100.090991810772, 10230.6419275325, 10234.976502349706, 10275.177985761271, 10705.19711021661, 9112.817743644957, 9514.38156519824, 9612.18296444782, 9650.565724542272, 9958.253131015348, 8151.877721834058, 9106.950250264701, 9262.72211833646, 9801.50992450389, 9871.40771553709], "unit": "score", "name": "yui.html", "value": 6760.7624411089255}], "name": "dromaeo_css", "value": 7371.298097407922}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 109.0, 112.0, 111.0, 115.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [155.0, 111.0, 144.0, 141.0, 139.0, 165.0, 163.0, 118.0, 156.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 141.2}, {"lowerIsBetter": true, "replicates": [183.0, 182.0, 196.0, 257.0, 202.0, 183.0, 184.0, 183.0, 182.0, 180.0], "unit": "score", "name": "audio-dft", "value": 193.2}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 87.0, 74.0, 57.0, 55.0, 57.0, 77.0, 75.0, 56.0], "unit": "score", "name": "audio-fft", "value": 68.4}, {"lowerIsBetter": true, "replicates": [94.0, 91.0, 128.0, 82.0, 113.0, 118.0, 136.0, 76.0, 77.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 84.0, 90.0, 83.0, 88.0, 83.0, 89.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 92.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 85.0, 86.0, 85.0, 84.0, 84.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.3}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 54.0, 54.0, 55.0, 55.0, 55.0, 63.0, 50.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [62.0, 69.0, 64.0, 72.0, 69.0, 66.0, 65.0, 64.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 82.0, 82.0, 82.0, 84.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [121.0, 122.0, 122.0, 121.0, 125.0, 126.0, 124.0, 124.0, 118.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [140.0, 138.0, 137.0, 136.0, 137.0, 136.0, 135.0, 134.0, 136.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0, 68.0, 67.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1409.8}]} 04:59:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1409.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7371.30"}}} 04:59:46 INFO - Return code: 0 04:59:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:59:46 INFO - # TBPL SUCCESS # 04:59:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:46 INFO - 2016-02-06 04:59:46.777 screenresolution[1802:17673] starting screenresolution argv=screenresolution get 04:59:46 INFO - 2016-02-06 04:59:46.780 screenresolution[1802:17673] Display 0: 1600x1200x32@60 04:59:46 INFO - 2016-02-06 04:59:46.786 screenresolution[1803:17676] starting screenresolution argv=screenresolution list 04:59:46 INFO - Available Modes on Display 0 04:59:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:47 INFO - Intel Iris: 04:59:47 INFO - Chipset Model: Intel Iris 04:59:47 INFO - Type: GPU 04:59:47 INFO - Bus: Built-In 04:59:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:47 INFO - Vendor: Intel (0x8086) 04:59:47 INFO - Device ID: 0x0a2e 04:59:47 INFO - Revision ID: 0x0009 04:59:47 INFO - Displays: 04:59:47 INFO - Display: 04:59:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:47 INFO - Display Serial Number: 1600x1200 60 04:59:47 INFO - Main Display: Yes 04:59:47 INFO - Mirror: Off 04:59:47 INFO - Online: Yes 04:59:47 INFO - Rotation: Supported 04:59:47 INFO - Return code: 0 04:59:47 INFO - Running post-action listener: _resource_record_post_action 04:59:47 INFO - Running post-run listener: _resource_record_post_run 04:59:48 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 33795584; Write bytes: 709205504; Read time: 351; Write time: 1859 04:59:48 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399282688; Write bytes: 394672128; Read time: 29927; Write time: 733 04:59:48 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 32013824; Write bytes: 300901888; Read time: 333; Write time: 1092 04:59:48 INFO - Running post-run listener: _upload_blobber_files 04:59:48 INFO - Blob upload gear active. 04:59:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:59:48 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:48 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:48 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:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:59:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:59:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:59:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:49 INFO - (blobuploader) - INFO - Done attempting. 04:59:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:59:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:59:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:59:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:59:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:59:50 INFO - (blobuploader) - INFO - Done attempting. 04:59:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:59:50 INFO - Return code: 0 04:59:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:59:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:59:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448a4f0bf60b3d83bea099c6080e18a1729fc4e4a36e8c97eda12eea456d89ea1dd6fc318451fc1bb3e8da545ad6603ec8641bfc012e838cb493c565e955d533", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b46399614f177fb2b97da44fad696aa0f23521fe7ce6220c3de5f642261ec58cf0d98d5d42e50c7ebd2376462302ecb49b1a85a8c7226e1fec69fa005886a6"} 04:59:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:59:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:59:50 INFO - Contents: 04:59:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/448a4f0bf60b3d83bea099c6080e18a1729fc4e4a36e8c97eda12eea456d89ea1dd6fc318451fc1bb3e8da545ad6603ec8641bfc012e838cb493c565e955d533", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b46399614f177fb2b97da44fad696aa0f23521fe7ce6220c3de5f642261ec58cf0d98d5d42e50c7ebd2376462302ecb49b1a85a8c7226e1fec69fa005886a6"} 04:59:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:59:50 INFO - Copying logs to upload dir... 04:59:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:59:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.872929 ========= master_lag: 25.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-02-06 05:00:15.911355) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:15.919852) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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/448a4f0bf60b3d83bea099c6080e18a1729fc4e4a36e8c97eda12eea456d89ea1dd6fc318451fc1bb3e8da545ad6603ec8641bfc012e838cb493c565e955d533", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b46399614f177fb2b97da44fad696aa0f23521fe7ce6220c3de5f642261ec58cf0d98d5d42e50c7ebd2376462302ecb49b1a85a8c7226e1fec69fa005886a6"} 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.011581 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/448a4f0bf60b3d83bea099c6080e18a1729fc4e4a36e8c97eda12eea456d89ea1dd6fc318451fc1bb3e8da545ad6603ec8641bfc012e838cb493c565e955d533", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b46399614f177fb2b97da44fad696aa0f23521fe7ce6220c3de5f642261ec58cf0d98d5d42e50c7ebd2376462302ecb49b1a85a8c7226e1fec69fa005886a6"}' ========= master_lag: 8.65 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-02-06 05:00:24.580542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:24.580837) ========= 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.3Wr7qnBe77/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.6kHzn1ximb/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005245 ========= master_lag: 0.59 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 05:00:25.174938) ========= ========= Started reboot skipped (results: 3, elapsed: 49 secs) (at 2016-02-06 05:00:25.175414) ========= ========= Finished reboot skipped (results: 3, elapsed: 49 secs) (at 2016-02-06 05:01:15.011392) ========= ========= Total master_lag: 38.13 =========