builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0145 starttime: 1488507083.45 results: success (0) buildid: 20170302165138 builduid: a0246c0a7e454465a5c09329466465d7 revision: d5b97a00c7e41b500878d293c16140304e871482 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.453969) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.454471) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.454758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.481869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.482280) ========= 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.34AhMnopqn/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.ODQ71HtXg8/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 --2017-03-02 18:11:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2017-03-02 18:11:23 (15.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126667 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.633269) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.633589) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.34AhMnopqn/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.ODQ71HtXg8/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.026265 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:23.682641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 18:11:23.683011) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d5b97a00c7e41b500878d293c16140304e871482 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d5b97a00c7e41b500878d293c16140304e871482 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.34AhMnopqn/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.ODQ71HtXg8/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 2017-03-02 18:11:23,782 truncating revision to first 12 chars 2017-03-02 18:11:23,782 Setting DEBUG logging. 2017-03-02 18:11:23,782 attempt 1/10 2017-03-02 18:11:23,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d5b97a00c7e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 18:11:25,765 unpacking tar archive at: mozilla-aurora-d5b97a00c7e4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.247527 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 18:11:25.956198) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:25.956667) ========= script_repo_revision: d5b97a00c7e41b500878d293c16140304e871482 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:25.957304) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:25.957780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 18:11:25.980140) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-02 18:11:25.980748) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.34AhMnopqn/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.ODQ71HtXg8/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:11:26 INFO - MultiFileLogger online at 20170302 18:11:26 in /builds/slave/test 18:11:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:11:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:26 INFO - {'append_to_log': False, 18:11:26 INFO - 'base_work_dir': '/builds/slave/test', 18:11:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:11:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:26 INFO - 'branch': 'Mozilla-Aurora', 18:11:26 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:26 INFO - 'config_files': ('talos/mac_config.py',), 18:11:26 INFO - 'default_actions': ('clobber', 18:11:26 INFO - 'read-buildbot-config', 18:11:26 INFO - 'download-and-extract', 18:11:26 INFO - 'populate-webroot', 18:11:26 INFO - 'create-virtualenv', 18:11:26 INFO - 'install', 18:11:26 INFO - 'run-tests'), 18:11:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:26 INFO - 'download_minidump_stackwalk': True, 18:11:26 INFO - 'download_symbols': 'ondemand', 18:11:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:26 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:26 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:26 INFO - 'installer_path': 'installer.exe', 18:11:26 INFO - 'log_level': 'info', 18:11:26 INFO - 'log_name': 'talos', 18:11:26 INFO - 'log_to_console': True, 18:11:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:11:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:11:26 INFO - 'opt_config_files': (), 18:11:26 INFO - 'pip_index': False, 18:11:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:26 INFO - 'cmd': ('bash', 18:11:26 INFO - '-c', 18:11:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:26 INFO - 'enabled': True, 18:11:26 INFO - 'halt_on_failure': False, 18:11:26 INFO - 'name': 'check_screen_resolution'},), 18:11:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:26 INFO - 'cmd': ('bash', 18:11:26 INFO - '-c', 18:11:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:26 INFO - 'enabled': True, 18:11:26 INFO - 'halt_on_failure': False, 18:11:26 INFO - 'name': 'check_screen_resolution'},), 18:11:26 INFO - 'run_cmd_checks_enabled': True, 18:11:26 INFO - 'sps_profile': False, 18:11:26 INFO - 'sps_profile_interval': 0, 18:11:26 INFO - 'suite': 'dromaeojs-e10s', 18:11:26 INFO - 'system_bits': '32', 18:11:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:26 INFO - 'title': 't-yosemite-r7-0145', 18:11:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:26 INFO - 'use_talos_json': True, 18:11:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:26 INFO - 'work_dir': 'build'} 18:11:26 INFO - [mozharness: 2017-03-03 02:11:26.194393Z] Running clobber step. 18:11:26 INFO - Running pre-action listener: _resource_record_pre_action 18:11:26 INFO - Running main action method: clobber 18:11:26 INFO - rmtree: /builds/slave/test/build 18:11:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:28 INFO - Running post-action listener: _resource_record_post_action 18:11:28 INFO - [mozharness: 2017-03-03 02:11:28.751018Z] Finished clobber step (success) 18:11:28 INFO - [mozharness: 2017-03-03 02:11:28.751143Z] Running read-buildbot-config step. 18:11:28 INFO - Running pre-action listener: _resource_record_pre_action 18:11:28 INFO - Running main action method: read_buildbot_config 18:11:28 INFO - Using buildbot properties: 18:11:28 INFO - { 18:11:28 INFO - "project": "", 18:11:28 INFO - "product": "firefox", 18:11:28 INFO - "script_repo_revision": "production", 18:11:28 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 18:11:28 INFO - "repository": "", 18:11:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 18:11:28 INFO - "buildid": "20170302165138", 18:11:28 INFO - "pgo_build": "False", 18:11:28 INFO - "basedir": "/builds/slave/test", 18:11:28 INFO - "buildnumber": 20, 18:11:28 INFO - "slavename": "t-yosemite-r7-0145", 18:11:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:11:28 INFO - "platform": "yosemite_r7", 18:11:28 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 18:11:28 INFO - "branch": "mozilla-aurora", 18:11:28 INFO - "repo_path": "releases/mozilla-aurora", 18:11:28 INFO - "revision": "d5b97a00c7e41b500878d293c16140304e871482", 18:11:28 INFO - "stage_platform": "macosx64", 18:11:28 INFO - "builduid": "a0246c0a7e454465a5c09329466465d7", 18:11:28 INFO - "slavebuilddir": "test" 18:11:28 INFO - } 18:11:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 18:11:28 INFO - Running post-action listener: _resource_record_post_action 18:11:28 INFO - [mozharness: 2017-03-03 02:11:28.754373Z] Finished read-buildbot-config step (success) 18:11:28 INFO - [mozharness: 2017-03-03 02:11:28.754509Z] Running download-and-extract step. 18:11:28 INFO - Running pre-action listener: _resource_record_pre_action 18:11:28 INFO - Running main action method: download_and_extract 18:11:28 INFO - mkdir: /builds/slave/test/build/tests 18:11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:28 INFO - trying https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 18:11:28 INFO - Downloading https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 18:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 18:11:30 INFO - Downloaded 1199 bytes. 18:11:30 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 18:11:30 INFO - Using the following test package requirements: 18:11:30 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 18:11:30 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 18:11:30 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 18:11:30 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'jsshell-mac.zip'], 18:11:30 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 18:11:30 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 18:11:30 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 18:11:30 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 18:11:30 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 18:11:30 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 18:11:30 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 18:11:30 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 18:11:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 18:11:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:11:30 INFO - Fetch https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 18:11:30 INFO - Expected file size: 16357808 18:11:30 INFO - Obtained file size: 16357808 18:11:37 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 18:11:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 18:11:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 18:11:37 INFO - Fetch https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 18:11:39 INFO - Expected file size: 16357808 18:11:39 INFO - Obtained file size: 16357808 18:11:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 18:11:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 18:11:45 INFO - Fetch https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 18:11:48 INFO - Expected file size: 14403650 18:11:48 INFO - Obtained file size: 14403650 18:11:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:48 INFO - trying https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:11:48 INFO - Downloading https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 18:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 18:11:50 INFO - Downloaded 73908521 bytes. 18:11:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:11:50 INFO - mkdir: /builds/slave/test/properties 18:11:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:11:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:11:50 INFO - Contents: 18:11:50 INFO - build_url:https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 18:11:51 INFO - Running post-action listener: _resource_record_post_action 18:11:51 INFO - Running post-action listener: set_extra_try_arguments 18:11:51 INFO - [mozharness: 2017-03-03 02:11:51.328867Z] Finished download-and-extract step (success) 18:11:51 INFO - [mozharness: 2017-03-03 02:11:51.328989Z] Running populate-webroot step. 18:11:51 INFO - Running pre-action listener: _resource_record_pre_action 18:11:51 INFO - Running main action method: populate_webroot 18:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:11:51 INFO - '--tppagecycles', 18:11:51 INFO - '7'], 18:11:51 INFO - 'tests': ['tsvgm']}}, 18:11:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:11:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:11:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:11:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:11:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:11:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['damp', 'tps']}, 18:11:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'tests': ['damp', 'tps']}, 18:11:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['dromaeo_dom']}, 18:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:11:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['basic_compositor_video']}, 18:11:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:11:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['a11yr', 18:11:51 INFO - 'ts_paint', 18:11:51 INFO - 'tpaint', 18:11:51 INFO - 'sessionrestore', 18:11:51 INFO - 'sessionrestore_no_auto_restore', 18:11:51 INFO - 'tabpaint']}, 18:11:51 INFO - 'other-e10s': {'tests': ['a11yr', 18:11:51 INFO - 'ts_paint', 18:11:51 INFO - 'tpaint', 18:11:51 INFO - 'sessionrestore', 18:11:51 INFO - 'sessionrestore_no_auto_restore', 18:11:51 INFO - 'tabpaint']}, 18:11:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:11:51 INFO - 'ts_paint', 18:11:51 INFO - 'tpaint', 18:11:51 INFO - 'sessionrestore', 18:11:51 INFO - 'sessionrestore_no_auto_restore', 18:11:51 INFO - 'tabpaint']}, 18:11:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:11:51 INFO - 'ts_paint', 18:11:51 INFO - 'tpaint', 18:11:51 INFO - 'sessionrestore', 18:11:51 INFO - 'sessionrestore_no_auto_restore', 18:11:51 INFO - 'tabpaint']}, 18:11:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['a11yr', 18:11:51 INFO - 'ts_paint', 18:11:51 INFO - 'tpaint', 18:11:51 INFO - 'sessionrestore', 18:11:51 INFO - 'sessionrestore_no_auto_restore', 18:11:51 INFO - 'tabpaint']}, 18:11:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['a11yr', 18:11:51 INFO - 'ts_paint', 18:11:51 INFO - 'tpaint', 18:11:51 INFO - 'sessionrestore', 18:11:51 INFO - 'sessionrestore_no_auto_restore', 18:11:51 INFO - 'tabpaint']}, 18:11:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['tsvgx', 18:11:51 INFO - 'tsvgr_opacity', 18:11:51 INFO - 'tart', 18:11:51 INFO - 'tscrollx', 18:11:51 INFO - 'cart', 18:11:51 INFO - 'tsvg_static']}, 18:11:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:11:51 INFO - 'tsvgr_opacity', 18:11:51 INFO - 'tart', 18:11:51 INFO - 'tscrollx', 18:11:51 INFO - 'cart', 18:11:51 INFO - 'tsvg_static']}, 18:11:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'talos_options': ['--disable-e10s'], 18:11:51 INFO - 'tests': ['tp5o']}, 18:11:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:11:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'talos_options': ['--disable-e10s', 18:11:51 INFO - '--xperf_path', 18:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:51 INFO - 'tests': ['tp5n']}, 18:11:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:11:51 INFO - 'talos_options': ['--xperf_path', 18:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:11:51 INFO - 'tests': ['tp5n']}}, 18:11:51 INFO - 'talos.zip': {'path': '', 18:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:11:51 INFO - Running post-action listener: _resource_record_post_action 18:11:51 INFO - [mozharness: 2017-03-03 02:11:51.348024Z] Finished populate-webroot step (success) 18:11:51 INFO - [mozharness: 2017-03-03 02:11:51.348160Z] Running create-virtualenv step. 18:11:51 INFO - Running pre-action listener: _resource_record_pre_action 18:11:51 INFO - Running main action method: create_virtualenv 18:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:11:51 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 18:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:11:51 INFO - Using real prefix '/tools/python27' 18:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:11:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:11:55 INFO - Installing pip.................done. 18:11:55 INFO - Return code: 0 18:11:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:11:55 INFO - Reading from file tmpfile_stdout 18:11:55 INFO - Output received: 18:11:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:11:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:11:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:55 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 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:11:55 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 18:11:55 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 18:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:55 INFO - 'HOME': '/Users/cltbld', 18:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:55 INFO - 'LOGNAME': 'cltbld', 18:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:55 INFO - 'MOZ_NO_REMOTE': '1', 18:11:55 INFO - 'NO_EM_RESTART': '1', 18:11:55 INFO - 'PAGER': '/bin/cat', 18:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:55 INFO - 'PWD': '/builds/slave/test', 18:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:55 INFO - 'SHELL': '/bin/bash', 18:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:11:55 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:55 INFO - 'USER': 'cltbld', 18:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:55 INFO - 'XPC_FLAGS': '0x0', 18:11:55 INFO - 'XPC_SERVICE_NAME': '0', 18:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:55 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 18:11:55 INFO - Cleaning up... 18:11:55 INFO - Return code: 0 18:11:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:11:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:11:55 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:11:55 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>=3.1.1'] in /builds/slave/test/build 18:11:55 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>=3.1.1 18:11:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:11:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:11:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:11:55 INFO - 'HOME': '/Users/cltbld', 18:11:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:11:55 INFO - 'LOGNAME': 'cltbld', 18:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:11:55 INFO - 'MOZ_NO_REMOTE': '1', 18:11:55 INFO - 'NO_EM_RESTART': '1', 18:11:55 INFO - 'PAGER': '/bin/cat', 18:11:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:11:55 INFO - 'PWD': '/builds/slave/test', 18:11:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:11:55 INFO - 'SHELL': '/bin/bash', 18:11:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:11:55 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:11:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:11:55 INFO - 'USER': 'cltbld', 18:11:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:11:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:11:55 INFO - 'XPC_FLAGS': '0x0', 18:11:55 INFO - 'XPC_SERVICE_NAME': '0', 18:11:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:11:55 INFO - Downloading/unpacking psutil>=3.1.1 18:11:55 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 18:11:55 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 18:11:55 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 18:11:55 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 18:11:55 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 18:11:55 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 18:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:11:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:11:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:11:59 INFO - Installing collected packages: psutil 18:11:59 INFO - Running setup.py install for psutil 18:11:59 INFO - building 'psutil._psutil_osx' extension 18:11:59 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 INFO - building 'psutil._psutil_posix' extension 18:12:00 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 18:12:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:12:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:12:00 INFO - ^ 18:12:00 INFO - 1 warning generated. 18:12:00 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 18:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:00 INFO - Successfully installed psutil 18:12:00 INFO - Cleaning up... 18:12:00 INFO - Return code: 0 18:12:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:00 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:00 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.3'] in /builds/slave/test/build 18:12:00 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.3 18:12:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:00 INFO - 'HOME': '/Users/cltbld', 18:12:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:00 INFO - 'LOGNAME': 'cltbld', 18:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:00 INFO - 'MOZ_NO_REMOTE': '1', 18:12:00 INFO - 'NO_EM_RESTART': '1', 18:12:00 INFO - 'PAGER': '/bin/cat', 18:12:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:00 INFO - 'PWD': '/builds/slave/test', 18:12:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:00 INFO - 'SHELL': '/bin/bash', 18:12:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:00 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:00 INFO - 'USER': 'cltbld', 18:12:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:00 INFO - 'XPC_FLAGS': '0x0', 18:12:00 INFO - 'XPC_SERVICE_NAME': '0', 18:12:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:00 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 18:12:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:03 INFO - Installing collected packages: mozsystemmonitor 18:12:03 INFO - Running setup.py install for mozsystemmonitor 18:12:03 INFO - Successfully installed mozsystemmonitor 18:12:03 INFO - Cleaning up... 18:12:03 INFO - Return code: 0 18:12:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:03 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:03 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==2.5.1'] in /builds/slave/test/build 18:12:03 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==2.5.1 18:12:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:03 INFO - 'HOME': '/Users/cltbld', 18:12:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:03 INFO - 'LOGNAME': 'cltbld', 18:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:03 INFO - 'MOZ_NO_REMOTE': '1', 18:12:03 INFO - 'NO_EM_RESTART': '1', 18:12:03 INFO - 'PAGER': '/bin/cat', 18:12:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:03 INFO - 'PWD': '/builds/slave/test', 18:12:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:03 INFO - 'SHELL': '/bin/bash', 18:12:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:03 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:03 INFO - 'USER': 'cltbld', 18:12:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:03 INFO - 'XPC_FLAGS': '0x0', 18:12:03 INFO - 'XPC_SERVICE_NAME': '0', 18:12:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:04 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:04 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 18:12:04 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 18:12:04 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 18:12:04 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 18:12:04 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 18:12:04 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 18:12:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12:06 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 18:12:06 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 18:12:06 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 18:12:06 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 18:12:06 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 18:12:06 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 18:12:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:07 INFO - warning: no files found matching '*.txt' 18:12:07 INFO - no previously-included directories found matching 'build' 18:12:07 INFO - no previously-included directories found matching 'dist' 18:12:07 INFO - no previously-included directories found matching '.git*' 18:12:07 INFO - Installing collected packages: jsonschema, functools32 18:12:07 INFO - Running setup.py install for functools32 18:12:07 INFO - warning: no files found matching '*.txt' 18:12:07 INFO - no previously-included directories found matching 'build' 18:12:07 INFO - no previously-included directories found matching 'dist' 18:12:07 INFO - no previously-included directories found matching '.git*' 18:12:07 INFO - Successfully installed jsonschema functools32 18:12:07 INFO - Cleaning up... 18:12:07 INFO - Return code: 0 18:12:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:07 INFO - 'HOME': '/Users/cltbld', 18:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:07 INFO - 'LOGNAME': 'cltbld', 18:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:07 INFO - 'MOZ_NO_REMOTE': '1', 18:12:07 INFO - 'NO_EM_RESTART': '1', 18:12:07 INFO - 'PAGER': '/bin/cat', 18:12:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:07 INFO - 'PWD': '/builds/slave/test', 18:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:07 INFO - 'SHELL': '/bin/bash', 18:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:07 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:07 INFO - 'USER': 'cltbld', 18:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:07 INFO - 'XPC_FLAGS': '0x0', 18:12:07 INFO - 'XPC_SERVICE_NAME': '0', 18:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:07 INFO - Cleaning up... 18:12:07 INFO - Return code: 0 18:12:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:12:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:07 INFO - 'HOME': '/Users/cltbld', 18:12:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:07 INFO - 'LOGNAME': 'cltbld', 18:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:07 INFO - 'MOZ_NO_REMOTE': '1', 18:12:07 INFO - 'NO_EM_RESTART': '1', 18:12:07 INFO - 'PAGER': '/bin/cat', 18:12:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:07 INFO - 'PWD': '/builds/slave/test', 18:12:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:07 INFO - 'SHELL': '/bin/bash', 18:12:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:07 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:07 INFO - 'USER': 'cltbld', 18:12:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:07 INFO - 'XPC_FLAGS': '0x0', 18:12:07 INFO - 'XPC_SERVICE_NAME': '0', 18:12:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:08 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:10 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:10 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 18:12:10 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 18:12:10 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 18:12:10 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 18:12:10 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 18:12:10 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 18:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:11 INFO - Downloading docopt-0.6.1.tar.gz 18:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:12 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:12 INFO - Running setup.py install for blobuploader 18:12:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:12 INFO - Running setup.py install for requests 18:12:12 INFO - Running setup.py install for docopt 18:12:12 INFO - Successfully installed blobuploader requests docopt 18:12:12 INFO - Cleaning up... 18:12:12 INFO - Return code: 0 18:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:12 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 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:12 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 18:12:12 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 18:12:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:12 INFO - 'HOME': '/Users/cltbld', 18:12:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:12 INFO - 'LOGNAME': 'cltbld', 18:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:12 INFO - 'MOZ_NO_REMOTE': '1', 18:12:12 INFO - 'NO_EM_RESTART': '1', 18:12:12 INFO - 'PAGER': '/bin/cat', 18:12:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:12 INFO - 'PWD': '/builds/slave/test', 18:12:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:12 INFO - 'SHELL': '/bin/bash', 18:12:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:12 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:12 INFO - 'USER': 'cltbld', 18:12:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:12 INFO - 'XPC_FLAGS': '0x0', 18:12:12 INFO - 'XPC_SERVICE_NAME': '0', 18:12:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-3OZZ8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-RUwdNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Vans1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-12F3DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ak14da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-rW6Xjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-FH9c59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:13 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-eJUQjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-nbBFSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-MJm5LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-qTqtbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-oETfiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-VyO4qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Pq8zHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-NyZtSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-4kcUsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:14 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-RJt5n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:14 INFO - Running setup.py install for manifestparser 18:12:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:15 INFO - Running setup.py install for mozcrash 18:12:15 INFO - Running setup.py install for mozdebug 18:12:15 INFO - Running setup.py install for mozdevice 18:12:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:15 INFO - Running setup.py install for mozfile 18:12:15 INFO - Running setup.py install for mozhttpd 18:12:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:15 INFO - Running setup.py install for mozinfo 18:12:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:15 INFO - Running setup.py install for mozInstall 18:12:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Running setup.py install for mozleak 18:12:16 INFO - Running setup.py install for mozlog 18:12:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Running setup.py install for moznetwork 18:12:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Running setup.py install for mozprocess 18:12:16 INFO - Running setup.py install for mozprofile 18:12:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:16 INFO - Running setup.py install for mozrunner 18:12:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Running setup.py install for mozscreenshot 18:12:17 INFO - Running setup.py install for moztest 18:12:17 INFO - Running setup.py install for mozversion 18:12:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:17 INFO - Cleaning up... 18:12:17 INFO - Return code: 0 18:12:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:17 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 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:17 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 18:12:17 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 18:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:17 INFO - 'HOME': '/Users/cltbld', 18:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:17 INFO - 'LOGNAME': 'cltbld', 18:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:17 INFO - 'MOZ_NO_REMOTE': '1', 18:12:17 INFO - 'NO_EM_RESTART': '1', 18:12:17 INFO - 'PAGER': '/bin/cat', 18:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:17 INFO - 'PWD': '/builds/slave/test', 18:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:17 INFO - 'SHELL': '/bin/bash', 18:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:17 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:17 INFO - 'USER': 'cltbld', 18:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:17 INFO - 'XPC_FLAGS': '0x0', 18:12:17 INFO - 'XPC_SERVICE_NAME': '0', 18:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:17 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-oB3w_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:17 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)) 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:17 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-oZFjgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-6BQ8ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-BMp276-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-z4ggBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-QbAZvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-LhCQxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-FGlPN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-GngovD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-K0gT3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-dcnVix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:18 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)) 18:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:18 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-UqAl7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:19 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-vc85EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:19 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)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:19 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-W5LNsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:19 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-KFO0oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:19 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)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:19 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-lxcniA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:19 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-_2PBq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:19 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)) 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:12:19 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)) 18:12:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:12:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:22 INFO - Downloading blessings-1.6.tar.gz 18:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:22 INFO - Installing collected packages: blessings 18:12:22 INFO - Running setup.py install for blessings 18:12:22 INFO - Successfully installed blessings 18:12:22 INFO - Cleaning up... 18:12:22 INFO - Return code: 0 18:12:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:23 INFO - Reading from file tmpfile_stdout 18:12:23 INFO - Current package versions: 18:12:23 INFO - blessings == 1.6 18:12:23 INFO - blobuploader == 1.2.4 18:12:23 INFO - docopt == 0.6.1 18:12:23 INFO - functools32 == 3.2.3-2 18:12:23 INFO - jsonschema == 2.5.1 18:12:23 INFO - manifestparser == 1.1 18:12:23 INFO - mozInstall == 1.12 18:12:23 INFO - mozcrash == 1.0 18:12:23 INFO - mozdebug == 0.1 18:12:23 INFO - mozdevice == 0.49 18:12:23 INFO - mozfile == 1.2 18:12:23 INFO - mozhttpd == 0.7 18:12:23 INFO - mozinfo == 0.9 18:12:23 INFO - mozleak == 0.1 18:12:23 INFO - mozlog == 3.4 18:12:23 INFO - moznetwork == 0.27 18:12:23 INFO - mozprocess == 0.24 18:12:23 INFO - mozprofile == 0.28 18:12:23 INFO - mozrunner == 6.13 18:12:23 INFO - mozscreenshot == 0.1 18:12:23 INFO - mozsystemmonitor == 0.3 18:12:23 INFO - moztest == 0.8 18:12:23 INFO - mozversion == 1.4 18:12:23 INFO - psutil == 3.1.1 18:12:23 INFO - requests == 1.2.3 18:12:23 INFO - wsgiref == 0.1.2 18:12:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:23 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 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:23 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 18:12:23 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 18:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:23 INFO - 'HOME': '/Users/cltbld', 18:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:23 INFO - 'LOGNAME': 'cltbld', 18:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:23 INFO - 'MOZ_NO_REMOTE': '1', 18:12:23 INFO - 'NO_EM_RESTART': '1', 18:12:23 INFO - 'PAGER': '/bin/cat', 18:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:23 INFO - 'PWD': '/builds/slave/test', 18:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:23 INFO - 'SHELL': '/bin/bash', 18:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:23 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:23 INFO - 'USER': 'cltbld', 18:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:23 INFO - 'XPC_FLAGS': '0x0', 18:12:23 INFO - 'XPC_SERVICE_NAME': '0', 18:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 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)) 18:12:23 INFO - Cleaning up... 18:12:23 INFO - Return code: 0 18:12:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:23 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 0x105361b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105364768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f847b4a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, '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.34AhMnopqn/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.ODQ71HtXg8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 18:12:23 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 18:12:23 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 18:12:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:23 INFO - 'HOME': '/Users/cltbld', 18:12:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:23 INFO - 'LOGNAME': 'cltbld', 18:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:23 INFO - 'MOZ_NO_REMOTE': '1', 18:12:23 INFO - 'NO_EM_RESTART': '1', 18:12:23 INFO - 'PAGER': '/bin/cat', 18:12:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:23 INFO - 'PWD': '/builds/slave/test', 18:12:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:23 INFO - 'SHELL': '/bin/bash', 18:12:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:23 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:23 INFO - 'USER': 'cltbld', 18:12:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:23 INFO - 'XPC_FLAGS': '0x0', 18:12:23 INFO - 'XPC_SERVICE_NAME': '0', 18:12:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:24 INFO - Cleaning up... 18:12:24 INFO - Return code: 0 18:12:24 INFO - Running post-action listener: _resource_record_post_action 18:12:24 INFO - Running post-action listener: _start_resource_monitoring 18:12:24 INFO - Starting resource monitoring. 18:12:24 INFO - [mozharness: 2017-03-03 02:12:24.059277Z] Finished create-virtualenv step (success) 18:12:24 INFO - [mozharness: 2017-03-03 02:12:24.060260Z] Running install step. 18:12:24 INFO - Running pre-action listener: _resource_record_pre_action 18:12:24 INFO - Running main action method: install 18:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:24 INFO - Reading from file tmpfile_stdout 18:12:24 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:24 INFO - Reading from file tmpfile_stdout 18:12:24 INFO - Output received: 18:12:24 INFO - Usage: mozinstall [options] installer 18:12:24 INFO - Options: 18:12:24 INFO - -h, --help show this help message and exit 18:12:24 INFO - -d DEST, --destination=DEST 18:12:24 INFO - Directory to install application into. [default: 18:12:24 INFO - "/builds/slave/test"] 18:12:24 INFO - --app=APP Application being installed. [default: firefox] 18:12:24 INFO - mkdir: /builds/slave/test/build/application 18:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 18:12:44 INFO - Reading from file tmpfile_stdout 18:12:44 INFO - Output received: 18:12:44 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 18:12:44 INFO - Running post-action listener: _resource_record_post_action 18:12:44 INFO - [mozharness: 2017-03-03 02:12:44.452993Z] Finished install step (success) 18:12:44 INFO - [mozharness: 2017-03-03 02:12:44.453109Z] Running run-tests step. 18:12:44 INFO - Running pre-action listener: _resource_record_pre_action 18:12:44 INFO - Running main action method: run_tests 18:12:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:12:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:12:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:12:44 INFO - 2017-03-02 18:12:44.467 screenresolution[1625:7424] starting screenresolution argv=screenresolution get 18:12:44 INFO - 2017-03-02 18:12:44.470 screenresolution[1625:7424] Display 0: 1600x1200x32@60 18:12:44 INFO - 2017-03-02 18:12:44.476 screenresolution[1626:7426] starting screenresolution argv=screenresolution list 18:12:44 INFO - Available Modes on Display 0 18:12:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:12:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:12:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:12:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:12:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:12:44 INFO - Intel Iris: 18:12:44 INFO - Chipset Model: Intel Iris 18:12:44 INFO - Type: GPU 18:12:44 INFO - Bus: Built-In 18:12:44 INFO - VRAM (Dynamic, Max): 1536 MB 18:12:44 INFO - Vendor: Intel (0x8086) 18:12:44 INFO - Device ID: 0x0a2e 18:12:44 INFO - Revision ID: 0x0009 18:12:44 INFO - Displays: 18:12:44 INFO - Display: 18:12:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:12:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:12:44 INFO - Display Serial Number: 1600x1200 60 18:12:44 INFO - Main Display: Yes 18:12:44 INFO - Mirror: Off 18:12:44 INFO - Online: Yes 18:12:44 INFO - Rotation: Supported 18:12:44 INFO - Return code: 0 18:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:44 INFO - Python 2.7.3 18:12:44 INFO - Return code: 0 18:12:44 INFO - grabbing minidump binary from tooltool 18:12:44 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:44 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513fd30>, '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 0x105066db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105134be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:44 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 18:12:44 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 18:12:44 INFO - Calling ['/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'] with output_timeout 600 18:12:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:44 INFO - Return code: 0 18:12:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:12:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:12:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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 18:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --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 18:12:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.34AhMnopqn/Render', 18:12:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:44 INFO - 'HOME': '/Users/cltbld', 18:12:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:44 INFO - 'LOGNAME': 'cltbld', 18:12:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:44 INFO - 'MOZ_NO_REMOTE': '1', 18:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:44 INFO - 'NO_EM_RESTART': '1', 18:12:44 INFO - 'PAGER': '/bin/cat', 18:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:44 INFO - 'PWD': '/builds/slave/test', 18:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:44 INFO - 'SHELL': '/bin/bash', 18:12:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODQ71HtXg8/Listeners', 18:12:44 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 18:12:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:44 INFO - 'USER': 'cltbld', 18:12:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:44 INFO - 'XPC_FLAGS': '0x0', 18:12:44 INFO - 'XPC_SERVICE_NAME': '0', 18:12:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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 18:12:45 INFO - mozversion application_buildid: 20170302165138 18:12:45 INFO - mozversion application_changeset: d5b97a00c7e41b500878d293c16140304e871482 18:12:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:12:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:45 INFO - mozversion application_name: Firefox 18:12:45 INFO - mozversion application_remotingname: firefox-dev 18:12:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:12:45 INFO - mozversion application_vendor: Mozilla 18:12:45 INFO - mozversion application_version: 53.0a2 18:12:45 INFO - mozversion platform_buildid: 20170302165138 18:12:45 INFO - mozversion platform_changeset: d5b97a00c7e41b500878d293c16140304e871482 18:12:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:12:45 INFO - mozversion platform_version: 53.0a2 18:12:45 INFO - using testdate: 1488507165 18:12:45 INFO - actual date: 1488507165 18:12:45 INFO - starting webserver on 'localhost:49251' 18:12:45 INFO - SUITE-START | Running 2 tests 18:12:45 INFO - TEST-START | dromaeo_css 18:12:45 INFO - operating with platform_type : mac_ 18:12:45 INFO - Initialising browser for dromaeo_css test... 18:12:45 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpYc4aO0/profile http://localhost:49251/getInfo.html) 18:12:48 INFO - PROCESS | 1636 | 2017-03-02 18:12:48.031 plugin-container[1638:7599] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a47, name = 'com.apple.tsm.portname' 18:12:48 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:48 INFO - PROCESS | 1636 | 2017-03-02 18:12:48.034 plugin-container[1638:7599] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 18:12:48 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:48 INFO - PROCESS | 1636 | 2017-03-02 18:12:48.034 plugin-container[1638:7599] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:12:48 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 18:12:48 INFO - PROCESS | 1636 | colorDepth:24 18:12:48 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 18:12:48 INFO - PROCESS | 1636 | __metrics 18:12:48 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 18:12:48 INFO - TEST-INFO | 1636: exit 0 18:12:48 INFO - Browser initialized. 18:12:48 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:48 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpYc4aO0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:12:51 INFO - PROCESS | 1639 | 2017-03-02 18:12:51.372 plugin-container[1640:7727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 18:12:51 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:51 INFO - PROCESS | 1639 | 2017-03-02 18:12:51.372 plugin-container[1640:7727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4807, name = 'com.apple.CFPasteboardClient' 18:12:51 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:12:51 INFO - PROCESS | 1639 | 2017-03-02 18:12:51.372 plugin-container[1640:7727] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:13:01 INFO - PROCESS | 1639 | RSS: Main: 218415104 18:13:01 INFO - PROCESS | 1639 | 18:16:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 18:16:05 INFO - PROCESS | 1639 | RSS: Main: 235552768 18:16:05 INFO - PROCESS | 1639 | 18:17:49 INFO - PROCESS | 1639 | ************************* 18:17:49 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 18:17:49 INFO - PROCESS | 1639 | 18:17:49 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:17:49 INFO - PROCESS | 1639 | Full stack: 18:17:49 INFO - PROCESS | 1639 | ************************* 18:19:07 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 18:19:08 INFO - PROCESS | 1639 | RSS: Main: 248270848 18:19:08 INFO - PROCESS | 1639 | 18:22:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 18:22:10 INFO - PROCESS | 1639 | RSS: Main: 255930368 18:22:10 INFO - PROCESS | 1639 | 18:25:12 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 18:25:13 INFO - PROCESS | 1639 | RSS: Main: 252837888 18:25:13 INFO - PROCESS | 1639 | 18:28:16 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 18:28:16 INFO - PROCESS | 1639 | RSS: Main: 256229376 18:28:16 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 18:31:19 INFO - PROCESS | 1639 | RSS: Main: 257339392 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | __start_tp_report 18:31:19 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 18:31:19 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 18:31:19 INFO - PROCESS | 1639 | |i|pagename|runs| 18:31:19 INFO - PROCESS | 1639 | |0;dojo.html;3388.7458440616942;3404.914877128072;3426.5031570422275;3450.982745086275;3467.843947022384;5769.16347129666;5801.245838041059;5805.883882322351;5843.065109582468;5859.589828711992;5609.831705048855;5812.273465816773;5860.267466566679;5871.530277577795;5882.29412470503;4543.477500087499;5247.86880327992;5264.368275806889;5340.332458442695;5355.946440535584;4347.5652434756585;5378.300820893298;5383.542398896098;5402.486763757437;5418.4039755626845;5229.137192363274;5232.973835130838;5386.434424385442;5393.2449457076045;5405.621606487547;5326.7869285228735;5330.786768529274;5376.381716102659;5393.379761327458;5441.401445840955;5266.420693723688;5305.946940530584;5310.123829568117;5334.5732341412595;5343.438938911398;5653.540709791254;5846.356900740915;5906.586538942276;5972.701364931736;6018.3981601839905;6215.440610345046;6249.625022498664;6267.4986001119805;6285.59143655661;6329.810105696836;6276.686165691697;6278.183836101278;6294.779682711129;6302.212223472066;6310.2427708674795;5957.076653118774;5967.731452084667;5968.522518198533;5999.520038396918;5999.940000599981;6210.4100110489435;6237.220347456568;6274.278457977391;6329;6330.05049242608;6235.688215589203;6241.906371404432;6276.843078923063;6298.653574053379;6311.810645680637;6271.655058971709;6285.622862628257;6289.119523266746;6295.370462953668;6302.8424289392215;6143.082036032938;6184.226971628546;6234.3453937336835;6242.219722534684;6262.812115636538;6266.997280435108;6311.810645680637;6312.4634406076;6319.33646967071;6328.905066424008;5044.369453818273;5047.646664733434;5048.949510504922;5066.214736715815;5084.872878178001;4414.80133393998;4445.977770111193;4467.30756732707;4534.319852022223;4539.59143677064;5943.31651860033;5985.670788106609;5993.940060599425;5999.910001349983;6096.177016102769;6235.315831217508;6254.968725156436;6271;6287.1826662534495;6290.8427289317215;5797.275340582427;5899.646021238739;5913.645181289136;5948.256467941507;5949.494292985145;5525.640833345819;5533.916991245134;5536.335639723178;5543.390227075019;5560.638558493685;6420.229572451336;6434.710438030206;6439.356064393523;6448.484121270381;6468.611883287018;5665.923474539824;5831.766729330949;6139.768135342541;6223.37766223374;6285.5600107992;6433.228012638513;6472.838179045561;6477.77327793525;6480.513961453004;6482.57863238888;6293.087502312231;6297.307296197506;6300.275468321019;6307.30619631831;6318.115463835159;6092.939070609237;6135.018317212141;6242.282137554058;6245.843853903689;6291.370862913672;6156.876862462636;6237.157983672328;6238.095476156022;6245.156903817927;6266.561340706106;6233.252009758858;6248.562600617913;6257.28041275241;6257.843553911189;6290.433860952537;5924.7037648118285;5955;5963.642181469126;6078.635281883101;6130.233720784902;6141.762184093141;6154.630722156685;6194.194754681863;6257.937420625735;6267.62394256346;5138.665986710852;6013.037913933749;6111.358307377662;6118.816435506942;6123 18:31:19 INFO - PROCESS | 1639 | |1;ext.html;448.16193717747797;474.65587449099405;476.452080107876;496.5630245384061;530.9089820419038;32742.83628581857;35993;40911.59088409119;40934.59065409345;41026;35076;40924.77225683227;41516;41932.790336048354;41976.16047679044;7104.822379440504;8486.78783030423;8664.61009254585;8951.820963580725;9457.196138328216;11118.166137539676;11417.48621312043;11420.71448213793;11569.53721851125;11608;11497.712557186054;11538.942305288461;11544.653660390202;11610.12924030697;11643.12676549258;10366.844497332546;11154.832677509803;11529.999999999958;11540.249883757613;11604.941975290154;11472.08223342139;11549.249298795552;11552.191346605741;11553.711157221052;11575.47910344028;34512;40383.192336153115;40673.79663101695;40863.38704919429;41150.1769964602;3577.2130131371055;3954.070793363557;3982.1239327348226;4003.719739618228;4017.8593749218635;29186;30369.848150759324;30774;30869.38261234763;31025.14120057984;3024.2439390152463;3149.748020158405;3168.1129283800574;3199.360127974391;3208.69517395847;316124;328117;328454;330077;330913;60491;60716.39283607107;60836.69581652152;60851.695741521005;60929;63426.36573634297;63872.68063659745;63949.36050639527;64508;64825;16158.43445479426;16230.269637866324;16689.749653755203;16693.499195024167;16704.248308826132;9407.341486095907;11801.468933897995;12776.872231277754;12871.03467239942;12938.611841644766;16078.919605402132;16104;16119.758203626954;16130;16179.595510112105;6167.969160154171;6460.353964603502;7077.221505634376;7393.963030184815;7426.2945020223;883.7348795361365;885.1193062902453;890.5413711938357;903.2322525852973;916.9449833010041;29488.705112948595;30460.84769576138;30461;30495.542566861513;30563.60258126393;946;957.4494665567327;1034.5481209533455;1073.4042606353548;1087.8477013218155;14404.855951440351;14439.92780036093;14490.420383184766;14609.561713148623;14765.557033289018;548409;610072;621608;621824;622191;49290.26064609034;50411.74794126006;50472.747636261585;50581.24128138081;50658.24012639813;1288.2850018239778;1407.3174510362467;1440.229477229677;1461.7429011050701;1474.668199655069;20496.59006819885;26796;26909.776799748914;27267.863660682364;28020;44910;45082.54917450915;45172;45221.32168017548;45306.77346613246;499763.5011824918;500383.4980825073;502129;503656;509225.90774093266;23996.520069598162;24321.878390607933;24977.87511062433;25003.49993000166;25776.355591110372;42560.935976600835;42887.571124288355;43522.78238608786;43848.780756097294;43900.341494878245;29700.851495742383;35506.467402989496;35719.821400892826;35828;36033.81983090068;30736.231594210323;32220.83889580537;35496.82251588725;35956.101097472776;36249.09377265589;34980.30039399249;35128;35444.82277588596;35521.644783551834;35559.11102222465;30401;31306.21734456657;31818.363632726752;31879;31916;19905.407567394283;23831.88084059638;24877.756112193954;25073;26234.60648090242 18:31:19 INFO - PROCESS | 1639 | |2;jquery.html;382.16306289226577;383.4248627059411;399.3430806323598;404.3631280732845;415.93968874513195;16957.57606059849;20494;20649;21416.678749818744;21464.785352146475;21057.157713691435;21263.787362126375;21422.57154856902;21989.340319790394;22253.332400028026;5632.605717599769;5923.022701254288;5946.43508866657;5964.761409543635;5968.641881487125;5639.943600564004;5762.6254293471;5813.215215945836;5829.09649004405;5883.47048765611;5851.736671849756;5863.970680146594;5866.677332746719;5870.97064514679;5874.823755287348;5580.91628625571;5756;5802.361740208574;5826.300843898759;5842.094475356305;5127.1796512558185;5133.024725302181;5134.7689353978785;5142.845714628567;5145.30538377318;25644.743552564607;26646.20061398161;26817.329566760793;26861.791219395174;26877.462450750874;2761.226856480189;2786.6795318538425;2803.5374163263036;2804.2568719289407;2806.480801051812;11199.496022678917;14886.404543818235;15017.774733379008;15196.46031841152;15917.283722232412;1797.9550511237194;1821.9362322318789;1858.349577647826;1866.56135808085;1882.2000649723814;115750.842491574;131728;132495;141543.29228353896;141606;9708.368956017835;12207.328596927076;12240.571579994657;12243.265404075606;12433.316167610868;14010.439582416793;14563.563093107225;15821.129837859029;15872.52382428506;15882.841171588136;7056;7654.2345765423015;7756.612169391507;8828.911710882938;9007.549622518978;6949.89575156373;8641.654333826576;8654.74506196598;8777.517236551923;8808.339374546806;4731.455882573479;4824.276358546176;4843.07981483517;4900.06898689255;4960.751962401865;1746.5371676505736;2004.4487765864212;2056.5475595369294;2061.752589689247;2158.568286342738;991.2218908157062;1015.9695209143738;1029.2126523209602;1034.022848408247;1064.8243039898484;21207.257745978815;21543.78456215418;21640.458988525414;21681.34955951324;21790.237341693282;976.6484065736329;1038.1798379280283;1040.953157107932;1069.8555694981078;1078.2775540387959;9445.291603129794;11214.383208923424;11294.152938529644;11340.149488788375;11394.658160255205;730901;738964;739040;755905;759790;140491;145047;152329;153323.23338383235;158172;993.5082134343402;1001.5727588186804;1021.4943602916604;1027.306568066567;1034.8758149022015;15357.462488812838;17824.197911094292;18851.622967540847;18935.33726319572;19039.428817135507;35146.64853351434;47243.05513889772;59301;59437.81124377402;59832;85507.14492854991;85551;86497;86808;87463.25073498621;8016.278534931651;8106.513609183467;8286.378521610783;8457.112003239572;8781.429207101519;12403.689907752378;12920.676983075498;13004.089713719948;13173.93413032967;13479.663008424868;11130.10959123252;11174;11238.66284011481;11308.321500709984;11650.592229271935;9237.815243694955;9744.561494732612;10965.396903170084;11030.28303160292;11401.144914131639;11439.885601143882;11510.48202830858;11659.417029148679;11706.70733231676;11840;8203.71287004952;8203.794905127419;8478.32173426112;8525.616347264264;8668.046514883232;8777.605007774539;9538.761530961781;11134.665960020888;11354.978051975362;11677.357745323749 18:31:19 INFO - PROCESS | 1639 | |3;mootools.html;1310.8464551194947;1431.8711315981566;1445.8987870849044;1454.7959840841127;1467.8238611366635;7317.3780228680625;7574.469787114904;8035.437519373653;8035.959820200898;8520.360972927025;7380;7516.774496765092;7563.470557061008;7590.089189297279;7645.694172233118;2221.8111460525874;2240.417491452226;2251.583457060449;2259.367377134397;2266.2634643740766;2070.0167420475227;2219.500612362214;2260.6156953317895;2279.635258358663;2280.8175345972363;2090.6968489569003;2155.3426205007468;2227.175944900389;2228.1755750372386;2233.597952368573;1949.4638974282045;2254.4363909022745;2274.624686926655;2277.749447560767;2282.543491301738;2261.9095236190533;2317.084751523156;2328.7554806745216;2329.743728189898;2332.8600283983014;8285.171482851727;8346.457480263824;8349.624266907944;8413.495190288602;8438.367122465777;4873.951260487385;4969.080720066763;5006.123928312531;5020;5034.672746271481;3232.4666430039015;3337.7997320160625;3441.776284541497;3450.861965521401;3468.0982944434377;1117.972050698731;1165.2891736041008;1193.2601786892096;1206.8008778551527;1216.7688139253603;10656.09423199029;10697;10767.676969690843;10769;10876.945615271952;4098.938515922264;4373.234683930363;4642.535746425398;4669.626429885601;4684.578387945101;7759.92240077592;9450.054994500495;9481.146696797321;9489.145976862115;9506.429614223169;5119.87200319995;5193.039287731782;5208.088584497697;5218.6868787872845;5225.790968361299;4674.135284972291;4705.835295764632;4723;4731.195696731564;4741.881452963635;3909.257241124177;3951.1110000249714;3957.1887763008513;3984.86052988144;4060.939085913714;1184.0705046538426;1280.564608033273;1282.1473719976298;1283.4224598930332;1289.2973329535425;684.2849222562435;734.6804140199031;759.3090287838041;764.4992529892929;776.9028871391076;5456.91814622781;5749.108888122348;5799.18811366409;5802.274715660543;5954.285485741652;864.3344624639118;978.2076518020426;986.284943416032;1025.620520407454;1028.9691309260734;3769.86805461813;3802.6007269236884;3807.6192380762254;3897.61023897608;3936.3308237599676;9653.46905920167;9973.202143828476;10012.54943527543;10017.899821001842;10034.397936123856;9690.321677482649;9740.853887191697;9960.601575936882;9971.252156088321;9982.80034399308;7691.423143264277;7805.570693611792;7812.179721129313;7828.138904720477;7864.93823333854;5404.621676482609;5415.079436495726;5449.264349312792;5547.362053363915;5554.75003624846;8912.376133670581;9263.76840578991;9279.907200927904;9295.76760580991;9302.813943721223;8956;9265.305102117234;9273.979862215287;9317.673881414117;9320.95339523298;7169.856602868018;7230.9638451807405;7236.312550307713;7315.48791584584;7335.559866408033;7799.181085986117;7849.882251766114;7907.011623547057;7917.168697286702;7928.603569821371;6494.447971922439;7061.152661680631;7172.856542869009;7200.819979500555;7276.818079548054;7026.473014524034;7033.683484243119;7058.1245667888315;7069.893951590833;7115.786526404217;6357.427831495188;6365.2361716594305;6366.108744775643;6438.90341644885;6458.773942911976;4921.753912304442;4942.184539550934;4966.428860680923;4978.751062446936;5016.874578135576;4068.9186216274916;4902;4941.703497790144;4951.777170027285;5111.309973153577 18:31:19 INFO - PROCESS | 1639 | |4;prototype.html;298.9491786396313;355.58574260985955;366.9139347531307;366.94128939369705;372.2833545425056;4894.140226713848;5224.45143259958;5357.491038351351;5434.891302173959;5601;4509.759816050588;5325.920111198326;5419.241306217123;5455.236266922634;5483.243977875159;3526.770759900611;3732.64539868712;4258.954847284192;4275.273203555387;4275.786210689469;3689.8192578374933;4079.9800049987502;4260.893477663052;4276.337167739005;4324.891877703067;3464.6708562686504;4143.606357396043;4219.198352313066;4237.322028475444;4239.830406783741;3704.3887758519813;3873.3802591585213;4231.70378073535;4236.894077648052;4252;3772.170122573057;3776.433534969749;3785.6025117362556;3788.8673896413493;3795.5387175937462;4962.975185124052;5303.7082960437165;5336.813211537617;5355.598330125256;5372.764264219251;4711.269753188261;4715.056988602293;4734.976325118387;4742.909130899878;4775.307580400822;5517.200005999108;5768.567357448166;5797.072468405077;5806.5354771618595;5833.737481813286;3267.6242232143372;3292.884749033796;3554.3957527220177;3726.273376691546;4008.899777505586;4864.343313652647;5043.38611644274;5382.11625930921;6157.768446310711;6185.226846644169;4299.376590394375;4310.383606147695;4317.525072242051;4319.200947824663;4333.696641235083;4129.233413612887;4362.931081884958;4370.781460926941;4394.560543945579;4405.757683327448;4510.8421205257655;4589.908201836011;4976.0794253063295;5012.8496145115705;5015.291742459031;4909.281751386986;5373.919391209135;5861.8311224847075;5880.941190588125;5893.911591326134;1284.6852521132382;1292.3215311961296;1302.6873550348039;1427.5075099090798;1438.7697968325017;877.7937184761576;993.8310487217191;995.6515219673201;1012.7569383347943;1017.4251547875575;5012.423571289349;5104.464031276737;5201.852879008221;5221.6344855859725;5221.843344699589;4977.850664480072;5301.761420735999;5511.3937466878615;5649.435056494318;5774.545818027322;4528.6150677192145;4728.014234021719;4851.51484851512;4891.364122664102;5253.375171131906;2528.987355063213;2805.2928923588834;2805.8215549469273;3010.397920415882;3020.879164833426;5181;5838.299404071454;5961.433663801932;5982;6021.367756385516;5253.527182553588;5382.730863456812;5731.512821410227;5736.078413731363;5762.94237057624;5218.347706536683;5923.075000624728;5930.28836539618;5957.017092179828;5969.283685957626;4909.975450122726;5128.07699611233;5711.429856564479;5719.996002797975;5737.483626473638;4688.843132159245;4919;4939.678920870276;5586.441355864381;5658;4907.723991762096;5232.944468037302;5886.558508111823;5943.940560594338;5950.7917222896995;3401.7448691347754;3566.968077134415;4124;4133.615238894884;4141.627253547195;4678.17551155043;5259.342582177228;5351.331083614548;5660.735705717581;5710.5146062585145;5007.073691367109;5400.432954539717;5792;5829;5830.62100963436;5512.503874651301;5541.307336582927;5789.421057894177;5794;5809;4922.901541969212;5235.240890070994;5609.775608975595;5638.661680299195;5642.150713889624;4825.662203645711;5065.164247899203;5665.461781130786;5799.043157879071;5826.592138550431;4836.903261934671;5655.745491452977;5670.5180059695385;5688.431156884279;5706.457886500776 18:31:19 INFO - PROCESS | 1639 | |5;yui.html;693.5214701855722;698.9755358562448;750.0774047921057;812.2243257688906;829.9626516806743;14626.122432654049;15050.473233436833;15521.223938803043;15550.377984880606;15658;14205.431782728678;14484.782728259059;14489.130652160879;14528.418863245457;15424.61438464039;831.2518733140176;856.1267507142711;858.4548811504677;859.1322764008335;860.0238729042551;663.0948754949484;676.8680107379063;828.4863384701493;846.4878748357216;849.4478588917192;882.3029806452927;890.4746199742151;899.6311512279966;899.7075950316141;902.0393281155548;888.2228050455851;889.6530353162271;889.7241855024963;892.281713220857;893.2050475077219;662.0235153149115;666.3569655282676;669.6484345718488;670.4468813229106;673.141744276047;14931.477398291116;15395.769063464057;15889;16014.199290035569;16100.59748506285;12059.939700301442;13815.861841381558;14032.579022629337;14103.647408814759;14120.082194657418;11362.261453005529;11373.203875728703;11627.825582616268;11692.590759323468;11731.765364692743;3597.3165098631175;3626.673599376069;3658.1951970566697;3693.4829123922405;3808.619138086197;104243.95756042418;105802;106542.46728766306;106751;107462;10189;10546.209034322457;10670.306430082175;10713.571457141783;10741.946290268656;21782.455438613844;21943.122275109137;21961.560768784533;21999.450013749465;21999.890000550215;7491.812704682427;7590.745951105045;7595.848083038419;7624.085109786861;7638.427117966175;3226.516022596629;3987.7009224308295;4086.959130408717;4158.91682166355;4177.561356057631;3016.291171574678;3474.7220222382653;3521.8591256349973;3547.2018795770746;3564.3940530109944;642.1555654314561;646.7089809585706;651.0364660302779;654.7773756922669;661.5865084322298;613.9570230083851;659.2484567592948;672.9966350168218;689.152342618582;693.7779910428716;8822.426542274732;9935.701928942144;10015.599376025024;10168.034036766496;10304.381737095799;623.9143889632098;656.8522082531392;664.5547483186277;671.7212356871844;672.5023482622823;5309.134085319308;5500.972495137498;5544.362398324163;5579.581531385163;5646.265985421951;101749.49125254326;101824;101838.90805459846;102458;102569;90634;90808.1838363229;92610;93608;94318.11363772824;80909.19090809017;80965.19034809577;81227.18772812314;82535.58732206421;82678.58660706658;10151.898481015096;10588.364698118137;10822.101954434695;10944.288621239593;10972.177086718368;43817.56182438135;51595.96808063742;51736;52006.95986080333;52947.73526132499;67361.30554777753;68222.31777682358;69988.6500567494;70310;71832;12803.03977201695;12936.09447338715;13116.540921067717;13170.012249081166;13176.538821141214;14320.212388318743;14358.353874075483;14536.563903082924;14777;14889.627759306104;12850.871491284968;13187.472501100232;13607.86392136066;13862.861371386158;14267.928660356632;12961.611151665466;13282.203067815963;13420.060595758203;13500.054996150175;13552.119112257671;12640.783629441814;12809.231446113263;13420.39608217613;13572.660683482993;13923.930380348034;9170.862437063583;10713.035826775316;11000.449977500934;11167.49746261404;11276.492557834754;7582.256081101488;9631.422114673142;10993.835092473779;11020;11061.281016733887 18:31:19 INFO - PROCESS | 1639 | __end_tp_report 18:31:19 INFO - PROCESS | 1639 | __start_cc_report 18:31:19 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,384 18:31:19 INFO - PROCESS | 1639 | __end_cc_report 18:31:19 INFO - PROCESS | 1639 | __startTimestamp1488508279602__endTimestamp 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | ------- Summary: start ------- 18:31:19 INFO - PROCESS | 1639 | Number of tests: 6 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5832.75 Median:6092.94 stddev:647.80 (10.6%) stddev-sans-first:620.76 18:31:19 INFO - PROCESS | 1639 | Values: 3388.7 3404.9 3426.5 3451.0 3467.8 5769.2 5801.2 5805.9 5843.1 5859.6 5609.8 5812.3 5860.3 5871.5 5882.3 4543.5 5247.9 5264.4 5340.3 5355.9 4347.6 5378.3 5383.5 5402.5 5418.4 5229.1 5233.0 5386.4 5393.2 5405.6 5326.8 5330.8 5376.4 5393.4 5441.4 5266.4 5305.9 5310.1 5334.6 5343.4 5653.5 5846.4 5906.6 5972.7 6018.4 6215.4 6249.6 6267.5 6285.6 6329.8 6276.7 6278.2 6294.8 6302.2 6310.2 5957.1 5967.7 5968.5 5999.5 5999.9 6210.4 6237.2 6274.3 6329.0 6330.1 6235.7 6241.9 6276.8 6298.7 6311.8 6271.7 6285.6 6289.1 6295.4 6302.8 6143.1 6184.2 6234.3 6242.2 6262.8 6267.0 6311.8 6312.5 6319.3 6328.9 5044.4 5047.6 5048.9 5066.2 5084.9 4414.8 4446.0 4467.3 4534.3 4539.6 5943.3 5985.7 5993.9 5999.9 6096.2 6235.3 6255.0 6271.0 6287.2 6290.8 5797.3 5899.6 5913.6 5948.3 5949.5 5525.6 5533.9 5536.3 5543.4 5560.6 6420.2 6434.7 6439.4 6448.5 6468.6 5665.9 5831.8 6139.8 6223.4 6285.6 6433.2 6472.8 6477.8 6480.5 6482.6 6293.1 6297.3 6300.3 6307.3 6318.1 6092.9 6135.0 6242.3 6245.8 6291.4 6156.9 6237.2 6238.1 6245.2 6266.6 6233.3 6248.6 6257.3 6257.8 6290.4 5924.7 5955.0 5963.6 6078.6 6130.2 6141.8 6154.6 6194.2 6257.9 6267.6 5138.7 6013.0 6111.4 6118.8 6123.0 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:61624.44 Median:182712.50 stddev:131447.49 (71.9%) stddev-sans-first:131735.99 18:31:19 INFO - PROCESS | 1639 | Values: 448.2 474.7 476.5 496.6 530.9 32742.8 35993.0 40911.6 40934.6 41026.0 35076.0 40924.8 41516.0 41932.8 41976.2 7104.8 8486.8 8664.6 8951.8 9457.2 11118.2 11417.5 11420.7 11569.5 11608.0 11497.7 11538.9 11544.7 11610.1 11643.1 10366.8 11154.8 11530.0 11540.2 11604.9 11472.1 11549.2 11552.2 11553.7 11575.5 34512.0 40383.2 40673.8 40863.4 41150.2 3577.2 3954.1 3982.1 4003.7 4017.9 29186.0 30369.8 30774.0 30869.4 31025.1 3024.2 3149.7 3168.1 3199.4 3208.7 316124.0 328117.0 328454.0 330077.0 330913.0 60491.0 60716.4 60836.7 60851.7 60929.0 63426.4 63872.7 63949.4 64508.0 64825.0 16158.4 16230.3 16689.7 16693.5 16704.2 9407.3 11801.5 12776.9 12871.0 12938.6 16078.9 16104.0 16119.8 16130.0 16179.6 6168.0 6460.4 7077.2 7394.0 7426.3 883.7 885.1 890.5 903.2 916.9 29488.7 30460.8 30461.0 30495.5 30563.6 946.0 957.4 1034.5 1073.4 1087.8 14404.9 14439.9 14490.4 14609.6 14765.6 548409.0 610072.0 621608.0 621824.0 622191.0 49290.3 50411.7 50472.7 50581.2 50658.2 1288.3 1407.3 1440.2 1461.7 1474.7 20496.6 26796.0 26909.8 27267.9 28020.0 44910.0 45082.5 45172.0 45221.3 45306.8 499763.5 500383.5 502129.0 503656.0 509225.9 23996.5 24321.9 24977.9 25003.5 25776.4 42560.9 42887.6 43522.8 43848.8 43900.3 29700.9 35506.5 35719.8 35828.0 36033.8 30736.2 32220.8 35496.8 35956.1 36249.1 34980.3 35128.0 35444.8 35521.6 35559.1 30401.0 31306.2 31818.4 31879.0 31916.0 19905.4 23831.9 24877.8 25073.0 26234.6 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:40549.31 Median:23949.04 stddev:124005.13 (517.8%) stddev-sans-first:124316.32 18:31:19 INFO - PROCESS | 1639 | Values: 382.2 383.4 399.3 404.4 415.9 16957.6 20494.0 20649.0 21416.7 21464.8 21057.2 21263.8 21422.6 21989.3 22253.3 5632.6 5923.0 5946.4 5964.8 5968.6 5639.9 5762.6 5813.2 5829.1 5883.5 5851.7 5864.0 5866.7 5871.0 5874.8 5580.9 5756.0 5802.4 5826.3 5842.1 5127.2 5133.0 5134.8 5142.8 5145.3 25644.7 26646.2 26817.3 26861.8 26877.5 2761.2 2786.7 2803.5 2804.3 2806.5 11199.5 14886.4 15017.8 15196.5 15917.3 1798.0 1821.9 1858.3 1866.6 1882.2 115750.8 131728.0 132495.0 141543.3 141606.0 9708.4 12207.3 12240.6 12243.3 12433.3 14010.4 14563.6 15821.1 15872.5 15882.8 7056.0 7654.2 7756.6 8828.9 9007.5 6949.9 8641.7 8654.7 8777.5 8808.3 4731.5 4824.3 4843.1 4900.1 4960.8 1746.5 2004.4 2056.5 2061.8 2158.6 991.2 1016.0 1029.2 1034.0 1064.8 21207.3 21543.8 21640.5 21681.3 21790.2 976.6 1038.2 1041.0 1069.9 1078.3 9445.3 11214.4 11294.2 11340.1 11394.7 730901.0 738964.0 739040.0 755905.0 759790.0 140491.0 145047.0 152329.0 153323.2 158172.0 993.5 1001.6 1021.5 1027.3 1034.9 15357.5 17824.2 18851.6 18935.3 19039.4 35146.6 47243.1 59301.0 59437.8 59832.0 85507.1 85551.0 86497.0 86808.0 87463.3 8016.3 8106.5 8286.4 8457.1 8781.4 12403.7 12920.7 13004.1 13173.9 13479.7 11130.1 11174.0 11238.7 11308.3 11650.6 9237.8 9744.6 10965.4 11030.3 11401.1 11439.9 11510.5 11659.4 11706.7 11840.0 8203.7 8203.8 8478.3 8525.6 8668.0 8777.6 9538.8 11134.7 11355.0 11677.4 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5380.92 Median:5156.46 stddev:2931.48 (56.9%) stddev-sans-first:2923.74 18:31:19 INFO - PROCESS | 1639 | Values: 1310.8 1431.9 1445.9 1454.8 1467.8 7317.4 7574.5 8035.4 8036.0 8520.4 7380.0 7516.8 7563.5 7590.1 7645.7 2221.8 2240.4 2251.6 2259.4 2266.3 2070.0 2219.5 2260.6 2279.6 2280.8 2090.7 2155.3 2227.2 2228.2 2233.6 1949.5 2254.4 2274.6 2277.7 2282.5 2261.9 2317.1 2328.8 2329.7 2332.9 8285.2 8346.5 8349.6 8413.5 8438.4 4874.0 4969.1 5006.1 5020.0 5034.7 3232.5 3337.8 3441.8 3450.9 3468.1 1118.0 1165.3 1193.3 1206.8 1216.8 10656.1 10697.0 10767.7 10769.0 10876.9 4098.9 4373.2 4642.5 4669.6 4684.6 7759.9 9450.1 9481.1 9489.1 9506.4 5119.9 5193.0 5208.1 5218.7 5225.8 4674.1 4705.8 4723.0 4731.2 4741.9 3909.3 3951.1 3957.2 3984.9 4060.9 1184.1 1280.6 1282.1 1283.4 1289.3 684.3 734.7 759.3 764.5 776.9 5456.9 5749.1 5799.2 5802.3 5954.3 864.3 978.2 986.3 1025.6 1029.0 3769.9 3802.6 3807.6 3897.6 3936.3 9653.5 9973.2 10012.5 10017.9 10034.4 9690.3 9740.9 9960.6 9971.3 9982.8 7691.4 7805.6 7812.2 7828.1 7864.9 5404.6 5415.1 5449.3 5547.4 5554.8 8912.4 9263.8 9279.9 9295.8 9302.8 8956.0 9265.3 9274.0 9317.7 9321.0 7169.9 7231.0 7236.3 7315.5 7335.6 7799.2 7849.9 7907.0 7917.2 7928.6 6494.4 7061.2 7172.9 7200.8 7276.8 7026.5 7033.7 7058.1 7069.9 7115.8 6357.4 6365.2 6366.1 6438.9 6458.8 4921.8 4942.2 4966.4 4978.8 5016.9 4068.9 4902.0 4941.7 4951.8 5111.3 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4600.62 Median:5012.64 stddev:1372.23 (27.4%) stddev-sans-first:1337.55 18:31:19 INFO - PROCESS | 1639 | Values: 298.9 355.6 366.9 366.9 372.3 4894.1 5224.5 5357.5 5434.9 5601.0 4509.8 5325.9 5419.2 5455.2 5483.2 3526.8 3732.6 4259.0 4275.3 4275.8 3689.8 4080.0 4260.9 4276.3 4324.9 3464.7 4143.6 4219.2 4237.3 4239.8 3704.4 3873.4 4231.7 4236.9 4252.0 3772.2 3776.4 3785.6 3788.9 3795.5 4963.0 5303.7 5336.8 5355.6 5372.8 4711.3 4715.1 4735.0 4742.9 4775.3 5517.2 5768.6 5797.1 5806.5 5833.7 3267.6 3292.9 3554.4 3726.3 4008.9 4864.3 5043.4 5382.1 6157.8 6185.2 4299.4 4310.4 4317.5 4319.2 4333.7 4129.2 4362.9 4370.8 4394.6 4405.8 4510.8 4589.9 4976.1 5012.8 5015.3 4909.3 5373.9 5861.8 5880.9 5893.9 1284.7 1292.3 1302.7 1427.5 1438.8 877.8 993.8 995.7 1012.8 1017.4 5012.4 5104.5 5201.9 5221.6 5221.8 4977.9 5301.8 5511.4 5649.4 5774.5 4528.6 4728.0 4851.5 4891.4 5253.4 2529.0 2805.3 2805.8 3010.4 3020.9 5181.0 5838.3 5961.4 5982.0 6021.4 5253.5 5382.7 5731.5 5736.1 5762.9 5218.3 5923.1 5930.3 5957.0 5969.3 4910.0 5128.1 5711.4 5720.0 5737.5 4688.8 4919.0 4939.7 5586.4 5658.0 4907.7 5232.9 5886.6 5943.9 5950.8 3401.7 3567.0 4124.0 4133.6 4141.6 4678.2 5259.3 5351.3 5660.7 5710.5 5007.1 5400.4 5792.0 5829.0 5830.6 5512.5 5541.3 5789.4 5794.0 5809.0 4922.9 5235.2 5609.8 5638.7 5642.2 4825.7 5065.2 5665.5 5799.0 5826.6 4836.9 5655.7 5670.5 5688.4 5706.5 18:31:19 INFO - PROCESS | 1639 | 18:31:19 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20709.46 Median:3580.86 stddev:29871.66 (834.2%) stddev-sans-first:29917.65 18:31:19 INFO - PROCESS | 1639 | Values: 693.5 699.0 750.1 812.2 830.0 14626.1 15050.5 15521.2 15550.4 15658.0 14205.4 14484.8 14489.1 14528.4 15424.6 831.3 856.1 858.5 859.1 860.0 663.1 676.9 828.5 846.5 849.4 882.3 890.5 899.6 899.7 902.0 888.2 889.7 889.7 892.3 893.2 662.0 666.4 669.6 670.4 673.1 14931.5 15395.8 15889.0 16014.2 16100.6 12059.9 13815.9 14032.6 14103.6 14120.1 11362.3 11373.2 11627.8 11692.6 11731.8 3597.3 3626.7 3658.2 3693.5 3808.6 104244.0 105802.0 106542.5 106751.0 107462.0 10189.0 10546.2 10670.3 10713.6 10741.9 21782.5 21943.1 21961.6 21999.5 21999.9 7491.8 7590.7 7595.8 7624.1 7638.4 3226.5 3987.7 4087.0 4158.9 4177.6 3016.3 3474.7 3521.9 3547.2 3564.4 642.2 646.7 651.0 654.8 661.6 614.0 659.2 673.0 689.2 693.8 8822.4 9935.7 10015.6 10168.0 10304.4 623.9 656.9 664.6 671.7 672.5 5309.1 5501.0 5544.4 5579.6 5646.3 101749.5 101824.0 101838.9 102458.0 102569.0 90634.0 90808.2 92610.0 93608.0 94318.1 80909.2 80965.2 81227.2 82535.6 82678.6 10151.9 10588.4 10822.1 10944.3 10972.2 43817.6 51596.0 51736.0 52007.0 52947.7 67361.3 68222.3 69988.7 70310.0 71832.0 12803.0 12936.1 13116.5 13170.0 13176.5 14320.2 14358.4 14536.6 14777.0 14889.6 12850.9 13187.5 13607.9 13862.9 14267.9 12961.6 13282.2 13420.1 13500.1 13552.1 12640.8 12809.2 13420.4 13572.7 13923.9 9170.9 10713.0 11000.4 11167.5 11276.5 7582.3 9631.4 10993.8 11020.0 11061.3 18:31:19 INFO - PROCESS | 1639 | -------- Summary: end -------- 18:31:19 INFO - PROCESS | 1639 | 18:31:20 INFO - TEST-INFO | 1639: exit 0 18:31:20 INFO - TEST-OK | dromaeo_css | took 1115188ms 18:31:20 INFO - TEST-START | kraken 18:31:20 INFO - operating with platform_type : mac_ 18:31:20 INFO - Initialising browser for kraken test... 18:31:20 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmp6meCvL/profile http://localhost:49251/getInfo.html) 18:31:22 INFO - PROCESS | 1652 | 2017-03-02 18:31:22.832 plugin-container[1653:10038] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 18:31:22 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:31:22 INFO - PROCESS | 1652 | 2017-03-02 18:31:22.834 plugin-container[1653:10038] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 18:31:22 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:31:22 INFO - PROCESS | 1652 | 2017-03-02 18:31:22.834 plugin-container[1653:10038] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:31:22 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 18:31:22 INFO - PROCESS | 1652 | colorDepth:24 18:31:22 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 18:31:22 INFO - PROCESS | 1652 | __metrics 18:31:22 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 18:31:23 INFO - TEST-INFO | 1652: exit 0 18:31:23 INFO - Browser initialized. 18:31:23 INFO - Running cycle 1/1 for kraken test... 18:31:23 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmp6meCvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:26 INFO - PROCESS | 1654 | 2017-03-02 18:31:26.063 plugin-container[1655:10163] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 18:31:26 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:31:26 INFO - PROCESS | 1654 | 2017-03-02 18:31:26.063 plugin-container[1655:10163] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 18:31:26 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:31:26 INFO - PROCESS | 1654 | 2017-03-02 18:31:26.064 plugin-container[1655:10163] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:31:35 INFO - PROCESS | 1654 | RSS: Main: 218181632 18:31:35 INFO - PROCESS | 1654 | 18:31:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:39 INFO - PROCESS | 1654 | RSS: Main: 232673280 18:31:39 INFO - PROCESS | 1654 | 18:31:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 18:31:43 INFO - PROCESS | 1654 | RSS: Main: 241750016 18:31:43 INFO - PROCESS | 1654 | 18:31:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 18:31:47 INFO - PROCESS | 1654 | RSS: Main: 244916224 18:31:47 INFO - PROCESS | 1654 | 18:31:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 18:31:49 INFO - PROCESS | 1654 | RSS: Main: 246099968 18:31:49 INFO - PROCESS | 1654 | 18:31:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:52 INFO - PROCESS | 1654 | RSS: Main: 246108160 18:31:52 INFO - PROCESS | 1654 | 18:31:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 18:31:55 INFO - PROCESS | 1654 | RSS: Main: 250134528 18:31:55 INFO - PROCESS | 1654 | 18:31:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 18:31:59 INFO - PROCESS | 1654 | RSS: Main: 249749504 18:31:59 INFO - PROCESS | 1654 | 18:32:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 18:32:03 INFO - PROCESS | 1654 | RSS: Main: 249643008 18:32:03 INFO - PROCESS | 1654 | 18:32:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:05 INFO - PROCESS | 1654 | RSS: Main: 248569856 18:32:05 INFO - PROCESS | 1654 | 18:32:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:08 INFO - PROCESS | 1654 | RSS: Main: 248606720 18:32:08 INFO - PROCESS | 1654 | 18:32:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:11 INFO - PROCESS | 1654 | RSS: Main: 248635392 18:32:11 INFO - PROCESS | 1654 | 18:32:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:14 INFO - PROCESS | 1654 | RSS: Main: 248999936 18:32:14 INFO - PROCESS | 1654 | 18:32:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:18 INFO - PROCESS | 1654 | RSS: Main: 248799232 18:32:18 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 18:32:20 INFO - PROCESS | 1654 | RSS: Main: 250765312 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | __start_tp_report 18:32:20 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 18:32:20 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 18:32:20 INFO - PROCESS | 1654 | |i|pagename|runs| 18:32:20 INFO - PROCESS | 1654 | |0;ai-astar;106;119;127;174;125;122;122;122;121;121 18:32:20 INFO - PROCESS | 1654 | |1;audio-beat-detection;145;108;111;146;114;115;140;144;129;113 18:32:20 INFO - PROCESS | 1654 | |2;audio-dft;200;197;229;265;197;201;193;195;206;193 18:32:20 INFO - PROCESS | 1654 | |3;audio-fft;72;60;57;107;51;68;83;82;91;82 18:32:20 INFO - PROCESS | 1654 | |4;audio-oscillator;86;71;87;73;71;69;66;72;104;113 18:32:20 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;91;88;90;88;91;101;90;90;89;77 18:32:20 INFO - PROCESS | 1654 | |6;imaging-darkroom;155;109;103;98;105;154;116;97;97;101 18:32:20 INFO - PROCESS | 1654 | |7;imaging-desaturate;142;74;139;143;133;91;87;92;87;92 18:32:20 INFO - PROCESS | 1654 | |8;json-parse-financial;61;61;60;63;64;62;63;63;64;63 18:32:20 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;69;63;88;103;69;93;96;92;58;98 18:32:20 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;83;102;107;72;98;71;101;103;108;104 18:32:20 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;138;139;179;141;134;150;152;195;155 18:32:20 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;172;171;206;226;242;169;169;171;171;169 18:32:20 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;67;67;66;68;66;66;67;68;67 18:32:20 INFO - PROCESS | 1654 | __end_tp_report 18:32:20 INFO - PROCESS | 1654 | __start_cc_report 18:32:20 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,974 18:32:20 INFO - PROCESS | 1654 | __end_cc_report 18:32:20 INFO - PROCESS | 1654 | __startTimestamp1488508340363__endTimestamp 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | ------- Summary: start ------- 18:32:20 INFO - PROCESS | 1654 | Number of tests: 14 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:125.90 Median:122.00 stddev:17.80 (14.6%) stddev-sans-first:17.37 18:32:20 INFO - PROCESS | 1654 | Values: 106.0 119.0 127.0 174.0 125.0 122.0 122.0 122.0 121.0 121.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:126.50 Median:134.50 stddev:15.88 (11.8%) stddev-sans-first:15.37 18:32:20 INFO - PROCESS | 1654 | Values: 145.0 108.0 111.0 146.0 114.0 115.0 140.0 144.0 129.0 113.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:207.60 Median:200.50 stddev:22.77 (11.4%) stddev-sans-first:23.98 18:32:20 INFO - PROCESS | 1654 | Values: 200.0 197.0 229.0 265.0 197.0 201.0 193.0 195.0 206.0 193.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:75.30 Median:77.00 stddev:17.08 (22.2%) stddev-sans-first:18.07 18:32:20 INFO - PROCESS | 1654 | Values: 72.0 60.0 57.0 107.0 51.0 68.0 83.0 82.0 91.0 82.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:71.50 stddev:16.08 (22.5%) stddev-sans-first:16.96 18:32:20 INFO - PROCESS | 1654 | Values: 86.0 71.0 87.0 73.0 71.0 69.0 66.0 72.0 104.0 113.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:90.00 stddev:5.76 (6.4%) stddev-sans-first:6.08 18:32:20 INFO - PROCESS | 1654 | Values: 91.0 88.0 90.0 88.0 91.0 101.0 90.0 90.0 89.0 77.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:113.50 Median:154.50 stddev:22.39 (14.5%) stddev-sans-first:18.02 18:32:20 INFO - PROCESS | 1654 | Values: 155.0 109.0 103.0 98.0 105.0 154.0 116.0 97.0 97.0 101.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:108.00 Median:87.00 stddev:27.50 (31.6%) stddev-sans-first:26.27 18:32:20 INFO - PROCESS | 1654 | Values: 142.0 74.0 139.0 143.0 133.0 91.0 87.0 92.0 87.0 92.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.33 18:32:20 INFO - PROCESS | 1654 | Values: 61.0 61.0 60.0 63.0 64.0 62.0 63.0 63.0 64.0 63.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:82.90 Median:90.00 stddev:16.39 (18.2%) stddev-sans-first:16.59 18:32:20 INFO - PROCESS | 1654 | Values: 69.0 63.0 88.0 103.0 69.0 93.0 96.0 92.0 58.0 98.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:94.90 Median:89.50 stddev:14.15 (15.8%) stddev-sans-first:14.33 18:32:20 INFO - PROCESS | 1654 | Values: 83.0 102.0 107.0 72.0 98.0 71.0 101.0 103.0 108.0 104.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:151.00 stddev:20.16 (13.3%) stddev-sans-first:20.54 18:32:20 INFO - PROCESS | 1654 | Values: 136.0 138.0 139.0 179.0 141.0 134.0 150.0 152.0 195.0 155.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:171.50 stddev:27.63 (16.1%) stddev-sans-first:28.80 18:32:20 INFO - PROCESS | 1654 | Values: 172.0 171.0 206.0 226.0 242.0 169.0 169.0 171.0 171.0 169.0 18:32:20 INFO - PROCESS | 1654 | 18:32:20 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 18:32:20 INFO - PROCESS | 1654 | Values: 68.0 67.0 67.0 66.0 68.0 66.0 66.0 67.0 68.0 67.0 18:32:20 INFO - PROCESS | 1654 | -------- Summary: end -------- 18:32:20 INFO - PROCESS | 1654 | 18:32:21 INFO - TEST-INFO | 1654: exit 0 18:32:21 INFO - TEST-OK | kraken | took 61091ms 18:32:21 INFO - SUITE-END | took 1176s 18:32:21 INFO - Completed test suite (00:19:36) 18:32:21 INFO - javascript benchmark 18:32:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7302.341633373407, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.7458440616942, 3404.914877128072, 3426.5031570422275, 3450.982745086275, 3467.843947022384, 5769.16347129666, 5801.245838041059, 5805.883882322351, 5843.065109582468, 5859.589828711992, 5609.831705048855, 5812.273465816773, 5860.267466566679, 5871.530277577795, 5882.29412470503, 4543.477500087499, 5247.86880327992, 5264.368275806889, 5340.332458442695, 5355.946440535584, 4347.5652434756585, 5378.300820893298, 5383.542398896098, 5402.486763757437, 5418.4039755626845, 5229.137192363274, 5232.973835130838, 5386.434424385442, 5393.2449457076045, 5405.621606487547, 5326.7869285228735, 5330.786768529274, 5376.381716102659, 5393.379761327458, 5441.401445840955, 5266.420693723688, 5305.946940530584, 5310.123829568117, 5334.5732341412595, 5343.438938911398, 5653.540709791254, 5846.356900740915, 5906.586538942276, 5972.701364931736, 6018.3981601839905, 6215.440610345046, 6249.625022498664, 6267.4986001119805, 6285.59143655661, 6329.810105696836, 6276.686165691697, 6278.183836101278, 6294.779682711129, 6302.212223472066, 6310.2427708674795, 5957.076653118774, 5967.731452084667, 5968.522518198533, 5999.520038396918, 5999.940000599981, 6210.4100110489435, 6237.220347456568, 6274.278457977391, 6329.0, 6330.05049242608, 6235.688215589203, 6241.906371404432, 6276.843078923063, 6298.653574053379, 6311.810645680637, 6271.655058971709, 6285.622862628257, 6289.119523266746, 6295.370462953668, 6302.8424289392215, 6143.082036032938, 6184.226971628546, 6234.3453937336835, 6242.219722534684, 6262.812115636538, 6266.997280435108, 6311.810645680637, 6312.4634406076, 6319.33646967071, 6328.905066424008, 5044.369453818273, 5047.646664733434, 5048.949510504922, 5066.214736715815, 5084.872878178001, 4414.80133393998, 4445.977770111193, 4467.30756732707, 4534.319852022223, 4539.59143677064, 5943.31651860033, 5985.670788106609, 5993.940060599425, 5999.910001349983, 6096.177016102769, 6235.315831217508, 6254.968725156436, 6271.0, 6287.1826662534495, 6290.8427289317215, 5797.275340582427, 5899.646021238739, 5913.645181289136, 5948.256467941507, 5949.494292985145, 5525.640833345819, 5533.916991245134, 5536.335639723178, 5543.390227075019, 5560.638558493685, 6420.229572451336, 6434.710438030206, 6439.356064393523, 6448.484121270381, 6468.611883287018, 5665.923474539824, 5831.766729330949, 6139.768135342541, 6223.37766223374, 6285.5600107992, 6433.228012638513, 6472.838179045561, 6477.77327793525, 6480.513961453004, 6482.57863238888, 6293.087502312231, 6297.307296197506, 6300.275468321019, 6307.30619631831, 6318.115463835159, 6092.939070609237, 6135.018317212141, 6242.282137554058, 6245.843853903689, 6291.370862913672, 6156.876862462636, 6237.157983672328, 6238.095476156022, 6245.156903817927, 6266.561340706106, 6233.252009758858, 6248.562600617913, 6257.28041275241, 6257.843553911189, 6290.433860952537, 5924.7037648118285, 5955.0, 5963.642181469126, 6078.635281883101, 6130.233720784902, 6141.762184093141, 6154.630722156685, 6194.194754681863, 6257.937420625735, 6267.62394256346, 5138.665986710852, 6013.037913933749, 6111.358307377662, 6118.816435506942, 6123.0], "value": 5791.582577522312, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.16193717747797, 474.65587449099405, 476.452080107876, 496.5630245384061, 530.9089820419038, 32742.83628581857, 35993.0, 40911.59088409119, 40934.59065409345, 41026.0, 35076.0, 40924.77225683227, 41516.0, 41932.790336048354, 41976.16047679044, 7104.822379440504, 8486.78783030423, 8664.61009254585, 8951.820963580725, 9457.196138328216, 11118.166137539676, 11417.48621312043, 11420.71448213793, 11569.53721851125, 11608.0, 11497.712557186054, 11538.942305288461, 11544.653660390202, 11610.12924030697, 11643.12676549258, 10366.844497332546, 11154.832677509803, 11529.999999999958, 11540.249883757613, 11604.941975290154, 11472.08223342139, 11549.249298795552, 11552.191346605741, 11553.711157221052, 11575.47910344028, 34512.0, 40383.192336153115, 40673.79663101695, 40863.38704919429, 41150.1769964602, 3577.2130131371055, 3954.070793363557, 3982.1239327348226, 4003.719739618228, 4017.8593749218635, 29186.0, 30369.848150759324, 30774.0, 30869.38261234763, 31025.14120057984, 3024.2439390152463, 3149.748020158405, 3168.1129283800574, 3199.360127974391, 3208.69517395847, 316124.0, 328117.0, 328454.0, 330077.0, 330913.0, 60491.0, 60716.39283607107, 60836.69581652152, 60851.695741521005, 60929.0, 63426.36573634297, 63872.68063659745, 63949.36050639527, 64508.0, 64825.0, 16158.43445479426, 16230.269637866324, 16689.749653755203, 16693.499195024167, 16704.248308826132, 9407.341486095907, 11801.468933897995, 12776.872231277754, 12871.03467239942, 12938.611841644766, 16078.919605402132, 16104.0, 16119.758203626954, 16130.0, 16179.595510112105, 6167.969160154171, 6460.353964603502, 7077.221505634376, 7393.963030184815, 7426.2945020223, 883.7348795361365, 885.1193062902453, 890.5413711938357, 903.2322525852973, 916.9449833010041, 29488.705112948595, 30460.84769576138, 30461.0, 30495.542566861513, 30563.60258126393, 946.0, 957.4494665567327, 1034.5481209533455, 1073.4042606353548, 1087.8477013218155, 14404.855951440351, 14439.92780036093, 14490.420383184766, 14609.561713148623, 14765.557033289018, 548409.0, 610072.0, 621608.0, 621824.0, 622191.0, 49290.26064609034, 50411.74794126006, 50472.747636261585, 50581.24128138081, 50658.24012639813, 1288.2850018239778, 1407.3174510362467, 1440.229477229677, 1461.7429011050701, 1474.668199655069, 20496.59006819885, 26796.0, 26909.776799748914, 27267.863660682364, 28020.0, 44910.0, 45082.54917450915, 45172.0, 45221.32168017548, 45306.77346613246, 499763.5011824918, 500383.4980825073, 502129.0, 503656.0, 509225.90774093266, 23996.520069598162, 24321.878390607933, 24977.87511062433, 25003.49993000166, 25776.355591110372, 42560.935976600835, 42887.571124288355, 43522.78238608786, 43848.780756097294, 43900.341494878245, 29700.851495742383, 35506.467402989496, 35719.821400892826, 35828.0, 36033.81983090068, 30736.231594210323, 32220.83889580537, 35496.82251588725, 35956.101097472776, 36249.09377265589, 34980.30039399249, 35128.0, 35444.82277588596, 35521.644783551834, 35559.11102222465, 30401.0, 31306.21734456657, 31818.363632726752, 31879.0, 31916.0, 19905.407567394283, 23831.88084059638, 24877.756112193954, 25073.0, 26234.60648090242], "value": 19196.459583752396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.16306289226577, 383.4248627059411, 399.3430806323598, 404.3631280732845, 415.93968874513195, 16957.57606059849, 20494.0, 20649.0, 21416.678749818744, 21464.785352146475, 21057.157713691435, 21263.787362126375, 21422.57154856902, 21989.340319790394, 22253.332400028026, 5632.605717599769, 5923.022701254288, 5946.43508866657, 5964.761409543635, 5968.641881487125, 5639.943600564004, 5762.6254293471, 5813.215215945836, 5829.09649004405, 5883.47048765611, 5851.736671849756, 5863.970680146594, 5866.677332746719, 5870.97064514679, 5874.823755287348, 5580.91628625571, 5756.0, 5802.361740208574, 5826.300843898759, 5842.094475356305, 5127.1796512558185, 5133.024725302181, 5134.7689353978785, 5142.845714628567, 5145.30538377318, 25644.743552564607, 26646.20061398161, 26817.329566760793, 26861.791219395174, 26877.462450750874, 2761.226856480189, 2786.6795318538425, 2803.5374163263036, 2804.2568719289407, 2806.480801051812, 11199.496022678917, 14886.404543818235, 15017.774733379008, 15196.46031841152, 15917.283722232412, 1797.9550511237194, 1821.9362322318789, 1858.349577647826, 1866.56135808085, 1882.2000649723814, 115750.842491574, 131728.0, 132495.0, 141543.29228353896, 141606.0, 9708.368956017835, 12207.328596927076, 12240.571579994657, 12243.265404075606, 12433.316167610868, 14010.439582416793, 14563.563093107225, 15821.129837859029, 15872.52382428506, 15882.841171588136, 7056.0, 7654.2345765423015, 7756.612169391507, 8828.911710882938, 9007.549622518978, 6949.89575156373, 8641.654333826576, 8654.74506196598, 8777.517236551923, 8808.339374546806, 4731.455882573479, 4824.276358546176, 4843.07981483517, 4900.06898689255, 4960.751962401865, 1746.5371676505736, 2004.4487765864212, 2056.5475595369294, 2061.752589689247, 2158.568286342738, 991.2218908157062, 1015.9695209143738, 1029.2126523209602, 1034.022848408247, 1064.8243039898484, 21207.257745978815, 21543.78456215418, 21640.458988525414, 21681.34955951324, 21790.237341693282, 976.6484065736329, 1038.1798379280283, 1040.953157107932, 1069.8555694981078, 1078.2775540387959, 9445.291603129794, 11214.383208923424, 11294.152938529644, 11340.149488788375, 11394.658160255205, 730901.0, 738964.0, 739040.0, 755905.0, 759790.0, 140491.0, 145047.0, 152329.0, 153323.23338383235, 158172.0, 993.5082134343402, 1001.5727588186804, 1021.4943602916604, 1027.306568066567, 1034.8758149022015, 15357.462488812838, 17824.197911094292, 18851.622967540847, 18935.33726319572, 19039.428817135507, 35146.64853351434, 47243.05513889772, 59301.0, 59437.81124377402, 59832.0, 85507.14492854991, 85551.0, 86497.0, 86808.0, 87463.25073498621, 8016.278534931651, 8106.513609183467, 8286.378521610783, 8457.112003239572, 8781.429207101519, 12403.689907752378, 12920.676983075498, 13004.089713719948, 13173.93413032967, 13479.663008424868, 11130.10959123252, 11174.0, 11238.66284011481, 11308.321500709984, 11650.592229271935, 9237.815243694955, 9744.561494732612, 10965.396903170084, 11030.28303160292, 11401.144914131639, 11439.885601143882, 11510.48202830858, 11659.417029148679, 11706.70733231676, 11840.0, 8203.71287004952, 8203.794905127419, 8478.32173426112, 8525.616347264264, 8668.046514883232, 8777.605007774539, 9538.761530961781, 11134.665960020888, 11354.978051975362, 11677.357745323749], "value": 9991.793152514376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.8464551194947, 1431.8711315981566, 1445.8987870849044, 1454.7959840841127, 1467.8238611366635, 7317.3780228680625, 7574.469787114904, 8035.437519373653, 8035.959820200898, 8520.360972927025, 7380.0, 7516.774496765092, 7563.470557061008, 7590.089189297279, 7645.694172233118, 2221.8111460525874, 2240.417491452226, 2251.583457060449, 2259.367377134397, 2266.2634643740766, 2070.0167420475227, 2219.500612362214, 2260.6156953317895, 2279.635258358663, 2280.8175345972363, 2090.6968489569003, 2155.3426205007468, 2227.175944900389, 2228.1755750372386, 2233.597952368573, 1949.4638974282045, 2254.4363909022745, 2274.624686926655, 2277.749447560767, 2282.543491301738, 2261.9095236190533, 2317.084751523156, 2328.7554806745216, 2329.743728189898, 2332.8600283983014, 8285.171482851727, 8346.457480263824, 8349.624266907944, 8413.495190288602, 8438.367122465777, 4873.951260487385, 4969.080720066763, 5006.123928312531, 5020.0, 5034.672746271481, 3232.4666430039015, 3337.7997320160625, 3441.776284541497, 3450.861965521401, 3468.0982944434377, 1117.972050698731, 1165.2891736041008, 1193.2601786892096, 1206.8008778551527, 1216.7688139253603, 10656.09423199029, 10697.0, 10767.676969690843, 10769.0, 10876.945615271952, 4098.938515922264, 4373.234683930363, 4642.535746425398, 4669.626429885601, 4684.578387945101, 7759.92240077592, 9450.054994500495, 9481.146696797321, 9489.145976862115, 9506.429614223169, 5119.87200319995, 5193.039287731782, 5208.088584497697, 5218.6868787872845, 5225.790968361299, 4674.135284972291, 4705.835295764632, 4723.0, 4731.195696731564, 4741.881452963635, 3909.257241124177, 3951.1110000249714, 3957.1887763008513, 3984.86052988144, 4060.939085913714, 1184.0705046538426, 1280.564608033273, 1282.1473719976298, 1283.4224598930332, 1289.2973329535425, 684.2849222562435, 734.6804140199031, 759.3090287838041, 764.4992529892929, 776.9028871391076, 5456.91814622781, 5749.108888122348, 5799.18811366409, 5802.274715660543, 5954.285485741652, 864.3344624639118, 978.2076518020426, 986.284943416032, 1025.620520407454, 1028.9691309260734, 3769.86805461813, 3802.6007269236884, 3807.6192380762254, 3897.61023897608, 3936.3308237599676, 9653.46905920167, 9973.202143828476, 10012.54943527543, 10017.899821001842, 10034.397936123856, 9690.321677482649, 9740.853887191697, 9960.601575936882, 9971.252156088321, 9982.80034399308, 7691.423143264277, 7805.570693611792, 7812.179721129313, 7828.138904720477, 7864.93823333854, 5404.621676482609, 5415.079436495726, 5449.264349312792, 5547.362053363915, 5554.75003624846, 8912.376133670581, 9263.76840578991, 9279.907200927904, 9295.76760580991, 9302.813943721223, 8956.0, 9265.305102117234, 9273.979862215287, 9317.673881414117, 9320.95339523298, 7169.856602868018, 7230.9638451807405, 7236.312550307713, 7315.48791584584, 7335.559866408033, 7799.181085986117, 7849.882251766114, 7907.011623547057, 7917.168697286702, 7928.603569821371, 6494.447971922439, 7061.152661680631, 7172.856542869009, 7200.819979500555, 7276.818079548054, 7026.473014524034, 7033.683484243119, 7058.1245667888315, 7069.893951590833, 7115.786526404217, 6357.427831495188, 6365.2361716594305, 6366.108744775643, 6438.90341644885, 6458.773942911976, 4921.753912304442, 4942.184539550934, 4966.428860680923, 4978.751062446936, 5016.874578135576, 4068.9186216274916, 4902.0, 4941.703497790144, 4951.777170027285, 5111.309973153577], "value": 4361.148356914855, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.9491786396313, 355.58574260985955, 366.9139347531307, 366.94128939369705, 372.2833545425056, 4894.140226713848, 5224.45143259958, 5357.491038351351, 5434.891302173959, 5601.0, 4509.759816050588, 5325.920111198326, 5419.241306217123, 5455.236266922634, 5483.243977875159, 3526.770759900611, 3732.64539868712, 4258.954847284192, 4275.273203555387, 4275.786210689469, 3689.8192578374933, 4079.9800049987502, 4260.893477663052, 4276.337167739005, 4324.891877703067, 3464.6708562686504, 4143.606357396043, 4219.198352313066, 4237.322028475444, 4239.830406783741, 3704.3887758519813, 3873.3802591585213, 4231.70378073535, 4236.894077648052, 4252.0, 3772.170122573057, 3776.433534969749, 3785.6025117362556, 3788.8673896413493, 3795.5387175937462, 4962.975185124052, 5303.7082960437165, 5336.813211537617, 5355.598330125256, 5372.764264219251, 4711.269753188261, 4715.056988602293, 4734.976325118387, 4742.909130899878, 4775.307580400822, 5517.200005999108, 5768.567357448166, 5797.072468405077, 5806.5354771618595, 5833.737481813286, 3267.6242232143372, 3292.884749033796, 3554.3957527220177, 3726.273376691546, 4008.899777505586, 4864.343313652647, 5043.38611644274, 5382.11625930921, 6157.768446310711, 6185.226846644169, 4299.376590394375, 4310.383606147695, 4317.525072242051, 4319.200947824663, 4333.696641235083, 4129.233413612887, 4362.931081884958, 4370.781460926941, 4394.560543945579, 4405.757683327448, 4510.8421205257655, 4589.908201836011, 4976.0794253063295, 5012.8496145115705, 5015.291742459031, 4909.281751386986, 5373.919391209135, 5861.8311224847075, 5880.941190588125, 5893.911591326134, 1284.6852521132382, 1292.3215311961296, 1302.6873550348039, 1427.5075099090798, 1438.7697968325017, 877.7937184761576, 993.8310487217191, 995.6515219673201, 1012.7569383347943, 1017.4251547875575, 5012.423571289349, 5104.464031276737, 5201.852879008221, 5221.6344855859725, 5221.843344699589, 4977.850664480072, 5301.761420735999, 5511.3937466878615, 5649.435056494318, 5774.545818027322, 4528.6150677192145, 4728.014234021719, 4851.51484851512, 4891.364122664102, 5253.375171131906, 2528.987355063213, 2805.2928923588834, 2805.8215549469273, 3010.397920415882, 3020.879164833426, 5181.0, 5838.299404071454, 5961.433663801932, 5982.0, 6021.367756385516, 5253.527182553588, 5382.730863456812, 5731.512821410227, 5736.078413731363, 5762.94237057624, 5218.347706536683, 5923.075000624728, 5930.28836539618, 5957.017092179828, 5969.283685957626, 4909.975450122726, 5128.07699611233, 5711.429856564479, 5719.996002797975, 5737.483626473638, 4688.843132159245, 4919.0, 4939.678920870276, 5586.441355864381, 5658.0, 4907.723991762096, 5232.944468037302, 5886.558508111823, 5943.940560594338, 5950.7917222896995, 3401.7448691347754, 3566.968077134415, 4124.0, 4133.615238894884, 4141.627253547195, 4678.17551155043, 5259.342582177228, 5351.331083614548, 5660.735705717581, 5710.5146062585145, 5007.073691367109, 5400.432954539717, 5792.0, 5829.0, 5830.62100963436, 5512.503874651301, 5541.307336582927, 5789.421057894177, 5794.0, 5809.0, 4922.901541969212, 5235.240890070994, 5609.775608975595, 5638.661680299195, 5642.150713889624, 4825.662203645711, 5065.164247899203, 5665.461781130786, 5799.043157879071, 5826.592138550431, 4836.903261934671, 5655.745491452977, 5670.5180059695385, 5688.431156884279, 5706.457886500776], "value": 4179.353840328296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.5214701855722, 698.9755358562448, 750.0774047921057, 812.2243257688906, 829.9626516806743, 14626.122432654049, 15050.473233436833, 15521.223938803043, 15550.377984880606, 15658.0, 14205.431782728678, 14484.782728259059, 14489.130652160879, 14528.418863245457, 15424.61438464039, 831.2518733140176, 856.1267507142711, 858.4548811504677, 859.1322764008335, 860.0238729042551, 663.0948754949484, 676.8680107379063, 828.4863384701493, 846.4878748357216, 849.4478588917192, 882.3029806452927, 890.4746199742151, 899.6311512279966, 899.7075950316141, 902.0393281155548, 888.2228050455851, 889.6530353162271, 889.7241855024963, 892.281713220857, 893.2050475077219, 662.0235153149115, 666.3569655282676, 669.6484345718488, 670.4468813229106, 673.141744276047, 14931.477398291116, 15395.769063464057, 15889.0, 16014.199290035569, 16100.59748506285, 12059.939700301442, 13815.861841381558, 14032.579022629337, 14103.647408814759, 14120.082194657418, 11362.261453005529, 11373.203875728703, 11627.825582616268, 11692.590759323468, 11731.765364692743, 3597.3165098631175, 3626.673599376069, 3658.1951970566697, 3693.4829123922405, 3808.619138086197, 104243.95756042418, 105802.0, 106542.46728766306, 106751.0, 107462.0, 10189.0, 10546.209034322457, 10670.306430082175, 10713.571457141783, 10741.946290268656, 21782.455438613844, 21943.122275109137, 21961.560768784533, 21999.450013749465, 21999.890000550215, 7491.812704682427, 7590.745951105045, 7595.848083038419, 7624.085109786861, 7638.427117966175, 3226.516022596629, 3987.7009224308295, 4086.959130408717, 4158.91682166355, 4177.561356057631, 3016.291171574678, 3474.7220222382653, 3521.8591256349973, 3547.2018795770746, 3564.3940530109944, 642.1555654314561, 646.7089809585706, 651.0364660302779, 654.7773756922669, 661.5865084322298, 613.9570230083851, 659.2484567592948, 672.9966350168218, 689.152342618582, 693.7779910428716, 8822.426542274732, 9935.701928942144, 10015.599376025024, 10168.034036766496, 10304.381737095799, 623.9143889632098, 656.8522082531392, 664.5547483186277, 671.7212356871844, 672.5023482622823, 5309.134085319308, 5500.972495137498, 5544.362398324163, 5579.581531385163, 5646.265985421951, 101749.49125254326, 101824.0, 101838.90805459846, 102458.0, 102569.0, 90634.0, 90808.1838363229, 92610.0, 93608.0, 94318.11363772824, 80909.19090809017, 80965.19034809577, 81227.18772812314, 82535.58732206421, 82678.58660706658, 10151.898481015096, 10588.364698118137, 10822.101954434695, 10944.288621239593, 10972.177086718368, 43817.56182438135, 51595.96808063742, 51736.0, 52006.95986080333, 52947.73526132499, 67361.30554777753, 68222.31777682358, 69988.6500567494, 70310.0, 71832.0, 12803.03977201695, 12936.09447338715, 13116.540921067717, 13170.012249081166, 13176.538821141214, 14320.212388318743, 14358.353874075483, 14536.563903082924, 14777.0, 14889.627759306104, 12850.871491284968, 13187.472501100232, 13607.86392136066, 13862.861371386158, 14267.928660356632, 12961.611151665466, 13282.203067815963, 13420.060595758203, 13500.054996150175, 13552.119112257671, 12640.783629441814, 12809.231446113263, 13420.39608217613, 13572.660683482993, 13923.930380348034, 9170.862437063583, 10713.035826775316, 11000.449977500934, 11167.49746261404, 11276.492557834754, 7582.256081101488, 9631.422114673142, 10993.835092473779, 11020.0, 11061.281016733887], "value": 7487.818922023819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 127.0, 174.0, 125.0, 122.0, 122.0, 122.0, 121.0, 121.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 111.0, 146.0, 114.0, 115.0, 140.0, 144.0, 129.0, 113.0], "value": 126.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 197.0, 229.0, 265.0, 197.0, 201.0, 193.0, 195.0, 206.0, 193.0], "value": 207.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 60.0, 57.0, 107.0, 51.0, 68.0, 83.0, 82.0, 91.0, 82.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 87.0, 73.0, 71.0, 69.0, 66.0, 72.0, 104.0, 113.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 88.0, 91.0, 101.0, 90.0, 90.0, 89.0, 77.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 109.0, 103.0, 98.0, 105.0, 154.0, 116.0, 97.0, 97.0, 101.0], "value": 113.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 74.0, 139.0, 143.0, 133.0, 91.0, 87.0, 92.0, 87.0, 92.0], "value": 108.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 63.0, 64.0, 62.0, 63.0, 63.0, 64.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 88.0, 103.0, 69.0, 93.0, 96.0, 92.0, 58.0, 98.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 102.0, 107.0, 72.0, 98.0, 71.0, 101.0, 103.0, 108.0, 104.0], "value": 94.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 139.0, 179.0, 141.0, 134.0, 150.0, 152.0, 195.0, 155.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 206.0, 226.0, 242.0, 169.0, 169.0, 171.0, 171.0, 169.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 68.0, 66.0, 66.0, 67.0, 68.0, 67.0], "value": 67.0, "unit": "score"}]}]} 18:32:21 INFO - Return code: 0 18:32:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:21 ERROR - # TBPL SUCCESS # 18:32:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:21 INFO - 2017-03-02 18:32:21.709 screenresolution[1659:10555] starting screenresolution argv=screenresolution get 18:32:21 INFO - 2017-03-02 18:32:21.712 screenresolution[1659:10555] Display 0: 1600x1200x32@60 18:32:21 INFO - 2017-03-02 18:32:21.718 screenresolution[1660:10558] starting screenresolution argv=screenresolution list 18:32:21 INFO - Available Modes on Display 0 18:32:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:21 INFO - Intel Iris: 18:32:21 INFO - Chipset Model: Intel Iris 18:32:21 INFO - Type: GPU 18:32:21 INFO - Bus: Built-In 18:32:21 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:21 INFO - Vendor: Intel (0x8086) 18:32:21 INFO - Device ID: 0x0a2e 18:32:21 INFO - Revision ID: 0x0009 18:32:21 INFO - Displays: 18:32:21 INFO - Display: 18:32:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:21 INFO - Display Serial Number: 1600x1200 60 18:32:21 INFO - Main Display: Yes 18:32:21 INFO - Mirror: Off 18:32:21 INFO - Online: Yes 18:32:21 INFO - Rotation: Supported 18:32:21 INFO - Return code: 0 18:32:21 INFO - Running post-action listener: _resource_record_post_action 18:32:21 INFO - [mozharness: 2017-03-03 02:32:21.958004Z] Finished run-tests step (success) 18:32:21 INFO - Running post-run listener: _resource_record_post_run 18:32:22 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 39750144; Write bytes: 510883840; Read time: 383; Write time: 1726 18:32:22 INFO - TinderboxPrint: CPU usage
54.4% 18:32:22 INFO - TinderboxPrint: I/O read bytes / time
39,750,144 / 383 18:32:22 INFO - TinderboxPrint: I/O write bytes / time
510,883,840 / 1,726 18:32:22 INFO - TinderboxPrint: CPU idle
2,182.2 (45.6%) 18:32:22 INFO - TinderboxPrint: CPU system
966.8 (20.2%) 18:32:22 INFO - TinderboxPrint: CPU user
1,640.7 (34.3%) 18:32:22 INFO - TinderboxPrint: Swap in / out
247,943,168 / 0 18:32:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205591040; Write bytes: 198955008; Read time: 15810; Write time: 401 18:32:22 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 37681664; Write bytes: 300967936; Read time: 361; Write time: 1289 18:32:22 INFO - Running post-run listener: _upload_blobber_files 18:32:22 INFO - Blob upload gear active. 18:32:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:22 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 18:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:22 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:23 INFO - (blobuploader) - INFO - Done attempting. 18:32:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:32:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:24 INFO - (blobuploader) - INFO - Done attempting. 18:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:25 INFO - (blobuploader) - INFO - Done attempting. 18:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:31 INFO - (blobuploader) - INFO - Done attempting. 18:32:31 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:31 INFO - Return code: 0 18:32:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dc9aa8eb1f65a61386714013179c916ec998f90e12c9f768cfcb5f158a38188a058b2bb4720e395e5a98b7ed8818c30f35dd0200445a98bdef6a2327519813d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8f946d1e62a40039c193dde2531b7b10a8ee07cc16eeb1cbb7854e5f33cf3916d191285e203cb30b4e0f45ae3c1ea6285d9ec5ce25dde2ff7af339b5f82a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28848d59274af370bde040eba1593db8092988c5f8185b262517ef97f7268806aad85871019afa7c45389892e5a0b22491784fb1d5182859c424d4c942813ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ceaf33d45423cb57a08ea71925b3633106e25f68351d01b14566ac540d6389bb0c061b2af4fd3e9a76c04420c13517ff0fe0bab133d55d7c85745e865779a1"} 18:32:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:31 INFO - Contents: 18:32:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dc9aa8eb1f65a61386714013179c916ec998f90e12c9f768cfcb5f158a38188a058b2bb4720e395e5a98b7ed8818c30f35dd0200445a98bdef6a2327519813d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8f946d1e62a40039c193dde2531b7b10a8ee07cc16eeb1cbb7854e5f33cf3916d191285e203cb30b4e0f45ae3c1ea6285d9ec5ce25dde2ff7af339b5f82a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28848d59274af370bde040eba1593db8092988c5f8185b262517ef97f7268806aad85871019afa7c45389892e5a0b22491784fb1d5182859c424d4c942813ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ceaf33d45423cb57a08ea71925b3633106e25f68351d01b14566ac540d6389bb0c061b2af4fd3e9a76c04420c13517ff0fe0bab133d55d7c85745e865779a1"} 18:32:31 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:31 INFO - Copying logs to upload dir... 18:32:31 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.462622 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-03-02 18:32:31.480891) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:31.484278) ========= 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.34AhMnopqn/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.ODQ71HtXg8/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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/Mozilla-Aurora/sha512/8dc9aa8eb1f65a61386714013179c916ec998f90e12c9f768cfcb5f158a38188a058b2bb4720e395e5a98b7ed8818c30f35dd0200445a98bdef6a2327519813d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8f946d1e62a40039c193dde2531b7b10a8ee07cc16eeb1cbb7854e5f33cf3916d191285e203cb30b4e0f45ae3c1ea6285d9ec5ce25dde2ff7af339b5f82a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28848d59274af370bde040eba1593db8092988c5f8185b262517ef97f7268806aad85871019afa7c45389892e5a0b22491784fb1d5182859c424d4c942813ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ceaf33d45423cb57a08ea71925b3633106e25f68351d01b14566ac540d6389bb0c061b2af4fd3e9a76c04420c13517ff0fe0bab133d55d7c85745e865779a1"} build_url:https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/LS58YrH1Q_qQ-7KzEg3_cg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8dc9aa8eb1f65a61386714013179c916ec998f90e12c9f768cfcb5f158a38188a058b2bb4720e395e5a98b7ed8818c30f35dd0200445a98bdef6a2327519813d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8f946d1e62a40039c193dde2531b7b10a8ee07cc16eeb1cbb7854e5f33cf3916d191285e203cb30b4e0f45ae3c1ea6285d9ec5ce25dde2ff7af339b5f82a21", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28848d59274af370bde040eba1593db8092988c5f8185b262517ef97f7268806aad85871019afa7c45389892e5a0b22491784fb1d5182859c424d4c942813ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d1ceaf33d45423cb57a08ea71925b3633106e25f68351d01b14566ac540d6389bb0c061b2af4fd3e9a76c04420c13517ff0fe0bab133d55d7c85745e865779a1"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:31.527207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:31.527526) ========= 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.34AhMnopqn/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.ODQ71HtXg8/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005285 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 18:32:31.575585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 18:32:31.575900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 18:32:31.576217) ========= ========= Total master_lag: 0.18 =========