builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0185 starttime: 1485579173.23 results: success (0) buildid: 20170127192620 builduid: 2dba74d18e0e4731afee48c301097fc1 revision: e11c1e5538f15f82188f9ddad113b8bf5e8d68e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.233949) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.234440) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.234718) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.261759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.262255) ========= 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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-01-27 20:52:53-- 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% 60.5M=0s 2017-01-27 20:52:53 (60.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128294 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.413915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.414190) ========= 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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.028084 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:53.462823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 20:52:53.463132) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11c1e5538f15f82188f9ddad113b8bf5e8d68e7 --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 e11c1e5538f15f82188f9ddad113b8bf5e8d68e7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IDHZ2Ftte6/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.cEg0LtwykH/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-01-27 20:52:53,563 truncating revision to first 12 chars 2017-01-27 20:52:53,564 Setting DEBUG logging. 2017-01-27 20:52:53,564 attempt 1/10 2017-01-27 20:52:53,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e11c1e5538f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 20:52:54,606 unpacking tar archive at: mozilla-aurora-e11c1e5538f1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 20:52:54.793860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:54.794164) ========= script_repo_revision: e11c1e5538f15f82188f9ddad113b8bf5e8d68e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:54.794539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:54.794851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 20:52:54.814092) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-27 20:52:54.814362) ========= /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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:52:55 INFO - MultiFileLogger online at 20170127 20:52:55 in /builds/slave/test 20:52:55 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 20:52:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:52:55 INFO - {'append_to_log': False, 20:52:55 INFO - 'base_work_dir': '/builds/slave/test', 20:52:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:52:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:52:55 INFO - 'branch': 'Mozilla-Aurora', 20:52:55 INFO - 'buildbot_json_path': 'buildprops.json', 20:52:55 INFO - 'config_files': ('talos/mac_config.py',), 20:52:55 INFO - 'default_actions': ('clobber', 20:52:55 INFO - 'read-buildbot-config', 20:52:55 INFO - 'download-and-extract', 20:52:55 INFO - 'populate-webroot', 20:52:55 INFO - 'create-virtualenv', 20:52:55 INFO - 'install', 20:52:55 INFO - 'run-tests'), 20:52:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:52:55 INFO - 'download_minidump_stackwalk': True, 20:52:55 INFO - 'download_symbols': 'ondemand', 20:52:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:52:55 INFO - 'tooltool.py': '/tools/tooltool.py', 20:52:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:52:55 INFO - '/tools/misc-python/virtualenv.py')}, 20:52:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:52:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:52:55 INFO - 'installer_path': 'installer.exe', 20:52:55 INFO - 'log_level': 'info', 20:52:55 INFO - 'log_name': 'talos', 20:52:55 INFO - 'log_to_console': True, 20:52:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:52:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:52:55 INFO - 'opt_config_files': (), 20:52:55 INFO - 'pip_index': False, 20:52:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:52:55 INFO - 'cmd': ('bash', 20:52:55 INFO - '-c', 20:52:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:52:55 INFO - 'enabled': True, 20:52:55 INFO - 'halt_on_failure': False, 20:52:55 INFO - 'name': 'check_screen_resolution'},), 20:52:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:52:55 INFO - 'cmd': ('bash', 20:52:55 INFO - '-c', 20:52:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:52:55 INFO - 'enabled': True, 20:52:55 INFO - 'halt_on_failure': False, 20:52:55 INFO - 'name': 'check_screen_resolution'},), 20:52:55 INFO - 'run_cmd_checks_enabled': True, 20:52:55 INFO - 'sps_profile': False, 20:52:55 INFO - 'sps_profile_interval': 0, 20:52:55 INFO - 'suite': 'dromaeojs-e10s', 20:52:55 INFO - 'system_bits': '32', 20:52:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:52:55 INFO - 'title': 't-yosemite-r7-0185', 20:52:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:52:55 INFO - 'use_talos_json': True, 20:52:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:52:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:52:55 INFO - 'work_dir': 'build'} 20:52:55 INFO - [mozharness: 2017-01-28 04:52:55.029808Z] Running clobber step. 20:52:55 INFO - Running pre-action listener: _resource_record_pre_action 20:52:55 INFO - Running main action method: clobber 20:52:55 INFO - rmtree: /builds/slave/test/build 20:52:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:52:57 INFO - Running post-action listener: _resource_record_post_action 20:52:57 INFO - [mozharness: 2017-01-28 04:52:57.620638Z] Finished clobber step (success) 20:52:57 INFO - [mozharness: 2017-01-28 04:52:57.620772Z] Running read-buildbot-config step. 20:52:57 INFO - Running pre-action listener: _resource_record_pre_action 20:52:57 INFO - Running main action method: read_buildbot_config 20:52:57 INFO - Using buildbot properties: 20:52:57 INFO - { 20:52:57 INFO - "project": "", 20:52:57 INFO - "product": "firefox", 20:52:57 INFO - "script_repo_revision": "production", 20:52:57 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 20:52:57 INFO - "repository": "", 20:52:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 20:52:57 INFO - "buildid": "20170127192620", 20:52:57 INFO - "pgo_build": "False", 20:52:57 INFO - "basedir": "/builds/slave/test", 20:52:57 INFO - "buildnumber": 26, 20:52:57 INFO - "slavename": "t-yosemite-r7-0185", 20:52:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:52:57 INFO - "platform": "yosemite_r7", 20:52:57 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:52:57 INFO - "branch": "mozilla-aurora", 20:52:57 INFO - "repo_path": "releases/mozilla-aurora", 20:52:57 INFO - "revision": "e11c1e5538f15f82188f9ddad113b8bf5e8d68e7", 20:52:57 INFO - "stage_platform": "macosx64", 20:52:57 INFO - "builduid": "2dba74d18e0e4731afee48c301097fc1", 20:52:57 INFO - "slavebuilddir": "test" 20:52:57 INFO - } 20:52:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 20:52:57 INFO - Running post-action listener: _resource_record_post_action 20:52:57 INFO - [mozharness: 2017-01-28 04:52:57.624053Z] Finished read-buildbot-config step (success) 20:52:57 INFO - [mozharness: 2017-01-28 04:52:57.624200Z] Running download-and-extract step. 20:52:57 INFO - Running pre-action listener: _resource_record_pre_action 20:52:57 INFO - Running main action method: download_and_extract 20:52:57 INFO - mkdir: /builds/slave/test/build/tests 20:52:57 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')]} 20:52:57 INFO - trying https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 20:52:57 INFO - Downloading https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/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 20:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/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 20:52:58 INFO - Downloaded 1199 bytes. 20:52:58 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:52:58 INFO - Using the following test package requirements: 20:52:58 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:52:58 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 20:52:58 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 20:52:58 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'jsshell-mac.zip'], 20:52:58 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 20:52:58 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:52:58 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 20:52:58 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 20:52:58 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 20:52:58 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:52:58 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 20:52:58 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:52:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:52:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:52:58 INFO - Fetch https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:52:59 INFO - Expected file size: 16351709 20:52:59 INFO - Obtained file size: 16351709 20:53:06 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 20:53:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:53:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:53:06 INFO - Fetch https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:53:07 INFO - Expected file size: 16351709 20:53:07 INFO - Obtained file size: 16351709 20:53:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 20:53:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:53:13 INFO - Fetch https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 20:53:15 INFO - Expected file size: 14403485 20:53:15 INFO - Obtained file size: 14403485 20:53:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:15 INFO - trying https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:53:15 INFO - Downloading https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 20:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/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 20:53:17 INFO - Downloaded 73868131 bytes. 20:53:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:53:17 INFO - mkdir: /builds/slave/test/properties 20:53:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:53:17 INFO - Writing to file /builds/slave/test/properties/build_url 20:53:17 INFO - Contents: 20:53:17 INFO - build_url:https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:53:18 INFO - Running post-action listener: _resource_record_post_action 20:53:18 INFO - Running post-action listener: set_extra_try_arguments 20:53:18 INFO - [mozharness: 2017-01-28 04:53:18.215910Z] Finished download-and-extract step (success) 20:53:18 INFO - [mozharness: 2017-01-28 04:53:18.216031Z] Running populate-webroot step. 20:53:18 INFO - Running pre-action listener: _resource_record_pre_action 20:53:18 INFO - Running main action method: populate_webroot 20:53:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:53:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:53:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:53:18 INFO - '--tppagecycles', 20:53:18 INFO - '7'], 20:53:18 INFO - 'tests': ['tsvgm']}}, 20:53:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:53:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:53:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:53:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:53:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['damp', 'tps']}, 20:53:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'tests': ['damp', 'tps']}, 20:53:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['dromaeo_dom']}, 20:53:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:53:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['basic_compositor_video']}, 20:53:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:53:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['a11yr', 20:53:18 INFO - 'ts_paint', 20:53:18 INFO - 'tpaint', 20:53:18 INFO - 'sessionrestore', 20:53:18 INFO - 'sessionrestore_no_auto_restore', 20:53:18 INFO - 'tabpaint']}, 20:53:18 INFO - 'other-e10s': {'tests': ['a11yr', 20:53:18 INFO - 'ts_paint', 20:53:18 INFO - 'tpaint', 20:53:18 INFO - 'sessionrestore', 20:53:18 INFO - 'sessionrestore_no_auto_restore', 20:53:18 INFO - 'tabpaint']}, 20:53:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:53:18 INFO - 'ts_paint', 20:53:18 INFO - 'tpaint', 20:53:18 INFO - 'sessionrestore', 20:53:18 INFO - 'sessionrestore_no_auto_restore', 20:53:18 INFO - 'tabpaint']}, 20:53:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:53:18 INFO - 'ts_paint', 20:53:18 INFO - 'tpaint', 20:53:18 INFO - 'sessionrestore', 20:53:18 INFO - 'sessionrestore_no_auto_restore', 20:53:18 INFO - 'tabpaint']}, 20:53:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['a11yr', 20:53:18 INFO - 'ts_paint', 20:53:18 INFO - 'tpaint', 20:53:18 INFO - 'sessionrestore', 20:53:18 INFO - 'sessionrestore_no_auto_restore', 20:53:18 INFO - 'tabpaint']}, 20:53:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['a11yr', 20:53:18 INFO - 'ts_paint', 20:53:18 INFO - 'tpaint', 20:53:18 INFO - 'sessionrestore', 20:53:18 INFO - 'sessionrestore_no_auto_restore', 20:53:18 INFO - 'tabpaint']}, 20:53:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['tsvgx', 20:53:18 INFO - 'tsvgr_opacity', 20:53:18 INFO - 'tart', 20:53:18 INFO - 'tscrollx', 20:53:18 INFO - 'cart', 20:53:18 INFO - 'tsvg_static']}, 20:53:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:53:18 INFO - 'tsvgr_opacity', 20:53:18 INFO - 'tart', 20:53:18 INFO - 'tscrollx', 20:53:18 INFO - 'cart', 20:53:18 INFO - 'tsvg_static']}, 20:53:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'talos_options': ['--disable-e10s'], 20:53:18 INFO - 'tests': ['tp5o']}, 20:53:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:53:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'talos_options': ['--disable-e10s', 20:53:18 INFO - '--xperf_path', 20:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:18 INFO - 'tests': ['tp5n']}, 20:53:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:53:18 INFO - 'talos_options': ['--xperf_path', 20:53:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:18 INFO - 'tests': ['tp5n']}}, 20:53:18 INFO - 'talos.zip': {'path': '', 20:53:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:53:18 INFO - Running post-action listener: _resource_record_post_action 20:53:18 INFO - [mozharness: 2017-01-28 04:53:18.234973Z] Finished populate-webroot step (success) 20:53:18 INFO - [mozharness: 2017-01-28 04:53:18.235088Z] Running create-virtualenv step. 20:53:18 INFO - Running pre-action listener: _resource_record_pre_action 20:53:18 INFO - Running main action method: create_virtualenv 20:53:18 INFO - Creating virtualenv /builds/slave/test/build/venv 20:53:18 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 20:53:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:53:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:53:18 INFO - Using real prefix '/tools/python27' 20:53:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:53:19 INFO - Installing distribute.............................................................................................................................................................................................done. 20:53:21 INFO - Installing pip.................done. 20:53:21 INFO - Return code: 0 20:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:53:22 INFO - Reading from file tmpfile_stdout 20:53:22 INFO - Output received: 20:53:22 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) 20:53:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:53:22 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')]} 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:22 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')]} 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:22 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:22 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 20:53:22 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 20:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:22 INFO - 'HOME': '/Users/cltbld', 20:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:22 INFO - 'LOGNAME': 'cltbld', 20:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:22 INFO - 'MOZ_NO_REMOTE': '1', 20:53:22 INFO - 'NO_EM_RESTART': '1', 20:53:22 INFO - 'PAGER': '/bin/cat', 20:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:22 INFO - 'PWD': '/builds/slave/test', 20:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:22 INFO - 'SHELL': '/bin/bash', 20:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:22 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:22 INFO - 'USER': 'cltbld', 20:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:22 INFO - 'XPC_FLAGS': '0x0', 20:53:22 INFO - 'XPC_SERVICE_NAME': '0', 20:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:22 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 20:53:22 INFO - Cleaning up... 20:53:22 INFO - Return code: 0 20:53:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:53:22 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')]} 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:22 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')]} 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:22 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:22 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 20:53:22 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 20:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:22 INFO - 'HOME': '/Users/cltbld', 20:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:22 INFO - 'LOGNAME': 'cltbld', 20:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:22 INFO - 'MOZ_NO_REMOTE': '1', 20:53:22 INFO - 'NO_EM_RESTART': '1', 20:53:22 INFO - 'PAGER': '/bin/cat', 20:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:22 INFO - 'PWD': '/builds/slave/test', 20:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:22 INFO - 'SHELL': '/bin/bash', 20:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:22 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:22 INFO - 'USER': 'cltbld', 20:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:22 INFO - 'XPC_FLAGS': '0x0', 20:53:22 INFO - 'XPC_SERVICE_NAME': '0', 20:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:22 INFO - Downloading/unpacking psutil>=3.1.1 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:26 INFO - Installing collected packages: psutil 20:53:26 INFO - Running setup.py install for psutil 20:53:26 INFO - building 'psutil._psutil_osx' extension 20:53:26 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 20:53:26 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 20:53:26 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 20:53:27 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 20:53:27 INFO - building 'psutil._psutil_posix' extension 20:53:27 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 20:53:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:53:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:53:27 INFO - ^ 20:53:27 INFO - 1 warning generated. 20:53:27 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 20:53:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:27 INFO - Successfully installed psutil 20:53:27 INFO - Cleaning up... 20:53:27 INFO - Return code: 0 20:53:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:53:27 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')]} 20:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:27 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')]} 20:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:27 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:27 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 20:53:27 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 20:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:27 INFO - 'HOME': '/Users/cltbld', 20:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:27 INFO - 'LOGNAME': 'cltbld', 20:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:27 INFO - 'MOZ_NO_REMOTE': '1', 20:53:27 INFO - 'NO_EM_RESTART': '1', 20:53:27 INFO - 'PAGER': '/bin/cat', 20:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:27 INFO - 'PWD': '/builds/slave/test', 20:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:27 INFO - 'SHELL': '/bin/bash', 20:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:27 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:27 INFO - 'USER': 'cltbld', 20:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:27 INFO - 'XPC_FLAGS': '0x0', 20:53:27 INFO - 'XPC_SERVICE_NAME': '0', 20:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:53:30 INFO - Installing collected packages: mozsystemmonitor 20:53:30 INFO - Running setup.py install for mozsystemmonitor 20:53:30 INFO - Successfully installed mozsystemmonitor 20:53:30 INFO - Cleaning up... 20:53:30 INFO - Return code: 0 20:53:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:30 INFO - 'HOME': '/Users/cltbld', 20:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:30 INFO - 'LOGNAME': 'cltbld', 20:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:30 INFO - 'MOZ_NO_REMOTE': '1', 20:53:30 INFO - 'NO_EM_RESTART': '1', 20:53:30 INFO - 'PAGER': '/bin/cat', 20:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:30 INFO - 'PWD': '/builds/slave/test', 20:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:30 INFO - 'SHELL': '/bin/bash', 20:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:30 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:30 INFO - 'USER': 'cltbld', 20:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:30 INFO - 'XPC_FLAGS': '0x0', 20:53:30 INFO - 'XPC_SERVICE_NAME': '0', 20:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:30 INFO - Downloading/unpacking jsonschema==2.5.1 20:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:53:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:33 INFO - Downloading functools32-3.2.3-2.tar.gz 20:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:53:34 INFO - warning: no files found matching '*.txt' 20:53:34 INFO - no previously-included directories found matching 'build' 20:53:34 INFO - no previously-included directories found matching 'dist' 20:53:34 INFO - no previously-included directories found matching '.git*' 20:53:34 INFO - Installing collected packages: jsonschema, functools32 20:53:34 INFO - Running setup.py install for functools32 20:53:34 INFO - warning: no files found matching '*.txt' 20:53:34 INFO - no previously-included directories found matching 'build' 20:53:34 INFO - no previously-included directories found matching 'dist' 20:53:34 INFO - no previously-included directories found matching '.git*' 20:53:34 INFO - Successfully installed jsonschema functools32 20:53:34 INFO - Cleaning up... 20:53:34 INFO - Return code: 0 20:53:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:53:34 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')]} 20:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:34 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')]} 20:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:34 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:34 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 20:53:34 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 20:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:34 INFO - 'HOME': '/Users/cltbld', 20:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:34 INFO - 'LOGNAME': 'cltbld', 20:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:34 INFO - 'MOZ_NO_REMOTE': '1', 20:53:34 INFO - 'NO_EM_RESTART': '1', 20:53:34 INFO - 'PAGER': '/bin/cat', 20:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:34 INFO - 'PWD': '/builds/slave/test', 20:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:34 INFO - 'SHELL': '/bin/bash', 20:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:34 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:34 INFO - 'USER': 'cltbld', 20:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:34 INFO - 'XPC_FLAGS': '0x0', 20:53:34 INFO - 'XPC_SERVICE_NAME': '0', 20:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:53:34 INFO - Cleaning up... 20:53:34 INFO - Return code: 0 20:53:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:53:34 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')]} 20:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:34 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')]} 20:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:34 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:34 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 20:53:34 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 20:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:34 INFO - 'HOME': '/Users/cltbld', 20:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:34 INFO - 'LOGNAME': 'cltbld', 20:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:34 INFO - 'MOZ_NO_REMOTE': '1', 20:53:34 INFO - 'NO_EM_RESTART': '1', 20:53:34 INFO - 'PAGER': '/bin/cat', 20:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:34 INFO - 'PWD': '/builds/slave/test', 20:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:34 INFO - 'SHELL': '/bin/bash', 20:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:34 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:34 INFO - 'USER': 'cltbld', 20:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:34 INFO - 'XPC_FLAGS': '0x0', 20:53:34 INFO - 'XPC_SERVICE_NAME': '0', 20:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:34 INFO - Downloading/unpacking blobuploader==1.2.4 20:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:37 INFO - Downloading blobuploader-1.2.4.tar.gz 20:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:53:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:53:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:53:38 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 20:53:38 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 20:53:38 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 20:53:38 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 20:53:38 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 20:53:38 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 20:53:38 INFO - Downloading docopt-0.6.1.tar.gz 20:53:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:53:38 INFO - Installing collected packages: blobuploader, requests, docopt 20:53:38 INFO - Running setup.py install for blobuploader 20:53:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:53:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:53:39 INFO - Running setup.py install for requests 20:53:39 INFO - Running setup.py install for docopt 20:53:39 INFO - Successfully installed blobuploader requests docopt 20:53:39 INFO - Cleaning up... 20:53:39 INFO - Return code: 0 20:53:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:39 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')]} 20:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:39 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')]} 20:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:39 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:39 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 20:53:39 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 20:53:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:39 INFO - 'HOME': '/Users/cltbld', 20:53:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:39 INFO - 'LOGNAME': 'cltbld', 20:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:39 INFO - 'MOZ_NO_REMOTE': '1', 20:53:39 INFO - 'NO_EM_RESTART': '1', 20:53:39 INFO - 'PAGER': '/bin/cat', 20:53:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:39 INFO - 'PWD': '/builds/slave/test', 20:53:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:39 INFO - 'SHELL': '/bin/bash', 20:53:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:39 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:39 INFO - 'USER': 'cltbld', 20:53:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:39 INFO - 'XPC_FLAGS': '0x0', 20:53:39 INFO - 'XPC_SERVICE_NAME': '0', 20:53:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ISfgch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-qSJCHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-cOKEwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9ZN9cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-iKoXr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-kxqa8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-YItbEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-7aJQV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-xauJN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:40 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Z3bO5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-L0rqzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-1ozpiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-UA_onc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-cELqiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-lxO53i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-jbvFTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:41 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-egbvOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:53:41 INFO - Running setup.py install for manifestparser 20:53:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:53:41 INFO - Running setup.py install for mozcrash 20:53:42 INFO - Running setup.py install for mozdebug 20:53:42 INFO - Running setup.py install for mozdevice 20:53:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Running setup.py install for mozfile 20:53:42 INFO - Running setup.py install for mozhttpd 20:53:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Running setup.py install for mozinfo 20:53:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Running setup.py install for mozInstall 20:53:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:53:42 INFO - Running setup.py install for mozleak 20:53:43 INFO - Running setup.py install for mozlog 20:53:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:53:43 INFO - Running setup.py install for moznetwork 20:53:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:53:43 INFO - Running setup.py install for mozprocess 20:53:43 INFO - Running setup.py install for mozprofile 20:53:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:53:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:53:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:53:43 INFO - Running setup.py install for mozrunner 20:53:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:53:43 INFO - Running setup.py install for mozscreenshot 20:53:44 INFO - Running setup.py install for moztest 20:53:44 INFO - Running setup.py install for mozversion 20:53:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:53:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:53:44 INFO - Cleaning up... 20:53:44 INFO - Return code: 0 20:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53: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')]} 20:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53: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')]} 20:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:44 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:44 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 20:53:44 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 20:53:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:44 INFO - 'HOME': '/Users/cltbld', 20:53:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:44 INFO - 'LOGNAME': 'cltbld', 20:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:44 INFO - 'MOZ_NO_REMOTE': '1', 20:53:44 INFO - 'NO_EM_RESTART': '1', 20:53:44 INFO - 'PAGER': '/bin/cat', 20:53:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:44 INFO - 'PWD': '/builds/slave/test', 20:53:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:44 INFO - 'SHELL': '/bin/bash', 20:53:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:44 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:44 INFO - 'USER': 'cltbld', 20:53:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:44 INFO - 'XPC_FLAGS': '0x0', 20:53:44 INFO - 'XPC_SERVICE_NAME': '0', 20:53:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rh8gAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:44 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)) 20:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-1QR9QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:44 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)) 20:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-kcFsRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:44 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)) 20:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:44 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-fHVZRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-hQA_zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-SVeYEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-19URZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-b1_TNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-bstNt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-I3lCrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-SKgzZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-fLRMTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:45 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)) 20:53:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:45 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-7AhVmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:46 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)) 20:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:46 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-qZgaK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:46 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)) 20:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:46 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Txz349-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:46 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)) 20:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:46 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ccQ2uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:46 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)) 20:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:46 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-g8y28u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:46 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)) 20:53:46 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)) 20:53:46 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)) 20:53:46 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)) 20:53:46 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)) 20:53:46 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)) 20:53:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:49 INFO - Downloading blessings-1.6.tar.gz 20:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:53:49 INFO - Installing collected packages: blessings 20:53:49 INFO - Running setup.py install for blessings 20:53:49 INFO - Successfully installed blessings 20:53:49 INFO - Cleaning up... 20:53:49 INFO - Return code: 0 20:53:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:53:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:53:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:53:49 INFO - Reading from file tmpfile_stdout 20:53:49 INFO - Current package versions: 20:53:49 INFO - blessings == 1.6 20:53:49 INFO - blobuploader == 1.2.4 20:53:49 INFO - docopt == 0.6.1 20:53:49 INFO - functools32 == 3.2.3-2 20:53:49 INFO - jsonschema == 2.5.1 20:53:49 INFO - manifestparser == 1.1 20:53:49 INFO - mozInstall == 1.12 20:53:49 INFO - mozcrash == 1.0 20:53:49 INFO - mozdebug == 0.1 20:53:49 INFO - mozdevice == 0.49 20:53:49 INFO - mozfile == 1.2 20:53:49 INFO - mozhttpd == 0.7 20:53:49 INFO - mozinfo == 0.9 20:53:49 INFO - mozleak == 0.1 20:53:49 INFO - mozlog == 3.4 20:53:49 INFO - moznetwork == 0.27 20:53:49 INFO - mozprocess == 0.24 20:53:49 INFO - mozprofile == 0.28 20:53:49 INFO - mozrunner == 6.13 20:53:49 INFO - mozscreenshot == 0.1 20:53:49 INFO - mozsystemmonitor == 0.3 20:53:49 INFO - moztest == 0.8 20:53:49 INFO - mozversion == 1.4 20:53:49 INFO - psutil == 3.1.1 20:53:49 INFO - requests == 1.2.3 20:53:49 INFO - wsgiref == 0.1.2 20:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:50 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:50 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 20:53:50 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 20:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:50 INFO - 'HOME': '/Users/cltbld', 20:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:50 INFO - 'LOGNAME': 'cltbld', 20:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:50 INFO - 'MOZ_NO_REMOTE': '1', 20:53:50 INFO - 'NO_EM_RESTART': '1', 20:53:50 INFO - 'PAGER': '/bin/cat', 20:53:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:50 INFO - 'PWD': '/builds/slave/test', 20:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:50 INFO - 'SHELL': '/bin/bash', 20:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:50 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:50 INFO - 'USER': 'cltbld', 20:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:50 INFO - 'XPC_FLAGS': '0x0', 20:53:50 INFO - 'XPC_SERVICE_NAME': '0', 20:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 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)) 20:53:51 INFO - Cleaning up... 20:53:51 INFO - Return code: 0 20:53:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:53:51 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')]} 20:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:51 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')]} 20:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:51 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 0x1049e0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4d24a4e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, '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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 20:53:51 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 20:53:51 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 20:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:51 INFO - 'HOME': '/Users/cltbld', 20:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:51 INFO - 'LOGNAME': 'cltbld', 20:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:51 INFO - 'MOZ_NO_REMOTE': '1', 20:53:51 INFO - 'NO_EM_RESTART': '1', 20:53:51 INFO - 'PAGER': '/bin/cat', 20:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:51 INFO - 'PWD': '/builds/slave/test', 20:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:51 INFO - 'SHELL': '/bin/bash', 20:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:53:51 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:51 INFO - 'USER': 'cltbld', 20:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:51 INFO - 'XPC_FLAGS': '0x0', 20:53:51 INFO - 'XPC_SERVICE_NAME': '0', 20:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:53:51 INFO - Cleaning up... 20:53:51 INFO - Return code: 0 20:53:51 INFO - Running post-action listener: _resource_record_post_action 20:53:51 INFO - Running post-action listener: _start_resource_monitoring 20:53:51 INFO - Starting resource monitoring. 20:53:51 INFO - [mozharness: 2017-01-28 04:53:51.688681Z] Finished create-virtualenv step (success) 20:53:51 INFO - [mozharness: 2017-01-28 04:53:51.689604Z] Running install step. 20:53:51 INFO - Running pre-action listener: _resource_record_pre_action 20:53:51 INFO - Running main action method: install 20:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:53:51 INFO - Reading from file tmpfile_stdout 20:53:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:53:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:53:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:53:52 INFO - Reading from file tmpfile_stdout 20:53:52 INFO - Output received: 20:53:52 INFO - Usage: mozinstall [options] installer 20:53:52 INFO - Options: 20:53:52 INFO - -h, --help show this help message and exit 20:53:52 INFO - -d DEST, --destination=DEST 20:53:52 INFO - Directory to install application into. [default: 20:53:52 INFO - "/builds/slave/test"] 20:53:52 INFO - --app=APP Application being installed. [default: firefox] 20:53:52 INFO - mkdir: /builds/slave/test/build/application 20:53:52 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'] 20:53:52 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 20:54:12 INFO - Reading from file tmpfile_stdout 20:54:12 INFO - Output received: 20:54:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:54:12 INFO - Running post-action listener: _resource_record_post_action 20:54:12 INFO - [mozharness: 2017-01-28 04:54:12.061686Z] Finished install step (success) 20:54:12 INFO - [mozharness: 2017-01-28 04:54:12.061825Z] Running run-tests step. 20:54:12 INFO - Running pre-action listener: _resource_record_pre_action 20:54:12 INFO - Running main action method: run_tests 20:54:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:54:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:54:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:54:12 INFO - 2017-01-27 20:54:12.076 screenresolution[1630:7466] starting screenresolution argv=screenresolution get 20:54:12 INFO - 2017-01-27 20:54:12.078 screenresolution[1630:7466] Display 0: 1600x1200x32@60 20:54:12 INFO - 2017-01-27 20:54:12.084 screenresolution[1631:7469] starting screenresolution argv=screenresolution list 20:54:12 INFO - Available Modes on Display 0 20:54:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:54:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:54:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:54:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:54:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:54:12 INFO - Intel Iris: 20:54:12 INFO - Chipset Model: Intel Iris 20:54:12 INFO - Type: GPU 20:54:12 INFO - Bus: Built-In 20:54:12 INFO - VRAM (Dynamic, Max): 1536 MB 20:54:12 INFO - Vendor: Intel (0x8086) 20:54:12 INFO - Device ID: 0x0a2e 20:54:12 INFO - Revision ID: 0x0009 20:54:12 INFO - Displays: 20:54:12 INFO - Display: 20:54:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:54:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:54:12 INFO - Display Serial Number: 1600x1200 60 20:54:12 INFO - Main Display: Yes 20:54:12 INFO - Mirror: Off 20:54:12 INFO - Online: Yes 20:54:12 INFO - Rotation: Supported 20:54:12 INFO - Return code: 0 20:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:54:12 INFO - Python 2.7.3 20:54:12 INFO - Return code: 0 20:54:12 INFO - grabbing minidump binary from tooltool 20:54: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')]} 20:54:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1047bed30>, '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 0x1046e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1047b3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:54:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:54:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:54:12 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 20:54:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:54:12 INFO - Return code: 0 20:54:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:54:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:54:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:54:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:54:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:54:12 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/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 20:54:12 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/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --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 20:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IDHZ2Ftte6/Render', 20:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:12 INFO - 'HOME': '/Users/cltbld', 20:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:12 INFO - 'LOGNAME': 'cltbld', 20:54:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:54:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:12 INFO - 'MOZ_NO_REMOTE': '1', 20:54:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:54:12 INFO - 'NO_EM_RESTART': '1', 20:54:12 INFO - 'PAGER': '/bin/cat', 20:54:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:12 INFO - 'PWD': '/builds/slave/test', 20:54:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:12 INFO - 'SHELL': '/bin/bash', 20:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cEg0LtwykH/Listeners', 20:54:12 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 20:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:12 INFO - 'USER': 'cltbld', 20:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:12 INFO - 'XPC_FLAGS': '0x0', 20:54:12 INFO - 'XPC_SERVICE_NAME': '0', 20:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:12 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/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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 20:54:12 INFO - mozversion application_buildid: 20170127192620 20:54:12 INFO - mozversion application_changeset: e11c1e5538f15f82188f9ddad113b8bf5e8d68e7 20:54:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:54:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:54:12 INFO - mozversion application_name: Firefox 20:54:12 INFO - mozversion application_remotingname: firefox-dev 20:54:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:54:12 INFO - mozversion application_vendor: Mozilla 20:54:12 INFO - mozversion application_version: 53.0a2 20:54:12 INFO - mozversion platform_buildid: 20170127192620 20:54:12 INFO - mozversion platform_changeset: e11c1e5538f15f82188f9ddad113b8bf5e8d68e7 20:54:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:54:12 INFO - mozversion platform_version: 53.0a2 20:54:12 INFO - using testdate: 1485579252 20:54:12 INFO - actual date: 1485579252 20:54:12 INFO - starting webserver on 'localhost:49240' 20:54:12 INFO - SUITE-START | Running 2 tests 20:54:12 INFO - TEST-START | dromaeo_css 20:54:12 INFO - operating with platform_type : mac_ 20:54:12 INFO - Initialising browser for dromaeo_css test... 20:54:12 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpigljSp/profile http://localhost:49240/getInfo.html) 20:54:15 INFO - PROCESS | 1641 | 2017-01-27 20:54:15.512 plugin-container[1643:7644] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e37, name = 'com.apple.tsm.portname' 20:54:15 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:15 INFO - PROCESS | 1641 | 2017-01-27 20:54:15.516 plugin-container[1643:7644] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b07, name = 'com.apple.CFPasteboardClient' 20:54:15 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:15 INFO - PROCESS | 1641 | 2017-01-27 20:54:15.516 plugin-container[1643:7644] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:54:15 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 20:54:15 INFO - PROCESS | 1641 | colorDepth:24 20:54:15 INFO - PROCESS | 1641 | Browser inner width/height: 1024/663 20:54:15 INFO - PROCESS | 1641 | __metrics 20:54:15 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:54:16 INFO - TEST-INFO | 1641: exit 0 20:54:16 INFO - Browser initialized. 20:54:16 INFO - Running cycle 1/1 for dromaeo_css test... 20:54:16 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpigljSp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:18 INFO - PROCESS | 1644 | 2017-01-27 20:54:18.908 plugin-container[1645:7780] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8837, name = 'com.apple.tsm.portname' 20:54:18 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:18 INFO - PROCESS | 1644 | 2017-01-27 20:54:18.909 plugin-container[1645:7780] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 20:54:18 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:18 INFO - PROCESS | 1644 | 2017-01-27 20:54:18.909 plugin-container[1645:7780] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:54:28 INFO - PROCESS | 1644 | RSS: Main: 228360192 20:54:28 INFO - PROCESS | 1644 | 20:57:30 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 20:57:32 INFO - PROCESS | 1644 | RSS: Main: 246452224 20:57:32 INFO - PROCESS | 1644 | 20:59:16 INFO - PROCESS | 1644 | ************************* 20:59:16 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 20:59:16 INFO - PROCESS | 1644 | 20:59:16 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:59:16 INFO - PROCESS | 1644 | Full stack: 20:59:16 INFO - PROCESS | 1644 | ************************* 21:00:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 21:00:35 INFO - PROCESS | 1644 | RSS: Main: 252260352 21:00:35 INFO - PROCESS | 1644 | 21:03:37 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 21:03:37 INFO - PROCESS | 1644 | RSS: Main: 262832128 21:03:37 INFO - PROCESS | 1644 | 21:06:39 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 21:06:40 INFO - PROCESS | 1644 | RSS: Main: 259260416 21:06:40 INFO - PROCESS | 1644 | 21:09:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 21:09:43 INFO - PROCESS | 1644 | RSS: Main: 263290880 21:09:43 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 21:12:46 INFO - PROCESS | 1644 | RSS: Main: 264335360 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | __start_tp_report 21:12:46 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 21:12:46 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 21:12:46 INFO - PROCESS | 1644 | |i|pagename|runs| 21:12:46 INFO - PROCESS | 1644 | |0;dojo.html;3043.71084746949;3327.4010678077952;3358.328334333134;3374.156460884779;3383.8308084595765;5642.492175704186;5656.490915817576;5663.348714897788;5711.628744131628;5754.309482862052;5683.204351390808;5761.654300741959;5775.913361299574;5777.4511421415;5797.681127537984;5141.511556402145;5231.163013917774;5231.163013917774;5245.816396426126;5299.761510732026;4283.3146696528565;4840.370751802261;5307.389650190239;5309.469053094679;5338.546223570982;5146.330976973007;5289.471052894718;5316.255724198596;5327.547158491533;5345.705986170759;5162.148245539482;5235.869103272411;5245.26566280721;5274.7626356814035;5337.306150200449;5125.256837758541;5214.739263036833;5228.346456692913;5240.973795131038;5243.737813109329;5701.401352857932;5742.994975879246;5833.4749872511675;5867.325257595388;5907.438793314628;6093.634381937098;6152.261728592553;6184.721687524027;6200.81397558074;6215.12988181655;6232.127502149703;6266.154069200645;6267.905981410283;6284.4344009039405;6287;5880.617759845596;5902.6458412495385;5908.02517584598;5946.43508866657;5951.345352011232;6236.906446403307;6240.875182496325;6244.0321750128805;6244.250689917239;6309.779157729457;6132.20254427538;6199.659018754011;6204.689765511796;6232.345603711636;6234.127222188898;5255.290535777621;5290.100682883919;6118.632882027004;6248.375162483806;6321.020241862519;6084.969575152184;6140.074827791203;6178.104174894705;6249.96875015622;6279.717412716439;6139.001538246403;6190.628562286277;6218.160548326008;6231.003039513656;6245.6252624842655;4366.716163449366;4982.451930287665;4991.101601711727;5007.749612519359;5025.522575355335;4422.690411671217;4448.177087238806;4478.932816007762;4489.416375871116;4510.436195475566;5797.275340582427;5817.476427121579;5821.621594596338;5826.359100498942;5878.088896221093;6259.96870015647;6263.686815659199;6279.497640188865;6293.842653933597;6300.054991751183;4887.022595480918;5360.16917377807;5368.651037682616;5793.536517078624;5895.086261629454;5484.506394424521;5501.532369748536;5502.202180683778;5523.6409633373705;5526.50261476469;6336.081268216083;6340.080688300263;6363.713632886531;6371.108044873628;6371.840703982438;6140.933729673127;6230.968845155745;6243.282022567463;6294.15028971083;6296.937030629635;6180.103884936569;6300.558960872878;6343.61938283686;6353.174087368798;6373;6203.96898015507;6207.503399727921;6210.689465526796;6216.937830621817;6219.906701399392;6153.138560601609;6230.906536401867;6300.9684951574945;6306.716197771019;6322.178116844964;4831.444383895897;5176.844694659167;6129.387061293835;6164.044573091178;6181;5182.922256166236;6195.566310358232;6195.628262304276;6196.690165491797;6210.223722034746;5831.970840145772;6028.788992385421;6067.54493412987;6067.847109049267;6094.969525152346;6064.241969753781;6084.817455476343;6108.847278818065;6133.51829027926;6210.223722034746;6042.1843051187525;6045.6070355426755;6056.939430605814;6065.878682426415;6075.848103797441 21:12:46 INFO - PROCESS | 1644 | |1;ext.html;432.4918221090218;491.3195224613909;500.9649324547282;507.92066857926903;508.29093414686514;26834.597481037774;41792.37311440327;41960.370594441105;42000;42056.36915446267;42457.45255284685;43234.567654323444;43362;43421.13157736851;43476.913077173085;8435.873461898076;8623.698170564032;9250.722478325644;9564.37831540951;9584.712458626253;8483.194096560817;11192.38441885696;11467;11524.366159861203;11683.415829208505;11495.310281383103;11517.654470365902;11527.365994870279;11533.36566488847;11542.422878856065;9876.703698889045;11420.371879546621;11458.598949036785;11522.769544609144;11539.019183369466;11327.037201837853;11429.942850285695;11432.942835285854;11454.541818327258;11494.252873563275;39900.20199596021;40218.39672404916;40304.59695403067;40309.79845100785;40444.797776011226;3946.763194208328;3979.2240513099955;4008.8596899108393;4084.2852500812537;4181.790910454465;27977;28433.00484483054;28739.425211495654;29225.41549169026;29336;3207.1180425383204;3247.7888937219004;3253.788503747249;3275.950860737091;3394.915127121817;466581;467407;470107;472956;475869;58142.41857581455;58611.413885861446;58657.70671146617;58713;58788.70605646945;60931.39068609257;61210.387896121356;61497.692511537156;61613.69193154005;61677.69161154165;15330;15889.443869464745;15894.92052539753;15895.841041589436;15906.204689765465;11059.059979901798;11373.601923932623;12006.279623222634;12244.387780610934;12301.630951071482;17985.910070449565;18250.45248642516;18316.267349306145;18323.816761832477;18350.632987340177;6581.387560047723;6717.294684058202;8033.156518565466;8040;8047.356211503065;807.1645846548794;851.3997631669782;881.9867701984475;899.8470260055806;905.7101727447285;29389.26526836846;29607.407851843273;30511;30543.472826358593;30742.38515229683;1043.8277684182176;1046.8900765419673;1107.5791199344358;1114.5263263113145;1115.4199816095586;13649.454021839214;15618.531444056469;15781.763273550905;15945.123018234108;15989.600259993593;432196;436753;438707;439448;442542;56212.43787562072;56748.716256418455;56861.43138568644;56917.71541142268;57136.71431642815;1425;1438.280859570215;1464.6631274806855;1466.2155746675264;1475.4467074846932;28844.42311153807;29249.976250831118;29728.851355743947;30399.54400684036;30511.389772204875;46979;47019;47348.7632561835;47398.28902566533;47564;369921;372544.1372793119;372731;375085;375279;25368.492630147663;25849.966001359735;25952.610710838973;25962.610560841982;26872.925082996462;42472.150556989305;43046.784766077224;43113.49102781388;43543.69368918938;43755;27960.86019569889;35496.935091947285;35889.64110358863;35920.64079359173;36588;36012.63987360093;36320.81839590785;36338.63661363353;36815.07962300964;37466;28181.577276341282;35036.77371291992;35229.82385088058;35443.82278088593;35624.46563301604;29712.85143574355;29811;30806;31957.201069972507;32581.674183258812;24228.757712422652;24338.90474928597;24871.378215544755;25270;25592.336498127563 21:12:46 INFO - PROCESS | 1644 | |2;jquery.html;371.2611902314392;397.1778418673346;400.2175746415756;404.7955782329924;422.00828054072934;16297.83702162978;19810.40568782937;20964.8951755241;21124.89437552812;21205.363839084832;21336;21351.252706155286;21407.464813379633;22017.66973495399;22155.446113847163;5624.128260119688;5904.88190236195;5943.167956486095;5945.16767652529;5958.493528050121;5610.270664813568;5783.10361893905;5827.417258274181;5833.737481813308;5912.260967379078;5756.107803290497;5794.884102317951;5807.2160258365;5811.593188476808;5815.156802263669;5568.443155684439;5799.246098007275;5800.390958949291;5801.274840644919;5850.385709500484;5149.794008239666;5171.689698618095;5173.611979101544;5179.896402071975;5180.378354597435;25632.615510767355;25900.611490827654;25967.610485842728;26163.345916352053;26556;2747.189579074178;2789.693133755285;2810.4098139390753;2813.85930703464;2822.633057702506;15669.764953525706;15819.60450988723;15960.76058859118;16027.519174424786;16633.584160395967;1846.0861873372767;1853.647806916695;1856.1368963431935;1862.4691962790675;1874.3158747057225;104914;115683;127760;131125.34437327847;131649.6835031647;10660.94669526663;11321.094312454983;11700.94149529264;11706.414679266003;11718.648440546796;12688.23870567769;13311.534096306583;13362.33188340579;14492.34784434703;14670.559883203521;8273.669053237803;8530.445521041112;8870.911290887138;8946.015938246788;8981.05698901619;8188.631511581993;8994.955025224963;9048;9154.588043538057;9155.084491550924;6518.804435866931;7162.92837071633;7271.745488907863;7275.454340924452;7280.563166210044;1641.253229780447;1813.3471950097953;1943.3975467605087;1947.2405761752927;1949.756280464942;988.4267125067444;1012.6911292055994;1022.6727447216967;1041.656253436364;1075.3601607043797;21647.891760541097;22159.889200554215;22161.778382215973;22229.77770222277;22293.55412891733;1027.9691609251734;1040.953157107932;1041.9687409377732;1070.7590792071721;1088.0860077534908;9042.502662353634;11318.434078296217;11494.96545310926;11547.942260288644;11594.304341739522;685968.3303346921;692232;706198;714229;767831;137431;142643;159857;160196;161103;962.7352478068588;978.3591747405603;1014.4521958142668;1021.5862575656871;1022.9846552301722;19444.513887152367;19478.415647530597;20195.798042019393;20328.288509902082;20538.17847286092;47467.52532474631;54464.14358484584;61100.38899610947;61896;63355.36644633495;86770;87297.6905346433;88165.55917220374;88602;90505.64241536251;7676.080979755061;7762;8627.103807742747;8692.348073894356;8767.473951562926;13206.405711743188;13366.997475189593;13401.66495837612;13480.393382298016;13504.594862154152;10432.634857779942;10538.631147909786;11121.499532520895;11166;11429.428528573371;9123.5438228087;10423;10878.94560527224;11599.594014209462;11663.416829158678;11358.716032099264;11607.76784464289;11644.53421863116;11667.533298667959;11918.582849600569;8464.66141354339;8494.44786088927;8567.871481927652;8679.435836670596;8713.172248636623;9284.489353085644;11407.25852819564;11499.367534785668;11651.59219427316;11870.02354211349 21:12:46 INFO - PROCESS | 1644 | |3;mootools.html;1422.6158937086986;1430.2419717549703;1440.2006886178174;1449.5868677426931;1451.0640636789267;7641.579713115776;7867.8426431471335;8126.796830079251;8532.189442003015;8549.57252137393;8059.959700201505;8344.45761025533;8385;8404.747857564267;8486;2299.8965046572944;2343.625019996801;2344.753800850912;2351.8471299365574;2352.870592117433;2094.287942099686;2330.0679728108807;2380.0241900820665;2391.4021494626345;2392.8923198456023;2109.3988213359194;2263.7283525976904;2344.909617028082;2349.6710460535537;2355.9293221203393;2265.105283413043;2283.3949003513917;2283.4291427143216;2291.472961218921;2299.9310020699404;2293.5068960173644;2294.862308261493;2360.44529535559;2361.3860396296914;2361.9881900590385;8477.237048665587;8567.186117318844;8577.27093197079;8588.82822343556;8594;5027.597792176617;5157.613179011589;5169.2504586835075;5178.741062946875;5178.938317644874;3172.143521249273;3327.7188282511165;3474.6872781449792;3524.7708898921487;3577.9051120780596;1211.2913945341897;1227.8158276258544;1262.7474505099017;1272.9554465593753;1276.4575055601333;8415.621297041647;9344.112309330603;11182.440877956069;11253.831192532036;11727.17909746318;4111.835526578963;4458.398116254264;4760;4773.880652983703;4783.880402989953;9585.808283834283;9656.27577931658;9668.806623867624;9674.75813104678;9683.66107186245;5286.97356513215;5300.496452836975;5302.2046692996355;5316.574674026068;5328.227407025959;4645.907081858344;4730.716157030589;4754.809807607657;4788.162071637449;4835.540623640749;3255.772095953308;3919.3729003359326;3923.391874259494;3978.3236849735613;4001.899477643671;1173.167051393503;1214.2532342609409;1281.6027031620042;1285.0554842190982;1292.2246652008719;725.1950335128004;758.7078974594821;779.3375630713848;795.1650766694947;796.0845028217481;4909.68087074339;5809.3609702932645;5843.211166492554;5913.408659134138;5983.940160598426;822.6339279020898;946.9053094690476;987.2299606307092;995.4773743784426;1051.9579216831394;3772.8113594320175;3808.4858544096746;3895.454636350913;3911.8239679214503;3950.051987523031;9866.901330986742;10147.289689721796;10159.238057145743;10177.134943529883;10214.233932455096;9987.350822196535;10002.949985250027;10137.2903896728;10157.542910569042;10160.237982151368;7737.806554836062;7879.172686867911;7887.132415434297;7887.881681774778;8016.478928869605;5530.751116199861;5569.66050410147;5579.9163012555655;5727.140928860705;5734;9039.141281578239;9049.366544341832;9160.129787670161;9277.443353398818;9409.435433873989;8846.46921184731;8997;9267.72196834096;9393.85909211376;9432.198263147435;7149.392301654209;7290.599017054113;7295.416366690758;7312.488125831141;7316.707331706672;7742.7677169685;7830.804229894298;7852.685892564234;7860.803479913048;7957.641906114354;6424.678766061772;6561.573497722633;7242.3843973262865;7247.202807691256;7308.598027108347;6992.580445173306;7074.080369552131;7099.893501597377;7100.964495177491;7119.359257666835;6312.337204593451;6470.28826829039;6496.935030649633;6518.771842985473;6528.967355163194;4911.287863259736;5018.749062546931;5095.566876815512;5102.897942041212;5139.793830853773;4328.480582330015;4989.2516122580455;5061.746912654279;5113;5245.370555533361 21:12:46 INFO - PROCESS | 1644 | |4;prototype.html;346.13984249140896;367.25997115811634;375.2551185895997;376.8247764789372;381.89688784028294;5301.284326615906;5464.12573988162;5505.476979686929;5545.1682247662875;5649.943500564998;4299.957000430002;4764.45208800988;5153.3815942087;5331.680099194051;5438.184272359148;3578.2306804037125;4256.361545768136;4278.679099067567;4298.699091063627;4301.451477468109;4143.96400899775;4278.336857787032;4306.720063195898;4317.805698743548;4332.436783218177;3842.1931394407206;4147.419361289422;4202.201581699467;4203.579642035803;4252.9787351063205;3704.665541316666;3856.151646637735;4017.634004438505;4036.535798383194;4228.809703563347;3663.6153203913736;3760.811959402019;3763.73653844231;3765.7363984521094;3789.6020917803507;5029.421616514074;5280.471952804727;5312.237636429035;5350;5377.11277639189;3906.4921560196995;4397.2964325707735;4687.648426368002;4692.653673163419;4777.713337199744;4747.154804608278;5843.240378750777;5873.882522349571;5880.911786323209;5953.613015154045;3799.620037996206;3903.258380907647;3928.1750832325247;3949.8617548385955;3949.9605003949882;6089.634621922699;6093.786717464867;6142;6150.66171360575;6181.907271390888;3828.8896220096417;3913.9021524461546;4008.138250276146;4026.4765580474937;4040;3587.6366980547746;3858.266929283427;3919.569866682618;4032.548282618255;4083.734557253769;4539.500654927955;4758.500357462486;4760.119377915097;4775.233163729373;4798.616110711135;5576.90865925278;5885.558583106199;5915.64506129625;5957.851053723605;5982.4316689914385;1238.9876101239051;1239.5971309324505;1241.0629974369474;1258.1570347866768;1274.5985014720334;859;874.5277550122862;884.4472204871955;887.8369336169638;899.7930475990559;4448.799804008828;4543.909121817545;5089.541941225308;5179.378474582999;5228.555572776357;4908.730019848871;5245.291885595472;5406.729663516809;5664.951983882995;5744.195812586241;4266.807993640232;4587.357769912215;4856.490068542752;4989.190416489843;5153.458886816905;2767.906676862628;2786.804923655365;2894.956575651367;2934.53047512397;2989.8505074746176;5206.6309829027705;5682.573806964494;5832.066869300891;5853.94146058534;5928.614640048383;5098.59211263098;5143.974280128576;5595.832125036255;5867.941320586825;6237.812865614039;5753.942460575341;6157.261128664589;6241.002879078651;6254.687265636791;6259.43665070155;5225.895482090413;5395.892082158413;5805.767769289181;6080.898741641883;6094.878102437838;5106.310648062613;5282.735863206747;5840.561957853263;5962;5981.551383646331;5496.835094947158;5734.741936612779;5787.9131813021995;6001.927407636722;6238.812835614939;3272.869085236564;3802.543694756647;3989.601039895987;4021.93967090488;4022.0146064214455;4971.768350572012;5157.974210128926;5527.309086364205;6051.636901785907;6057.697115144137;5153.330067091254;5662.405447428126;5711.457411545896;5852.385499522659;5901.90814699282;4461.464624244982;4871.732054736882;5257.290265814219;5565.16522521625;5720.713964301685;5505.449455054462;5684.658920464785;5768.394318596655;5785.016547186904;5789.565782566408;4877.365942427604;5755.043285283024;5829.562782791223;5852.5317974561085;5941.702914854153;5742.425757424224;5753.367129615823;5758.107493338539;5758.1362795581;5794.203796822999 21:12:46 INFO - PROCESS | 1644 | |5;yui.html;703.6235613946533;710.357126800246;765.2003656179293;815.5555222403789;843.8185790055137;14068.29658517074;15407.614809629766;16573.75139372909;17274.654506909854;17442.3023079077;15527;16143.83856161438;16284.10437425941;16582.419615313465;16851.66296674066;856.4518708026852;876.7939534209455;880.6037283222544;881.3566096749377;886.6586364249746;680.5780416141974;699.9265077166875;839.9244068033876;875.2560323724847;875.9912400876005;894.4767311123001;898.3442087276293;910.7404389748923;911.5715613661602;912.2291663544328;898.4609234459338;902.0843843498853;902.4900930974012;902.4946030223097;904.4618452021037;666.3336663336663;671.4863129705778;673.3132205150719;674.4536925090692;674.6491824251411;15109.168995705231;15545.766813497807;15892.364305427769;15950.202489875459;16008.919955400264;13996.510122145777;14061;14112.153270803681;14264.286785660675;14298.928505357511;11253.493592788343;11264.549418023269;11451.026662733677;11488.483018264198;11495.367754773484;3617.5658920929395;3622.040159357772;3628.4375921732176;3707.4277977441066;3755.4742336072973;97560;98505.5074724629;100892;102218.99999999926;104510.47744761227;9268.443893366419;10846.752623448247;10942;10946;10994.230403871652;22046.33860984173;22169.778302217095;22467.88766056192;22471.775282246967;22487;7507.699692012258;7629.6566654499575;7737.613119344122;7750.379969602418;7843.960780196063;4293.355996600472;4310.978445107754;4398.142362239397;4417.028253784162;4421.270490369117;3517.278957813642;3604.567451905788;3614.584322802859;3641.8725344612812;3646.690031347312;644.1529388853736;648.740503798475;661.9007148927603;667.9699413526403;668.9364510371507;671.6675245753383;680.6562685843618;699.3391245273269;699.874022675913;724.4602770935581;8819.603117859711;10316.615438438634;10578.418186999788;10761.623343182951;10855.023047925724;612.3722985760932;622.7664625765339;700.264722041854;705.1502938958645;721.7834649605097;3797.3608342202456;5089.211172268304;5107.514786095315;5110.233464980282;5132.666376685504;96781;100516.49741751244;104301;105021;106188;74404.62797685977;81886;83254.16745832463;87064;91378.54310728537;82427.58786206151;82514.58742706248;84278.15721842826;85243;86665.56667216624;9840;10693.465326733476;10908.072813810597;11135.99776020162;11253.549858005588;38607;48427.5157248423;48680;51826;52295.73852130715;67866;70640;71780;72586;73772.63113684612;13183.736325273248;13246.876324912242;13312;13391.263480508665;13417.060805743504;14341.856581434053;14622.853771462149;14748.852511474748;15288.694226115193;15583.220838958234;12532.872041516308;13167.934160329138;13227.47090116423;14716.411343546566;14731.558053258419;11610.94194529022;13412.798808018082;14026.08830426019;14595.854041459874;14608.926955365156;13359.265240411481;14019.50931717385;14126.293685315899;14362.425502979764;14392.352344144329;11534.94232528832;11545.82681259765;11726.472308746297;11808.94095529517;12017.879821201675;10942.17933654963;11022.692319141264;11080.05819505351;11094.11247100214;11125.666230013112 21:12:46 INFO - PROCESS | 1644 | __end_tp_report 21:12:46 INFO - PROCESS | 1644 | __start_cc_report 21:12:46 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,379 21:12:46 INFO - PROCESS | 1644 | __end_cc_report 21:12:46 INFO - PROCESS | 1644 | __startTimestamp1485580366510__endTimestamp 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | ------- Summary: start ------- 21:12:46 INFO - PROCESS | 1644 | Number of tests: 6 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5735.93 Median:6042.18 stddev:668.97 (11.1%) stddev-sans-first:636.81 21:12:46 INFO - PROCESS | 1644 | Values: 3043.7 3327.4 3358.3 3374.2 3383.8 5642.5 5656.5 5663.3 5711.6 5754.3 5683.2 5761.7 5775.9 5777.5 5797.7 5141.5 5231.2 5231.2 5245.8 5299.8 4283.3 4840.4 5307.4 5309.5 5338.5 5146.3 5289.5 5316.3 5327.5 5345.7 5162.1 5235.9 5245.3 5274.8 5337.3 5125.3 5214.7 5228.3 5241.0 5243.7 5701.4 5743.0 5833.5 5867.3 5907.4 6093.6 6152.3 6184.7 6200.8 6215.1 6232.1 6266.2 6267.9 6284.4 6287.0 5880.6 5902.6 5908.0 5946.4 5951.3 6236.9 6240.9 6244.0 6244.3 6309.8 6132.2 6199.7 6204.7 6232.3 6234.1 5255.3 5290.1 6118.6 6248.4 6321.0 6085.0 6140.1 6178.1 6250.0 6279.7 6139.0 6190.6 6218.2 6231.0 6245.6 4366.7 4982.5 4991.1 5007.7 5025.5 4422.7 4448.2 4478.9 4489.4 4510.4 5797.3 5817.5 5821.6 5826.4 5878.1 6260.0 6263.7 6279.5 6293.8 6300.1 4887.0 5360.2 5368.7 5793.5 5895.1 5484.5 5501.5 5502.2 5523.6 5526.5 6336.1 6340.1 6363.7 6371.1 6371.8 6140.9 6231.0 6243.3 6294.2 6296.9 6180.1 6300.6 6343.6 6353.2 6373.0 6204.0 6207.5 6210.7 6216.9 6219.9 6153.1 6230.9 6301.0 6306.7 6322.2 4831.4 5176.8 6129.4 6164.0 6181.0 5182.9 6195.6 6195.6 6196.7 6210.2 5832.0 6028.8 6067.5 6067.8 6095.0 6064.2 6084.8 6108.8 6133.5 6210.2 6042.2 6045.6 6056.9 6065.9 6075.8 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:57792.12 Median:35757.05 stddev:113599.90 (317.7%) stddev-sans-first:113836.94 21:12:46 INFO - PROCESS | 1644 | Values: 432.5 491.3 501.0 507.9 508.3 26834.6 41792.4 41960.4 42000.0 42056.4 42457.5 43234.6 43362.0 43421.1 43476.9 8435.9 8623.7 9250.7 9564.4 9584.7 8483.2 11192.4 11467.0 11524.4 11683.4 11495.3 11517.7 11527.4 11533.4 11542.4 9876.7 11420.4 11458.6 11522.8 11539.0 11327.0 11429.9 11432.9 11454.5 11494.3 39900.2 40218.4 40304.6 40309.8 40444.8 3946.8 3979.2 4008.9 4084.3 4181.8 27977.0 28433.0 28739.4 29225.4 29336.0 3207.1 3247.8 3253.8 3276.0 3394.9 466581.0 467407.0 470107.0 472956.0 475869.0 58142.4 58611.4 58657.7 58713.0 58788.7 60931.4 61210.4 61497.7 61613.7 61677.7 15330.0 15889.4 15894.9 15895.8 15906.2 11059.1 11373.6 12006.3 12244.4 12301.6 17985.9 18250.5 18316.3 18323.8 18350.6 6581.4 6717.3 8033.2 8040.0 8047.4 807.2 851.4 882.0 899.8 905.7 29389.3 29607.4 30511.0 30543.5 30742.4 1043.8 1046.9 1107.6 1114.5 1115.4 13649.5 15618.5 15781.8 15945.1 15989.6 432196.0 436753.0 438707.0 439448.0 442542.0 56212.4 56748.7 56861.4 56917.7 57136.7 1425.0 1438.3 1464.7 1466.2 1475.4 28844.4 29250.0 29728.9 30399.5 30511.4 46979.0 47019.0 47348.8 47398.3 47564.0 369921.0 372544.1 372731.0 375085.0 375279.0 25368.5 25850.0 25952.6 25962.6 26872.9 42472.2 43046.8 43113.5 43543.7 43755.0 27960.9 35496.9 35889.6 35920.6 36588.0 36012.6 36320.8 36338.6 36815.1 37466.0 28181.6 35036.8 35229.8 35443.8 35624.5 29712.9 29811.0 30806.0 31957.2 32581.7 24228.8 24338.9 24871.4 25270.0 25592.3 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:39816.01 Median:22160.83 stddev:118930.87 (536.7%) stddev-sans-first:119227.63 21:12:46 INFO - PROCESS | 1644 | Values: 371.3 397.2 400.2 404.8 422.0 16297.8 19810.4 20964.9 21124.9 21205.4 21336.0 21351.3 21407.5 22017.7 22155.4 5624.1 5904.9 5943.2 5945.2 5958.5 5610.3 5783.1 5827.4 5833.7 5912.3 5756.1 5794.9 5807.2 5811.6 5815.2 5568.4 5799.2 5800.4 5801.3 5850.4 5149.8 5171.7 5173.6 5179.9 5180.4 25632.6 25900.6 25967.6 26163.3 26556.0 2747.2 2789.7 2810.4 2813.9 2822.6 15669.8 15819.6 15960.8 16027.5 16633.6 1846.1 1853.6 1856.1 1862.5 1874.3 104914.0 115683.0 127760.0 131125.3 131649.7 10660.9 11321.1 11700.9 11706.4 11718.6 12688.2 13311.5 13362.3 14492.3 14670.6 8273.7 8530.4 8870.9 8946.0 8981.1 8188.6 8995.0 9048.0 9154.6 9155.1 6518.8 7162.9 7271.7 7275.5 7280.6 1641.3 1813.3 1943.4 1947.2 1949.8 988.4 1012.7 1022.7 1041.7 1075.4 21647.9 22159.9 22161.8 22229.8 22293.6 1028.0 1041.0 1042.0 1070.8 1088.1 9042.5 11318.4 11495.0 11547.9 11594.3 685968.3 692232.0 706198.0 714229.0 767831.0 137431.0 142643.0 159857.0 160196.0 161103.0 962.7 978.4 1014.5 1021.6 1023.0 19444.5 19478.4 20195.8 20328.3 20538.2 47467.5 54464.1 61100.4 61896.0 63355.4 86770.0 87297.7 88165.6 88602.0 90505.6 7676.1 7762.0 8627.1 8692.3 8767.5 13206.4 13367.0 13401.7 13480.4 13504.6 10432.6 10538.6 11121.5 11166.0 11429.4 9123.5 10423.0 10878.9 11599.6 11663.4 11358.7 11607.8 11644.5 11667.5 11918.6 8464.7 8494.4 8567.9 8679.4 8713.2 9284.5 11407.3 11499.4 11651.6 11870.0 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5460.76 Median:5178.84 stddev:2970.03 (57.3%) stddev-sans-first:2962.85 21:12:46 INFO - PROCESS | 1644 | Values: 1422.6 1430.2 1440.2 1449.6 1451.1 7641.6 7867.8 8126.8 8532.2 8549.6 8060.0 8344.5 8385.0 8404.7 8486.0 2299.9 2343.6 2344.8 2351.8 2352.9 2094.3 2330.1 2380.0 2391.4 2392.9 2109.4 2263.7 2344.9 2349.7 2355.9 2265.1 2283.4 2283.4 2291.5 2299.9 2293.5 2294.9 2360.4 2361.4 2362.0 8477.2 8567.2 8577.3 8588.8 8594.0 5027.6 5157.6 5169.3 5178.7 5178.9 3172.1 3327.7 3474.7 3524.8 3577.9 1211.3 1227.8 1262.7 1273.0 1276.5 8415.6 9344.1 11182.4 11253.8 11727.2 4111.8 4458.4 4760.0 4773.9 4783.9 9585.8 9656.3 9668.8 9674.8 9683.7 5287.0 5300.5 5302.2 5316.6 5328.2 4645.9 4730.7 4754.8 4788.2 4835.5 3255.8 3919.4 3923.4 3978.3 4001.9 1173.2 1214.3 1281.6 1285.1 1292.2 725.2 758.7 779.3 795.2 796.1 4909.7 5809.4 5843.2 5913.4 5983.9 822.6 946.9 987.2 995.5 1052.0 3772.8 3808.5 3895.5 3911.8 3950.1 9866.9 10147.3 10159.2 10177.1 10214.2 9987.4 10002.9 10137.3 10157.5 10160.2 7737.8 7879.2 7887.1 7887.9 8016.5 5530.8 5569.7 5579.9 5727.1 5734.0 9039.1 9049.4 9160.1 9277.4 9409.4 8846.5 8997.0 9267.7 9393.9 9432.2 7149.4 7290.6 7295.4 7312.5 7316.7 7742.8 7830.8 7852.7 7860.8 7957.6 6424.7 6561.6 7242.4 7247.2 7308.6 6992.6 7074.1 7099.9 7101.0 7119.4 6312.3 6470.3 6496.9 6518.8 6529.0 4911.3 5018.7 5095.6 5102.9 5139.8 4328.5 4989.3 5061.7 5113.0 5245.4 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4640.57 Median:5153.42 stddev:1433.84 (27.8%) stddev-sans-first:1401.17 21:12:46 INFO - PROCESS | 1644 | Values: 346.1 367.3 375.3 376.8 381.9 5301.3 5464.1 5505.5 5545.2 5649.9 4300.0 4764.5 5153.4 5331.7 5438.2 3578.2 4256.4 4278.7 4298.7 4301.5 4144.0 4278.3 4306.7 4317.8 4332.4 3842.2 4147.4 4202.2 4203.6 4253.0 3704.7 3856.2 4017.6 4036.5 4228.8 3663.6 3760.8 3763.7 3765.7 3789.6 5029.4 5280.5 5312.2 5350.0 5377.1 3906.5 4397.3 4687.6 4692.7 4777.7 4747.2 5843.2 5873.9 5880.9 5953.6 3799.6 3903.3 3928.2 3949.9 3950.0 6089.6 6093.8 6142.0 6150.7 6181.9 3828.9 3913.9 4008.1 4026.5 4040.0 3587.6 3858.3 3919.6 4032.5 4083.7 4539.5 4758.5 4760.1 4775.2 4798.6 5576.9 5885.6 5915.6 5957.9 5982.4 1239.0 1239.6 1241.1 1258.2 1274.6 859.0 874.5 884.4 887.8 899.8 4448.8 4543.9 5089.5 5179.4 5228.6 4908.7 5245.3 5406.7 5665.0 5744.2 4266.8 4587.4 4856.5 4989.2 5153.5 2767.9 2786.8 2895.0 2934.5 2989.9 5206.6 5682.6 5832.1 5853.9 5928.6 5098.6 5144.0 5595.8 5867.9 6237.8 5753.9 6157.3 6241.0 6254.7 6259.4 5225.9 5395.9 5805.8 6080.9 6094.9 5106.3 5282.7 5840.6 5962.0 5981.6 5496.8 5734.7 5787.9 6001.9 6238.8 3272.9 3802.5 3989.6 4021.9 4022.0 4971.8 5158.0 5527.3 6051.6 6057.7 5153.3 5662.4 5711.5 5852.4 5901.9 4461.5 4871.7 5257.3 5565.2 5720.7 5505.4 5684.7 5768.4 5785.0 5789.6 4877.4 5755.0 5829.6 5852.5 5941.7 5742.4 5753.4 5758.1 5758.1 5794.2 21:12:46 INFO - PROCESS | 1644 | 21:12:46 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20598.84 Median:3644.28 stddev:29067.69 (797.6%) stddev-sans-first:29110.84 21:12:46 INFO - PROCESS | 1644 | Values: 703.6 710.4 765.2 815.6 843.8 14068.3 15407.6 16573.8 17274.7 17442.3 15527.0 16143.8 16284.1 16582.4 16851.7 856.5 876.8 880.6 881.4 886.7 680.6 699.9 839.9 875.3 876.0 894.5 898.3 910.7 911.6 912.2 898.5 902.1 902.5 902.5 904.5 666.3 671.5 673.3 674.5 674.6 15109.2 15545.8 15892.4 15950.2 16008.9 13996.5 14061.0 14112.2 14264.3 14298.9 11253.5 11264.5 11451.0 11488.5 11495.4 3617.6 3622.0 3628.4 3707.4 3755.5 97560.0 98505.5 100892.0 102219.0 104510.5 9268.4 10846.8 10942.0 10946.0 10994.2 22046.3 22169.8 22467.9 22471.8 22487.0 7507.7 7629.7 7737.6 7750.4 7844.0 4293.4 4311.0 4398.1 4417.0 4421.3 3517.3 3604.6 3614.6 3641.9 3646.7 644.2 648.7 661.9 668.0 668.9 671.7 680.7 699.3 699.9 724.5 8819.6 10316.6 10578.4 10761.6 10855.0 612.4 622.8 700.3 705.2 721.8 3797.4 5089.2 5107.5 5110.2 5132.7 96781.0 100516.5 104301.0 105021.0 106188.0 74404.6 81886.0 83254.2 87064.0 91378.5 82427.6 82514.6 84278.2 85243.0 86665.6 9840.0 10693.5 10908.1 11136.0 11253.5 38607.0 48427.5 48680.0 51826.0 52295.7 67866.0 70640.0 71780.0 72586.0 73772.6 13183.7 13246.9 13312.0 13391.3 13417.1 14341.9 14622.9 14748.9 15288.7 15583.2 12532.9 13167.9 13227.5 14716.4 14731.6 11610.9 13412.8 14026.1 14595.9 14608.9 13359.3 14019.5 14126.3 14362.4 14392.4 11534.9 11545.8 11726.5 11808.9 12017.9 10942.2 11022.7 11080.1 11094.1 11125.7 21:12:46 INFO - PROCESS | 1644 | -------- Summary: end -------- 21:12:46 INFO - PROCESS | 1644 | 21:12:47 INFO - TEST-INFO | 1644: exit 0 21:12:47 INFO - TEST-OK | dromaeo_css | took 1114458ms 21:12:47 INFO - TEST-START | kraken 21:12:47 INFO - operating with platform_type : mac_ 21:12:47 INFO - Initialising browser for kraken test... 21:12:47 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpYZI_rW/profile http://localhost:49240/getInfo.html) 21:12:49 INFO - PROCESS | 1656 | 2017-01-27 21:12:49.976 plugin-container[1657:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 21:12:49 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:12:49 INFO - PROCESS | 1656 | 2017-01-27 21:12:49.979 plugin-container[1657:10044] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.CFPasteboardClient' 21:12:49 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:12:49 INFO - PROCESS | 1656 | 2017-01-27 21:12:49.979 plugin-container[1657:10044] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:12:50 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 21:12:50 INFO - PROCESS | 1656 | colorDepth:24 21:12:50 INFO - PROCESS | 1656 | Browser inner width/height: 1024/663 21:12:50 INFO - PROCESS | 1656 | __metrics 21:12:50 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 21:12:50 INFO - TEST-INFO | 1656: exit 0 21:12:50 INFO - Browser initialized. 21:12:50 INFO - Running cycle 1/1 for kraken test... 21:12:50 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpYZI_rW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:12:53 INFO - PROCESS | 1658 | 2017-01-27 21:12:53.506 plugin-container[1659:10164] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 21:12:53 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:12:53 INFO - PROCESS | 1658 | 2017-01-27 21:12:53.507 plugin-container[1659:10164] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 21:12:53 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:12:53 INFO - PROCESS | 1658 | 2017-01-27 21:12:53.507 plugin-container[1659:10164] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:13:03 INFO - PROCESS | 1658 | RSS: Main: 228147200 21:13:03 INFO - PROCESS | 1658 | 21:13:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 21:13:06 INFO - PROCESS | 1658 | RSS: Main: 240013312 21:13:06 INFO - PROCESS | 1658 | 21:13:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 21:13:10 INFO - PROCESS | 1658 | RSS: Main: 247668736 21:13:10 INFO - PROCESS | 1658 | 21:13:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 21:13:14 INFO - PROCESS | 1658 | RSS: Main: 249942016 21:13:14 INFO - PROCESS | 1658 | 21:13:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 21:13:16 INFO - PROCESS | 1658 | RSS: Main: 249749504 21:13:16 INFO - PROCESS | 1658 | 21:13:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:13:19 INFO - PROCESS | 1658 | RSS: Main: 249761792 21:13:19 INFO - PROCESS | 1658 | 21:13:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 21:13:22 INFO - PROCESS | 1658 | RSS: Main: 253526016 21:13:22 INFO - PROCESS | 1658 | 21:13:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 21:13:26 INFO - PROCESS | 1658 | RSS: Main: 253288448 21:13:26 INFO - PROCESS | 1658 | 21:13:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 21:13:30 INFO - PROCESS | 1658 | RSS: Main: 253210624 21:13:30 INFO - PROCESS | 1658 | 21:13:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:13:32 INFO - PROCESS | 1658 | RSS: Main: 251973632 21:13:32 INFO - PROCESS | 1658 | 21:13:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:13:35 INFO - PROCESS | 1658 | RSS: Main: 252051456 21:13:35 INFO - PROCESS | 1658 | 21:13:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:13:37 INFO - PROCESS | 1658 | RSS: Main: 252047360 21:13:37 INFO - PROCESS | 1658 | 21:13:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:13:41 INFO - PROCESS | 1658 | RSS: Main: 252297216 21:13:41 INFO - PROCESS | 1658 | 21:13:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:13:45 INFO - PROCESS | 1658 | RSS: Main: 252379136 21:13:45 INFO - PROCESS | 1658 | 21:13:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 21:13:47 INFO - PROCESS | 1658 | RSS: Main: 254263296 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | __start_tp_report 21:13:47 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 21:13:47 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 21:13:47 INFO - PROCESS | 1658 | |i|pagename|runs| 21:13:47 INFO - PROCESS | 1658 | |0;ai-astar;172;176;123;121;117;118;119;117;115;121 21:13:47 INFO - PROCESS | 1658 | |1;audio-beat-detection;138;144;97;177;99;144;143;148;137;113 21:13:47 INFO - PROCESS | 1658 | |2;audio-dft;194;206;198;199;195;197;197;221;272;241 21:13:47 INFO - PROCESS | 1658 | |3;audio-fft;81;61;60;87;63;64;61;63;71;60 21:13:47 INFO - PROCESS | 1658 | |4;audio-oscillator;82;72;85;78;100;101;116;100;73;82 21:13:47 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;90;128;88;85;89;90;88;88;89;73 21:13:47 INFO - PROCESS | 1658 | |6;imaging-darkroom;98;98;98;100;101;100;99;97;99;98 21:13:47 INFO - PROCESS | 1658 | |7;imaging-desaturate;78;81;136;147;121;94;96;91;132;143 21:13:47 INFO - PROCESS | 1658 | |8;json-parse-financial;58;59;58;59;60;62;62;60;61;61 21:13:47 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;77;74;75;92;81;79;74;74;75;73 21:13:47 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;94;104;103;102;85;83;89;84;76;97 21:13:47 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;138;142;138;136;142;152;149;166;190;141 21:13:47 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;172;184;168;173;174;173;171;173;224;180 21:13:47 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;69;68;70;67;67;70;82;72;60;62 21:13:47 INFO - PROCESS | 1658 | __end_tp_report 21:13:47 INFO - PROCESS | 1658 | __start_cc_report 21:13:47 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,933 21:13:47 INFO - PROCESS | 1658 | __end_cc_report 21:13:47 INFO - PROCESS | 1658 | __startTimestamp1485580427087__endTimestamp 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | ------- Summary: start ------- 21:13:47 INFO - PROCESS | 1658 | Number of tests: 14 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:129.90 Median:121.00 stddev:23.38 (19.3%) stddev-sans-first:19.20 21:13:47 INFO - PROCESS | 1658 | Values: 172.0 176.0 123.0 121.0 117.0 118.0 119.0 117.0 115.0 121.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:146.00 stddev:24.46 (16.8%) stddev-sans-first:25.90 21:13:47 INFO - PROCESS | 1658 | Values: 138.0 144.0 97.0 177.0 99.0 144.0 143.0 148.0 137.0 113.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:212.00 Median:202.50 stddev:25.79 (12.7%) stddev-sans-first:26.52 21:13:47 INFO - PROCESS | 1658 | Values: 194.0 206.0 198.0 199.0 195.0 197.0 197.0 221.0 272.0 241.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:67.10 Median:63.50 stddev:9.56 (15.1%) stddev-sans-first:8.72 21:13:47 INFO - PROCESS | 1658 | Values: 81.0 61.0 60.0 87.0 63.0 64.0 61.0 63.0 71.0 60.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:75.50 stddev:14.51 (19.2%) stddev-sans-first:15.17 21:13:47 INFO - PROCESS | 1658 | Values: 82.0 72.0 85.0 78.0 100.0 101.0 116.0 100.0 73.0 82.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:88.50 stddev:14.01 (15.8%) stddev-sans-first:14.85 21:13:47 INFO - PROCESS | 1658 | Values: 90.0 128.0 88.0 85.0 89.0 90.0 88.0 88.0 89.0 73.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:98.80 Median:98.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 21:13:47 INFO - PROCESS | 1658 | Values: 98.0 98.0 98.0 100.0 101.0 100.0 99.0 97.0 99.0 98.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:111.90 Median:79.50 stddev:26.63 (33.5%) stddev-sans-first:25.26 21:13:47 INFO - PROCESS | 1658 | Values: 78.0 81.0 136.0 147.0 121.0 94.0 96.0 91.0 132.0 143.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.50 stddev:1.49 (2.5%) stddev-sans-first:1.39 21:13:47 INFO - PROCESS | 1658 | Values: 58.0 59.0 58.0 59.0 60.0 62.0 62.0 60.0 61.0 61.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:76.00 stddev:5.72 (7.5%) stddev-sans-first:6.06 21:13:47 INFO - PROCESS | 1658 | Values: 77.0 74.0 75.0 92.0 81.0 79.0 74.0 74.0 75.0 73.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:84.50 stddev:9.73 (11.5%) stddev-sans-first:10.28 21:13:47 INFO - PROCESS | 1658 | Values: 94.0 104.0 103.0 102.0 85.0 83.0 89.0 84.0 76.0 97.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:145.50 stddev:16.83 (11.6%) stddev-sans-first:17.34 21:13:47 INFO - PROCESS | 1658 | Values: 138.0 142.0 138.0 136.0 142.0 152.0 149.0 166.0 190.0 141.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:173.50 stddev:16.39 (9.4%) stddev-sans-first:17.18 21:13:47 INFO - PROCESS | 1658 | Values: 172.0 184.0 168.0 173.0 174.0 173.0 171.0 173.0 224.0 180.0 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:5.95 (8.6%) stddev-sans-first:6.30 21:13:47 INFO - PROCESS | 1658 | Values: 69.0 68.0 70.0 67.0 67.0 70.0 82.0 72.0 60.0 62.0 21:13:47 INFO - PROCESS | 1658 | -------- Summary: end -------- 21:13:47 INFO - PROCESS | 1658 | 21:13:47 INFO - TEST-INFO | 1658: exit 0 21:13:47 INFO - TEST-OK | kraken | took 60809ms 21:13:47 INFO - SUITE-END | took 1175s 21:13:48 INFO - Completed test suite (00:19:35) 21:13:48 INFO - javascript benchmark 21:13:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7363.441030087586, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.71084746949, 3327.4010678077952, 3358.328334333134, 3374.156460884779, 3383.8308084595765, 5642.492175704186, 5656.490915817576, 5663.348714897788, 5711.628744131628, 5754.309482862052, 5683.204351390808, 5761.654300741959, 5775.913361299574, 5777.4511421415, 5797.681127537984, 5141.511556402145, 5231.163013917774, 5231.163013917774, 5245.816396426126, 5299.761510732026, 4283.3146696528565, 4840.370751802261, 5307.389650190239, 5309.469053094679, 5338.546223570982, 5146.330976973007, 5289.471052894718, 5316.255724198596, 5327.547158491533, 5345.705986170759, 5162.148245539482, 5235.869103272411, 5245.26566280721, 5274.7626356814035, 5337.306150200449, 5125.256837758541, 5214.739263036833, 5228.346456692913, 5240.973795131038, 5243.737813109329, 5701.401352857932, 5742.994975879246, 5833.4749872511675, 5867.325257595388, 5907.438793314628, 6093.634381937098, 6152.261728592553, 6184.721687524027, 6200.81397558074, 6215.12988181655, 6232.127502149703, 6266.154069200645, 6267.905981410283, 6284.4344009039405, 6287.0, 5880.617759845596, 5902.6458412495385, 5908.02517584598, 5946.43508866657, 5951.345352011232, 6236.906446403307, 6240.875182496325, 6244.0321750128805, 6244.250689917239, 6309.779157729457, 6132.20254427538, 6199.659018754011, 6204.689765511796, 6232.345603711636, 6234.127222188898, 5255.290535777621, 5290.100682883919, 6118.632882027004, 6248.375162483806, 6321.020241862519, 6084.969575152184, 6140.074827791203, 6178.104174894705, 6249.96875015622, 6279.717412716439, 6139.001538246403, 6190.628562286277, 6218.160548326008, 6231.003039513656, 6245.6252624842655, 4366.716163449366, 4982.451930287665, 4991.101601711727, 5007.749612519359, 5025.522575355335, 4422.690411671217, 4448.177087238806, 4478.932816007762, 4489.416375871116, 4510.436195475566, 5797.275340582427, 5817.476427121579, 5821.621594596338, 5826.359100498942, 5878.088896221093, 6259.96870015647, 6263.686815659199, 6279.497640188865, 6293.842653933597, 6300.054991751183, 4887.022595480918, 5360.16917377807, 5368.651037682616, 5793.536517078624, 5895.086261629454, 5484.506394424521, 5501.532369748536, 5502.202180683778, 5523.6409633373705, 5526.50261476469, 6336.081268216083, 6340.080688300263, 6363.713632886531, 6371.108044873628, 6371.840703982438, 6140.933729673127, 6230.968845155745, 6243.282022567463, 6294.15028971083, 6296.937030629635, 6180.103884936569, 6300.558960872878, 6343.61938283686, 6353.174087368798, 6373.0, 6203.96898015507, 6207.503399727921, 6210.689465526796, 6216.937830621817, 6219.906701399392, 6153.138560601609, 6230.906536401867, 6300.9684951574945, 6306.716197771019, 6322.178116844964, 4831.444383895897, 5176.844694659167, 6129.387061293835, 6164.044573091178, 6181.0, 5182.922256166236, 6195.566310358232, 6195.628262304276, 6196.690165491797, 6210.223722034746, 5831.970840145772, 6028.788992385421, 6067.54493412987, 6067.847109049267, 6094.969525152346, 6064.241969753781, 6084.817455476343, 6108.847278818065, 6133.51829027926, 6210.223722034746, 6042.1843051187525, 6045.6070355426755, 6056.939430605814, 6065.878682426415, 6075.848103797441], "value": 5693.016351685552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.4918221090218, 491.3195224613909, 500.9649324547282, 507.92066857926903, 508.29093414686514, 26834.597481037774, 41792.37311440327, 41960.370594441105, 42000.0, 42056.36915446267, 42457.45255284685, 43234.567654323444, 43362.0, 43421.13157736851, 43476.913077173085, 8435.873461898076, 8623.698170564032, 9250.722478325644, 9564.37831540951, 9584.712458626253, 8483.194096560817, 11192.38441885696, 11467.0, 11524.366159861203, 11683.415829208505, 11495.310281383103, 11517.654470365902, 11527.365994870279, 11533.36566488847, 11542.422878856065, 9876.703698889045, 11420.371879546621, 11458.598949036785, 11522.769544609144, 11539.019183369466, 11327.037201837853, 11429.942850285695, 11432.942835285854, 11454.541818327258, 11494.252873563275, 39900.20199596021, 40218.39672404916, 40304.59695403067, 40309.79845100785, 40444.797776011226, 3946.763194208328, 3979.2240513099955, 4008.8596899108393, 4084.2852500812537, 4181.790910454465, 27977.0, 28433.00484483054, 28739.425211495654, 29225.41549169026, 29336.0, 3207.1180425383204, 3247.7888937219004, 3253.788503747249, 3275.950860737091, 3394.915127121817, 466581.0, 467407.0, 470107.0, 472956.0, 475869.0, 58142.41857581455, 58611.413885861446, 58657.70671146617, 58713.0, 58788.70605646945, 60931.39068609257, 61210.387896121356, 61497.692511537156, 61613.69193154005, 61677.69161154165, 15330.0, 15889.443869464745, 15894.92052539753, 15895.841041589436, 15906.204689765465, 11059.059979901798, 11373.601923932623, 12006.279623222634, 12244.387780610934, 12301.630951071482, 17985.910070449565, 18250.45248642516, 18316.267349306145, 18323.816761832477, 18350.632987340177, 6581.387560047723, 6717.294684058202, 8033.156518565466, 8040.0, 8047.356211503065, 807.1645846548794, 851.3997631669782, 881.9867701984475, 899.8470260055806, 905.7101727447285, 29389.26526836846, 29607.407851843273, 30511.0, 30543.472826358593, 30742.38515229683, 1043.8277684182176, 1046.8900765419673, 1107.5791199344358, 1114.5263263113145, 1115.4199816095586, 13649.454021839214, 15618.531444056469, 15781.763273550905, 15945.123018234108, 15989.600259993593, 432196.0, 436753.0, 438707.0, 439448.0, 442542.0, 56212.43787562072, 56748.716256418455, 56861.43138568644, 56917.71541142268, 57136.71431642815, 1425.0, 1438.280859570215, 1464.6631274806855, 1466.2155746675264, 1475.4467074846932, 28844.42311153807, 29249.976250831118, 29728.851355743947, 30399.54400684036, 30511.389772204875, 46979.0, 47019.0, 47348.7632561835, 47398.28902566533, 47564.0, 369921.0, 372544.1372793119, 372731.0, 375085.0, 375279.0, 25368.492630147663, 25849.966001359735, 25952.610710838973, 25962.610560841982, 26872.925082996462, 42472.150556989305, 43046.784766077224, 43113.49102781388, 43543.69368918938, 43755.0, 27960.86019569889, 35496.935091947285, 35889.64110358863, 35920.64079359173, 36588.0, 36012.63987360093, 36320.81839590785, 36338.63661363353, 36815.07962300964, 37466.0, 28181.577276341282, 35036.77371291992, 35229.82385088058, 35443.82278088593, 35624.46563301604, 29712.85143574355, 29811.0, 30806.0, 31957.201069972507, 32581.674183258812, 24228.757712422652, 24338.90474928597, 24871.378215544755, 25270.0, 25592.336498127563], "value": 19427.9523911175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.2611902314392, 397.1778418673346, 400.2175746415756, 404.7955782329924, 422.00828054072934, 16297.83702162978, 19810.40568782937, 20964.8951755241, 21124.89437552812, 21205.363839084832, 21336.0, 21351.252706155286, 21407.464813379633, 22017.66973495399, 22155.446113847163, 5624.128260119688, 5904.88190236195, 5943.167956486095, 5945.16767652529, 5958.493528050121, 5610.270664813568, 5783.10361893905, 5827.417258274181, 5833.737481813308, 5912.260967379078, 5756.107803290497, 5794.884102317951, 5807.2160258365, 5811.593188476808, 5815.156802263669, 5568.443155684439, 5799.246098007275, 5800.390958949291, 5801.274840644919, 5850.385709500484, 5149.794008239666, 5171.689698618095, 5173.611979101544, 5179.896402071975, 5180.378354597435, 25632.615510767355, 25900.611490827654, 25967.610485842728, 26163.345916352053, 26556.0, 2747.189579074178, 2789.693133755285, 2810.4098139390753, 2813.85930703464, 2822.633057702506, 15669.764953525706, 15819.60450988723, 15960.76058859118, 16027.519174424786, 16633.584160395967, 1846.0861873372767, 1853.647806916695, 1856.1368963431935, 1862.4691962790675, 1874.3158747057225, 104914.0, 115683.0, 127760.0, 131125.34437327847, 131649.6835031647, 10660.94669526663, 11321.094312454983, 11700.94149529264, 11706.414679266003, 11718.648440546796, 12688.23870567769, 13311.534096306583, 13362.33188340579, 14492.34784434703, 14670.559883203521, 8273.669053237803, 8530.445521041112, 8870.911290887138, 8946.015938246788, 8981.05698901619, 8188.631511581993, 8994.955025224963, 9048.0, 9154.588043538057, 9155.084491550924, 6518.804435866931, 7162.92837071633, 7271.745488907863, 7275.454340924452, 7280.563166210044, 1641.253229780447, 1813.3471950097953, 1943.3975467605087, 1947.2405761752927, 1949.756280464942, 988.4267125067444, 1012.6911292055994, 1022.6727447216967, 1041.656253436364, 1075.3601607043797, 21647.891760541097, 22159.889200554215, 22161.778382215973, 22229.77770222277, 22293.55412891733, 1027.9691609251734, 1040.953157107932, 1041.9687409377732, 1070.7590792071721, 1088.0860077534908, 9042.502662353634, 11318.434078296217, 11494.96545310926, 11547.942260288644, 11594.304341739522, 685968.3303346921, 692232.0, 706198.0, 714229.0, 767831.0, 137431.0, 142643.0, 159857.0, 160196.0, 161103.0, 962.7352478068588, 978.3591747405603, 1014.4521958142668, 1021.5862575656871, 1022.9846552301722, 19444.513887152367, 19478.415647530597, 20195.798042019393, 20328.288509902082, 20538.17847286092, 47467.52532474631, 54464.14358484584, 61100.38899610947, 61896.0, 63355.36644633495, 86770.0, 87297.6905346433, 88165.55917220374, 88602.0, 90505.64241536251, 7676.080979755061, 7762.0, 8627.103807742747, 8692.348073894356, 8767.473951562926, 13206.405711743188, 13366.997475189593, 13401.66495837612, 13480.393382298016, 13504.594862154152, 10432.634857779942, 10538.631147909786, 11121.499532520895, 11166.0, 11429.428528573371, 9123.5438228087, 10423.0, 10878.94560527224, 11599.594014209462, 11663.416829158678, 11358.716032099264, 11607.76784464289, 11644.53421863116, 11667.533298667959, 11918.582849600569, 8464.66141354339, 8494.44786088927, 8567.871481927652, 8679.435836670596, 8713.172248636623, 9284.489353085644, 11407.25852819564, 11499.367534785668, 11651.59219427316, 11870.02354211349], "value": 10169.455232822636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.6158937086986, 1430.2419717549703, 1440.2006886178174, 1449.5868677426931, 1451.0640636789267, 7641.579713115776, 7867.8426431471335, 8126.796830079251, 8532.189442003015, 8549.57252137393, 8059.959700201505, 8344.45761025533, 8385.0, 8404.747857564267, 8486.0, 2299.8965046572944, 2343.625019996801, 2344.753800850912, 2351.8471299365574, 2352.870592117433, 2094.287942099686, 2330.0679728108807, 2380.0241900820665, 2391.4021494626345, 2392.8923198456023, 2109.3988213359194, 2263.7283525976904, 2344.909617028082, 2349.6710460535537, 2355.9293221203393, 2265.105283413043, 2283.3949003513917, 2283.4291427143216, 2291.472961218921, 2299.9310020699404, 2293.5068960173644, 2294.862308261493, 2360.44529535559, 2361.3860396296914, 2361.9881900590385, 8477.237048665587, 8567.186117318844, 8577.27093197079, 8588.82822343556, 8594.0, 5027.597792176617, 5157.613179011589, 5169.2504586835075, 5178.741062946875, 5178.938317644874, 3172.143521249273, 3327.7188282511165, 3474.6872781449792, 3524.7708898921487, 3577.9051120780596, 1211.2913945341897, 1227.8158276258544, 1262.7474505099017, 1272.9554465593753, 1276.4575055601333, 8415.621297041647, 9344.112309330603, 11182.440877956069, 11253.831192532036, 11727.17909746318, 4111.835526578963, 4458.398116254264, 4760.0, 4773.880652983703, 4783.880402989953, 9585.808283834283, 9656.27577931658, 9668.806623867624, 9674.75813104678, 9683.66107186245, 5286.97356513215, 5300.496452836975, 5302.2046692996355, 5316.574674026068, 5328.227407025959, 4645.907081858344, 4730.716157030589, 4754.809807607657, 4788.162071637449, 4835.540623640749, 3255.772095953308, 3919.3729003359326, 3923.391874259494, 3978.3236849735613, 4001.899477643671, 1173.167051393503, 1214.2532342609409, 1281.6027031620042, 1285.0554842190982, 1292.2246652008719, 725.1950335128004, 758.7078974594821, 779.3375630713848, 795.1650766694947, 796.0845028217481, 4909.68087074339, 5809.3609702932645, 5843.211166492554, 5913.408659134138, 5983.940160598426, 822.6339279020898, 946.9053094690476, 987.2299606307092, 995.4773743784426, 1051.9579216831394, 3772.8113594320175, 3808.4858544096746, 3895.454636350913, 3911.8239679214503, 3950.051987523031, 9866.901330986742, 10147.289689721796, 10159.238057145743, 10177.134943529883, 10214.233932455096, 9987.350822196535, 10002.949985250027, 10137.2903896728, 10157.542910569042, 10160.237982151368, 7737.806554836062, 7879.172686867911, 7887.132415434297, 7887.881681774778, 8016.478928869605, 5530.751116199861, 5569.66050410147, 5579.9163012555655, 5727.140928860705, 5734.0, 9039.141281578239, 9049.366544341832, 9160.129787670161, 9277.443353398818, 9409.435433873989, 8846.46921184731, 8997.0, 9267.72196834096, 9393.85909211376, 9432.198263147435, 7149.392301654209, 7290.599017054113, 7295.416366690758, 7312.488125831141, 7316.707331706672, 7742.7677169685, 7830.804229894298, 7852.685892564234, 7860.803479913048, 7957.641906114354, 6424.678766061772, 6561.573497722633, 7242.3843973262865, 7247.202807691256, 7308.598027108347, 6992.580445173306, 7074.080369552131, 7099.893501597377, 7100.964495177491, 7119.359257666835, 6312.337204593451, 6470.28826829039, 6496.935030649633, 6518.771842985473, 6528.967355163194, 4911.287863259736, 5018.749062546931, 5095.566876815512, 5102.897942041212, 5139.793830853773, 4328.480582330015, 4989.2516122580455, 5061.746912654279, 5113.0, 5245.370555533361], "value": 4432.243419435974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.13984249140896, 367.25997115811634, 375.2551185895997, 376.8247764789372, 381.89688784028294, 5301.284326615906, 5464.12573988162, 5505.476979686929, 5545.1682247662875, 5649.943500564998, 4299.957000430002, 4764.45208800988, 5153.3815942087, 5331.680099194051, 5438.184272359148, 3578.2306804037125, 4256.361545768136, 4278.679099067567, 4298.699091063627, 4301.451477468109, 4143.96400899775, 4278.336857787032, 4306.720063195898, 4317.805698743548, 4332.436783218177, 3842.1931394407206, 4147.419361289422, 4202.201581699467, 4203.579642035803, 4252.9787351063205, 3704.665541316666, 3856.151646637735, 4017.634004438505, 4036.535798383194, 4228.809703563347, 3663.6153203913736, 3760.811959402019, 3763.73653844231, 3765.7363984521094, 3789.6020917803507, 5029.421616514074, 5280.471952804727, 5312.237636429035, 5350.0, 5377.11277639189, 3906.4921560196995, 4397.2964325707735, 4687.648426368002, 4692.653673163419, 4777.713337199744, 4747.154804608278, 5843.240378750777, 5873.882522349571, 5880.911786323209, 5953.613015154045, 3799.620037996206, 3903.258380907647, 3928.1750832325247, 3949.8617548385955, 3949.9605003949882, 6089.634621922699, 6093.786717464867, 6142.0, 6150.66171360575, 6181.907271390888, 3828.8896220096417, 3913.9021524461546, 4008.138250276146, 4026.4765580474937, 4040.0, 3587.6366980547746, 3858.266929283427, 3919.569866682618, 4032.548282618255, 4083.734557253769, 4539.500654927955, 4758.500357462486, 4760.119377915097, 4775.233163729373, 4798.616110711135, 5576.90865925278, 5885.558583106199, 5915.64506129625, 5957.851053723605, 5982.4316689914385, 1238.9876101239051, 1239.5971309324505, 1241.0629974369474, 1258.1570347866768, 1274.5985014720334, 859.0, 874.5277550122862, 884.4472204871955, 887.8369336169638, 899.7930475990559, 4448.799804008828, 4543.909121817545, 5089.541941225308, 5179.378474582999, 5228.555572776357, 4908.730019848871, 5245.291885595472, 5406.729663516809, 5664.951983882995, 5744.195812586241, 4266.807993640232, 4587.357769912215, 4856.490068542752, 4989.190416489843, 5153.458886816905, 2767.906676862628, 2786.804923655365, 2894.956575651367, 2934.53047512397, 2989.8505074746176, 5206.6309829027705, 5682.573806964494, 5832.066869300891, 5853.94146058534, 5928.614640048383, 5098.59211263098, 5143.974280128576, 5595.832125036255, 5867.941320586825, 6237.812865614039, 5753.942460575341, 6157.261128664589, 6241.002879078651, 6254.687265636791, 6259.43665070155, 5225.895482090413, 5395.892082158413, 5805.767769289181, 6080.898741641883, 6094.878102437838, 5106.310648062613, 5282.735863206747, 5840.561957853263, 5962.0, 5981.551383646331, 5496.835094947158, 5734.741936612779, 5787.9131813021995, 6001.927407636722, 6238.812835614939, 3272.869085236564, 3802.543694756647, 3989.601039895987, 4021.93967090488, 4022.0146064214455, 4971.768350572012, 5157.974210128926, 5527.309086364205, 6051.636901785907, 6057.697115144137, 5153.330067091254, 5662.405447428126, 5711.457411545896, 5852.385499522659, 5901.90814699282, 4461.464624244982, 4871.732054736882, 5257.290265814219, 5565.16522521625, 5720.713964301685, 5505.449455054462, 5684.658920464785, 5768.394318596655, 5785.016547186904, 5789.565782566408, 4877.365942427604, 5755.043285283024, 5829.562782791223, 5852.5317974561085, 5941.702914854153, 5742.425757424224, 5753.367129615823, 5758.107493338539, 5758.1362795581, 5794.203796822999], "value": 4193.330985141965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.6235613946533, 710.357126800246, 765.2003656179293, 815.5555222403789, 843.8185790055137, 14068.29658517074, 15407.614809629766, 16573.75139372909, 17274.654506909854, 17442.3023079077, 15527.0, 16143.83856161438, 16284.10437425941, 16582.419615313465, 16851.66296674066, 856.4518708026852, 876.7939534209455, 880.6037283222544, 881.3566096749377, 886.6586364249746, 680.5780416141974, 699.9265077166875, 839.9244068033876, 875.2560323724847, 875.9912400876005, 894.4767311123001, 898.3442087276293, 910.7404389748923, 911.5715613661602, 912.2291663544328, 898.4609234459338, 902.0843843498853, 902.4900930974012, 902.4946030223097, 904.4618452021037, 666.3336663336663, 671.4863129705778, 673.3132205150719, 674.4536925090692, 674.6491824251411, 15109.168995705231, 15545.766813497807, 15892.364305427769, 15950.202489875459, 16008.919955400264, 13996.510122145777, 14061.0, 14112.153270803681, 14264.286785660675, 14298.928505357511, 11253.493592788343, 11264.549418023269, 11451.026662733677, 11488.483018264198, 11495.367754773484, 3617.5658920929395, 3622.040159357772, 3628.4375921732176, 3707.4277977441066, 3755.4742336072973, 97560.0, 98505.5074724629, 100892.0, 102218.99999999926, 104510.47744761227, 9268.443893366419, 10846.752623448247, 10942.0, 10946.0, 10994.230403871652, 22046.33860984173, 22169.778302217095, 22467.88766056192, 22471.775282246967, 22487.0, 7507.699692012258, 7629.6566654499575, 7737.613119344122, 7750.379969602418, 7843.960780196063, 4293.355996600472, 4310.978445107754, 4398.142362239397, 4417.028253784162, 4421.270490369117, 3517.278957813642, 3604.567451905788, 3614.584322802859, 3641.8725344612812, 3646.690031347312, 644.1529388853736, 648.740503798475, 661.9007148927603, 667.9699413526403, 668.9364510371507, 671.6675245753383, 680.6562685843618, 699.3391245273269, 699.874022675913, 724.4602770935581, 8819.603117859711, 10316.615438438634, 10578.418186999788, 10761.623343182951, 10855.023047925724, 612.3722985760932, 622.7664625765339, 700.264722041854, 705.1502938958645, 721.7834649605097, 3797.3608342202456, 5089.211172268304, 5107.514786095315, 5110.233464980282, 5132.666376685504, 96781.0, 100516.49741751244, 104301.0, 105021.0, 106188.0, 74404.62797685977, 81886.0, 83254.16745832463, 87064.0, 91378.54310728537, 82427.58786206151, 82514.58742706248, 84278.15721842826, 85243.0, 86665.56667216624, 9840.0, 10693.465326733476, 10908.072813810597, 11135.99776020162, 11253.549858005588, 38607.0, 48427.5157248423, 48680.0, 51826.0, 52295.73852130715, 67866.0, 70640.0, 71780.0, 72586.0, 73772.63113684612, 13183.736325273248, 13246.876324912242, 13312.0, 13391.263480508665, 13417.060805743504, 14341.856581434053, 14622.853771462149, 14748.852511474748, 15288.694226115193, 15583.220838958234, 12532.872041516308, 13167.934160329138, 13227.47090116423, 14716.411343546566, 14731.558053258419, 11610.94194529022, 13412.798808018082, 14026.08830426019, 14595.854041459874, 14608.926955365156, 13359.265240411481, 14019.50931717385, 14126.293685315899, 14362.425502979764, 14392.352344144329, 11534.94232528832, 11545.82681259765, 11726.472308746297, 11808.94095529517, 12017.879821201675, 10942.17933654963, 11022.692319141264, 11080.05819505351, 11094.11247100214, 11125.666230013112], "value": 7624.1074913821085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 123.0, 121.0, 117.0, 118.0, 119.0, 117.0, 115.0, 121.0], "value": 129.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 97.0, 177.0, 99.0, 144.0, 143.0, 148.0, 137.0, 113.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 206.0, 198.0, 199.0, 195.0, 197.0, 197.0, 221.0, 272.0, 241.0], "value": 212.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 60.0, 87.0, 63.0, 64.0, 61.0, 63.0, 71.0, 60.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 85.0, 78.0, 100.0, 101.0, 116.0, 100.0, 73.0, 82.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 128.0, 88.0, 85.0, 89.0, 90.0, 88.0, 88.0, 89.0, 73.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 98.0, 100.0, 101.0, 100.0, 99.0, 97.0, 99.0, 98.0], "value": 98.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 136.0, 147.0, 121.0, 94.0, 96.0, 91.0, 132.0, 143.0], "value": 111.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 60.0, 62.0, 62.0, 60.0, 61.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 92.0, 81.0, 79.0, 74.0, 74.0, 75.0, 73.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 104.0, 103.0, 102.0, 85.0, 83.0, 89.0, 84.0, 76.0, 97.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 138.0, 136.0, 142.0, 152.0, 149.0, 166.0, 190.0, 141.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 184.0, 168.0, 173.0, 174.0, 173.0, 171.0, 173.0, 224.0, 180.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 67.0, 67.0, 70.0, 82.0, 72.0, 60.0, 62.0], "value": 68.7, "unit": "score"}]}]} 21:13:48 INFO - Return code: 0 21:13:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:13:48 ERROR - # TBPL SUCCESS # 21:13:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:13:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:13:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:13:48 INFO - 2017-01-27 21:13:48.443 screenresolution[1663:10548] starting screenresolution argv=screenresolution get 21:13:48 INFO - 2017-01-27 21:13:48.446 screenresolution[1663:10548] Display 0: 1600x1200x32@60 21:13:48 INFO - 2017-01-27 21:13:48.451 screenresolution[1664:10551] starting screenresolution argv=screenresolution list 21:13:48 INFO - Available Modes on Display 0 21:13:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:13:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:13:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:13:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:13:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:13:48 INFO - Intel Iris: 21:13:48 INFO - Chipset Model: Intel Iris 21:13:48 INFO - Type: GPU 21:13:48 INFO - Bus: Built-In 21:13:48 INFO - VRAM (Dynamic, Max): 1536 MB 21:13:48 INFO - Vendor: Intel (0x8086) 21:13:48 INFO - Device ID: 0x0a2e 21:13:48 INFO - Revision ID: 0x0009 21:13:48 INFO - Displays: 21:13:48 INFO - Display: 21:13:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:13:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:13:48 INFO - Display Serial Number: 1600x1200 60 21:13:48 INFO - Main Display: Yes 21:13:48 INFO - Mirror: Off 21:13:48 INFO - Online: Yes 21:13:48 INFO - Rotation: Supported 21:13:48 INFO - Return code: 0 21:13:48 INFO - Running post-action listener: _resource_record_post_action 21:13:48 INFO - [mozharness: 2017-01-28 05:13:48.686396Z] Finished run-tests step (success) 21:13:48 INFO - Running post-run listener: _resource_record_post_run 21:13:48 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39619072; Write bytes: 510607360; Read time: 386; Write time: 1647 21:13:48 INFO - TinderboxPrint: CPU usage
54.1% 21:13:48 INFO - TinderboxPrint: I/O read bytes / time
39,619,072 / 386 21:13:48 INFO - TinderboxPrint: I/O write bytes / time
510,607,360 / 1,647 21:13:48 INFO - TinderboxPrint: CPU idle
2,195.6 (45.9%) 21:13:48 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 21:13:48 INFO - TinderboxPrint: CPU user
1,631.2 (34.1%) 21:13:48 INFO - TinderboxPrint: Swap in / out
247,070,720 / 0 21:13:48 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205324800; Write bytes: 200030208; Read time: 15760; Write time: 427 21:13:48 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37550592; Write bytes: 299591680; Read time: 364; Write time: 1181 21:13:49 INFO - Running post-run listener: _upload_blobber_files 21:13:49 INFO - Blob upload gear active. 21:13:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:13:49 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 21:13:49 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'] 21:13:49 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 21:13:49 INFO - (blobuploader) - INFO - Open directory for files ... 21:13:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:13:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:50 INFO - (blobuploader) - INFO - Done attempting. 21:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:51 INFO - (blobuploader) - INFO - Done attempting. 21:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:52 INFO - (blobuploader) - INFO - Done attempting. 21:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:54 INFO - (blobuploader) - INFO - Done attempting. 21:13:54 INFO - (blobuploader) - INFO - Iteration through files over. 21:13:54 INFO - Return code: 0 21:13:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:13:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:13:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb66420c8ad2cb4b360d21f519d3b91cfd46d80c7783359f5ac7d4d0ff4acda2397be9d11cf1ce45ad992cd2701ab89081cdace0ef33e8e93856dae7d42d74f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db32df85a106a39bc63dd93d34cecc91e202912658ae1c71d35077fe4f3b64243224d0566f6850d8d1eceef99f0020d2066de787c3e7dcd37edcd34c0960fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40f80133035aaa900e2644649d6b30b9cb7fc9527a4c2ce6ed7bb888c3d0ad43222246f1cae0620ed6c53d8cc4728d6870ef50c903fa0df527dfe54b8d15550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a243659fbcd2d908530392916933bbc31dc3e9bdf886b371f366c699065a14d3c1956cd8ef78e8ed2547b4f78200db50dec2f999adbb05afbc919d242833f3"} 21:13:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:13:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:13:54 INFO - Contents: 21:13:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb66420c8ad2cb4b360d21f519d3b91cfd46d80c7783359f5ac7d4d0ff4acda2397be9d11cf1ce45ad992cd2701ab89081cdace0ef33e8e93856dae7d42d74f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db32df85a106a39bc63dd93d34cecc91e202912658ae1c71d35077fe4f3b64243224d0566f6850d8d1eceef99f0020d2066de787c3e7dcd37edcd34c0960fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40f80133035aaa900e2644649d6b30b9cb7fc9527a4c2ce6ed7bb888c3d0ad43222246f1cae0620ed6c53d8cc4728d6870ef50c903fa0df527dfe54b8d15550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a243659fbcd2d908530392916933bbc31dc3e9bdf886b371f366c699065a14d3c1956cd8ef78e8ed2547b4f78200db50dec2f999adbb05afbc919d242833f3"} 21:13:54 INFO - Running post-run listener: copy_logs_to_upload_dir 21:13:54 INFO - Copying logs to upload dir... 21:13:54 INFO - mkdir: /builds/slave/test/build/upload/logs 21:13:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.035444 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-27 21:13:54.888019) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 21:13:54.891158) ========= 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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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/eb66420c8ad2cb4b360d21f519d3b91cfd46d80c7783359f5ac7d4d0ff4acda2397be9d11cf1ce45ad992cd2701ab89081cdace0ef33e8e93856dae7d42d74f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db32df85a106a39bc63dd93d34cecc91e202912658ae1c71d35077fe4f3b64243224d0566f6850d8d1eceef99f0020d2066de787c3e7dcd37edcd34c0960fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40f80133035aaa900e2644649d6b30b9cb7fc9527a4c2ce6ed7bb888c3d0ad43222246f1cae0620ed6c53d8cc4728d6870ef50c903fa0df527dfe54b8d15550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a243659fbcd2d908530392916933bbc31dc3e9bdf886b371f366c699065a14d3c1956cd8ef78e8ed2547b4f78200db50dec2f999adbb05afbc919d242833f3"} build_url:https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/GKFNP4-eTzm-Ppb1FyyV-Q/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/eb66420c8ad2cb4b360d21f519d3b91cfd46d80c7783359f5ac7d4d0ff4acda2397be9d11cf1ce45ad992cd2701ab89081cdace0ef33e8e93856dae7d42d74f5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9db32df85a106a39bc63dd93d34cecc91e202912658ae1c71d35077fe4f3b64243224d0566f6850d8d1eceef99f0020d2066de787c3e7dcd37edcd34c0960fd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c40f80133035aaa900e2644649d6b30b9cb7fc9527a4c2ce6ed7bb888c3d0ad43222246f1cae0620ed6c53d8cc4728d6870ef50c903fa0df527dfe54b8d15550", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33a243659fbcd2d908530392916933bbc31dc3e9bdf886b371f366c699065a14d3c1956cd8ef78e8ed2547b4f78200db50dec2f999adbb05afbc919d242833f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 21:13:54.924193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 21:13:54.924479) ========= 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.IDHZ2Ftte6/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.cEg0LtwykH/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005229 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 21:13:54.972241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 21:13:54.972515) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 21:13:54.972808) ========= ========= Total master_lag: 0.17 =========