builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0165 starttime: 1456529698.79 results: success (0) buildid: 20160226125526 builduid: 15227fb53ee547d6b61fa8aecf1c2b5a revision: 5592b9a4cad6e73e5f502a83f3d895300dd896e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.790956) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.791474) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.791825) ========= 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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005943 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.817963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.821350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.839737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.840132) ========= 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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005627 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.892176) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.892548) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.892975) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:58.893329) ========= 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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-26 15:34:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.24M=0.001s 2016-02-26 15:34:58 (8.24 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:59.007829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:59.008241) ========= 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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.020251 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:34:59.057862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-26 15:34:59.061327) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5592b9a4cad6e73e5f502a83f3d895300dd896e1 --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 5592b9a4cad6e73e5f502a83f3d895300dd896e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-26 15:34:59,096 truncating revision to first 12 chars 2016-02-26 15:34:59,097 Setting DEBUG logging. 2016-02-26 15:34:59,097 attempt 1/10 2016-02-26 15:34:59,097 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5592b9a4cad6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 15:35:00,933 unpacking tar archive at: fx-team-5592b9a4cad6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.098347 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-26 15:35:01.178089) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 15:35:01.178547) ========= echo 5592b9a4cad6e73e5f502a83f3d895300dd896e1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5592b9a4cad6e73e5f502a83f3d895300dd896e1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 5592b9a4cad6e73e5f502a83f3d895300dd896e1 program finished with exit code 0 elapsedTime=0.005218 script_repo_revision: '5592b9a4cad6e73e5f502a83f3d895300dd896e1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 15:35:01.232376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 15:35:01.232994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 15:35:01.246848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-26 15:35:01.247223) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:01 INFO - MultiFileLogger online at 20160226 15:35:01 in /builds/slave/test 15:35:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:35:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:35:01 INFO - {'append_to_log': False, 15:35:01 INFO - 'base_work_dir': '/builds/slave/test', 15:35:01 INFO - 'blob_upload_branch': 'Fx-Team', 15:35:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:35:01 INFO - 'branch': 'Fx-Team', 15:35:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:35:01 INFO - 'config_files': ('talos/mac_config.py',), 15:35:01 INFO - 'default_actions': ('clobber', 15:35:01 INFO - 'read-buildbot-config', 15:35:01 INFO - 'download-and-extract', 15:35:01 INFO - 'populate-webroot', 15:35:01 INFO - 'create-virtualenv', 15:35:01 INFO - 'install', 15:35:01 INFO - 'run-tests'), 15:35:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:35:01 INFO - 'download_minidump_stackwalk': True, 15:35:01 INFO - 'download_symbols': 'ondemand', 15:35:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:35:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:35:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:35:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:35:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:35:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:35:01 INFO - 'installer_path': 'installer.exe', 15:35:01 INFO - 'log_level': 'info', 15:35:01 INFO - 'log_name': 'talos', 15:35:01 INFO - 'log_to_console': True, 15:35:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:35:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:35:01 INFO - 'opt_config_files': (), 15:35:01 INFO - 'pip_index': False, 15:35:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:35:01 INFO - 'cmd': ('bash', 15:35:01 INFO - '-c', 15:35:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:35:01 INFO - 'enabled': True, 15:35:01 INFO - 'halt_on_failure': False, 15:35:01 INFO - 'name': 'check_screen_resolution'},), 15:35:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:35:01 INFO - 'cmd': ('bash', 15:35:01 INFO - '-c', 15:35:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:35:01 INFO - 'enabled': True, 15:35:01 INFO - 'halt_on_failure': False, 15:35:01 INFO - 'name': 'check_screen_resolution'},), 15:35:01 INFO - 'run_cmd_checks_enabled': True, 15:35:01 INFO - 'sps_profile': False, 15:35:01 INFO - 'sps_profile_interval': 0, 15:35:01 INFO - 'suite': 'dromaeojs-e10s', 15:35:01 INFO - 'system_bits': '32', 15:35:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:35:01 INFO - 'title': 't-yosemite-r7-0165', 15:35:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:35:01 INFO - 'use_talos_json': True, 15:35:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:35:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:35:01 INFO - 'work_dir': 'build'} 15:35:01 INFO - ##### 15:35:01 INFO - ##### Running clobber step. 15:35:01 INFO - ##### 15:35:01 INFO - Running pre-action listener: _resource_record_pre_action 15:35:01 INFO - Running main action method: clobber 15:35:01 INFO - rmtree: /builds/slave/test/build 15:35:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:35:02 INFO - Running post-action listener: _resource_record_post_action 15:35:02 INFO - ##### 15:35:02 INFO - ##### Running read-buildbot-config step. 15:35:02 INFO - ##### 15:35:02 INFO - Running pre-action listener: _resource_record_pre_action 15:35:02 INFO - Running main action method: read_buildbot_config 15:35:02 INFO - Using buildbot properties: 15:35:02 INFO - { 15:35:02 INFO - "project": "", 15:35:02 INFO - "product": "firefox", 15:35:02 INFO - "script_repo_revision": "production", 15:35:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:35:02 INFO - "repository": "", 15:35:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:35:02 INFO - "buildid": "20160226125526", 15:35:02 INFO - "pgo_build": "False", 15:35:02 INFO - "basedir": "/builds/slave/test", 15:35:02 INFO - "buildnumber": 539, 15:35:02 INFO - "slavename": "t-yosemite-r7-0165", 15:35:02 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:35:02 INFO - "platform": "yosemite_r7", 15:35:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:35:02 INFO - "branch": "fx-team", 15:35:02 INFO - "repo_path": "integration/fx-team", 15:35:02 INFO - "revision": "5592b9a4cad6e73e5f502a83f3d895300dd896e1", 15:35:02 INFO - "stage_platform": "macosx64", 15:35:02 INFO - "builduid": "15227fb53ee547d6b61fa8aecf1c2b5a", 15:35:02 INFO - "slavebuilddir": "test" 15:35:02 INFO - } 15:35:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:35:02 INFO - Running post-action listener: _resource_record_post_action 15:35:02 INFO - ##### 15:35:02 INFO - ##### Running download-and-extract step. 15:35:02 INFO - ##### 15:35:02 INFO - Running pre-action listener: _resource_record_pre_action 15:35:02 INFO - Running main action method: download_and_extract 15:35:02 INFO - mkdir: /builds/slave/test/build/tests 15:35:02 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')]} 15:35:02 INFO - https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:35:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/test_packages.json 15:35:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/test_packages.json 15:35:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:35:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:35:03 INFO - Downloaded 1277 bytes. 15:35:03 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:35:03 INFO - Using the following test package requirements: 15:35:03 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:35:03 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:35:03 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:35:03 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'jsshell-mac.zip'], 15:35:03 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:35:03 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:35:03 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:35:03 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:35:03 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:35:03 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:35:03 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:35:03 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:35:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:03 INFO - https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:35:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:35:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:35:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:35:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:35:04 INFO - Downloaded 17830495 bytes. 15:35:04 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'] 15:35:04 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 15:35:07 INFO - Return code: 0 15:35:07 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 15:35: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')]} 15:35:07 INFO - https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:35:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:35:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:35:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:35:08 INFO - Downloaded 17830495 bytes. 15:35:08 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'] 15:35:08 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 15:35:12 INFO - Return code: 0 15:35: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')]} 15:35:12 INFO - https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:35:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:35:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:35:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:35:13 INFO - Downloaded 10713410 bytes. 15:35:13 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'] 15:35:13 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 15:35:13 INFO - Return code: 0 15:35: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')]} 15:35:13 INFO - https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:35:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:35:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:35:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:35:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 15:35:19 INFO - Downloaded 111468168 bytes. 15:35:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:35:19 INFO - mkdir: /builds/slave/test/properties 15:35:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:35:19 INFO - Writing to file /builds/slave/test/properties/build_url 15:35:19 INFO - Contents: 15:35:19 INFO - build_url:https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:35:20 INFO - Running post-action listener: _resource_record_post_action 15:35:20 INFO - Running post-action listener: set_extra_try_arguments 15:35:20 INFO - ##### 15:35:20 INFO - ##### Running populate-webroot step. 15:35:20 INFO - ##### 15:35:20 INFO - Running pre-action listener: _resource_record_pre_action 15:35:20 INFO - Running main action method: populate_webroot 15:35:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:35:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:35:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:35:20 INFO - '--tppagecycles', 15:35:20 INFO - '7'], 15:35:20 INFO - 'tests': ['tsvgm']}}, 15:35:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:35:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:35:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:35:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:35:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'tests': ['damp', 'tps']}, 15:35:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['damp', 'tps']}, 15:35:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:35:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:35:20 INFO - 'other': {'tests': ['a11yr', 15:35:20 INFO - 'ts_paint', 15:35:20 INFO - 'tpaint', 15:35:20 INFO - 'sessionrestore', 15:35:20 INFO - 'sessionrestore_no_auto_restore']}, 15:35:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['a11yr', 15:35:20 INFO - 'ts_paint', 15:35:20 INFO - 'tpaint', 15:35:20 INFO - 'sessionrestore', 15:35:20 INFO - 'sessionrestore_no_auto_restore']}, 15:35:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['a11yr', 15:35:20 INFO - 'ts_paint', 15:35:20 INFO - 'tpaint', 15:35:20 INFO - 'sessionrestore', 15:35:20 INFO - 'sessionrestore_no_auto_restore']}, 15:35:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['a11yr', 15:35:20 INFO - 'ts_paint', 15:35:20 INFO - 'tpaint', 15:35:20 INFO - 'sessionrestore', 15:35:20 INFO - 'sessionrestore_no_auto_restore']}, 15:35:20 INFO - 'other_l64': {'tests': ['a11yr', 15:35:20 INFO - 'ts_paint', 15:35:20 INFO - 'tpaint', 15:35:20 INFO - 'sessionrestore', 15:35:20 INFO - 'sessionrestore_no_auto_restore']}, 15:35:20 INFO - 'other_nol64': {'tests': ['a11yr', 15:35:20 INFO - 'ts_paint', 15:35:20 INFO - 'tpaint', 15:35:20 INFO - 'sessionrestore', 15:35:20 INFO - 'sessionrestore_no_auto_restore']}, 15:35:20 INFO - 'svgr': {'tests': ['tsvgx', 15:35:20 INFO - 'tsvgr_opacity', 15:35:20 INFO - 'tart', 15:35:20 INFO - 'tscrollx', 15:35:20 INFO - 'cart']}, 15:35:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['tsvgx', 15:35:20 INFO - 'tsvgr_opacity', 15:35:20 INFO - 'tart', 15:35:20 INFO - 'tscrollx', 15:35:20 INFO - 'cart']}, 15:35:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'tests': ['tp5o']}, 15:35:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'talos_options': ['--e10s'], 15:35:20 INFO - 'tests': ['tp5o']}, 15:35:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'talos_options': ['--xperf_path', 15:35:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:20 INFO - 'tests': ['tp5n']}, 15:35:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:20 INFO - 'talos_options': ['--e10s', 15:35:20 INFO - '--xperf_path', 15:35:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:20 INFO - 'tests': ['tp5n']}}, 15:35:20 INFO - 'talos.zip': {'path': '', 15:35:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:35:20 INFO - Running post-action listener: _resource_record_post_action 15:35:20 INFO - ##### 15:35:20 INFO - ##### Running create-virtualenv step. 15:35:20 INFO - ##### 15:35:20 INFO - Running pre-action listener: _resource_record_pre_action 15:35:20 INFO - Running main action method: create_virtualenv 15:35:20 INFO - Creating virtualenv /builds/slave/test/build/venv 15:35:20 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 15:35:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:35:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:35:20 INFO - Using real prefix '/tools/python27' 15:35:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:35:21 INFO - Installing distribute.............................................................................................................................................................................................done. 15:35:24 INFO - Installing pip.................done. 15:35:24 INFO - Return code: 0 15:35:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:24 INFO - 'HOME': '/Users/cltbld', 15:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:24 INFO - 'LOGNAME': 'cltbld', 15:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:24 INFO - 'MOZ_NO_REMOTE': '1', 15:35:24 INFO - 'NO_EM_RESTART': '1', 15:35:24 INFO - 'PAGER': '/bin/cat', 15:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:24 INFO - 'PWD': '/builds/slave/test', 15:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:24 INFO - 'SHELL': '/bin/bash', 15:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:24 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:24 INFO - 'USER': 'cltbld', 15:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:24 INFO - 'XPC_FLAGS': '0x0', 15:35:24 INFO - 'XPC_SERVICE_NAME': '0', 15:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:24 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 15:35:24 INFO - Cleaning up... 15:35:24 INFO - Return code: 0 15:35:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:24 INFO - 'HOME': '/Users/cltbld', 15:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:24 INFO - 'LOGNAME': 'cltbld', 15:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:24 INFO - 'MOZ_NO_REMOTE': '1', 15:35:24 INFO - 'NO_EM_RESTART': '1', 15:35:24 INFO - 'PAGER': '/bin/cat', 15:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:24 INFO - 'PWD': '/builds/slave/test', 15:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:24 INFO - 'SHELL': '/bin/bash', 15:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:24 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:24 INFO - 'USER': 'cltbld', 15:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:24 INFO - 'XPC_FLAGS': '0x0', 15:35:24 INFO - 'XPC_SERVICE_NAME': '0', 15:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:24 INFO - Downloading/unpacking psutil>=0.7.1 15:35:24 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 15:35:24 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 15:35:24 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 15:35:24 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 15:35:24 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 15:35:24 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 15:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:35:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:27 INFO - Installing collected packages: psutil 15:35:27 INFO - Running setup.py install for psutil 15:35:27 INFO - building 'psutil._psutil_osx' extension 15:35:27 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 15:35:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:35:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:35:28 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 15:35:28 INFO - building 'psutil._psutil_posix' extension 15:35:28 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 15:35:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:35:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:35:28 INFO - ^ 15:35:28 INFO - 1 warning generated. 15:35:28 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 15:35:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:28 INFO - Successfully installed psutil 15:35:28 INFO - Cleaning up... 15:35:28 INFO - Return code: 0 15:35:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:28 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 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:28 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 15:35:28 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 15:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:28 INFO - 'HOME': '/Users/cltbld', 15:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:28 INFO - 'LOGNAME': 'cltbld', 15:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:28 INFO - 'MOZ_NO_REMOTE': '1', 15:35:28 INFO - 'NO_EM_RESTART': '1', 15:35:28 INFO - 'PAGER': '/bin/cat', 15:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:28 INFO - 'PWD': '/builds/slave/test', 15:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:28 INFO - 'SHELL': '/bin/bash', 15:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:28 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:28 INFO - 'USER': 'cltbld', 15:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:28 INFO - 'XPC_FLAGS': '0x0', 15:35:28 INFO - 'XPC_SERVICE_NAME': '0', 15:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:35:28 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 15:35:28 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 15:35:28 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 15:35:28 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 15:35:28 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 15:35:28 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 15:35:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:35:31 INFO - Installing collected packages: mozsystemmonitor 15:35:31 INFO - Running setup.py install for mozsystemmonitor 15:35:31 INFO - Successfully installed mozsystemmonitor 15:35:31 INFO - Cleaning up... 15:35:31 INFO - Return code: 0 15:35:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:35:31 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')]} 15:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:31 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')]} 15:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:31 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 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:31 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 15:35:31 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 15:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:31 INFO - 'HOME': '/Users/cltbld', 15:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:31 INFO - 'LOGNAME': 'cltbld', 15:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:31 INFO - 'MOZ_NO_REMOTE': '1', 15:35:31 INFO - 'NO_EM_RESTART': '1', 15:35:31 INFO - 'PAGER': '/bin/cat', 15:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:31 INFO - 'PWD': '/builds/slave/test', 15:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:31 INFO - 'SHELL': '/bin/bash', 15:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:31 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:31 INFO - 'USER': 'cltbld', 15:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:31 INFO - 'XPC_FLAGS': '0x0', 15:35:31 INFO - 'XPC_SERVICE_NAME': '0', 15:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:35:31 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 15:35:31 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 15:35:31 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 15:35:31 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 15:35:31 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 15:35:31 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 15:35:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:35:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35: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 15:35:35 INFO - Downloading docopt-0.6.1.tar.gz 15:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:35 INFO - Running setup.py install for blobuploader 15:35:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:35:35 INFO - Running setup.py install for requests 15:35:36 INFO - Running setup.py install for docopt 15:35:36 INFO - Successfully installed blobuploader requests docopt 15:35:36 INFO - Cleaning up... 15:35:36 INFO - Return code: 0 15:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:36 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')]} 15:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:36 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')]} 15:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:36 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 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:36 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 15:35:36 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 15:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:36 INFO - 'HOME': '/Users/cltbld', 15:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:36 INFO - 'LOGNAME': 'cltbld', 15:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:36 INFO - 'MOZ_NO_REMOTE': '1', 15:35:36 INFO - 'NO_EM_RESTART': '1', 15:35:36 INFO - 'PAGER': '/bin/cat', 15:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:36 INFO - 'PWD': '/builds/slave/test', 15:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:36 INFO - 'SHELL': '/bin/bash', 15:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:36 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:36 INFO - 'USER': 'cltbld', 15:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:36 INFO - 'XPC_FLAGS': '0x0', 15:35:36 INFO - 'XPC_SERVICE_NAME': '0', 15:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-fGjb8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JnyTf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-iCT69U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:36 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Pt6h3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-fKXSp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-yedbqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-cAlWOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rCFK9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-o9Jsg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-rVP1FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-jfb5zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-puwMhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ByXiK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:37 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-H8ldGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JibBwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-eAoQNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-iKU56p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:38 INFO - Running setup.py install for manifestparser 15:35:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:35:38 INFO - Running setup.py install for mozcrash 15:35:38 INFO - Running setup.py install for mozdebug 15:35:38 INFO - Running setup.py install for mozdevice 15:35:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Running setup.py install for mozfile 15:35:39 INFO - Running setup.py install for mozhttpd 15:35:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Running setup.py install for mozinfo 15:35:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Running setup.py install for mozInstall 15:35:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Running setup.py install for mozleak 15:35:39 INFO - Running setup.py install for mozlog 15:35:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:35:39 INFO - Running setup.py install for moznetwork 15:35:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Running setup.py install for mozprocess 15:35:40 INFO - Running setup.py install for mozprofile 15:35:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Running setup.py install for mozrunner 15:35:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Running setup.py install for mozscreenshot 15:35:40 INFO - Running setup.py install for moztest 15:35:40 INFO - Running setup.py install for mozversion 15:35:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:35:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:40 INFO - Cleaning up... 15:35:41 INFO - Return code: 0 15:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:41 INFO - 'HOME': '/Users/cltbld', 15:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:41 INFO - 'LOGNAME': 'cltbld', 15:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:41 INFO - 'MOZ_NO_REMOTE': '1', 15:35:41 INFO - 'NO_EM_RESTART': '1', 15:35:41 INFO - 'PAGER': '/bin/cat', 15:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:41 INFO - 'PWD': '/builds/slave/test', 15:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:41 INFO - 'SHELL': '/bin/bash', 15:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:41 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:41 INFO - 'USER': 'cltbld', 15:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:41 INFO - 'XPC_FLAGS': '0x0', 15:35:41 INFO - 'XPC_SERVICE_NAME': '0', 15:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-WvEAyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:41 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)) 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-yemwPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:41 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)) 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-RT_G7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:41 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)) 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-dUZZ0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:41 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)) 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JpDe3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:41 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)) 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-I9YFmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:41 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)) 15:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:41 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-k37Izr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Lkq1Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ZHptlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-vCRkGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-AIlZod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-2FQu3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-JaCKB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-N8KpFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-cdDgGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:42 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)) 15:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:42 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-8i8Rw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-9Gtbs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:35:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:45 INFO - Downloading blessings-1.6.tar.gz 15:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:45 INFO - Installing collected packages: blessings 15:35:45 INFO - Running setup.py install for blessings 15:35:45 INFO - Successfully installed blessings 15:35:45 INFO - Cleaning up... 15:35:45 INFO - Return code: 0 15:35:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:46 INFO - Reading from file tmpfile_stdout 15:35:46 INFO - Current package versions: 15:35:46 INFO - blessings == 1.6 15:35:46 INFO - blobuploader == 1.2.4 15:35:46 INFO - docopt == 0.6.1 15:35:46 INFO - manifestparser == 1.1 15:35:46 INFO - mozInstall == 1.12 15:35:46 INFO - mozcrash == 0.16 15:35:46 INFO - mozdebug == 0.1 15:35:46 INFO - mozdevice == 0.48 15:35:46 INFO - mozfile == 1.2 15:35:46 INFO - mozhttpd == 0.7 15:35:46 INFO - mozinfo == 0.9 15:35:46 INFO - mozleak == 0.1 15:35:46 INFO - mozlog == 3.1 15:35:46 INFO - moznetwork == 0.27 15:35:46 INFO - mozprocess == 0.22 15:35:46 INFO - mozprofile == 0.28 15:35:46 INFO - mozrunner == 6.11 15:35:46 INFO - mozscreenshot == 0.1 15:35:46 INFO - mozsystemmonitor == 0.0 15:35:46 INFO - moztest == 0.7 15:35:46 INFO - mozversion == 1.4 15:35:46 INFO - psutil == 3.1.1 15:35:46 INFO - requests == 1.2.3 15:35:46 INFO - wsgiref == 0.1.2 15:35:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:46 INFO - 'HOME': '/Users/cltbld', 15:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:46 INFO - 'LOGNAME': 'cltbld', 15:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:46 INFO - 'MOZ_NO_REMOTE': '1', 15:35:46 INFO - 'NO_EM_RESTART': '1', 15:35:46 INFO - 'PAGER': '/bin/cat', 15:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:46 INFO - 'PWD': '/builds/slave/test', 15:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:46 INFO - 'SHELL': '/bin/bash', 15:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:46 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:46 INFO - 'USER': 'cltbld', 15:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:46 INFO - 'XPC_FLAGS': '0x0', 15:35:46 INFO - 'XPC_SERVICE_NAME': '0', 15:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 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)) 15:35:46 INFO - Cleaning up... 15:35:46 INFO - Return code: 0 15:35:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:46 INFO - 'HOME': '/Users/cltbld', 15:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:46 INFO - 'LOGNAME': 'cltbld', 15:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:46 INFO - 'MOZ_NO_REMOTE': '1', 15:35:46 INFO - 'NO_EM_RESTART': '1', 15:35:46 INFO - 'PAGER': '/bin/cat', 15:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:46 INFO - 'PWD': '/builds/slave/test', 15:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:46 INFO - 'SHELL': '/bin/bash', 15:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:46 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:46 INFO - 'USER': 'cltbld', 15:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:46 INFO - 'XPC_FLAGS': '0x0', 15:35:46 INFO - 'XPC_SERVICE_NAME': '0', 15:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:46 INFO - Downloading/unpacking jsonschema 15:35:46 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 15:35:46 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 15:35:46 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 15:35:46 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 15:35:46 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 15:35:46 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 15:35:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:48 INFO - Downloading/unpacking functools32 (from jsonschema) 15:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:49 INFO - warning: no files found matching '*.txt' 15:35:49 INFO - no previously-included directories found matching 'build' 15:35:49 INFO - no previously-included directories found matching 'dist' 15:35:49 INFO - no previously-included directories found matching '.git*' 15:35:49 INFO - Installing collected packages: jsonschema, functools32 15:35:49 INFO - Running setup.py install for functools32 15:35:49 INFO - warning: no files found matching '*.txt' 15:35:49 INFO - no previously-included directories found matching 'build' 15:35:49 INFO - no previously-included directories found matching 'dist' 15:35:49 INFO - no previously-included directories found matching '.git*' 15:35:49 INFO - Successfully installed jsonschema functools32 15:35:49 INFO - Cleaning up... 15:35:49 INFO - Return code: 0 15:35:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35: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')]} 15:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:49 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 0x10ccbca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccc34c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a8d6bb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, '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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 15:35:49 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 15:35:49 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 15:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:35:49 INFO - 'HOME': '/Users/cltbld', 15:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:35:49 INFO - 'LOGNAME': 'cltbld', 15:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:49 INFO - 'MOZ_NO_REMOTE': '1', 15:35:49 INFO - 'NO_EM_RESTART': '1', 15:35:49 INFO - 'PAGER': '/bin/cat', 15:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:49 INFO - 'PWD': '/builds/slave/test', 15:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:35:49 INFO - 'SHELL': '/bin/bash', 15:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:35:49 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:35:49 INFO - 'USER': 'cltbld', 15:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:49 INFO - 'XPC_FLAGS': '0x0', 15:35:49 INFO - 'XPC_SERVICE_NAME': '0', 15:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:49 INFO - Downloading/unpacking flake8 15:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:35:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:35:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 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 15:35:52 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 15:35:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:35:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:35:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:35:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:35:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:35:53 INFO - no previously-included directories found matching 'docs/_build' 15:35:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:35:53 INFO - Running setup.py install for pep8 15:35:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:35:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:35:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:35:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:35:53 INFO - no previously-included directories found matching 'docs/_build' 15:35:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:35:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:35:53 INFO - Cleaning up... 15:35:54 INFO - Return code: 0 15:35:54 INFO - Running post-action listener: _resource_record_post_action 15:35:54 INFO - Running post-action listener: _start_resource_monitoring 15:35:54 INFO - Starting resource monitoring. 15:35:54 INFO - ##### 15:35:54 INFO - ##### Running install step. 15:35:54 INFO - ##### 15:35:54 INFO - Running pre-action listener: _resource_record_pre_action 15:35:54 INFO - Running main action method: install 15:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Output received: 15:35:54 INFO - Usage: mozinstall [options] installer 15:35:54 INFO - Options: 15:35:54 INFO - -h, --help show this help message and exit 15:35:54 INFO - -d DEST, --destination=DEST 15:35:54 INFO - Directory to install application into. [default: 15:35:54 INFO - "/builds/slave/test"] 15:35:54 INFO - --app=APP Application being installed. [default: firefox] 15:35:54 INFO - mkdir: /builds/slave/test/build/application 15:35:54 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'] 15:35:54 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 15:36:28 INFO - Reading from file tmpfile_stdout 15:36:28 INFO - Output received: 15:36:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:36:28 INFO - Running post-action listener: _resource_record_post_action 15:36:28 INFO - ##### 15:36:28 INFO - ##### Running run-tests step. 15:36:28 INFO - ##### 15:36:28 INFO - Running pre-action listener: _resource_record_pre_action 15:36:28 INFO - Running main action method: run_tests 15:36:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:36:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:36:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:36:28 INFO - 2016-02-26 15:36:28.412 screenresolution[2893:39787] starting screenresolution argv=screenresolution get 15:36:28 INFO - 2016-02-26 15:36:28.415 screenresolution[2893:39787] Display 0: 1600x1200x32@60 15:36:28 INFO - 2016-02-26 15:36:28.421 screenresolution[2894:39790] starting screenresolution argv=screenresolution list 15:36:28 INFO - Available Modes on Display 0 15:36:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:36:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:36:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:36:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:36:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:36:28 INFO - Intel Iris: 15:36:28 INFO - Chipset Model: Intel Iris 15:36:28 INFO - Type: GPU 15:36:28 INFO - Bus: Built-In 15:36:28 INFO - VRAM (Dynamic, Max): 1536 MB 15:36:28 INFO - Vendor: Intel (0x8086) 15:36:28 INFO - Device ID: 0x0a2e 15:36:28 INFO - Revision ID: 0x0009 15:36:28 INFO - Displays: 15:36:28 INFO - Display: 15:36:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:36:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:36:28 INFO - Display Serial Number: 1600x1200 60 15:36:28 INFO - Main Display: Yes 15:36:28 INFO - Mirror: Off 15:36:28 INFO - Online: Yes 15:36:28 INFO - Rotation: Supported 15:36:28 INFO - Return code: 0 15:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:36:28 INFO - Python 2.7.3 15:36:28 INFO - Return code: 0 15:36:28 INFO - grabbing minidump binary from tooltool 15:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:36:28 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 0x10cb60d30>, '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 0x10c984db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb57b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:36:28 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 15:36:28 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 15:36:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:36:28 INFO - Return code: 0 15:36:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:36:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:36:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:36:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:36:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:36:30 INFO - Return code: 0 15:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:36:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z6mKt47FlL/Render', 15:36:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:36:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:36:30 INFO - 'HOME': '/Users/cltbld', 15:36:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:36:30 INFO - 'LOGNAME': 'cltbld', 15:36:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:36:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:30 INFO - 'MOZ_NO_REMOTE': '1', 15:36:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:36:30 INFO - 'NO_EM_RESTART': '1', 15:36:30 INFO - 'PAGER': '/bin/cat', 15:36:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:30 INFO - 'PWD': '/builds/slave/test', 15:36:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:36:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:36:30 INFO - 'SHELL': '/bin/bash', 15:36:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PzoCX0RXXj/Listeners', 15:36:30 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 15:36:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:36:30 INFO - 'USER': 'cltbld', 15:36:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:36:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:30 INFO - 'XPC_FLAGS': '0x0', 15:36:30 INFO - 'XPC_SERVICE_NAME': '0', 15:36:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:36:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:36:30 INFO - mozversion application_buildid: 20160226125526 15:36:30 INFO - mozversion application_changeset: 5592b9a4cad6e73e5f502a83f3d895300dd896e1 15:36:30 INFO - mozversion application_display_name: Nightly 15:36:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:36:30 INFO - mozversion application_name: Firefox 15:36:30 INFO - mozversion application_remotingname: firefox 15:36:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:36:30 INFO - mozversion application_vendor: Mozilla 15:36:30 INFO - mozversion application_version: 47.0a1 15:36:30 INFO - mozversion platform_buildid: 20160226125526 15:36:30 INFO - mozversion platform_changeset: 5592b9a4cad6e73e5f502a83f3d895300dd896e1 15:36:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:36:30 INFO - mozversion platform_version: 47.0a1 15:36:30 INFO - using testdate: 1456529790 15:36:30 INFO - actual date: 1456529790 15:36:30 INFO - starting webserver on 'localhost:49615' 15:36:30 INFO - SUITE-START | Running 2 tests 15:36:30 INFO - TEST-START | dromaeo_css 15:36:30 INFO - operating with platform_type : mac_ 15:36:30 INFO - Initialising browser for dromaeo_css test... 15:36:30 INFO - TEST-INFO | started process 2912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpzT5bKT/profile http://localhost:49615/getInfo.html) 15:36:33 INFO - PROCESS | 2912 | __metrics Screen width/height:1600/1200 15:36:33 INFO - PROCESS | 2912 | colorDepth:24 15:36:33 INFO - PROCESS | 2912 | Browser inner width/height: 1024/689 15:36:33 INFO - PROCESS | 2912 | __metrics 15:36:33 ERROR - PROCESS | 2912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:36:34 INFO - TEST-INFO | 2912: exit 0 15:36:34 INFO - Browser initialized. 15:36:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:36:34 INFO - TEST-INFO | started process 2916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpzT5bKT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:46 INFO - PROCESS | 2916 | RSS: Main: 255598592 15:36:46 INFO - PROCESS | 2916 | 15:37:35 INFO - PROCESS | 2916 | 1456529855727 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] 15:39:45 INFO - PROCESS | 2916 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49615/tests/dromaeo/cssquery-ext.html) 15:39:46 INFO - PROCESS | 2916 | RSS: Main: 270483456 15:39:46 INFO - PROCESS | 2916 | 15:42:48 INFO - PROCESS | 2916 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-ext.html (next: http://localhost:49615/tests/dromaeo/cssquery-jquery.html) 15:42:49 INFO - PROCESS | 2916 | RSS: Main: 282148864 15:42:49 INFO - PROCESS | 2916 | 15:45:51 INFO - PROCESS | 2916 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49615/tests/dromaeo/cssquery-mootools.html) 15:45:51 INFO - PROCESS | 2916 | RSS: Main: 283791360 15:45:51 INFO - PROCESS | 2916 | 15:48:53 INFO - PROCESS | 2916 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49615/tests/dromaeo/cssquery-prototype.html) 15:48:54 INFO - PROCESS | 2916 | RSS: Main: 286748672 15:48:54 INFO - PROCESS | 2916 | 15:51:56 INFO - PROCESS | 2916 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49615/tests/dromaeo/cssquery-yui.html) 15:51:57 INFO - PROCESS | 2916 | RSS: Main: 287576064 15:51:57 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-yui.html (next: http://localhost:49615/tests/dromaeo/cssquery-dojo.html) 15:54:59 INFO - PROCESS | 2916 | RSS: Main: 290729984 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | __start_tp_report 15:54:59 INFO - PROCESS | 2916 | _x_x_mozilla_page_load 15:54:59 INFO - PROCESS | 2916 | _x_x_mozilla_page_load_details 15:54:59 INFO - PROCESS | 2916 | |i|pagename|runs| 15:54:59 INFO - PROCESS | 2916 | |0;dojo.html;2754.7245275472455;2949.233199368164;3502.614712381639;3524.907278743588;3547.0068380853354;5245.921311180326;5664.20701101846;5779.162021506879;5789.305283366002;5792.565557583182;4432.268675668519;5066.695998240109;5641.153826925953;5727.42725727427;5849.415058494148;5180.792768289264;5212.869678258036;5280.392754833186;5340.91988620171;5370.1139312013665;639.8622257999139;5242;5247.317848679666;5247.47525247476;5303.840884773444;5192.428832828386;5211.895762084775;5229.843104706865;5251.081060814342;5267.47325267474;5109.463506331856;5245.659032162897;5251.474852514756;5253.711045892474;5272.710000949946;5124.692518448905;5184.300119483859;5231.5291623753665;5269;5284.894302113936;5573.693446860421;5606.915896261559;5661.7735290588325;5695.288088988877;5709.74306156224;6116.3053375860445;6210.472109870667;6242.906356404657;6245.906311405332;6267.937320626781;5168.250603662485;5370.167624018283;6188.690565471708;6228.96885515574;6249.750049989974;5831.620944638627;5844.123381492767;5850.063989761617;5870.853228669274;5871.4715675589405;6172.351903050205;6231.626102433868;6259.499240060784;6278.937210627927;6279.277883043417;6138.978968775459;6148.723307451175;6162;6166;6166.537509686791;6138.570300078952;6165.260168779775;6183;6219.595726277777;6225.968870155621;6114.480269177081;6135.937063216329;6180.351063138306;6197.566170368031;6286.528510361742;6113.780377411107;6141.823559979168;6209.813705588749;6218.502519798405;6237.563370564108;4900.632452566072;4905.705657660552;4919.237518184687;4927.605791536668;4941.851744447672;4336.197803406317;4343.348497725303;4418.381426600278;4441.533638967927;4499.392582001454;5774.393688662714;5892.823215303548;5907.3501914790195;5931.436513531207;5942;6238.033104868752;6239.438450539383;6246.15676883624;6257.655828929362;6264;5702.116171993348;5851.034579294454;5927.9407205928255;5952.672603006789;5975.342712301644;5360.65155764874;5372.247885296062;5380.219868119101;5390.434004429557;5402.35171779389;6185.628862268189;6337.144485494491;6344.080108384258;6347.270063942706;6377.3303803100935;6181.196444462191;6183.196184495987;6238.532110091671;6238.781642642486;6253.530985176221;6290.150829637941;6304.243490781136;6317.6209427434505;6350.872982540416;6357.4596159326975;6104.755809767559;6180.258368995749;6197;6238;6242.406971337898;6236.968815155895;6243.188385509855;6250.031245157008;6252.781152659635;6257.843553911007;6146.969265153645;6187.319394866651;6188.659623720739;6191.752329906753;6196.783112591038;5812.21535092774;5905.852353691193;5963.3142188647125;6035.456808887221;6151.507879369729;5871.178035075008;5939.703014849327;5954.345022047484;6017.909731353946;6070.696465176635;5961.374055724086;6171.876562468815;6195.884740746528;6201.3178550358525;6209.751609935552;5814.651120932757;5994.31065427464;6011;6042.637441753509;6077.604955677867 15:54:59 INFO - PROCESS | 2916 | |1;ext.html;421.2901261374584;461.3172504693054;497.0183886823523;510.7053619075644;527.738769309192;30369.24076898076;36820.631793682085;36877.262454750955;36879;36905.44641830371;37500.43749343762;37584.81207593958;38031.619683803154;38049.33654644176;38054.619453805455;8775.780605484882;8942.552872356406;9491.38306010107;9528.047195280486;9562.187214086776;9436.245100391952;9593.280503962196;9659.46872921989;9675.27435442341;9697.95151024244;9647.083527064917;9664.613415463373;9700;9710;9758.268129890252;9439.150476457118;9531.142197202285;9678.95160524193;9706.320557560974;9716.076972687584;9385.155336019723;9525.618975240983;9533.618655253782;9563.760905977337;9567.808643827155;37181.62818371809;37434;37552.24895502102;37607;37610.81194594037;2830.4763618730394;3025.9243518912203;3050.977922396;3254.544363789071;3349.7152742016956;25603.743962560322;25789.194731601947;25953.351166220807;27241;27342.863285683445;2743.506168889599;2746.1714434132873;2768.5708715149185;2829.1936798012675;2829.4341131773726;325771.37114314514;326127;326459;326509.3674531636;328568;38896.80551597224;43644.78177609155;46595.76702116535;50204.74488137826;59049.11426328609;43568.69293921188;43589.34615980699;43646.56353436488;43668.563314367086;43691.78154109209;15504.147271899928;15682.372705091897;15746.606334841721;15755.212239388215;15806.841931580537;10474.581016759244;11895.464704088165;11965.820512692317;12210.755784884253;12234.571789987485;14077.929610351883;14253.572392828231;14273.357698903366;14345.64135896611;14380.496682616058;5210.400803907523;5942.970285148633;6175.907361389583;6200.519792083112;6257.9687101564205;830.1366578758144;917.1287277086794;964.4165280005636;973.8539219117189;1089.2593036735095;27947.161585152477;28332.71667283301;28626.427471450872;29155.85422072876;29178.978735744146;1076.9069394564524;1088.3959402531514;1113.8607674040745;1120.7839494148777;1143.7475963819604;11609.419529023515;13894.166350019032;13949.651258718613;14006.71986560263;14147;474875;515784;521569;529184;529898;55944.44055559392;56360.71819640876;56440.717796410754;56529;56663;1305.2690493323769;1355.6881917159108;1376.2361889151616;1380.0408715942524;1392.8537503562184;24423;25858.35354116162;27500;27516.58725119085;27579.862100689366;47146.76426617845;47418;47452.52547474481;47469;47707.5229247717;486443;488384;488632;489046;489728;31639.841800790848;32606.021819345457;32650.83674581612;33071.50392744159;33307.83346083254;41908.790456048744;42724.08673002644;43679.12641747211;43741;44431.33352999643;31512.842435787676;36100.63899361078;36358.636413635526;36508;36989.815050924575;35497;35700.64299356973;36048.4592731104;36159.63840361563;36308.45537316995;29979.850100749358;34034.82982585071;35765.28469430545;35848.4622730654;36637.81681091578;29694.960676376224;30378.84810575933;30447;30519.542206867358;30731.692683072884;20056.398308050782;22805.88597057004;23605.763942360358;23874.40313992164;23953.640695389233 15:54:59 INFO - PROCESS | 2916 | |2;jquery.html;319.22269274317034;351.18525021949074;353.60043151239086;359.2742659827149;365.4664190282188;15600.453984110558;19454.011927554853;19757.814531128126;20049.699254511157;20156.798432015676;19687.704684429744;20167.39497815064;20846.270380536684;20848.270310539134;20896.477588060305;5500.614956953015;5764.875849209406;5815.360310365856;5824.563157763164;5835.474807267345;4132.566080561543;5677.120046392815;6065.211522502069;6356;6370.49036077115;5430.83707488776;6243.6565988870825;6284.183056202687;6289.685515724218;6319;5324.254604355374;5894.675792831393;6298.149749783812;6299.842503937392;6301.117843501914;5435.83692489222;5437.972810135963;5474.616776825624;5477.04151773442;5495.203195536625;12483.75032499354;13062.216267023914;13090.934545327213;13146.934265328708;13171.538996135185;1991.9004049797597;2042.2035406191596;2208.983867420988;2318.26974503031;2732.2076597786618;9085.636574537011;9513.381630194084;9761.755956101155;9813.852792208123;10151.238657100746;1696.5080126763223;1702.8893121947033;1776.4581802550217;1777.4667599720033;1793.1392931393004;105205.47397263041;107774;109045.45477272563;111163.44418277938;111265.33102003476;11286.040686541735;11442.94278528602;11464.31214127155;11532.36571988532;11598.652040438801;11703;13704.24626645524;13730.725385492235;13743.793843092362;13762.311884405739;7631.046119235096;7774.455788094779;8486.490810551386;8492.150784921458;8511.65953361871;8563.785905352415;8641.395102342776;8660.133986601415;8669.609867555975;8782.780430489289;4406.889827754332;4440.444944381952;4460.30865215892;4474.821007159742;4512.706674066175;1618.2556024228986;1651.471529110697;1803.386848471526;1853.4439668099517;1867.3380691184857;845.3659755183612;873.702941000063;896.6908313861704;908.2643059122132;1044.5090807320548;19880.204791808166;20287.695684564744;20523.692144617842;20609.175632974515;20860.79139208619;920.231606608476;921.8663293822358;954.5704433005176;972.2999440402899;1037.5953378182514;10944.343339399662;11117.944410277896;11129.77572467028;11146.554137834559;11222.102231821435;586972;596574;599078;635450;636161;112944.43527782308;113357.43321283505;113958.72082558302;114072;115220.42389788166;992.5632721602472;992.6128809764198;1008.9394636321845;1009.8232809258351;1015.4618052432223;18174.818251817313;18379.724304135718;18406.447806565826;18463.04591265391;18504.58779162404;52197.21704174516;52326;52661.47338526566;52924.47075529196;53385.46614533805;74253.51492970002;75306.62346688232;77589.61205193937;77735.6113219453;78857.60571197107;8040.3969702273735;8161.428699990944;8242.29940455068;8243.917560824315;8479.81282620446;9609.759756006155;13230.470781168646;13304.201747895157;13355.666108347368;13458.05793594439;9910.504474776377;11120.721981950515;11145;11296.03983661398;11669.299842009506;11040.668779936615;11318.037966772916;11426.143039271921;11593.420328983348;11700.180987330805;11245.606403775828;11754;11923.986461150553;11949.22330048544;11986.28082315029;8101.513909165469;8140.104588495143;8214.096449390443;8238.752837414888;8436.367272454469;11191.72020699489;11544.365059921785;11665.708357291136;11791.174617776673;11857.881421185677 15:54:59 INFO - PROCESS | 2916 | |3;mootools.html;1534.3479021415897;1551.2553974092439;1791.381973219239;1903.3338331583939;1912.426272118364;7784.649690763915;8388.328933685305;8512.361572882028;8686.565671716413;8730.476171429711;8485.91514084859;8487.193716596928;8491.745247642566;8551.444156129863;8563.143685631434;2423.127674037345;2435.415500279929;2436.4030812450887;2439.3047981325326;2449.2407353720314;2429.9392515187087;2441.633754936765;2453.9018439262495;2454.214651311581;2467.7655622715815;2432.817538684597;2439.1706819681303;2450.5588993981078;2458.938526536833;2459.5449841779237;2432.927012189637;2436.768506991833;2451.2768733223743;2461.384653836541;2467.7655622715815;2428.627825278712;2447.7062752469637;2449.1672831237465;2452.31335226137;2458.950820983588;8603.053664096944;8645.221930026264;8646.567671616456;8649.394542382035;8655.826883462296;5300.973495132538;5392.245085688007;5405.054115529767;5410.215518749798;5427.0773968425465;3127.03062050765;3545.8839574135613;3580.606133325332;3637.890863274106;3684.44733290006;824.8968878890139;1058.6188971970084;1097.8353247012933;1613.4998150573242;1650.8361605068399;9751.658691945748;11336;11446.542138314457;11480.71298217543;11557.306561606247;4557.6581756368405;4573.131105090022;4654.976725116353;4675.462321832964;4682.41469816273;7671.808204794925;8095.23095305945;8938.955305223562;9118.40730352525;9145.725628231165;5243.790248390022;5249.238860365225;5265.131253343232;5266.710330931835;5301.734913254322;4366.8908277292685;4749.1926372516755;4863.1732605457155;4873.853784386474;4915.48387419323;3648.5804132524568;3713.8700145494777;3723.9255214896093;3726.9627303727157;3756.4740936268945;1169.7660467906453;1173.0849937049115;1175.1362748379934;1175.7883580955338;1183.2249876331016;1319.2018828608745;1338.919664820114;1341.584108926236;1344.0121510689635;1369.7876829091506;8048.4366094374;8058.395620328499;8194.180581941759;8220.876686849702;8269.04905935813;947.5309721687809;1121.725177331559;1179.9056075513938;1180.9055275577932;1205.3852535207106;6149.385061493905;6242.09489624002;6249.96875015622;6299.685015749286;6340.4293613575;10140.138088262433;10622.521986510626;10645.361278323326;10683.626073087406;10708.411037392862;8712.564371781385;10179.694609161588;10548.261621686563;10556.208284378548;10559;8122.634481448349;8276.172382761675;8280.461769984931;8294.253517183482;8317.708880189164;7708.49894756839;7758.262965018314;7761.0298712660915;7830.725924592612;7838.412119091205;9234.630614775602;9476.905230947877;9550.283728720513;9583.472908990072;9587.808243835223;9762.121409073217;9813.214942804416;9867.40795552269;9869.555869985725;9932.205423566242;6315.936840631535;6643.036759669917;6827.93172068273;6893.03497510359;6991.44068474531;8027.518348899085;8046.275835174863;8056.798580035546;8058.033036035479;8100.635471403919;7108.431325494052;7222.422206223595;7265.164506081868;7337.559746415232;7432.591207483641;7055.788326350218;7108.111486064242;7133.072700548895;7142.003108684289;7252.854942901218;7550.131734850563;7602;7631.809204769926;7651.693932242648;7658.081030276402;5873.588848780544;6842.7605033823575;6878.896816547655;6892.517523773488;6894.931285650732;6947.895781563382;7033.824154396181;7041.647917603997;7054.929450705427;7077.858442831011 15:54:59 INFO - PROCESS | 2916 | |4;prototype.html;320.19630726875545;323.2823132645526;325.4126302024844;328.0682860675682;331.57061605221236;6810.931890681091;6868.2788307227775;6870;6875.621840798754;6884.9311506884915;5450.91823622646;6783.050372947791;6818.420434263081;6827.146606674166;6829.795106146811;3981.323175060232;4767.976160119195;4996.950030499703;5016.749162541867;5024.899502009957;4993.251012348159;4995.500449955011;5014.648974571764;5014.899702005976;5016.172331565287;4007.519097708279;4052.6555242804397;4979.7261150636705;4996.9500304996845;5039.521245481692;4971.204607262856;4982.476839931809;4983.576396006326;4986.152354099811;5000.67495612784;4272.209641216354;4273.401723758676;4276.50820155683;4294.377315289296;4300.956990430087;6282.340354262782;6496.123023391829;6555.6066636002;6580.5722628029025;6593.3736295051895;5893.381194974509;5914.881702365971;5914.9112763308585;5925.437083477106;5966.67183304918;7263.963680181618;7271.527350722239;7288.70845166198;7290.380317673004;7296.270372962715;4313.547077556874;4483.753393563353;4734.124187025377;4745.074710431467;4761.59526440253;7699.422543309274;7770.184130666255;7778.066632004139;7785.610719464061;7792.493487923323;4644.58198762113;4840.709557426495;4892.510748925079;4900.264960255919;4906.386701662293;4911.9754401227765;4946.3817022872145;4966.428860681068;4966.528179822911;4980.850574482772;5883.499902508249;5912.9113063304085;5918.852028699231;5937.218834349678;5940;7336.339729424378;7341.70633174667;7351.8162045949275;7366.189719130892;7394.001809755721;1709.3077303692025;1716.2362748577013;1730.2819329977917;1733.9739903901452;1738.8087310395847;1094.8029354716227;1135.8807325230896;1144.8683401408944;1151.9596814111467;1153.6539038288647;6845.760398386033;6865.622390768456;6887.20797108339;6899.517033807686;6924.757633482804;6356.682165891687;7358.638651849425;7559.357454616309;7584;7624.161342252348;5482.725863706878;5761.452661997104;6883.208431030395;7014.877619580842;7069.92930070703;4046.109855831712;4073.2668119738137;4075.91848163041;4097.713160078766;4108.5275193352545;5660.349059858169;7387.67021936046;8003.559804210824;8065.1934806518875;8105.8378832424205;5567.220589117527;7233.348998590152;7965.123836377994;7993.760187194393;8024.2376974187355;7801.882971755428;8064.870918071475;8077.434579579373;8088.959555202304;8111.553864537389;6541.771038013647;7458.142313633784;7713.267239612228;7730.994970653779;7774.144844067035;6091.329953705001;7555.584442855696;7596.240375962359;7609.277118673717;7621.161672215941;6479.708413121515;7511.887321690069;7704.26809453101;8026.719064832703;8099.797505062421;4571.908561828678;4916.213405855046;4931.914978704679;4965.304857319906;4982.601391888713;7672.923270767445;7673.194314596887;7679.961600192187;7685.538867667958;7704.768856934301;7360.77917662471;7371.889421658787;7375.336219740249;7385.113786345673;7397;7067.752628657972;7354.595497247488;7369;7385.150707668472;7396.260373962776;7143;7167.211606723152;7168.856622867618;7174.641267936478;7181.281871812777;7382.013712595353;7384.667689953858;7396.149442814145;7397;7425;7216.097987751531;7220.675069621985;7234.674439650334;7249.166345870081;7266.564006159436 15:54:59 INFO - PROCESS | 2916 | |5;yui.html;629.8756719256129;650.6584043377227;651.8012006338066;666.6101179041698;691.446842525979;14652.4871629493;14898;14938.5518434447;14961.775573366409;17168.742468862976;15645.765313520305;15805.130717810516;15849.92075039626;15931.840681593181;15967.760483592727;859.3898332184157;870.2168048756107;873.3406278259905;874.0691163910446;879.1077056787366;708.9468289878254;840.1682334488873;865.3596338709373;867.5878957495171;871.6469829718942;895.9641614335419;910.2808781062952;911.9831388002362;913.8811954445913;916.5829547555879;741.910970683516;819.8319344534386;867.8804342398267;893.3835653399134;895.7715782475492;650.1970066967339;664.4817042706696;669.6484345718488;676.3405679462534;677.2888467109515;14879.256037198205;14971.625709357244;14988.47540336083;15082.924585377112;15099.622509437242;10450.68647940563;10772.5690972361;12029.639110826689;12110.091743119301;12250.571230006995;9977.950110249474;10206.183505319557;10342.37945723259;10386.390109532958;10418.895811041868;3423.6918677318913;3449.6550344965553;3486.599041110254;3489;3569.446735755962;78502.42995140122;78541.60729196317;79122.60438697827;79696.80454793182;82007;8105.554194519358;8124.5937703114605;9089.81820363589;9174.220191283815;9251.76870578241;20405.79594204039;20418.897905510377;20431.897840511;20434.284800031928;20481.590368192552;7419.703211871572;7550.7734767957045;7618.504797188165;7683.462157648911;7758.340541053961;4024.8558808115827;4103.117829666636;4127.958720412757;4132.173565286955;4146.771927543954;3545.0782796473104;3553.182767963383;3554.7156227501737;3555.235624340779;3575.3028159508644;650.1612919334101;656.7537173559915;658.5949640970769;664.3987191591617;665.3778716899715;529.5419462165199;589.8820235952827;594.8602078511547;613.9539534534928;615.0712424239431;7883.487573307717;8144;8216.34269258458;8247.670093196324;8254.092049874509;524.2320001198262;525.8238490105857;599.838043728191;606.6854355842848;612.1185492890223;3844.500214972036;3850.210706805098;3864.1112544115012;3888.1640447303967;3943.5662077171487;70144;82891.5855420719;88858.3342499726;89554.55222723975;89997;71863;71983;72458.63770681218;72536;73729;57426.13860792008;64089;64132;64856;66246.33753662498;6996.475264355092;8371;8414.074451810418;8568.828623427622;8675.609597567998;42218.36672449854;43693.56306436895;48771.268430974276;49010.50989490059;50516.98966020586;59759;59808.401915980285;60427.69786151041;62821;65678;7879.133295337623;9251.537423128952;9542.950275469831;10907.781844363228;11026.558937642405;9785.902140978498;11638.70903227426;11920.582779602672;12063.21589096706;12378.690532736753;9401.952990235006;11136.49885755159;11252.943735281598;11299.548018079186;11716.004139648225;10901.83647245276;11220.943895280472;11275.210735248455;11480.138989575982;11845.5854045108;9589.376690515093;10714.678559643224;11223.4388280584;11398.202125851443;11581.05190732365;9288.23523530527;9482.051794820463;9607.471589062668;9609.423434593948;9670.903290967282;7791.766247012599;8268.83462330762;9347.485888276211;9684.75788105303;9767.365121267096 15:54:59 INFO - PROCESS | 2916 | __end_tp_report 15:54:59 INFO - PROCESS | 2916 | __start_cc_report 15:54:59 INFO - PROCESS | 2916 | _x_x_mozilla_cycle_collect,344 15:54:59 INFO - PROCESS | 2916 | __end_cc_report 15:54:59 INFO - PROCESS | 2916 | __startTimestamp1456530899895__endTimestamp 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | ------- Summary: start ------- 15:54:59 INFO - PROCESS | 2916 | Number of tests: 6 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | [#0] dojo.html Cycles:165 Average:5707.61 Median:5963.31 stddev:771.13 (12.9%) stddev-sans-first:737.88 15:54:59 INFO - PROCESS | 2916 | Values: 2754.7 2949.2 3502.6 3524.9 3547.0 5245.9 5664.2 5779.2 5789.3 5792.6 4432.3 5066.7 5641.2 5727.4 5849.4 5180.8 5212.9 5280.4 5340.9 5370.1 639.9 5242.0 5247.3 5247.5 5303.8 5192.4 5211.9 5229.8 5251.1 5267.5 5109.5 5245.7 5251.5 5253.7 5272.7 5124.7 5184.3 5231.5 5269.0 5284.9 5573.7 5606.9 5661.8 5695.3 5709.7 6116.3 6210.5 6242.9 6245.9 6267.9 5168.3 5370.2 6188.7 6229.0 6249.8 5831.6 5844.1 5850.1 5870.9 5871.5 6172.4 6231.6 6259.5 6278.9 6279.3 6139.0 6148.7 6162.0 6166.0 6166.5 6138.6 6165.3 6183.0 6219.6 6226.0 6114.5 6135.9 6180.4 6197.6 6286.5 6113.8 6141.8 6209.8 6218.5 6237.6 4900.6 4905.7 4919.2 4927.6 4941.9 4336.2 4343.3 4418.4 4441.5 4499.4 5774.4 5892.8 5907.4 5931.4 5942.0 6238.0 6239.4 6246.2 6257.7 6264.0 5702.1 5851.0 5927.9 5952.7 5975.3 5360.7 5372.2 5380.2 5390.4 5402.4 6185.6 6337.1 6344.1 6347.3 6377.3 6181.2 6183.2 6238.5 6238.8 6253.5 6290.2 6304.2 6317.6 6350.9 6357.5 6104.8 6180.3 6197.0 6238.0 6242.4 6237.0 6243.2 6250.0 6252.8 6257.8 6147.0 6187.3 6188.7 6191.8 6196.8 5812.2 5905.9 5963.3 6035.5 6151.5 5871.2 5939.7 5954.3 6017.9 6070.7 5961.4 6171.9 6195.9 6201.3 6209.8 5814.7 5994.3 6011.0 6042.6 6077.6 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | [#1] ext.html Cycles:180 Average:57521.77 Median:36729.22 stddev:120111.81 (327.0%) stddev-sans-first:120372.24 15:54:59 INFO - PROCESS | 2916 | Values: 421.3 461.3 497.0 510.7 527.7 30369.2 36820.6 36877.3 36879.0 36905.4 37500.4 37584.8 38031.6 38049.3 38054.6 8775.8 8942.6 9491.4 9528.0 9562.2 9436.2 9593.3 9659.5 9675.3 9698.0 9647.1 9664.6 9700.0 9710.0 9758.3 9439.2 9531.1 9679.0 9706.3 9716.1 9385.2 9525.6 9533.6 9563.8 9567.8 37181.6 37434.0 37552.2 37607.0 37610.8 2830.5 3025.9 3051.0 3254.5 3349.7 25603.7 25789.2 25953.4 27241.0 27342.9 2743.5 2746.2 2768.6 2829.2 2829.4 325771.4 326127.0 326459.0 326509.4 328568.0 38896.8 43644.8 46595.8 50204.7 59049.1 43568.7 43589.3 43646.6 43668.6 43691.8 15504.1 15682.4 15746.6 15755.2 15806.8 10474.6 11895.5 11965.8 12210.8 12234.6 14077.9 14253.6 14273.4 14345.6 14380.5 5210.4 5943.0 6175.9 6200.5 6258.0 830.1 917.1 964.4 973.9 1089.3 27947.2 28332.7 28626.4 29155.9 29179.0 1076.9 1088.4 1113.9 1120.8 1143.7 11609.4 13894.2 13949.7 14006.7 14147.0 474875.0 515784.0 521569.0 529184.0 529898.0 55944.4 56360.7 56440.7 56529.0 56663.0 1305.3 1355.7 1376.2 1380.0 1392.9 24423.0 25858.4 27500.0 27516.6 27579.9 47146.8 47418.0 47452.5 47469.0 47707.5 486443.0 488384.0 488632.0 489046.0 489728.0 31639.8 32606.0 32650.8 33071.5 33307.8 41908.8 42724.1 43679.1 43741.0 44431.3 31512.8 36100.6 36358.6 36508.0 36989.8 35497.0 35700.6 36048.5 36159.6 36308.5 29979.9 34034.8 35765.3 35848.5 36637.8 29695.0 30378.8 30447.0 30519.5 30731.7 20056.4 22805.9 23605.8 23874.4 23953.6 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | [#2] jquery.html Cycles:180 Average:34283.70 Median:11552.73 stddev:101409.82 (877.8%) stddev-sans-first:101662.24 15:54:59 INFO - PROCESS | 2916 | Values: 319.2 351.2 353.6 359.3 365.5 15600.5 19454.0 19757.8 20049.7 20156.8 19687.7 20167.4 20846.3 20848.3 20896.5 5500.6 5764.9 5815.4 5824.6 5835.5 4132.6 5677.1 6065.2 6356.0 6370.5 5430.8 6243.7 6284.2 6289.7 6319.0 5324.3 5894.7 6298.1 6299.8 6301.1 5435.8 5438.0 5474.6 5477.0 5495.2 12483.8 13062.2 13090.9 13146.9 13171.5 1991.9 2042.2 2209.0 2318.3 2732.2 9085.6 9513.4 9761.8 9813.9 10151.2 1696.5 1702.9 1776.5 1777.5 1793.1 105205.5 107774.0 109045.5 111163.4 111265.3 11286.0 11442.9 11464.3 11532.4 11598.7 11703.0 13704.2 13730.7 13743.8 13762.3 7631.0 7774.5 8486.5 8492.2 8511.7 8563.8 8641.4 8660.1 8669.6 8782.8 4406.9 4440.4 4460.3 4474.8 4512.7 1618.3 1651.5 1803.4 1853.4 1867.3 845.4 873.7 896.7 908.3 1044.5 19880.2 20287.7 20523.7 20609.2 20860.8 920.2 921.9 954.6 972.3 1037.6 10944.3 11117.9 11129.8 11146.6 11222.1 586972.0 596574.0 599078.0 635450.0 636161.0 112944.4 113357.4 113958.7 114072.0 115220.4 992.6 992.6 1008.9 1009.8 1015.5 18174.8 18379.7 18406.4 18463.0 18504.6 52197.2 52326.0 52661.5 52924.5 53385.5 74253.5 75306.6 77589.6 77735.6 78857.6 8040.4 8161.4 8242.3 8243.9 8479.8 9609.8 13230.5 13304.2 13355.7 13458.1 9910.5 11120.7 11145.0 11296.0 11669.3 11040.7 11318.0 11426.1 11593.4 11700.2 11245.6 11754.0 11924.0 11949.2 11986.3 8101.5 8140.1 8214.1 8238.8 8436.4 11191.7 11544.4 11665.7 11791.2 11857.9 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | [#3] mootools.html Cycles:180 Average:5900.07 Median:5650.33 stddev:3043.07 (53.9%) stddev-sans-first:3033.91 15:54:59 INFO - PROCESS | 2916 | Values: 1534.3 1551.3 1791.4 1903.3 1912.4 7784.6 8388.3 8512.4 8686.6 8730.5 8485.9 8487.2 8491.7 8551.4 8563.1 2423.1 2435.4 2436.4 2439.3 2449.2 2429.9 2441.6 2453.9 2454.2 2467.8 2432.8 2439.2 2450.6 2458.9 2459.5 2432.9 2436.8 2451.3 2461.4 2467.8 2428.6 2447.7 2449.2 2452.3 2459.0 8603.1 8645.2 8646.6 8649.4 8655.8 5301.0 5392.2 5405.1 5410.2 5427.1 3127.0 3545.9 3580.6 3637.9 3684.4 824.9 1058.6 1097.8 1613.5 1650.8 9751.7 11336.0 11446.5 11480.7 11557.3 4557.7 4573.1 4655.0 4675.5 4682.4 7671.8 8095.2 8939.0 9118.4 9145.7 5243.8 5249.2 5265.1 5266.7 5301.7 4366.9 4749.2 4863.2 4873.9 4915.5 3648.6 3713.9 3723.9 3727.0 3756.5 1169.8 1173.1 1175.1 1175.8 1183.2 1319.2 1338.9 1341.6 1344.0 1369.8 8048.4 8058.4 8194.2 8220.9 8269.0 947.5 1121.7 1179.9 1180.9 1205.4 6149.4 6242.1 6250.0 6299.7 6340.4 10140.1 10622.5 10645.4 10683.6 10708.4 8712.6 10179.7 10548.3 10556.2 10559.0 8122.6 8276.2 8280.5 8294.3 8317.7 7708.5 7758.3 7761.0 7830.7 7838.4 9234.6 9476.9 9550.3 9583.5 9587.8 9762.1 9813.2 9867.4 9869.6 9932.2 6315.9 6643.0 6827.9 6893.0 6991.4 8027.5 8046.3 8056.8 8058.0 8100.6 7108.4 7222.4 7265.2 7337.6 7432.6 7055.8 7108.1 7133.1 7142.0 7252.9 7550.1 7602.0 7631.8 7651.7 7658.1 5873.6 6842.8 6878.9 6892.5 6894.9 6947.9 7033.8 7041.6 7054.9 7077.9 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | [#4] prototype.html Cycles:180 Average:5952.08 Median:6814.68 stddev:1920.81 (28.2%) stddev-sans-first:1879.11 15:54:59 INFO - PROCESS | 2916 | Values: 320.2 323.3 325.4 328.1 331.6 6810.9 6868.3 6870.0 6875.6 6884.9 5450.9 6783.1 6818.4 6827.1 6829.8 3981.3 4768.0 4997.0 5016.7 5024.9 4993.3 4995.5 5014.6 5014.9 5016.2 4007.5 4052.7 4979.7 4997.0 5039.5 4971.2 4982.5 4983.6 4986.2 5000.7 4272.2 4273.4 4276.5 4294.4 4301.0 6282.3 6496.1 6555.6 6580.6 6593.4 5893.4 5914.9 5914.9 5925.4 5966.7 7264.0 7271.5 7288.7 7290.4 7296.3 4313.5 4483.8 4734.1 4745.1 4761.6 7699.4 7770.2 7778.1 7785.6 7792.5 4644.6 4840.7 4892.5 4900.3 4906.4 4912.0 4946.4 4966.4 4966.5 4980.9 5883.5 5912.9 5918.9 5937.2 5940.0 7336.3 7341.7 7351.8 7366.2 7394.0 1709.3 1716.2 1730.3 1734.0 1738.8 1094.8 1135.9 1144.9 1152.0 1153.7 6845.8 6865.6 6887.2 6899.5 6924.8 6356.7 7358.6 7559.4 7584.0 7624.2 5482.7 5761.5 6883.2 7014.9 7069.9 4046.1 4073.3 4075.9 4097.7 4108.5 5660.3 7387.7 8003.6 8065.2 8105.8 5567.2 7233.3 7965.1 7993.8 8024.2 7801.9 8064.9 8077.4 8089.0 8111.6 6541.8 7458.1 7713.3 7731.0 7774.1 6091.3 7555.6 7596.2 7609.3 7621.2 6479.7 7511.9 7704.3 8026.7 8099.8 4571.9 4916.2 4931.9 4965.3 4982.6 7672.9 7673.2 7680.0 7685.5 7704.8 7360.8 7371.9 7375.3 7385.1 7397.0 7067.8 7354.6 7369.0 7385.2 7396.3 7143.0 7167.2 7168.9 7174.6 7181.3 7382.0 7384.7 7396.1 7397.0 7425.0 7216.1 7220.7 7234.7 7249.2 7266.6 15:54:59 INFO - PROCESS | 2916 | 15:54:59 INFO - PROCESS | 2916 | [#5] yui.html Cycles:180 Average:17332.99 Median:64494.00 stddev:23898.83 (37.1%) stddev-sans-first:23932.96 15:54:59 INFO - PROCESS | 2916 | Values: 629.9 650.7 651.8 666.6 691.4 14652.5 14898.0 14938.6 14961.8 17168.7 15645.8 15805.1 15849.9 15931.8 15967.8 859.4 870.2 873.3 874.1 879.1 708.9 840.2 865.4 867.6 871.6 896.0 910.3 912.0 913.9 916.6 741.9 819.8 867.9 893.4 895.8 650.2 664.5 669.6 676.3 677.3 14879.3 14971.6 14988.5 15082.9 15099.6 10450.7 10772.6 12029.6 12110.1 12250.6 9978.0 10206.2 10342.4 10386.4 10418.9 3423.7 3449.7 3486.6 3489.0 3569.4 78502.4 78541.6 79122.6 79696.8 82007.0 8105.6 8124.6 9089.8 9174.2 9251.8 20405.8 20418.9 20431.9 20434.3 20481.6 7419.7 7550.8 7618.5 7683.5 7758.3 4024.9 4103.1 4128.0 4132.2 4146.8 3545.1 3553.2 3554.7 3555.2 3575.3 650.2 656.8 658.6 664.4 665.4 529.5 589.9 594.9 614.0 615.1 7883.5 8144.0 8216.3 8247.7 8254.1 524.2 525.8 599.8 606.7 612.1 3844.5 3850.2 3864.1 3888.2 3943.6 70144.0 82891.6 88858.3 89554.6 89997.0 71863.0 71983.0 72458.6 72536.0 73729.0 57426.1 64089.0 64132.0 64856.0 66246.3 6996.5 8371.0 8414.1 8568.8 8675.6 42218.4 43693.6 48771.3 49010.5 50517.0 59759.0 59808.4 60427.7 62821.0 65678.0 7879.1 9251.5 9543.0 10907.8 11026.6 9785.9 11638.7 11920.6 12063.2 12378.7 9402.0 11136.5 11252.9 11299.5 11716.0 10901.8 11220.9 11275.2 11480.1 11845.6 9589.4 10714.7 11223.4 11398.2 11581.1 9288.2 9482.1 9607.5 9609.4 9670.9 7791.8 8268.8 9347.5 9684.8 9767.4 15:54:59 INFO - PROCESS | 2916 | -------- Summary: end -------- 15:54:59 INFO - PROCESS | 2916 | 15:55:00 INFO - TEST-INFO | 2916: exit 0 15:55:00 INFO - TEST-OK | dromaeo_css | took 1109808ms 15:55:00 INFO - TEST-START | kraken 15:55:00 INFO - operating with platform_type : mac_ 15:55:00 INFO - Initialising browser for kraken test... 15:55:00 INFO - TEST-INFO | started process 2920 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpeYwpeZ/profile http://localhost:49615/getInfo.html) 15:55:03 INFO - PROCESS | 2920 | __metrics Screen width/height:1600/1200 15:55:03 INFO - PROCESS | 2920 | colorDepth:24 15:55:03 INFO - PROCESS | 2920 | Browser inner width/height: 1024/689 15:55:03 INFO - PROCESS | 2920 | __metrics 15:55:03 ERROR - PROCESS | 2920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:55:04 INFO - TEST-INFO | 2920: exit 0 15:55:04 INFO - Browser initialized. 15:55:04 INFO - Running cycle 1/1 for kraken test... 15:55:04 INFO - TEST-INFO | started process 2923 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpeYwpeZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:16 INFO - PROCESS | 2923 | RSS: Main: 257359872 15:55:16 INFO - PROCESS | 2923 | 15:55:18 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-beat-detection) 15:55:19 INFO - PROCESS | 2923 | RSS: Main: 269168640 15:55:19 INFO - PROCESS | 2923 | 15:55:22 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-dft) 15:55:22 INFO - PROCESS | 2923 | RSS: Main: 276561920 15:55:22 INFO - PROCESS | 2923 | 15:55:26 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-fft) 15:55:26 INFO - PROCESS | 2923 | RSS: Main: 280817664 15:55:26 INFO - PROCESS | 2923 | 15:55:28 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-oscillator) 15:55:29 INFO - PROCESS | 2923 | RSS: Main: 282845184 15:55:29 INFO - PROCESS | 2923 | 15:55:31 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:55:32 INFO - PROCESS | 2923 | RSS: Main: 283324416 15:55:32 INFO - PROCESS | 2923 | 15:55:35 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-darkroom) 15:55:35 INFO - PROCESS | 2923 | RSS: Main: 283009024 15:55:35 INFO - PROCESS | 2923 | 15:55:38 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-desaturate) 15:55:39 INFO - PROCESS | 2923 | RSS: Main: 282537984 15:55:39 INFO - PROCESS | 2923 | 15:55:42 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49615/tests/kraken/driver.html?testName=json-parse-financial) 15:55:42 INFO - PROCESS | 2923 | RSS: Main: 283455488 15:55:42 INFO - PROCESS | 2923 | 15:55:44 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:55:45 INFO - PROCESS | 2923 | RSS: Main: 284102656 15:55:45 INFO - PROCESS | 2923 | 15:55:46 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:55:47 INFO - PROCESS | 2923 | RSS: Main: 282439680 15:55:47 INFO - PROCESS | 2923 | 15:55:49 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:55:50 INFO - PROCESS | 2923 | RSS: Main: 282632192 15:55:50 INFO - PROCESS | 2923 | 15:55:52 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:55:53 INFO - PROCESS | 2923 | RSS: Main: 284569600 15:55:53 INFO - PROCESS | 2923 | 15:55:55 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:55:56 INFO - PROCESS | 2923 | RSS: Main: 283803648 15:55:56 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49615/tests/kraken/driver.html?testName=ai-astar) 15:55:58 INFO - PROCESS | 2923 | RSS: Main: 285093888 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | __start_tp_report 15:55:58 INFO - PROCESS | 2923 | _x_x_mozilla_page_load 15:55:58 INFO - PROCESS | 2923 | _x_x_mozilla_page_load_details 15:55:58 INFO - PROCESS | 2923 | |i|pagename|runs| 15:55:58 INFO - PROCESS | 2923 | |0;ai-astar;117;110;116;114;115;123;113;113;115;114 15:55:58 INFO - PROCESS | 2923 | |1;audio-beat-detection;160;142;170;156;123;162;171;120;191;148 15:55:58 INFO - PROCESS | 2923 | |2;audio-dft;219;253;225;259;238;280;242;193;201;201 15:55:58 INFO - PROCESS | 2923 | |3;audio-fft;71;71;77;127;56;59;59;60;87;83 15:55:58 INFO - PROCESS | 2923 | |4;audio-oscillator;83;83;130;99;84;81;108;89;117;101 15:55:58 INFO - PROCESS | 2923 | |5;imaging-gaussian-blur;86;94;86;123;114;139;113;137;129;91 15:55:58 INFO - PROCESS | 2923 | |6;imaging-darkroom;122;96;96;100;149;151;95;103;94;104 15:55:58 INFO - PROCESS | 2923 | |7;imaging-desaturate;114;85;150;142;91;92;92;89;92;91 15:55:58 INFO - PROCESS | 2923 | |8;json-parse-financial;57;58;56;56;56;57;58;88;54;56 15:55:58 INFO - PROCESS | 2923 | |9;json-stringify-tinderbox;69;67;68;71;76;75;68;68;67;67 15:55:58 INFO - PROCESS | 2923 | |10;stanford-crypto-aes;86;89;85;85;87;84;87;84;86;85 15:55:58 INFO - PROCESS | 2923 | |11;stanford-crypto-ccm;127;124;128;125;136;111;129;114;117;120 15:55:58 INFO - PROCESS | 2923 | |12;stanford-crypto-pbkdf2;163;142;138;140;146;144;177;177;143;139 15:55:58 INFO - PROCESS | 2923 | |13;stanford-crypto-sha256-iterative;68;68;68;66;69;65;69;66;73;92 15:55:58 INFO - PROCESS | 2923 | __end_tp_report 15:55:58 INFO - PROCESS | 2923 | __start_cc_report 15:55:58 INFO - PROCESS | 2923 | _x_x_mozilla_cycle_collect,880 15:55:58 INFO - PROCESS | 2923 | __end_cc_report 15:55:58 INFO - PROCESS | 2923 | __startTimestamp1456530958455__endTimestamp 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | ------- Summary: start ------- 15:55:58 INFO - PROCESS | 2923 | Number of tests: 14 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:3.40 (3.0%) stddev-sans-first:3.53 15:55:58 INFO - PROCESS | 2923 | Values: 117.0 110.0 116.0 114.0 115.0 123.0 113.0 113.0 115.0 114.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:161.00 stddev:21.89 (13.6%) stddev-sans-first:23.12 15:55:58 INFO - PROCESS | 2923 | Values: 160.0 142.0 170.0 156.0 123.0 162.0 171.0 120.0 191.0 148.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#2] audio-dft Cycles:10 Average:231.10 Median:240.00 stddev:28.41 (11.8%) stddev-sans-first:29.79 15:55:58 INFO - PROCESS | 2923 | Values: 219.0 253.0 225.0 259.0 238.0 280.0 242.0 193.0 201.0 201.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#3] audio-fft Cycles:10 Average:75.00 Median:71.00 stddev:21.20 (29.9%) stddev-sans-first:22.44 15:55:58 INFO - PROCESS | 2923 | Values: 71.0 71.0 77.0 127.0 56.0 59.0 59.0 60.0 87.0 83.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:83.00 stddev:16.69 (20.1%) stddev-sans-first:16.86 15:55:58 INFO - PROCESS | 2923 | Values: 83.0 83.0 130.0 99.0 84.0 81.0 108.0 89.0 117.0 101.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#5] imaging-gaussian-blur Cycles:10 Average:111.20 Median:112.50 stddev:20.76 (18.5%) stddev-sans-first:19.92 15:55:58 INFO - PROCESS | 2923 | Values: 86.0 94.0 86.0 123.0 114.0 139.0 113.0 137.0 129.0 91.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#6] imaging-darkroom Cycles:10 Average:111.00 Median:122.50 stddev:22.10 (18.0%) stddev-sans-first:23.07 15:55:58 INFO - PROCESS | 2923 | Values: 122.0 96.0 96.0 100.0 149.0 151.0 95.0 103.0 94.0 104.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:91.00 stddev:23.61 (25.9%) stddev-sans-first:24.75 15:55:58 INFO - PROCESS | 2923 | Values: 114.0 85.0 150.0 142.0 91.0 92.0 92.0 89.0 92.0 91.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:57.00 stddev:10.05 (17.6%) stddev-sans-first:10.61 15:55:58 INFO - PROCESS | 2923 | Values: 57.0 58.0 56.0 56.0 56.0 57.0 58.0 88.0 54.0 56.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:68.50 stddev:3.34 (4.9%) stddev-sans-first:3.54 15:55:58 INFO - PROCESS | 2923 | Values: 69.0 67.0 68.0 71.0 76.0 75.0 68.0 68.0 67.0 67.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.55 (1.8%) stddev-sans-first:1.64 15:55:58 INFO - PROCESS | 2923 | Values: 86.0 89.0 85.0 85.0 87.0 84.0 87.0 84.0 86.0 85.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:126.00 stddev:7.61 (6.0%) stddev-sans-first:7.94 15:55:58 INFO - PROCESS | 2923 | Values: 127.0 124.0 128.0 125.0 136.0 111.0 129.0 114.0 117.0 120.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:145.00 stddev:15.45 (10.7%) stddev-sans-first:15.76 15:55:58 INFO - PROCESS | 2923 | Values: 163.0 142.0 138.0 140.0 146.0 144.0 177.0 177.0 143.0 139.0 15:55:58 INFO - PROCESS | 2923 | 15:55:58 INFO - PROCESS | 2923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:68.50 stddev:7.90 (11.5%) stddev-sans-first:8.34 15:55:58 INFO - PROCESS | 2923 | Values: 68.0 68.0 68.0 66.0 69.0 65.0 69.0 66.0 73.0 92.0 15:55:58 INFO - PROCESS | 2923 | -------- Summary: end -------- 15:55:58 INFO - PROCESS | 2923 | 15:55:59 INFO - TEST-INFO | 2923: exit 0 15:55:59 INFO - TEST-OK | kraken | took 58725ms 15:55:59 INFO - SUITE-END | took 1168s 15:55:59 INFO - Completed test suite (00:19:28) 15:55:59 INFO - Working with test: dromaeo_css 15:55:59 INFO - Generating results file: dromaeo_css 15:55:59 INFO - Working with test: kraken 15:55:59 INFO - Generating results file: kraken 15:55:59 INFO - javascript benchmark 15:55:59 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:56:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 15:56:00 INFO - process_Request line: dromaeo_css 7399.36 graph.html#tests=[[72,64,61]] 15:56:00 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:56:00 INFO - process_Request line: kraken 1558.30 graph.html#tests=[[232,64,61]] 15:56:00 INFO - RETURN: dromaeo_css: 7399.36 15:56:00 INFO - RETURN: kraken: 1558.30 15:56:00 INFO - javascript benchmark 15:56:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2754.7245275472455, 2949.233199368164, 3502.614712381639, 3524.907278743588, 3547.0068380853354, 5245.921311180326, 5664.20701101846, 5779.162021506879, 5789.305283366002, 5792.565557583182, 4432.268675668519, 5066.695998240109, 5641.153826925953, 5727.42725727427, 5849.415058494148, 5180.792768289264, 5212.869678258036, 5280.392754833186, 5340.91988620171, 5370.1139312013665, 639.8622257999139, 5242.0, 5247.317848679666, 5247.47525247476, 5303.840884773444, 5192.428832828386, 5211.895762084775, 5229.843104706865, 5251.081060814342, 5267.47325267474, 5109.463506331856, 5245.659032162897, 5251.474852514756, 5253.711045892474, 5272.710000949946, 5124.692518448905, 5184.300119483859, 5231.5291623753665, 5269.0, 5284.894302113936, 5573.693446860421, 5606.915896261559, 5661.7735290588325, 5695.288088988877, 5709.74306156224, 6116.3053375860445, 6210.472109870667, 6242.906356404657, 6245.906311405332, 6267.937320626781, 5168.250603662485, 5370.167624018283, 6188.690565471708, 6228.96885515574, 6249.750049989974, 5831.620944638627, 5844.123381492767, 5850.063989761617, 5870.853228669274, 5871.4715675589405, 6172.351903050205, 6231.626102433868, 6259.499240060784, 6278.937210627927, 6279.277883043417, 6138.978968775459, 6148.723307451175, 6162.0, 6166.0, 6166.537509686791, 6138.570300078952, 6165.260168779775, 6183.0, 6219.595726277777, 6225.968870155621, 6114.480269177081, 6135.937063216329, 6180.351063138306, 6197.566170368031, 6286.528510361742, 6113.780377411107, 6141.823559979168, 6209.813705588749, 6218.502519798405, 6237.563370564108, 4900.632452566072, 4905.705657660552, 4919.237518184687, 4927.605791536668, 4941.851744447672, 4336.197803406317, 4343.348497725303, 4418.381426600278, 4441.533638967927, 4499.392582001454, 5774.393688662714, 5892.823215303548, 5907.3501914790195, 5931.436513531207, 5942.0, 6238.033104868752, 6239.438450539383, 6246.15676883624, 6257.655828929362, 6264.0, 5702.116171993348, 5851.034579294454, 5927.9407205928255, 5952.672603006789, 5975.342712301644, 5360.65155764874, 5372.247885296062, 5380.219868119101, 5390.434004429557, 5402.35171779389, 6185.628862268189, 6337.144485494491, 6344.080108384258, 6347.270063942706, 6377.3303803100935, 6181.196444462191, 6183.196184495987, 6238.532110091671, 6238.781642642486, 6253.530985176221, 6290.150829637941, 6304.243490781136, 6317.6209427434505, 6350.872982540416, 6357.4596159326975, 6104.755809767559, 6180.258368995749, 6197.0, 6238.0, 6242.406971337898, 6236.968815155895, 6243.188385509855, 6250.031245157008, 6252.781152659635, 6257.843553911007, 6146.969265153645, 6187.319394866651, 6188.659623720739, 6191.752329906753, 6196.783112591038, 5812.21535092774, 5905.852353691193, 5963.3142188647125, 6035.456808887221, 6151.507879369729, 5871.178035075008, 5939.703014849327, 5954.345022047484, 6017.909731353946, 6070.696465176635, 5961.374055724086, 6171.876562468815, 6195.884740746528, 6201.3178550358525, 6209.751609935552, 5814.651120932757, 5994.31065427464, 6011.0, 6042.637441753509, 6077.604955677867], "unit": "score", "name": "dojo.html", "value": 5658.720080848902}, {"lowerIsBetter": false, "replicates": [421.2901261374584, 461.3172504693054, 497.0183886823523, 510.7053619075644, 527.738769309192, 30369.24076898076, 36820.631793682085, 36877.262454750955, 36879.0, 36905.44641830371, 37500.43749343762, 37584.81207593958, 38031.619683803154, 38049.33654644176, 38054.619453805455, 8775.780605484882, 8942.552872356406, 9491.38306010107, 9528.047195280486, 9562.187214086776, 9436.245100391952, 9593.280503962196, 9659.46872921989, 9675.27435442341, 9697.95151024244, 9647.083527064917, 9664.613415463373, 9700.0, 9710.0, 9758.268129890252, 9439.150476457118, 9531.142197202285, 9678.95160524193, 9706.320557560974, 9716.076972687584, 9385.155336019723, 9525.618975240983, 9533.618655253782, 9563.760905977337, 9567.808643827155, 37181.62818371809, 37434.0, 37552.24895502102, 37607.0, 37610.81194594037, 2830.4763618730394, 3025.9243518912203, 3050.977922396, 3254.544363789071, 3349.7152742016956, 25603.743962560322, 25789.194731601947, 25953.351166220807, 27241.0, 27342.863285683445, 2743.506168889599, 2746.1714434132873, 2768.5708715149185, 2829.1936798012675, 2829.4341131773726, 325771.37114314514, 326127.0, 326459.0, 326509.3674531636, 328568.0, 38896.80551597224, 43644.78177609155, 46595.76702116535, 50204.74488137826, 59049.11426328609, 43568.69293921188, 43589.34615980699, 43646.56353436488, 43668.563314367086, 43691.78154109209, 15504.147271899928, 15682.372705091897, 15746.606334841721, 15755.212239388215, 15806.841931580537, 10474.581016759244, 11895.464704088165, 11965.820512692317, 12210.755784884253, 12234.571789987485, 14077.929610351883, 14253.572392828231, 14273.357698903366, 14345.64135896611, 14380.496682616058, 5210.400803907523, 5942.970285148633, 6175.907361389583, 6200.519792083112, 6257.9687101564205, 830.1366578758144, 917.1287277086794, 964.4165280005636, 973.8539219117189, 1089.2593036735095, 27947.161585152477, 28332.71667283301, 28626.427471450872, 29155.85422072876, 29178.978735744146, 1076.9069394564524, 1088.3959402531514, 1113.8607674040745, 1120.7839494148777, 1143.7475963819604, 11609.419529023515, 13894.166350019032, 13949.651258718613, 14006.71986560263, 14147.0, 474875.0, 515784.0, 521569.0, 529184.0, 529898.0, 55944.44055559392, 56360.71819640876, 56440.717796410754, 56529.0, 56663.0, 1305.2690493323769, 1355.6881917159108, 1376.2361889151616, 1380.0408715942524, 1392.8537503562184, 24423.0, 25858.35354116162, 27500.0, 27516.58725119085, 27579.862100689366, 47146.76426617845, 47418.0, 47452.52547474481, 47469.0, 47707.5229247717, 486443.0, 488384.0, 488632.0, 489046.0, 489728.0, 31639.841800790848, 32606.021819345457, 32650.83674581612, 33071.50392744159, 33307.83346083254, 41908.790456048744, 42724.08673002644, 43679.12641747211, 43741.0, 44431.33352999643, 31512.842435787676, 36100.63899361078, 36358.636413635526, 36508.0, 36989.815050924575, 35497.0, 35700.64299356973, 36048.4592731104, 36159.63840361563, 36308.45537316995, 29979.850100749358, 34034.82982585071, 35765.28469430545, 35848.4622730654, 36637.81681091578, 29694.960676376224, 30378.84810575933, 30447.0, 30519.542206867358, 30731.692683072884, 20056.398308050782, 22805.88597057004, 23605.763942360358, 23874.40313992164, 23953.640695389233], "unit": "score", "name": "ext.html", "value": 18134.13746100413}, {"lowerIsBetter": false, "replicates": [319.22269274317034, 351.18525021949074, 353.60043151239086, 359.2742659827149, 365.4664190282188, 15600.453984110558, 19454.011927554853, 19757.814531128126, 20049.699254511157, 20156.798432015676, 19687.704684429744, 20167.39497815064, 20846.270380536684, 20848.270310539134, 20896.477588060305, 5500.614956953015, 5764.875849209406, 5815.360310365856, 5824.563157763164, 5835.474807267345, 4132.566080561543, 5677.120046392815, 6065.211522502069, 6356.0, 6370.49036077115, 5430.83707488776, 6243.6565988870825, 6284.183056202687, 6289.685515724218, 6319.0, 5324.254604355374, 5894.675792831393, 6298.149749783812, 6299.842503937392, 6301.117843501914, 5435.83692489222, 5437.972810135963, 5474.616776825624, 5477.04151773442, 5495.203195536625, 12483.75032499354, 13062.216267023914, 13090.934545327213, 13146.934265328708, 13171.538996135185, 1991.9004049797597, 2042.2035406191596, 2208.983867420988, 2318.26974503031, 2732.2076597786618, 9085.636574537011, 9513.381630194084, 9761.755956101155, 9813.852792208123, 10151.238657100746, 1696.5080126763223, 1702.8893121947033, 1776.4581802550217, 1777.4667599720033, 1793.1392931393004, 105205.47397263041, 107774.0, 109045.45477272563, 111163.44418277938, 111265.33102003476, 11286.040686541735, 11442.94278528602, 11464.31214127155, 11532.36571988532, 11598.652040438801, 11703.0, 13704.24626645524, 13730.725385492235, 13743.793843092362, 13762.311884405739, 7631.046119235096, 7774.455788094779, 8486.490810551386, 8492.150784921458, 8511.65953361871, 8563.785905352415, 8641.395102342776, 8660.133986601415, 8669.609867555975, 8782.780430489289, 4406.889827754332, 4440.444944381952, 4460.30865215892, 4474.821007159742, 4512.706674066175, 1618.2556024228986, 1651.471529110697, 1803.386848471526, 1853.4439668099517, 1867.3380691184857, 845.3659755183612, 873.702941000063, 896.6908313861704, 908.2643059122132, 1044.5090807320548, 19880.204791808166, 20287.695684564744, 20523.692144617842, 20609.175632974515, 20860.79139208619, 920.231606608476, 921.8663293822358, 954.5704433005176, 972.2999440402899, 1037.5953378182514, 10944.343339399662, 11117.944410277896, 11129.77572467028, 11146.554137834559, 11222.102231821435, 586972.0, 596574.0, 599078.0, 635450.0, 636161.0, 112944.43527782308, 113357.43321283505, 113958.72082558302, 114072.0, 115220.42389788166, 992.5632721602472, 992.6128809764198, 1008.9394636321845, 1009.8232809258351, 1015.4618052432223, 18174.818251817313, 18379.724304135718, 18406.447806565826, 18463.04591265391, 18504.58779162404, 52197.21704174516, 52326.0, 52661.47338526566, 52924.47075529196, 53385.46614533805, 74253.51492970002, 75306.62346688232, 77589.61205193937, 77735.6113219453, 78857.60571197107, 8040.3969702273735, 8161.428699990944, 8242.29940455068, 8243.917560824315, 8479.81282620446, 9609.759756006155, 13230.470781168646, 13304.201747895157, 13355.666108347368, 13458.05793594439, 9910.504474776377, 11120.721981950515, 11145.0, 11296.03983661398, 11669.299842009506, 11040.668779936615, 11318.037966772916, 11426.143039271921, 11593.420328983348, 11700.180987330805, 11245.606403775828, 11754.0, 11923.986461150553, 11949.22330048544, 11986.28082315029, 8101.513909165469, 8140.104588495143, 8214.096449390443, 8238.752837414888, 8436.367272454469, 11191.72020699489, 11544.365059921785, 11665.708357291136, 11791.174617776673, 11857.881421185677], "unit": "score", "name": "jquery.html", "value": 9261.758868799696}, {"lowerIsBetter": false, "replicates": [1534.3479021415897, 1551.2553974092439, 1791.381973219239, 1903.3338331583939, 1912.426272118364, 7784.649690763915, 8388.328933685305, 8512.361572882028, 8686.565671716413, 8730.476171429711, 8485.91514084859, 8487.193716596928, 8491.745247642566, 8551.444156129863, 8563.143685631434, 2423.127674037345, 2435.415500279929, 2436.4030812450887, 2439.3047981325326, 2449.2407353720314, 2429.9392515187087, 2441.633754936765, 2453.9018439262495, 2454.214651311581, 2467.7655622715815, 2432.817538684597, 2439.1706819681303, 2450.5588993981078, 2458.938526536833, 2459.5449841779237, 2432.927012189637, 2436.768506991833, 2451.2768733223743, 2461.384653836541, 2467.7655622715815, 2428.627825278712, 2447.7062752469637, 2449.1672831237465, 2452.31335226137, 2458.950820983588, 8603.053664096944, 8645.221930026264, 8646.567671616456, 8649.394542382035, 8655.826883462296, 5300.973495132538, 5392.245085688007, 5405.054115529767, 5410.215518749798, 5427.0773968425465, 3127.03062050765, 3545.8839574135613, 3580.606133325332, 3637.890863274106, 3684.44733290006, 824.8968878890139, 1058.6188971970084, 1097.8353247012933, 1613.4998150573242, 1650.8361605068399, 9751.658691945748, 11336.0, 11446.542138314457, 11480.71298217543, 11557.306561606247, 4557.6581756368405, 4573.131105090022, 4654.976725116353, 4675.462321832964, 4682.41469816273, 7671.808204794925, 8095.23095305945, 8938.955305223562, 9118.40730352525, 9145.725628231165, 5243.790248390022, 5249.238860365225, 5265.131253343232, 5266.710330931835, 5301.734913254322, 4366.8908277292685, 4749.1926372516755, 4863.1732605457155, 4873.853784386474, 4915.48387419323, 3648.5804132524568, 3713.8700145494777, 3723.9255214896093, 3726.9627303727157, 3756.4740936268945, 1169.7660467906453, 1173.0849937049115, 1175.1362748379934, 1175.7883580955338, 1183.2249876331016, 1319.2018828608745, 1338.919664820114, 1341.584108926236, 1344.0121510689635, 1369.7876829091506, 8048.4366094374, 8058.395620328499, 8194.180581941759, 8220.876686849702, 8269.04905935813, 947.5309721687809, 1121.725177331559, 1179.9056075513938, 1180.9055275577932, 1205.3852535207106, 6149.385061493905, 6242.09489624002, 6249.96875015622, 6299.685015749286, 6340.4293613575, 10140.138088262433, 10622.521986510626, 10645.361278323326, 10683.626073087406, 10708.411037392862, 8712.564371781385, 10179.694609161588, 10548.261621686563, 10556.208284378548, 10559.0, 8122.634481448349, 8276.172382761675, 8280.461769984931, 8294.253517183482, 8317.708880189164, 7708.49894756839, 7758.262965018314, 7761.0298712660915, 7830.725924592612, 7838.412119091205, 9234.630614775602, 9476.905230947877, 9550.283728720513, 9583.472908990072, 9587.808243835223, 9762.121409073217, 9813.214942804416, 9867.40795552269, 9869.555869985725, 9932.205423566242, 6315.936840631535, 6643.036759669917, 6827.93172068273, 6893.03497510359, 6991.44068474531, 8027.518348899085, 8046.275835174863, 8056.798580035546, 8058.033036035479, 8100.635471403919, 7108.431325494052, 7222.422206223595, 7265.164506081868, 7337.559746415232, 7432.591207483641, 7055.788326350218, 7108.111486064242, 7133.072700548895, 7142.003108684289, 7252.854942901218, 7550.131734850563, 7602.0, 7631.809204769926, 7651.693932242648, 7658.081030276402, 5873.588848780544, 6842.7605033823575, 6878.896816547655, 6892.517523773488, 6894.931285650732, 6947.895781563382, 7033.824154396181, 7041.647917603997, 7054.929450705427, 7077.858442831011], "unit": "score", "name": "mootools.html", "value": 4863.997004571386}, {"lowerIsBetter": false, "replicates": [320.19630726875545, 323.2823132645526, 325.4126302024844, 328.0682860675682, 331.57061605221236, 6810.931890681091, 6868.2788307227775, 6870.0, 6875.621840798754, 6884.9311506884915, 5450.91823622646, 6783.050372947791, 6818.420434263081, 6827.146606674166, 6829.795106146811, 3981.323175060232, 4767.976160119195, 4996.950030499703, 5016.749162541867, 5024.899502009957, 4993.251012348159, 4995.500449955011, 5014.648974571764, 5014.899702005976, 5016.172331565287, 4007.519097708279, 4052.6555242804397, 4979.7261150636705, 4996.9500304996845, 5039.521245481692, 4971.204607262856, 4982.476839931809, 4983.576396006326, 4986.152354099811, 5000.67495612784, 4272.209641216354, 4273.401723758676, 4276.50820155683, 4294.377315289296, 4300.956990430087, 6282.340354262782, 6496.123023391829, 6555.6066636002, 6580.5722628029025, 6593.3736295051895, 5893.381194974509, 5914.881702365971, 5914.9112763308585, 5925.437083477106, 5966.67183304918, 7263.963680181618, 7271.527350722239, 7288.70845166198, 7290.380317673004, 7296.270372962715, 4313.547077556874, 4483.753393563353, 4734.124187025377, 4745.074710431467, 4761.59526440253, 7699.422543309274, 7770.184130666255, 7778.066632004139, 7785.610719464061, 7792.493487923323, 4644.58198762113, 4840.709557426495, 4892.510748925079, 4900.264960255919, 4906.386701662293, 4911.9754401227765, 4946.3817022872145, 4966.428860681068, 4966.528179822911, 4980.850574482772, 5883.499902508249, 5912.9113063304085, 5918.852028699231, 5937.218834349678, 5940.0, 7336.339729424378, 7341.70633174667, 7351.8162045949275, 7366.189719130892, 7394.001809755721, 1709.3077303692025, 1716.2362748577013, 1730.2819329977917, 1733.9739903901452, 1738.8087310395847, 1094.8029354716227, 1135.8807325230896, 1144.8683401408944, 1151.9596814111467, 1153.6539038288647, 6845.760398386033, 6865.622390768456, 6887.20797108339, 6899.517033807686, 6924.757633482804, 6356.682165891687, 7358.638651849425, 7559.357454616309, 7584.0, 7624.161342252348, 5482.725863706878, 5761.452661997104, 6883.208431030395, 7014.877619580842, 7069.92930070703, 4046.109855831712, 4073.2668119738137, 4075.91848163041, 4097.713160078766, 4108.5275193352545, 5660.349059858169, 7387.67021936046, 8003.559804210824, 8065.1934806518875, 8105.8378832424205, 5567.220589117527, 7233.348998590152, 7965.123836377994, 7993.760187194393, 8024.2376974187355, 7801.882971755428, 8064.870918071475, 8077.434579579373, 8088.959555202304, 8111.553864537389, 6541.771038013647, 7458.142313633784, 7713.267239612228, 7730.994970653779, 7774.144844067035, 6091.329953705001, 7555.584442855696, 7596.240375962359, 7609.277118673717, 7621.161672215941, 6479.708413121515, 7511.887321690069, 7704.26809453101, 8026.719064832703, 8099.797505062421, 4571.908561828678, 4916.213405855046, 4931.914978704679, 4965.304857319906, 4982.601391888713, 7672.923270767445, 7673.194314596887, 7679.961600192187, 7685.538867667958, 7704.768856934301, 7360.77917662471, 7371.889421658787, 7375.336219740249, 7385.113786345673, 7397.0, 7067.752628657972, 7354.595497247488, 7369.0, 7385.150707668472, 7396.260373962776, 7143.0, 7167.211606723152, 7168.856622867618, 7174.641267936478, 7181.281871812777, 7382.013712595353, 7384.667689953858, 7396.149442814145, 7397.0, 7425.0, 7216.097987751531, 7220.675069621985, 7234.674439650334, 7249.166345870081, 7266.564006159436], "unit": "score", "name": "prototype.html", "value": 5314.3991622291005}, {"lowerIsBetter": false, "replicates": [629.8756719256129, 650.6584043377227, 651.8012006338066, 666.6101179041698, 691.446842525979, 14652.4871629493, 14898.0, 14938.5518434447, 14961.775573366409, 17168.742468862976, 15645.765313520305, 15805.130717810516, 15849.92075039626, 15931.840681593181, 15967.760483592727, 859.3898332184157, 870.2168048756107, 873.3406278259905, 874.0691163910446, 879.1077056787366, 708.9468289878254, 840.1682334488873, 865.3596338709373, 867.5878957495171, 871.6469829718942, 895.9641614335419, 910.2808781062952, 911.9831388002362, 913.8811954445913, 916.5829547555879, 741.910970683516, 819.8319344534386, 867.8804342398267, 893.3835653399134, 895.7715782475492, 650.1970066967339, 664.4817042706696, 669.6484345718488, 676.3405679462534, 677.2888467109515, 14879.256037198205, 14971.625709357244, 14988.47540336083, 15082.924585377112, 15099.622509437242, 10450.68647940563, 10772.5690972361, 12029.639110826689, 12110.091743119301, 12250.571230006995, 9977.950110249474, 10206.183505319557, 10342.37945723259, 10386.390109532958, 10418.895811041868, 3423.6918677318913, 3449.6550344965553, 3486.599041110254, 3489.0, 3569.446735755962, 78502.42995140122, 78541.60729196317, 79122.60438697827, 79696.80454793182, 82007.0, 8105.554194519358, 8124.5937703114605, 9089.81820363589, 9174.220191283815, 9251.76870578241, 20405.79594204039, 20418.897905510377, 20431.897840511, 20434.284800031928, 20481.590368192552, 7419.703211871572, 7550.7734767957045, 7618.504797188165, 7683.462157648911, 7758.340541053961, 4024.8558808115827, 4103.117829666636, 4127.958720412757, 4132.173565286955, 4146.771927543954, 3545.0782796473104, 3553.182767963383, 3554.7156227501737, 3555.235624340779, 3575.3028159508644, 650.1612919334101, 656.7537173559915, 658.5949640970769, 664.3987191591617, 665.3778716899715, 529.5419462165199, 589.8820235952827, 594.8602078511547, 613.9539534534928, 615.0712424239431, 7883.487573307717, 8144.0, 8216.34269258458, 8247.670093196324, 8254.092049874509, 524.2320001198262, 525.8238490105857, 599.838043728191, 606.6854355842848, 612.1185492890223, 3844.500214972036, 3850.210706805098, 3864.1112544115012, 3888.1640447303967, 3943.5662077171487, 70144.0, 82891.5855420719, 88858.3342499726, 89554.55222723975, 89997.0, 71863.0, 71983.0, 72458.63770681218, 72536.0, 73729.0, 57426.13860792008, 64089.0, 64132.0, 64856.0, 66246.33753662498, 6996.475264355092, 8371.0, 8414.074451810418, 8568.828623427622, 8675.609597567998, 42218.36672449854, 43693.56306436895, 48771.268430974276, 49010.50989490059, 50516.98966020586, 59759.0, 59808.401915980285, 60427.69786151041, 62821.0, 65678.0, 7879.133295337623, 9251.537423128952, 9542.950275469831, 10907.781844363228, 11026.558937642405, 9785.902140978498, 11638.70903227426, 11920.582779602672, 12063.21589096706, 12378.690532736753, 9401.952990235006, 11136.49885755159, 11252.943735281598, 11299.548018079186, 11716.004139648225, 10901.83647245276, 11220.943895280472, 11275.210735248455, 11480.138989575982, 11845.5854045108, 9589.376690515093, 10714.678559643224, 11223.4388280584, 11398.202125851443, 11581.05190732365, 9288.23523530527, 9482.051794820463, 9607.471589062668, 9609.423434593948, 9670.903290967282, 7791.766247012599, 8268.83462330762, 9347.485888276211, 9684.75788105303, 9767.365121267096], "unit": "score", "name": "yui.html", "value": 6680.026190238551}], "name": "dromaeo_css", "value": 7399.362031573814}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 110.0, 116.0, 114.0, 115.0, 123.0, 113.0, 113.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [160.0, 142.0, 170.0, 156.0, 123.0, 162.0, 171.0, 120.0, 191.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 154.3}, {"lowerIsBetter": true, "replicates": [219.0, 253.0, 225.0, 259.0, 238.0, 280.0, 242.0, 193.0, 201.0, 201.0], "unit": "score", "name": "audio-dft", "value": 231.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 77.0, 127.0, 56.0, 59.0, 59.0, 60.0, 87.0, 83.0], "unit": "score", "name": "audio-fft", "value": 75.0}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 130.0, 99.0, 84.0, 81.0, 108.0, 89.0, 117.0, 101.0], "unit": "score", "name": "audio-oscillator", "value": 97.5}, {"lowerIsBetter": true, "replicates": [86.0, 94.0, 86.0, 123.0, 114.0, 139.0, 113.0, 137.0, 129.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 111.2}, {"lowerIsBetter": true, "replicates": [122.0, 96.0, 96.0, 100.0, 149.0, 151.0, 95.0, 103.0, 94.0, 104.0], "unit": "score", "name": "imaging-darkroom", "value": 111.0}, {"lowerIsBetter": true, "replicates": [114.0, 85.0, 150.0, 142.0, 91.0, 92.0, 92.0, 89.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 103.8}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 56.0, 56.0, 57.0, 58.0, 88.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 71.0, 76.0, 75.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [86.0, 89.0, 85.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.8}, {"lowerIsBetter": true, "replicates": [127.0, 124.0, 128.0, 125.0, 136.0, 111.0, 129.0, 114.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [163.0, 142.0, 138.0, 140.0, 146.0, 144.0, 177.0, 177.0, 143.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 66.0, 69.0, 65.0, 69.0, 66.0, 73.0, 92.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1558.3}]} 15:56:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1558.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7399.36"}}} 15:56:00 INFO - Return code: 0 15:56:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:56:00 ERROR - # TBPL SUCCESS # 15:56:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:56:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:56:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:56:00 INFO - 2016-02-26 15:56:00.199 screenresolution[2928:42504] starting screenresolution argv=screenresolution get 15:56:00 INFO - 2016-02-26 15:56:00.202 screenresolution[2928:42504] Display 0: 1600x1200x32@60 15:56:00 INFO - 2016-02-26 15:56:00.208 screenresolution[2929:42507] starting screenresolution argv=screenresolution list 15:56:00 INFO - Available Modes on Display 0 15:56:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:56:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:56:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:56:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:56:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:56:00 INFO - Intel Iris: 15:56:00 INFO - Chipset Model: Intel Iris 15:56:00 INFO - Type: GPU 15:56:00 INFO - Bus: Built-In 15:56:00 INFO - VRAM (Dynamic, Max): 1536 MB 15:56:00 INFO - Vendor: Intel (0x8086) 15:56:00 INFO - Device ID: 0x0a2e 15:56:00 INFO - Revision ID: 0x0009 15:56:00 INFO - Displays: 15:56:00 INFO - Display: 15:56:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:56:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:56:00 INFO - Display Serial Number: 1600x1200 60 15:56:00 INFO - Main Display: Yes 15:56:00 INFO - Mirror: Off 15:56:00 INFO - Online: Yes 15:56:00 INFO - Rotation: Supported 15:56:00 INFO - Return code: 0 15:56:00 INFO - Running post-action listener: _resource_record_post_action 15:56:00 INFO - Running post-run listener: _resource_record_post_run 15:56:01 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 0; Write bytes: 706713600; Read time: 0; Write time: 1973 15:56:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399542784; Write bytes: 393483776; Read time: 29954; Write time: 685 15:56:01 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 0; Write bytes: 299569664; Read time: 0; Write time: 1254 15:56:01 INFO - Running post-run listener: _upload_blobber_files 15:56:01 INFO - Blob upload gear active. 15:56:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:56:01 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 15:56:01 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'] 15:56:01 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 15:56:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:56:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:56:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:56:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:56:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:02 INFO - (blobuploader) - INFO - Done attempting. 15:56:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:56:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:56:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:56:03 INFO - (blobuploader) - INFO - Done attempting. 15:56:03 INFO - (blobuploader) - INFO - Iteration through files over. 15:56:03 INFO - Return code: 0 15:56:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:56:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:56:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bb4927a314a6f18c799842918a00e95d23736e9d1a75b2a8c795a955e42e158d480aecc49bbd8e587be542529215566ef492e64eac3792caecd812c77c44887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1b748b183717174ebb72efde88052e2d219ab2d1c35fa5215efa0971acc23e5f2bb2ae99f78c7137188e7d950b3946224106f4e8ee496e67b496d193d04153"} 15:56:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:56:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:56:03 INFO - Contents: 15:56:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bb4927a314a6f18c799842918a00e95d23736e9d1a75b2a8c795a955e42e158d480aecc49bbd8e587be542529215566ef492e64eac3792caecd812c77c44887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1b748b183717174ebb72efde88052e2d219ab2d1c35fa5215efa0971acc23e5f2bb2ae99f78c7137188e7d950b3946224106f4e8ee496e67b496d193d04153"} 15:56:03 INFO - Running post-run listener: copy_logs_to_upload_dir 15:56:03 INFO - Copying logs to upload dir... 15:56:03 INFO - mkdir: /builds/slave/test/build/upload/logs 15:56:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.719511 ========= master_lag: 2.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-26 15:56:06.367481) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 15:56:06.371412) ========= 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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bb4927a314a6f18c799842918a00e95d23736e9d1a75b2a8c795a955e42e158d480aecc49bbd8e587be542529215566ef492e64eac3792caecd812c77c44887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1b748b183717174ebb72efde88052e2d219ab2d1c35fa5215efa0971acc23e5f2bb2ae99f78c7137188e7d950b3946224106f4e8ee496e67b496d193d04153"} build_url:https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011624 build_url: 'https://queue.taskcluster.net/v1/task/MetVe_-4S4WVXytGIWRd8g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bb4927a314a6f18c799842918a00e95d23736e9d1a75b2a8c795a955e42e158d480aecc49bbd8e587be542529215566ef492e64eac3792caecd812c77c44887", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc1b748b183717174ebb72efde88052e2d219ab2d1c35fa5215efa0971acc23e5f2bb2ae99f78c7137188e7d950b3946224106f4e8ee496e67b496d193d04153"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 15:56:06.417542) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:56:06.417871) ========= 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.Z6mKt47FlL/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.PzoCX0RXXj/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005433 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:56:06.480923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 15:56:06.481240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 15:56:06.671848) ========= ========= Total master_lag: 2.68 =========