builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0316 starttime: 1492464224.91 results: success (0) buildid: 20170417125706 builduid: 0507d00f0a074ff395080681187cceb9 revision: a374c35469935a874fefe64d3e07003fc5bc8884 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:44.909048) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:44.909543) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:44.909840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:44.957439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:44.957809) ========= 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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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-04-17 14:23:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.7M=0s 2017-04-17 14:23:45 (23.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495425 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.752976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.753314) ========= 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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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.027527 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:45.826298) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 14:23:45.826743) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a374c35469935a874fefe64d3e07003fc5bc8884 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a374c35469935a874fefe64d3e07003fc5bc8884 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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-04-17 14:23:45,886 truncating revision to first 12 chars 2017-04-17 14:23:45,887 Setting DEBUG logging. 2017-04-17 14:23:45,887 attempt 1/10 2017-04-17 14:23:45,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a374c3546993?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 14:23:46,745 unpacking tar archive at: mozilla-central-a374c3546993/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-17 14:23:46.990982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:46.991293) ========= script_repo_revision: a374c35469935a874fefe64d3e07003fc5bc8884 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:46.991684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:46.991975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 14:23:47.011567) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-17 14:23:47.011921) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:23:47 INFO - MultiFileLogger online at 20170417 14:23:47 in /builds/slave/test 14:23:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:23:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:23:47 INFO - {'append_to_log': False, 14:23:47 INFO - 'base_work_dir': '/builds/slave/test', 14:23:47 INFO - 'blob_upload_branch': 'Firefox', 14:23:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:23:47 INFO - 'branch': 'Firefox', 14:23:47 INFO - 'buildbot_json_path': 'buildprops.json', 14:23:47 INFO - 'config_files': ('talos/mac_config.py',), 14:23:47 INFO - 'default_actions': ('clobber', 14:23:47 INFO - 'read-buildbot-config', 14:23:47 INFO - 'download-and-extract', 14:23:47 INFO - 'populate-webroot', 14:23:47 INFO - 'create-virtualenv', 14:23:47 INFO - 'install', 14:23:47 INFO - 'run-tests'), 14:23:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:23:47 INFO - 'download_minidump_stackwalk': True, 14:23:47 INFO - 'download_symbols': 'ondemand', 14:23:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:23:47 INFO - 'tooltool.py': '/tools/tooltool.py', 14:23:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:23:47 INFO - '/tools/misc-python/virtualenv.py')}, 14:23:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:23:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:23:47 INFO - 'gecko_profile': False, 14:23:47 INFO - 'gecko_profile_interval': 0, 14:23:47 INFO - 'installer_path': 'installer.exe', 14:23:47 INFO - 'log_level': 'info', 14:23:47 INFO - 'log_name': 'talos', 14:23:47 INFO - 'log_to_console': True, 14:23:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:23:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:23:47 INFO - 'opt_config_files': (), 14:23:47 INFO - 'pip_index': False, 14:23:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:47 INFO - 'cmd': ('bash', 14:23:47 INFO - '-c', 14:23:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:47 INFO - 'enabled': True, 14:23:47 INFO - 'halt_on_failure': False, 14:23:47 INFO - 'name': 'check_screen_resolution'},), 14:23:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:23:47 INFO - 'cmd': ('bash', 14:23:47 INFO - '-c', 14:23:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:23:47 INFO - 'enabled': True, 14:23:47 INFO - 'halt_on_failure': False, 14:23:47 INFO - 'name': 'check_screen_resolution'},), 14:23:47 INFO - 'run_cmd_checks_enabled': True, 14:23:47 INFO - 'suite': 'dromaeojs-e10s', 14:23:47 INFO - 'system_bits': '32', 14:23:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:23:47 INFO - 'title': 't-yosemite-r7-0316', 14:23:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:23:47 INFO - 'use_talos_json': True, 14:23:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:23:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:23:47 INFO - 'work_dir': 'build'} 14:23:47 INFO - [mozharness: 2017-04-17 21:23:47.175420Z] Running clobber step. 14:23:47 INFO - Running pre-action listener: _resource_record_pre_action 14:23:47 INFO - Running main action method: clobber 14:23:47 INFO - rmtree: /builds/slave/test/build 14:23:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:23:49 INFO - Running post-action listener: _resource_record_post_action 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.672861Z] Finished clobber step (success) 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.673109Z] Running read-buildbot-config step. 14:23:49 INFO - Running pre-action listener: _resource_record_pre_action 14:23:49 INFO - Running main action method: read_buildbot_config 14:23:49 INFO - Using buildbot properties: 14:23:49 INFO - { 14:23:49 INFO - "project": "", 14:23:49 INFO - "product": "firefox", 14:23:49 INFO - "script_repo_revision": "production", 14:23:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:23:49 INFO - "repository": "", 14:23:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:23:49 INFO - "buildid": "20170417125706", 14:23:49 INFO - "pgo_build": "False", 14:23:49 INFO - "basedir": "/builds/slave/test", 14:23:49 INFO - "buildnumber": 41, 14:23:49 INFO - "slavename": "t-yosemite-r7-0316", 14:23:49 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:23:49 INFO - "platform": "yosemite_r7", 14:23:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:23:49 INFO - "branch": "mozilla-central", 14:23:49 INFO - "repo_path": "mozilla-central", 14:23:49 INFO - "revision": "a374c35469935a874fefe64d3e07003fc5bc8884", 14:23:49 INFO - "stage_platform": "macosx64", 14:23:49 INFO - "builduid": "0507d00f0a074ff395080681187cceb9", 14:23:49 INFO - "slavebuilddir": "test" 14:23:49 INFO - } 14:23:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:23:49 INFO - Running post-action listener: _resource_record_post_action 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.676740Z] Finished read-buildbot-config step (success) 14:23:49 INFO - [mozharness: 2017-04-17 21:23:49.676851Z] Running download-and-extract step. 14:23:49 INFO - Running pre-action listener: _resource_record_pre_action 14:23:49 INFO - Running main action method: download_and_extract 14:23:49 INFO - mkdir: /builds/slave/test/build/tests 14:23: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')]} 14:23:49 INFO - trying https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:49 INFO - Downloading https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:23:50 INFO - Downloaded 1325 bytes. 14:23:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:23:50 INFO - Using the following test package requirements: 14:23:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:23:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:23:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:23:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:23:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'jsshell-mac.zip'], 14:23:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:23:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:23:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:23:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:23:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:23:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:23:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:23:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:23:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:23:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:23:50 INFO - Fetch https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:23:52 INFO - Expected file size: 52666944 14:23:52 INFO - Obtained file size: 52666944 14:24:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:24:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:24:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:24:09 INFO - Fetch https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:24:10 INFO - Expected file size: 52666944 14:24:10 INFO - Obtained file size: 52666944 14:24:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:24:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:24:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:24:27 INFO - Expected file size: 14408802 14:24:27 INFO - Obtained file size: 14408802 14:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:24:28 INFO - trying https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:28 INFO - Downloading https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:24:30 INFO - Downloaded 71419386 bytes. 14:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:30 INFO - mkdir: /builds/slave/test/properties 14:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:24:30 INFO - Contents: 14:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:24:31 INFO - Running post-action listener: _resource_record_post_action 14:24:31 INFO - Running post-action listener: set_extra_try_arguments 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.101092Z] Finished download-and-extract step (success) 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.101243Z] Running populate-webroot step. 14:24:31 INFO - Running pre-action listener: _resource_record_pre_action 14:24:31 INFO - Running main action method: populate_webroot 14:24:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:24:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:24:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:24:31 INFO - '--tppagecycles', 14:24:31 INFO - '7'], 14:24:31 INFO - 'tests': ['tsvgm']}}, 14:24:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:24:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:24:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:24:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:24:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:24:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['damp', 'tps']}, 14:24:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'tests': ['damp', 'tps']}, 14:24:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['dromaeo_dom']}, 14:24:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:24:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:24:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:24:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['a11yr', 14:24:31 INFO - 'ts_paint', 14:24:31 INFO - 'tpaint', 14:24:31 INFO - 'sessionrestore', 14:24:31 INFO - 'sessionrestore_no_auto_restore', 14:24:31 INFO - 'tabpaint']}, 14:24:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:24:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:24:31 INFO - 'bloom_basic_ref']}, 14:24:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tsvgx', 14:24:31 INFO - 'tsvgr_opacity', 14:24:31 INFO - 'tart', 14:24:31 INFO - 'tscrollx', 14:24:31 INFO - 'cart', 14:24:31 INFO - 'tsvg_static']}, 14:24:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:24:31 INFO - 'tsvgr_opacity', 14:24:31 INFO - 'tart', 14:24:31 INFO - 'tscrollx', 14:24:31 INFO - 'cart', 14:24:31 INFO - 'tsvg_static']}, 14:24:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s'], 14:24:31 INFO - 'tests': ['tp5o']}, 14:24:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:24:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--disable-e10s', 14:24:31 INFO - '--xperf_path', 14:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:31 INFO - 'tests': ['tp5n']}, 14:24:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:24:31 INFO - 'talos_options': ['--xperf_path', 14:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:24:31 INFO - 'tests': ['tp5n']}}, 14:24:31 INFO - 'talos.zip': {'path': '', 14:24:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:24:31 INFO - Running post-action listener: _resource_record_post_action 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.120809Z] Finished populate-webroot step (success) 14:24:31 INFO - [mozharness: 2017-04-17 21:24:31.120936Z] Running create-virtualenv step. 14:24:31 INFO - Running pre-action listener: _resource_record_pre_action 14:24:31 INFO - Running main action method: create_virtualenv 14:24:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:24:31 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 14:24:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:24:31 INFO - Using real prefix '/tools/python27' 14:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:24:31 INFO - Installing distribute.............................................................................................................................................................................................done. 14:24:34 INFO - Installing pip.................done. 14:24:34 INFO - Return code: 0 14:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:24:35 INFO - Reading from file tmpfile_stdout 14:24:35 INFO - Output received: 14:24:35 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) 14:24:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:24:35 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')]} 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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')]} 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:35 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 14:24:35 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 14:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:35 INFO - 'HOME': '/Users/cltbld', 14:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:35 INFO - 'LOGNAME': 'cltbld', 14:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:35 INFO - 'MOZ_NO_REMOTE': '1', 14:24:35 INFO - 'NO_EM_RESTART': '1', 14:24:35 INFO - 'PAGER': '/bin/cat', 14:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:35 INFO - 'PWD': '/builds/slave/test', 14:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:35 INFO - 'SHELL': '/bin/bash', 14:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:35 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:35 INFO - 'USER': 'cltbld', 14:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:35 INFO - 'XPC_FLAGS': '0x0', 14:24:35 INFO - 'XPC_SERVICE_NAME': '0', 14:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:35 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 14:24:35 INFO - Cleaning up... 14:24:35 INFO - Return code: 0 14:24:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:24:35 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')]} 14:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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')]} 14:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:35 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:35 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 14:24:35 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 14:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:35 INFO - 'HOME': '/Users/cltbld', 14:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:35 INFO - 'LOGNAME': 'cltbld', 14:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:35 INFO - 'MOZ_NO_REMOTE': '1', 14:24:35 INFO - 'NO_EM_RESTART': '1', 14:24:35 INFO - 'PAGER': '/bin/cat', 14:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:35 INFO - 'PWD': '/builds/slave/test', 14:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:35 INFO - 'SHELL': '/bin/bash', 14:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:35 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:35 INFO - 'USER': 'cltbld', 14:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:35 INFO - 'XPC_FLAGS': '0x0', 14:24:35 INFO - 'XPC_SERVICE_NAME': '0', 14:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:35 INFO - Downloading/unpacking psutil>=3.1.1 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:35 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 14:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:39 INFO - Installing collected packages: psutil 14:24:39 INFO - Running setup.py install for psutil 14:24:39 INFO - building 'psutil._psutil_osx' extension 14:24:39 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 14:24:40 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 14:24:40 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 14:24:40 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 14:24:40 INFO - building 'psutil._psutil_posix' extension 14:24:40 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 14:24:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:24:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:24:40 INFO - ^ 14:24:40 INFO - 1 warning generated. 14:24:40 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 14:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:24:40 INFO - Successfully installed psutil 14:24:40 INFO - Cleaning up... 14:24:40 INFO - Return code: 0 14:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:24:40 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')]} 14:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:40 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')]} 14:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:40 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:40 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 14:24:40 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 14:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:40 INFO - 'HOME': '/Users/cltbld', 14:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:40 INFO - 'LOGNAME': 'cltbld', 14:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:40 INFO - 'MOZ_NO_REMOTE': '1', 14:24:40 INFO - 'NO_EM_RESTART': '1', 14:24:40 INFO - 'PAGER': '/bin/cat', 14:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:40 INFO - 'PWD': '/builds/slave/test', 14:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:40 INFO - 'SHELL': '/bin/bash', 14:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:40 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:40 INFO - 'USER': 'cltbld', 14:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:40 INFO - 'XPC_FLAGS': '0x0', 14:24:40 INFO - 'XPC_SERVICE_NAME': '0', 14:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:24:41 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 14:24:41 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 14:24:41 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 14:24:41 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 14:24:41 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 14:24:41 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 14:24:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:24:43 INFO - Installing collected packages: mozsystemmonitor 14:24:43 INFO - Running setup.py install for mozsystemmonitor 14:24:43 INFO - Successfully installed mozsystemmonitor 14:24:43 INFO - Cleaning up... 14:24:43 INFO - Return code: 0 14:24:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:24:43 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')]} 14:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:43 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')]} 14:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:43 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:43 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 14:24:43 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 14:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:43 INFO - 'HOME': '/Users/cltbld', 14:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:43 INFO - 'LOGNAME': 'cltbld', 14:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:43 INFO - 'MOZ_NO_REMOTE': '1', 14:24:43 INFO - 'NO_EM_RESTART': '1', 14:24:43 INFO - 'PAGER': '/bin/cat', 14:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:43 INFO - 'PWD': '/builds/slave/test', 14:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:43 INFO - 'SHELL': '/bin/bash', 14:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:44 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:44 INFO - 'USER': 'cltbld', 14:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:44 INFO - 'XPC_FLAGS': '0x0', 14:24:44 INFO - 'XPC_SERVICE_NAME': '0', 14:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:24:44 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 14:24:44 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 14:24:44 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 14:24:44 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 14:24:44 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 14:24:44 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 14:24:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:24:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24: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 14:24:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:24:47 INFO - warning: no files found matching '*.txt' 14:24:47 INFO - no previously-included directories found matching 'build' 14:24:47 INFO - no previously-included directories found matching 'dist' 14:24:47 INFO - no previously-included directories found matching '.git*' 14:24:47 INFO - Installing collected packages: jsonschema, functools32 14:24:47 INFO - Running setup.py install for functools32 14:24:47 INFO - warning: no files found matching '*.txt' 14:24:47 INFO - no previously-included directories found matching 'build' 14:24:47 INFO - no previously-included directories found matching 'dist' 14:24:47 INFO - no previously-included directories found matching '.git*' 14:24:47 INFO - Successfully installed jsonschema functools32 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:24:47 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')]} 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 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')]} 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:47 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 14:24:47 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 14:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:47 INFO - 'HOME': '/Users/cltbld', 14:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PAGER': '/bin/cat', 14:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:47 INFO - 'PWD': '/builds/slave/test', 14:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:47 INFO - 'SHELL': '/bin/bash', 14:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:47 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:47 INFO - 'USER': 'cltbld', 14:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:47 INFO - 'XPC_FLAGS': '0x0', 14:24:47 INFO - 'XPC_SERVICE_NAME': '0', 14:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:24:47 INFO - Cleaning up... 14:24:47 INFO - Return code: 0 14:24:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:24:47 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')]} 14:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 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')]} 14:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:47 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:47 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 14:24:47 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 14:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:47 INFO - 'HOME': '/Users/cltbld', 14:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:47 INFO - 'LOGNAME': 'cltbld', 14:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:47 INFO - 'MOZ_NO_REMOTE': '1', 14:24:47 INFO - 'NO_EM_RESTART': '1', 14:24:47 INFO - 'PAGER': '/bin/cat', 14:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:47 INFO - 'PWD': '/builds/slave/test', 14:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:47 INFO - 'SHELL': '/bin/bash', 14:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:47 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:47 INFO - 'USER': 'cltbld', 14:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:47 INFO - 'XPC_FLAGS': '0x0', 14:24:47 INFO - 'XPC_SERVICE_NAME': '0', 14:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:24:50 INFO - Downloading blobuploader-1.2.4.tar.gz 14:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:24:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:24:50 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 14:24:50 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 14:24:50 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 14:24:50 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 14:24:50 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 14:24:50 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 14:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 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 14:24:51 INFO - Downloading docopt-0.6.1.tar.gz 14:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:24:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:24:52 INFO - Running setup.py install for blobuploader 14:24:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:24:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:24:52 INFO - Running setup.py install for requests 14:24:52 INFO - Running setup.py install for docopt 14:24:52 INFO - Successfully installed blobuploader requests docopt 14:24:52 INFO - Cleaning up... 14:24:52 INFO - Return code: 0 14:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24:52 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')]} 14:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:52 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')]} 14:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:52 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:52 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 14:24:52 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 14:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:52 INFO - 'HOME': '/Users/cltbld', 14:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:52 INFO - 'LOGNAME': 'cltbld', 14:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:52 INFO - 'MOZ_NO_REMOTE': '1', 14:24:52 INFO - 'NO_EM_RESTART': '1', 14:24:52 INFO - 'PAGER': '/bin/cat', 14:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:52 INFO - 'PWD': '/builds/slave/test', 14:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:52 INFO - 'SHELL': '/bin/bash', 14:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:52 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:52 INFO - 'USER': 'cltbld', 14:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:52 INFO - 'XPC_FLAGS': '0x0', 14:24:52 INFO - 'XPC_SERVICE_NAME': '0', 14:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-Bcr9uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-BzguP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-PdRJXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-7ZOadX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-ev3DXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-t0x9ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-o28jIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:53 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-E5_bUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-XxMZu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-UNxlx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-xpbUrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-CE4tt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-nY8axZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-JiVHPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-0MjF2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-OZ2Hp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:54 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-Ybb03d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:24:54 INFO - Running setup.py install for manifestparser 14:24:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:24:55 INFO - Running setup.py install for mozcrash 14:24:55 INFO - Running setup.py install for mozdebug 14:24:55 INFO - Running setup.py install for mozdevice 14:24:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:24:55 INFO - Running setup.py install for mozfile 14:24:55 INFO - Running setup.py install for mozhttpd 14:24:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:24:55 INFO - Running setup.py install for mozinfo 14:24:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:24:55 INFO - Running setup.py install for mozInstall 14:24:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozleak 14:24:56 INFO - Running setup.py install for mozlog 14:24:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for moznetwork 14:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozprocess 14:24:56 INFO - Running setup.py install for mozprofile 14:24:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:24:56 INFO - Running setup.py install for mozrunner 14:24:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Running setup.py install for mozscreenshot 14:24:57 INFO - Running setup.py install for moztest 14:24:57 INFO - Running setup.py install for mozversion 14:24:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:24:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:24:57 INFO - Cleaning up... 14:24:57 INFO - Return code: 0 14:24:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:24: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')]} 14:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24: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')]} 14:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:24:57 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:24:57 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 14:24:57 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 14:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:57 INFO - 'HOME': '/Users/cltbld', 14:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:57 INFO - 'LOGNAME': 'cltbld', 14:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:57 INFO - 'MOZ_NO_REMOTE': '1', 14:24:57 INFO - 'NO_EM_RESTART': '1', 14:24:57 INFO - 'PAGER': '/bin/cat', 14:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:57 INFO - 'PWD': '/builds/slave/test', 14:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:57 INFO - 'SHELL': '/bin/bash', 14:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:24:57 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:57 INFO - 'USER': 'cltbld', 14:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:57 INFO - 'XPC_FLAGS': '0x0', 14:24:57 INFO - 'XPC_SERVICE_NAME': '0', 14:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:24:57 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-gmHm0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:24:57 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)) 14:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:24:57 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-hW1wbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-V1U5MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-WwWdIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-m9T5K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-1dpbqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-xoTmh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-draEpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-JgiRet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-_6XOc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:24:58 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)) 14:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:24:58 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-a6_12G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-NkKfyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-ljFrj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-bXkFps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-t_XgbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:24:59 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-bBKOy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:24:59 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)) 14:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:24:59 INFO - Running setup.py (path:/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/pip-Lnkyim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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)) 14:24:59 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:59 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:24:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:24:59 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 14:24:59 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 14:24:59 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 14:24:59 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 14:24:59 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 14:24:59 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 14:25:02 INFO - Downloading blessings-1.6.tar.gz 14:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:25:02 INFO - Installing collected packages: blessings 14:25:02 INFO - Running setup.py install for blessings 14:25:02 INFO - Successfully installed blessings 14:25:02 INFO - Cleaning up... 14:25:02 INFO - Return code: 0 14:25:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:02 INFO - Reading from file tmpfile_stdout 14:25:02 INFO - Current package versions: 14:25:02 INFO - blessings == 1.6 14:25:02 INFO - blobuploader == 1.2.4 14:25:02 INFO - docopt == 0.6.1 14:25:02 INFO - functools32 == 3.2.3-2 14:25:02 INFO - jsonschema == 2.5.1 14:25:02 INFO - manifestparser == 1.1 14:25:02 INFO - mozInstall == 1.12 14:25:02 INFO - mozcrash == 1.0 14:25:02 INFO - mozdebug == 0.1 14:25:02 INFO - mozdevice == 0.50 14:25:02 INFO - mozfile == 1.2 14:25:02 INFO - mozhttpd == 0.7 14:25:02 INFO - mozinfo == 0.9 14:25:02 INFO - mozleak == 0.1 14:25:02 INFO - mozlog == 3.4 14:25:02 INFO - moznetwork == 0.27 14:25:02 INFO - mozprocess == 0.25 14:25:02 INFO - mozprofile == 0.28 14:25:02 INFO - mozrunner == 6.13 14:25:02 INFO - mozscreenshot == 0.1 14:25:02 INFO - mozsystemmonitor == 0.3 14:25:02 INFO - moztest == 0.8 14:25:02 INFO - mozversion == 1.4 14:25:02 INFO - psutil == 3.1.1 14:25:02 INFO - requests == 1.2.3 14:25:02 INFO - wsgiref == 0.1.2 14:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:02 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 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:25:02 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 14:25:02 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 14:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:02 INFO - 'HOME': '/Users/cltbld', 14:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:02 INFO - 'LOGNAME': 'cltbld', 14:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:02 INFO - 'MOZ_NO_REMOTE': '1', 14:25:02 INFO - 'NO_EM_RESTART': '1', 14:25:02 INFO - 'PAGER': '/bin/cat', 14:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:02 INFO - 'PWD': '/builds/slave/test', 14:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:02 INFO - 'SHELL': '/bin/bash', 14:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:25:02 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:02 INFO - 'USER': 'cltbld', 14:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:02 INFO - 'XPC_FLAGS': '0x0', 14:25:02 INFO - 'XPC_SERVICE_NAME': '0', 14:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 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)) 14:25:03 INFO - Cleaning up... 14:25:03 INFO - Return code: 0 14:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1062dcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062df768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d9da0ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, '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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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 14:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:03 INFO - 'HOME': '/Users/cltbld', 14:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:03 INFO - 'LOGNAME': 'cltbld', 14:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:03 INFO - 'MOZ_NO_REMOTE': '1', 14:25:03 INFO - 'NO_EM_RESTART': '1', 14:25:03 INFO - 'PAGER': '/bin/cat', 14:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:03 INFO - 'PWD': '/builds/slave/test', 14:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:03 INFO - 'SHELL': '/bin/bash', 14:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:25:03 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:03 INFO - 'USER': 'cltbld', 14:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:03 INFO - 'XPC_FLAGS': '0x0', 14:25:03 INFO - 'XPC_SERVICE_NAME': '0', 14:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:25:03 INFO - Cleaning up... 14:25:03 INFO - Return code: 0 14:25:03 INFO - Running post-action listener: _resource_record_post_action 14:25:03 INFO - Running post-action listener: _start_resource_monitoring 14:25:03 INFO - Starting resource monitoring. 14:25:03 INFO - [mozharness: 2017-04-17 21:25:03.545353Z] Finished create-virtualenv step (success) 14:25:03 INFO - [mozharness: 2017-04-17 21:25:03.546369Z] Running install step. 14:25:03 INFO - Running pre-action listener: _resource_record_pre_action 14:25:03 INFO - Running main action method: install 14:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:25:03 INFO - Reading from file tmpfile_stdout 14:25:03 INFO - Detecting whether we're running mozinstall >=1.0... 14:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:25:03 INFO - Reading from file tmpfile_stdout 14:25:03 INFO - Output received: 14:25:03 INFO - Usage: mozinstall [options] installer 14:25:03 INFO - Options: 14:25:03 INFO - -h, --help show this help message and exit 14:25:03 INFO - -d DEST, --destination=DEST 14:25:03 INFO - Directory to install application into. [default: 14:25:03 INFO - "/builds/slave/test"] 14:25:03 INFO - --app=APP Application being installed. [default: firefox] 14:25:03 INFO - mkdir: /builds/slave/test/build/application 14:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:25:24 INFO - Reading from file tmpfile_stdout 14:25:24 INFO - Output received: 14:25:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:25:24 INFO - Running post-action listener: _resource_record_post_action 14:25:24 INFO - [mozharness: 2017-04-17 21:25:24.101275Z] Finished install step (success) 14:25:24 INFO - [mozharness: 2017-04-17 21:25:24.101417Z] Running run-tests step. 14:25:24 INFO - Running pre-action listener: _resource_record_pre_action 14:25:24 INFO - Running main action method: run_tests 14:25:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:24 INFO - 2017-04-17 14:25:24.115 screenresolution[1629:7748] starting screenresolution argv=screenresolution get 14:25:24 INFO - 2017-04-17 14:25:24.118 screenresolution[1629:7748] Display 0: 1600x1200x32@60 14:25:24 INFO - 2017-04-17 14:25:24.124 screenresolution[1630:7751] starting screenresolution argv=screenresolution list 14:25:24 INFO - Available Modes on Display 0 14:25:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:24 INFO - Intel Iris: 14:25:24 INFO - Chipset Model: Intel Iris 14:25:24 INFO - Type: GPU 14:25:24 INFO - Bus: Built-In 14:25:24 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:24 INFO - Vendor: Intel (0x8086) 14:25:24 INFO - Device ID: 0x0a2e 14:25:24 INFO - Revision ID: 0x0009 14:25:24 INFO - Displays: 14:25:24 INFO - Display: 14:25:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:24 INFO - Display Serial Number: 1600x1200 60 14:25:24 INFO - Main Display: Yes 14:25:24 INFO - Mirror: Off 14:25:24 INFO - Online: Yes 14:25:24 INFO - Rotation: Supported 14:25:24 INFO - Return code: 0 14:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:25:24 INFO - Python 2.7.3 14:25:24 INFO - Return code: 0 14:25:24 INFO - grabbing minidump binary from tooltool 14:25:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:24 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 0x1060bad30>, '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 0x105fe0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060afbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:25:24 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 14:25:24 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 14:25:24 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 14:25:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:25:24 INFO - Return code: 0 14:25:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:25:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:25:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:25:24 INFO - ENV: RUST_BACKTRACE is now 1 14:25:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:25:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 14:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0316 --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 14:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WDIHx2qLnQ/Render', 14:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:25:24 INFO - 'HOME': '/Users/cltbld', 14:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:25:24 INFO - 'LOGNAME': 'cltbld', 14:25:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:25:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:25:24 INFO - 'MOZ_NO_REMOTE': '1', 14:25:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:25:24 INFO - 'NO_EM_RESTART': '1', 14:25:24 INFO - 'PAGER': '/bin/cat', 14:25:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:25:24 INFO - 'PWD': '/builds/slave/test', 14:25:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:25:24 INFO - 'RUST_BACKTRACE': '1', 14:25:24 INFO - 'SHELL': '/bin/bash', 14:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8W0zW9bkV3/Listeners', 14:25:24 INFO - 'TMPDIR': '/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/', 14:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:25:24 INFO - 'USER': 'cltbld', 14:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:25:24 INFO - 'XPC_FLAGS': '0x0', 14:25:24 INFO - 'XPC_SERVICE_NAME': '0', 14:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:25:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0316', '--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 14:25:24 INFO - mozversion application_buildid: 20170417125706 14:25:24 INFO - mozversion application_changeset: a374c35469935a874fefe64d3e07003fc5bc8884 14:25:24 INFO - mozversion application_display_name: Nightly 14:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:25:24 INFO - mozversion application_name: Firefox 14:25:24 INFO - mozversion application_remotingname: firefox 14:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:25:24 INFO - mozversion application_vendor: Mozilla 14:25:24 INFO - mozversion application_version: 55.0a1 14:25:24 INFO - mozversion platform_buildid: 20170417125706 14:25:24 INFO - mozversion platform_changeset: a374c35469935a874fefe64d3e07003fc5bc8884 14:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:25:24 INFO - mozversion platform_version: 55.0a1 14:25:24 INFO - using testdate: 1492464324 14:25:24 INFO - actual date: 1492464324 14:25:24 INFO - starting webserver on 'localhost:49243' 14:25:24 INFO - SUITE-START | Running 2 tests 14:25:24 INFO - TEST-START | dromaeo_css 14:25:24 INFO - operating with platform_type : mac_ 14:25:24 INFO - Initialising browser for dromaeo_css test... 14:25:24 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmpeP2gBL/profile http://localhost:49243/getInfo.html) 14:25:27 INFO - PID 1640 | 2017-04-17 14:25:27.788 plugin-container[1643:7947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 14:25:27 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:27 INFO - PID 1640 | 2017-04-17 14:25:27.791 plugin-container[1643:7947] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 14:25:27 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:27 INFO - PID 1640 | 2017-04-17 14:25:27.791 plugin-container[1643:7947] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:25:27 INFO - PID 1640 | __metrics Screen width/height:1600/1200 14:25:27 INFO - PID 1640 | colorDepth:24 14:25:27 INFO - PID 1640 | Browser inner width/height: 1024/689 14:25:27 INFO - PID 1640 | __metrics 14:25:27 ERROR - PID 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 14:25:28 INFO - TEST-INFO | 1640: exit 0 14:25:28 INFO - Browser initialized. 14:25:28 INFO - Running cycle 1/1 for dromaeo_css test... 14:25:28 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmpeP2gBL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:31 INFO - PID 1644 | 2017-04-17 14:25:31.128 plugin-container[1645:8082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 14:25:31 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:31 INFO - PID 1644 | 2017-04-17 14:25:31.129 plugin-container[1645:8082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 14:25:31 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:31 INFO - PID 1644 | 2017-04-17 14:25:31.129 plugin-container[1645:8082] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:25:40 INFO - PID 1644 | RSS: Main: 236224512 14:25:40 INFO - PID 1644 | 14:28:44 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 14:28:46 INFO - PID 1644 | RSS: Main: 258396160 14:28:46 INFO - PID 1644 | 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 14:30:29 INFO - PID 1644 | 14:30:29 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:29 INFO - PID 1644 | Full stack: 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 14:30:29 INFO - PID 1644 | 14:30:29 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:29 INFO - PID 1644 | Full stack: 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 14:30:29 INFO - PID 1644 | 14:30:29 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:29 INFO - PID 1644 | Full stack: 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | ************************* 14:30:29 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 14:30:29 INFO - PID 1644 | 14:30:29 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:30:29 INFO - PID 1644 | Full stack: 14:30:29 INFO - PID 1644 | ************************* 14:31:48 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 14:31:49 INFO - PID 1644 | RSS: Main: 257351680 14:31:49 INFO - PID 1644 | 14:34:50 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 14:34:51 INFO - PID 1644 | RSS: Main: 266137600 14:34:51 INFO - PID 1644 | 14:37:53 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 14:37:53 INFO - PID 1644 | RSS: Main: 259031040 14:37:53 INFO - PID 1644 | 14:40:56 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 14:40:57 INFO - PID 1644 | RSS: Main: 267804672 14:40:57 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 14:43:59 INFO - PID 1644 | RSS: Main: 262828032 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | __start_tp_report 14:43:59 INFO - PID 1644 | _x_x_mozilla_page_load 14:43:59 INFO - PID 1644 | _x_x_mozilla_page_load_details 14:43:59 INFO - PID 1644 | |i|pagename|runs| 14:43:59 INFO - PID 1644 | |0;dojo.html;3132.3735252949414;3331.816750078746;3402.523646689464;3659.963400365997;3672.540932383452;4791.568758811706;6144.941444616059;6186.690665466731;6284.245890493135;6340.58786178898;5962.463378295953;6182.969085154579;6235.438810507054;6270.153529273547;6290.811275661726;5502.8349149525575;5515.117581187011;5522.751476183581;5530.668159910399;5545.334559852823;4923.383851103444;5538.086215774392;5621.156826476041;5631.549476041927;5651.2653355063785;5375.8118465853895;5460.290162278879;5549.112142057292;5550.028744969654;5586.972065139668;5452.1276595744885;5455.645383050089;5459.69971651559;5481.095619222863;5500.697461639608;4206.326987681956;5435.945640543583;5440.265564148829;5513.255710479114;5522.834314970557;6151.108089327023;6189.381061893775;6256.937430625727;6265.9060114097865;6275.843103922392;5510.421405752419;6426.710798014054;6524.575902566318;6687.765928192539;6697.531172817905;6744.224414192382;6793.286704895964;6813.557118787313;6824.590524568542;6854.0404343391965;6303.747850086037;6337.176167098294;6340.175777148941;6359.20509936258;6364.077208804743;6718.630475323904;6839.521233513607;7023.227444981048;7031.753888613874;7033.613151276627;6462.127612772216;6575.572587781779;6614.735410583523;6639.701213445406;6644.468442524587;6754.797356079325;6772.424343930723;6784.3894049535775;6792.01515780219;6799.218089919723;6417.679116044179;6607.6365799880505;6638.800835974928;6643.86712265752;6699.497537684693;6492.415682588589;6632.801015969432;6662.600243985376;6713.697883595152;6730.865382692319;5361.705106219196;5370.221317908881;5371.328583927009;5373.328333958255;5400.297961265089;4756.762161891892;4766.142094423037;4780.306855505932;4798.880027999258;4831.565159135695;6262.937370626327;6276.623402595767;6342.143810585512;6342.334054924258;6399.232092148972;5876.6180198286975;6563.573367731082;6786.830329241809;6849.972504124322;6880.071190389333;6371.681415929185;6380.904286435707;6389.552731308764;6401;6421.197350331208;4943.382077240345;5255.842324730188;5475.780968761284;5938.792142275;6041.154238406539;6894.793156205322;6930.896036559355;6942.166939967236;6951.582905025714;6962.303769622998;6524.739010439529;6630.46956243509;6721.865562688817;6800.693968771318;6807.115075040411;6837.418819400406;6893.620850853051;6938.271481494572;6938.861222775416;6964.094667693167;6638.734450621921;6644.4020038196795;6660.83347916306;6665.466762659073;6672.599644021374;6480.740770369132;6633.800985970429;6672.266050734513;6723.697433615401;6783.491238157257;5519.3652729936575;6214.9067763984485;6477.77327793525;6499;6712.563683360566;4987.476314986874;6555.573887697285;6603.537752357481;6614.503912206507;6622.602643841385;6369.745210191726;6444.589810297607;6490.967545162244;6498.772542960974;6517.869642607026;6297.811065668037;6388.776392826228;6476.384743449365;6542;6613.2394774601535;6400.743970241138;6405;6411.166548348685;6412.775552855627;6422.743090276336 14:43:59 INFO - PID 1644 | |1;ext.html;718.2279050021225;797.3382092862923;825.8926339575854;1265.6645988812966;1278.852931912829;38158.23683526331;38761.80619096901;38777.806110969475;38813;38865.22269554611;38498.422523662164;38939.41590876139;38952;39003.609963900424;39014.60985390152;8042.914206582095;8216.917830821674;8654.264387527068;8878.778030549223;8893.644254229823;8660.783480412978;8753.47479151253;8756.299496040301;8758.60586273616;8774.517401542913;8685.609147588342;8703.390762646617;8736;8755.649774009033;8769.912300876973;8289.129641387657;8716.912830871674;8747.606357713887;8751.168638979287;8758.386912916098;7446.73936412223;8240.21717936795;8469.618867150994;8471.788205294917;8548.74353769388;37898.43152352717;38052.809735951145;38055;38106.61893381058;38126.61873381286;3646.9635303646887;3673.008287762316;3678.521792167028;3696.704263658901;3705.2404257127223;30862.691373086207;31129;31238;31240;31482.37035259282;2938;3086.706762857525;3189.6331921829055;3203.119142235904;3204.086835251942;250421;299789;301203;309745;311919;46967.76516117398;47083.5291647086;47234.29148562774;47244;47292.7635361821;39509.01227469336;50297.24554131691;51993.48006519886;53577.1963420549;53621.391358259316;14466.566003019927;14501.709965800625;14560.980731348916;14600.85399145995;14613.269336533343;11626.593069242535;11687;11687.824682629767;11716.121290903217;11725.941370293265;13821.516246931309;13943.721125577431;13965.650858728613;14001.579952601438;14090.647733806736;5918.141869428995;5920.4773159969745;5975.19334889793;5977.163197152402;5982.73077711504;861.8319427711662;1006.2050979726081;1025.74869157057;1027.994860025695;1069.6790962711154;18131.64012699053;23842.761572384054;24652;24709.87645061799;25047.62428563573;1106.3748981825242;1112.1325366214205;1141.0529260713754;1142.9257098288585;1148.0815347721789;12023.89395558845;12472.126951113334;12493.750124997448;12551.497940082294;12570.308633025088;280532;337979;338665;339259;340459;54519.72740136353;54756.452435475934;54926.901461970534;54991.45008549943;55058.72470637621;1488.1740633948264;1531.1655147944398;1533.4786172701336;1554.8989315694444;1559.7426424640034;23724.881375593013;23730.050797967888;23841.523169536165;23974.880125599262;24029.51940961136;37988.24023519569;38560;38575.807120964215;38607.6139238604;38612.8416147516;279669;281076;281796;282561;282837;34740;35033.64966350304;35035.64964350426;35164.47253291152;35494;44319.33520997123;45134;45184.77407612941;45196.54803451923;45352.77323613361;29423;29937.85031074831;30412.391752165277;30677.53983690291;31054.378912421173;28613.42773144567;29170.979015735196;29449.705502944696;29571.85214073916;29633.555496668;36242.8187859059;36276;36752.816235919716;36852.81573592115;36987;30236;30388.544171837;31146.22134446657;31204.843975780885;31374;22837.802707620613;23412.765872341057;24043.278701638978;24467.877660611583;24521.87739061293 14:43:59 INFO - PID 1644 | |2;jquery.html;418.7093955123188;424.8980244741263;433.39974135821876;439.3914428516505;449.74589357013303;21368.679469807947;21425.785742142572;21973.560528789414;21999.34001979939;22136.778632213674;21765.67351489725;22741.317760467173;23085.422864428398;23152.30543083706;23360.64959025612;4710.835120770774;5534.418886016951;5996.710707197952;6115.357887421824;6357.332480089593;6287.371262873722;6349.492040636738;6362.5546211765195;6363.140975968255;6369.363063693617;5138.845834624948;5590;5601.971990140044;6319.905201421982;6331.430171284584;6184.783532576361;6199.636080062402;6224.190855188842;6231.439170474634;6251.843703907416;4704.317873908299;5465.344158700981;5485.314335708036;5508.063629183049;5538.972305138489;27363.315917102034;27411.177664670093;27447.451050978867;27504.17487475379;27629.86185069082;2227.944301392462;2286.565552545011;2292.1748170658548;2292.598795210831;2293.415179129328;16890.324387024506;16995.49013529596;17021.91489042547;17211.397601084027;17262.3958161465;1967.7835438101797;1988.0656091636909;2029.4520479470461;2030.9593808123755;2031.6546187148072;133905;149914;150905.24547377301;151939;156492.99999999886;10487.370757754406;12047.457864395948;12683.112182147346;12742.61772146837;12757.681057973625;16454.177291135635;16471.752923706154;16485.093319867283;16499;16537.007779533025;8825.338099642553;9042.367034307536;9052.329562778996;9138.268938484905;9222.216111630452;8663.003754568179;8680.392372533863;8689.478631282143;8813.294936405073;8827.735167944971;7792.961035194788;7894.250046245597;7934.778262086625;7937.920620793718;7938.682452701943;2196.681481185219;2209.237812954528;2211.7014203082376;2218.7892150245702;2398.088726284001;775.4920527054788;921.203159267229;924.6717415317465;936.9250459963187;938.666773295484;19235.51911202203;19629.411117666492;20464;20516.07677654509;20735.481612959797;973.6154219083422;976.4824642939253;983.9163671088038;1013.9036791504795;1014.7822612864445;10432.947835260928;10794.650668666416;10829.620963266249;10900.400477973788;10914.017738403581;539290.9106363407;587169;595397;598238;600056;101585;112050.01724215463;112494.43752781184;113739;119157;1208.3897631696113;1209.3711270139654;1247.975040499203;1249.6750844780422;1253.8558065822365;14225.715485690022;18064.825786323847;18161.909190453964;18189.909050454662;18472.630547389246;54045.91908161894;54446.72776636091;55610;55793.72103139458;56965.575860603814;54099.459005409444;56084;61553.76892462036;77534.2246577527;79518.20481795339;8389.203025712548;8417.452865563719;8654.82690346202;8669.869951950852;8944.463332199828;13649.590512284647;13731.725365492834;13858.584242472742;13984;14129.505467308594;10029.796424429116;11509.769804603693;11631.568687237115;11795.469203886018;11831;10694.786104277715;10905.018548330689;11020.834687479855;11167.385793781095;11168.441577921234;11869.465874035517;12085.274883507018;12184.878151218374;12192.451339689558;12210.328431936328;7249.7675395184;8544.487330760174;8616.138386161334;8669.916260467442;8752.431091979255;10258.794824103625;11620.593279235525;11937.940310298392;12045.133004384334;12077.879221207675 14:43:59 INFO - PID 1644 | |3;mootools.html;1393.4286942353635;1442.725882082405;1443.4875619155207;1446.8352975854439;1479.9186044767537;10717.571297148104;11048.281861678985;11338.659840204797;11719.472623731932;12187.817182742267;11723.355215463145;11963.940180299109;11992.760144797121;12020.038396928247;12020.759584808298;2507.636392723054;2545.3127655532994;2550.7066687331007;2552.629868669042;2556.4503631719176;2402.387391215246;2480.6651102101255;2489.825712200147;2523.5962246040635;2526.898924043045;2465.987670061656;2504.8622325772076;2511.7613826686434;2521.1680145551923;2523.1169090818157;2443.4135807406183;2497.113524698733;2506.1103308325646;2517.3706573356662;2525.393905462685;1923.2979962313796;2411.493586346869;2499.7750202481866;2506.3358210074343;2533.075427468979;11839.704007399798;11932.343721095336;11932.70168245792;11942.761144777056;11947.701307467383;6562.343765623447;6776.830579235559;6819.147606549182;6821.658917054177;6824.761133360358;3542.4863394807867;4119.752814831119;4332.393464914914;4387.078713470143;4402.449693788277;1245.5391505143064;1265.6772523006666;1266.9326634156007;1275.5599318235195;1292.4700872642172;13498.865011349859;16052.03687778737;16451.341946322133;16526.83473165265;16552.5930295925;4965.535167125707;5520.530754885799;5655.349634792052;5830.679312637845;5864.970675146682;10051.296409251283;12091.790820917839;12453.75092498145;12479.93760031194;12479.937600312122;5434.972825135849;6635.601863888182;6642.302558231413;6650.3349665034075;6651.767188148391;6085.5435842312;6159.199304090529;6221.5333849961435;6232.407921247474;6246.906296405557;4454.443194600675;4512.954870451254;4541.250693635513;4550.271956486946;4637.234856248681;1239.4856134703996;1315.8223639808696;1325.1982550556775;1336.245021562814;1344.7781116115732;684.7261095561815;794.2454668065361;802.835418739157;821.6877586517205;835.6949713354581;6666.799996000128;6798.150231221098;6993.615351155735;7013.719451221894;7117.857642847114;913.9314551408671;939.910708482693;951.8857737071596;952.9428234305964;959.3236768078488;3367.983160084184;4143.212789569972;4335.609795118455;4347.369631403429;4522.751248681354;14555.708885822436;15010.049151294485;15131.54605361841;15164.24178791056;15249.542513724606;14881.627959300888;15207.467738629095;15209.087454752751;15284.770728439082;15302.158381289137;5450.754716037788;8559.786005349792;8620.698275560326;8711.738647840575;8733.25767309773;6457.6448295342325;7160.964195178991;7240.6017669026605;7249.782506524813;7250.673719682522;12821.679458013625;12845.678858028625;12850.228986260854;12869.806952895902;13482.865171348161;11152.776944461228;13665.795013074612;13942.302884855919;14011.299435028004;14062.859371406155;8083.393745469231;9356.719298421058;9556.95221523888;9660.613575456902;9670.56482458305;10762.246642734934;10771.46142692878;10778.514966826355;10894.074003709457;10932;9259.35184537103;9282.468392715127;9288.11762882525;9310.534473276173;9332.72001839946;7418.332350088518;9036.728898133066;9040.276777857887;9063.592138353923;9077.364584479286;8083.474574152661;8178.550179740171;8218.794530136554;8220.917790822015;8222.424430289822;6013.278406591237;6126.264848218242;6134.754609815557;6192.81421557354;6215.502759779297;6030.969845150747;6130.295016073031;6197.907031394623;6258.906116408349;6340.524460665561 14:43:59 INFO - PID 1644 | |4;prototype.html;401.656583621004;404.9250888585612;405.3919121318023;406.92675318442684;413.92342416652923;5693.544516438686;6277.591956522823;6369.840753981152;6370.585911915722;6381.680915954201;4507.504174540806;4914.631402644807;5967.075103358976;6015.669138197398;6076.605020673653;3965.2267807777494;4737.028909073631;4739.52604739525;4762.261849413347;4777.617790576763;4771.117343291485;4783.325835957422;4789.700943547099;4791.952080479203;4795.352627395292;4336.002719374545;4551.610404537611;4618.953810461902;4705.2236380997265;4714.811407543694;4277.508086570022;4423.535528769481;4662.603678687298;4711.939813541926;4734.880653831189;3974.5627980922077;4180.372944058385;4187.2044311581;4200.537940826537;4206.26390381682;5661.46216109469;6025.9096113558335;6079.422454866781;6098.237720284965;6201.224846894138;4958.9008219835405;5439.972800136014;5440.401555828856;5445.863853403657;5454.509094181503;5800.477956983892;6045.183900173464;6138.9693051534905;6293.748250069992;6697.6986035628515;3511.682289688819;4107.732997355162;4376.912461750779;4403.669724770655;4423.424954755893;6858;6977.790666279969;7073.858522829566;7081.768044121191;7095.858082838366;3758;4458.7547684877645;4510.44389685558;4511.05267893746;4525.932111018337;4597.954020459752;4603.470600880942;4603.608693261111;4605.263157894788;4656.16189085961;4555.544445555484;4658.930116048262;5242.898991211812;5439.728013599383;5440.347158341025;6203.31763506014;6234.251889773256;6519.152510173742;6649.767258146038;6672.86654266912;1371.5542448704211;1455.8571521355684;1541.306412114553;1569.1683407793887;1571.395012920034;749;992.6327258914248;997.6458357283205;1004.3321191407778;1019.0115587879744;5637.633553818989;6351.460125889259;6377.968110159512;6381.553291269566;6397.840053998594;5713.657400465789;6012.368701286389;6632.204135503771;6915.446764258847;6924.965375173092;5283.5773138149625;6048.243969503812;6395.872082558416;6434.581752186186;6465.741370345134;3473.513708080871;3595.209054008114;3635.4733460244875;3640.7997560134445;3648.6864728697647;5875.353711091777;6200.410960958701;6933.965330173317;7066.3993560546905;7122.786316410516;5719.542436605062;6406.263279722798;6480.4815614750705;7009.598080383842;7103;6087.691146403545;6553.737850485927;7114.679839407239;7142.5000249982;7157.821054473679;6928.911941954271;6944.652767361713;6954.235034146139;6958.478114141561;7015.368616824306;5933.762649493972;6457.964756564407;6548.967255163694;6851.314868513109;6861.142357205349;5843.795467158629;6181.53638477125;6766.4963963333885;7103.82240443993;7107.75122870697;4577.267637178169;4932.087563800708;4991.3511243538105;4996.300517927566;4997.925031124609;5926.436988486087;6581.901271480836;6919.515633905578;6945;6954.895676564956;5439.4288599696465;6561.40947314744;6695.832604184934;6696.1629796275465;6701.262861085179;6241.940159747363;6383.680815959091;6594.77996570636;6700.966495167493;6732.461403087839;5450.373207081077;6527.934720652733;6530.608163510205;6532.771353002622;6540.803775886731;5697.350731909682;6068.666223357758;6255.655938923403;6532.477401807749;6692.933070669231;5163.974180129076;5606.943930560806;6445.452136568444;6455.7740479083;6533.052707357311 14:43:59 INFO - PID 1644 | |5;yui.html;745.3776096959039;799.540264348;802.5826570183505;866.9263112635425;886.2865393358346;16384.59038524036;16810.495685129452;16817.906836055663;18043.097845107724;18718;17761.06942354513;17784.843985140957;18005.459836204904;18118.728219076693;18429.44711658649;952.7284723853703;960.3325688646358;963.6241865672393;971.3491960386523;978.6917121106865;981.3866333541537;987.2694206287367;989.5596459575492;990.6780296403698;991.2169386184905;1034.751659601694;1036.2435422141841;1037.2169012395632;1040.0743338428804;1040.2977989856815;1023.4371095897227;1033.3128469567728;1033.8345864661655;1035.0012238190106;1036.5801850250662;729.0777166883896;741.4661443760538;758.169804064554;758.7003133762133;760.224570937646;16351.345946162139;16400.917995410065;16526.843120981535;16537.503874883772;16559.42042028523;13684.794728079087;17142.742858857127;17144.05707686077;17239.482815515556;17410.651786964318;13811.102278351875;13882.028258021943;14077.084989475652;14085.295735213198;14091.859081409157;3430.485427185917;3542.3446662367287;3542.929141417183;3559.199180184464;3567.161716996504;113261.73476530505;121304.78695213023;121665.78334216632;121696.17455738172;122500.38749806283;13637.659058523615;13857.436374270792;13936.721265574835;13958.232297223547;13981.650458738613;20647.380578582666;25427.61858572123;25887.870560647076;26109.608355874676;26188.738112619012;7583.544987300779;7864.567448790257;7876.369890408753;7884.17216192303;7897.210278972172;3938.8030598469963;3979.263836190314;3997.320455522568;4026;4037.9192416151513;4316.899190706413;4396.142752163361;4399.780010999437;4411.84558540456;4424.513303536608;919.4253591505309;946.1626460582435;961.3270710502676;965.3676841668719;965.8551217317319;565.4204440448573;659.1102012283379;667.6361383046251;680.0547239337325;699.566268913277;10512.789744205225;10850.891491085145;11791.29252244868;11793.882061179278;11983;649.8667773106501;667.3993405934698;667.5894324990096;680.1775412326627;686.6909890549173;4472.552744725502;5008.874778130576;5174.43081261061;5390.838274851761;5396.64921780083;102848;103169;103387.48306258571;104673;105821.47089264504;93813;94322;94509.52745236368;95001.5249923746;96751;68522.65738671375;69823;70204;70997.99999999897;81894.18105818865;11030.613928512463;11984.820227696417;12429.254244745343;12431.954171227746;12617.684557886127;24288;35408;38003.61996380001;39245.6075439242;39433.40849887197;57674.711626441596;64835.67582162059;64983.353495766416;67096.32259193559;67140.66429667821;16431.58921026936;16504.83495165033;16542.255598498337;16636.417725379553;16667.499975000283;17876.463706088838;18320.450386487893;18330.90834545819;18342.633147337245;18463.446096617125;16228.432004879773;16473.34106635721;16644.251008704396;16700.916495417445;17366.39217627377;15145.848541514884;17188.656226875144;17729.822701772817;18091.638167236844;18533.9073304638;16786.916065419595;16963.982161070377;17522.474325770247;17626.29494820244;17719.20263588116;9453.952730236304;11516.356985077084;11831.52673893069;11885.465154067915;12157;12860;13782.793258101337;13838.238896860366;13863.72272554523;13867.375968081662 14:43:59 INFO - PID 1644 | __end_tp_report 14:43:59 INFO - PID 1644 | __start_cc_report 14:43:59 INFO - PID 1644 | _x_x_mozilla_cycle_collect,415 14:43:59 INFO - PID 1644 | __end_cc_report 14:43:59 INFO - PID 1644 | __startTimestamp1492465439315__endTimestamp 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | ------- Summary: start ------- 14:43:59 INFO - PID 1644 | Number of tests: 6 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6146.26 Median:6401.00 stddev:771.09 (12.0%) stddev-sans-first:736.31 14:43:59 INFO - PID 1644 | Values: 3132.4 3331.8 3402.5 3660.0 3672.5 4791.6 6144.9 6186.7 6284.2 6340.6 5962.5 6183.0 6235.4 6270.2 6290.8 5502.8 5515.1 5522.8 5530.7 5545.3 4923.4 5538.1 5621.2 5631.5 5651.3 5375.8 5460.3 5549.1 5550.0 5587.0 5452.1 5455.6 5459.7 5481.1 5500.7 4206.3 5435.9 5440.3 5513.3 5522.8 6151.1 6189.4 6256.9 6265.9 6275.8 5510.4 6426.7 6524.6 6687.8 6697.5 6744.2 6793.3 6813.6 6824.6 6854.0 6303.7 6337.2 6340.2 6359.2 6364.1 6718.6 6839.5 7023.2 7031.8 7033.6 6462.1 6575.6 6614.7 6639.7 6644.5 6754.8 6772.4 6784.4 6792.0 6799.2 6417.7 6607.6 6638.8 6643.9 6699.5 6492.4 6632.8 6662.6 6713.7 6730.9 5361.7 5370.2 5371.3 5373.3 5400.3 4756.8 4766.1 4780.3 4798.9 4831.6 6262.9 6276.6 6342.1 6342.3 6399.2 5876.6 6563.6 6786.8 6850.0 6880.1 6371.7 6380.9 6389.6 6401.0 6421.2 4943.4 5255.8 5475.8 5938.8 6041.2 6894.8 6930.9 6942.2 6951.6 6962.3 6524.7 6630.5 6721.9 6800.7 6807.1 6837.4 6893.6 6938.3 6938.9 6964.1 6638.7 6644.4 6660.8 6665.5 6672.6 6480.7 6633.8 6672.3 6723.7 6783.5 5519.4 6214.9 6477.8 6499.0 6712.6 4987.5 6555.6 6603.5 6614.5 6622.6 6369.7 6444.6 6491.0 6498.8 6517.9 6297.8 6388.8 6476.4 6542.0 6613.2 6400.7 6405.0 6411.2 6412.8 6422.7 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:45327.37 Median:187599.50 stddev:79305.90 (42.3%) stddev-sans-first:79457.65 14:43:59 INFO - PID 1644 | Values: 718.2 797.3 825.9 1265.7 1278.9 38158.2 38761.8 38777.8 38813.0 38865.2 38498.4 38939.4 38952.0 39003.6 39014.6 8042.9 8216.9 8654.3 8878.8 8893.6 8660.8 8753.5 8756.3 8758.6 8774.5 8685.6 8703.4 8736.0 8755.6 8769.9 8289.1 8716.9 8747.6 8751.2 8758.4 7446.7 8240.2 8469.6 8471.8 8548.7 37898.4 38052.8 38055.0 38106.6 38126.6 3647.0 3673.0 3678.5 3696.7 3705.2 30862.7 31129.0 31238.0 31240.0 31482.4 2938.0 3086.7 3189.6 3203.1 3204.1 250421.0 299789.0 301203.0 309745.0 311919.0 46967.8 47083.5 47234.3 47244.0 47292.8 39509.0 50297.2 51993.5 53577.2 53621.4 14466.6 14501.7 14561.0 14600.9 14613.3 11626.6 11687.0 11687.8 11716.1 11725.9 13821.5 13943.7 13965.7 14001.6 14090.6 5918.1 5920.5 5975.2 5977.2 5982.7 861.8 1006.2 1025.7 1028.0 1069.7 18131.6 23842.8 24652.0 24709.9 25047.6 1106.4 1112.1 1141.1 1142.9 1148.1 12023.9 12472.1 12493.8 12551.5 12570.3 280532.0 337979.0 338665.0 339259.0 340459.0 54519.7 54756.5 54926.9 54991.5 55058.7 1488.2 1531.2 1533.5 1554.9 1559.7 23724.9 23730.1 23841.5 23974.9 24029.5 37988.2 38560.0 38575.8 38607.6 38612.8 279669.0 281076.0 281796.0 282561.0 282837.0 34740.0 35033.6 35035.6 35164.5 35494.0 44319.3 45134.0 45184.8 45196.5 45352.8 29423.0 29937.9 30412.4 30677.5 31054.4 28613.4 29171.0 29449.7 29571.9 29633.6 36242.8 36276.0 36752.8 36852.8 36987.0 30236.0 30388.5 31146.2 31204.8 31374.0 22837.8 23412.8 24043.3 24467.9 24521.9 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:35383.93 Median:2292.39 stddev:97925.31 (4271.8%) stddev-sans-first:98164.83 14:43:59 INFO - PID 1644 | Values: 418.7 424.9 433.4 439.4 449.7 21368.7 21425.8 21973.6 21999.3 22136.8 21765.7 22741.3 23085.4 23152.3 23360.6 4710.8 5534.4 5996.7 6115.4 6357.3 6287.4 6349.5 6362.6 6363.1 6369.4 5138.8 5590.0 5602.0 6319.9 6331.4 6184.8 6199.6 6224.2 6231.4 6251.8 4704.3 5465.3 5485.3 5508.1 5539.0 27363.3 27411.2 27447.5 27504.2 27629.9 2227.9 2286.6 2292.2 2292.6 2293.4 16890.3 16995.5 17021.9 17211.4 17262.4 1967.8 1988.1 2029.5 2031.0 2031.7 133905.0 149914.0 150905.2 151939.0 156493.0 10487.4 12047.5 12683.1 12742.6 12757.7 16454.2 16471.8 16485.1 16499.0 16537.0 8825.3 9042.4 9052.3 9138.3 9222.2 8663.0 8680.4 8689.5 8813.3 8827.7 7793.0 7894.3 7934.8 7937.9 7938.7 2196.7 2209.2 2211.7 2218.8 2398.1 775.5 921.2 924.7 936.9 938.7 19235.5 19629.4 20464.0 20516.1 20735.5 973.6 976.5 983.9 1013.9 1014.8 10432.9 10794.7 10829.6 10900.4 10914.0 539290.9 587169.0 595397.0 598238.0 600056.0 101585.0 112050.0 112494.4 113739.0 119157.0 1208.4 1209.4 1248.0 1249.7 1253.9 14225.7 18064.8 18161.9 18189.9 18472.6 54045.9 54446.7 55610.0 55793.7 56965.6 54099.5 56084.0 61553.8 77534.2 79518.2 8389.2 8417.5 8654.8 8669.9 8944.5 13649.6 13731.7 13858.6 13984.0 14129.5 10029.8 11509.8 11631.6 11795.5 11831.0 10694.8 10905.0 11020.8 11167.4 11168.4 11869.5 12085.3 12184.9 12192.5 12210.3 7249.8 8544.5 8616.1 8669.9 8752.4 10258.8 11620.6 11937.9 12045.1 12077.9 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:7113.51 Median:3455.23 stddev:4468.53 (129.3%) stddev-sans-first:4460.39 14:43:59 INFO - PID 1644 | Values: 1393.4 1442.7 1443.5 1446.8 1479.9 10717.6 11048.3 11338.7 11719.5 12187.8 11723.4 11963.9 11992.8 12020.0 12020.8 2507.6 2545.3 2550.7 2552.6 2556.5 2402.4 2480.7 2489.8 2523.6 2526.9 2466.0 2504.9 2511.8 2521.2 2523.1 2443.4 2497.1 2506.1 2517.4 2525.4 1923.3 2411.5 2499.8 2506.3 2533.1 11839.7 11932.3 11932.7 11942.8 11947.7 6562.3 6776.8 6819.1 6821.7 6824.8 3542.5 4119.8 4332.4 4387.1 4402.4 1245.5 1265.7 1266.9 1275.6 1292.5 13498.9 16052.0 16451.3 16526.8 16552.6 4965.5 5520.5 5655.3 5830.7 5865.0 10051.3 12091.8 12453.8 12479.9 12479.9 5435.0 6635.6 6642.3 6650.3 6651.8 6085.5 6159.2 6221.5 6232.4 6246.9 4454.4 4513.0 4541.3 4550.3 4637.2 1239.5 1315.8 1325.2 1336.2 1344.8 684.7 794.2 802.8 821.7 835.7 6666.8 6798.2 6993.6 7013.7 7117.9 913.9 939.9 951.9 952.9 959.3 3368.0 4143.2 4335.6 4347.4 4522.8 14555.7 15010.0 15131.5 15164.2 15249.5 14881.6 15207.5 15209.1 15284.8 15302.2 5450.8 8559.8 8620.7 8711.7 8733.3 6457.6 7161.0 7240.6 7249.8 7250.7 12821.7 12845.7 12850.2 12869.8 13482.9 11152.8 13665.8 13942.3 14011.3 14062.9 8083.4 9356.7 9557.0 9660.6 9670.6 10762.2 10771.5 10778.5 10894.1 10932.0 9259.4 9282.5 9288.1 9310.5 9332.7 7418.3 9036.7 9040.3 9063.6 9077.4 8083.5 8178.6 8218.8 8220.9 8222.4 6013.3 6126.3 6134.8 6192.8 6215.5 6031.0 6130.3 6197.9 6258.9 6340.5 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5335.69 Median:5989.72 stddev:1655.10 (27.6%) stddev-sans-first:1617.78 14:43:59 INFO - PID 1644 | Values: 401.7 404.9 405.4 406.9 413.9 5693.5 6277.6 6369.8 6370.6 6381.7 4507.5 4914.6 5967.1 6015.7 6076.6 3965.2 4737.0 4739.5 4762.3 4777.6 4771.1 4783.3 4789.7 4792.0 4795.4 4336.0 4551.6 4619.0 4705.2 4714.8 4277.5 4423.5 4662.6 4711.9 4734.9 3974.6 4180.4 4187.2 4200.5 4206.3 5661.5 6025.9 6079.4 6098.2 6201.2 4958.9 5440.0 5440.4 5445.9 5454.5 5800.5 6045.2 6139.0 6293.7 6697.7 3511.7 4107.7 4376.9 4403.7 4423.4 6858.0 6977.8 7073.9 7081.8 7095.9 3758.0 4458.8 4510.4 4511.1 4525.9 4598.0 4603.5 4603.6 4605.3 4656.2 4555.5 4658.9 5242.9 5439.7 5440.3 6203.3 6234.3 6519.2 6649.8 6672.9 1371.6 1455.9 1541.3 1569.2 1571.4 749.0 992.6 997.6 1004.3 1019.0 5637.6 6351.5 6378.0 6381.6 6397.8 5713.7 6012.4 6632.2 6915.4 6925.0 5283.6 6048.2 6395.9 6434.6 6465.7 3473.5 3595.2 3635.5 3640.8 3648.7 5875.4 6200.4 6934.0 7066.4 7122.8 5719.5 6406.3 6480.5 7009.6 7103.0 6087.7 6553.7 7114.7 7142.5 7157.8 6928.9 6944.7 6954.2 6958.5 7015.4 5933.8 6458.0 6549.0 6851.3 6861.1 5843.8 6181.5 6766.5 7103.8 7107.8 4577.3 4932.1 4991.4 4996.3 4997.9 5926.4 6581.9 6919.5 6945.0 6954.9 5439.4 6561.4 6695.8 6696.2 6701.3 6241.9 6383.7 6594.8 6701.0 6732.5 5450.4 6527.9 6530.6 6532.8 6540.8 5697.4 6068.7 6255.7 6532.5 6692.9 5164.0 5606.9 6445.5 6455.8 6533.1 14:43:59 INFO - PID 1644 | 14:43:59 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:21647.31 Median:18446.45 stddev:30113.61 (163.2%) stddev-sans-first:30157.19 14:43:59 INFO - PID 1644 | Values: 745.4 799.5 802.6 866.9 886.3 16384.6 16810.5 16817.9 18043.1 18718.0 17761.1 17784.8 18005.5 18118.7 18429.4 952.7 960.3 963.6 971.3 978.7 981.4 987.3 989.6 990.7 991.2 1034.8 1036.2 1037.2 1040.1 1040.3 1023.4 1033.3 1033.8 1035.0 1036.6 729.1 741.5 758.2 758.7 760.2 16351.3 16400.9 16526.8 16537.5 16559.4 13684.8 17142.7 17144.1 17239.5 17410.7 13811.1 13882.0 14077.1 14085.3 14091.9 3430.5 3542.3 3542.9 3559.2 3567.2 113261.7 121304.8 121665.8 121696.2 122500.4 13637.7 13857.4 13936.7 13958.2 13981.7 20647.4 25427.6 25887.9 26109.6 26188.7 7583.5 7864.6 7876.4 7884.2 7897.2 3938.8 3979.3 3997.3 4026.0 4037.9 4316.9 4396.1 4399.8 4411.8 4424.5 919.4 946.2 961.3 965.4 965.9 565.4 659.1 667.6 680.1 699.6 10512.8 10850.9 11791.3 11793.9 11983.0 649.9 667.4 667.6 680.2 686.7 4472.6 5008.9 5174.4 5390.8 5396.6 102848.0 103169.0 103387.5 104673.0 105821.5 93813.0 94322.0 94509.5 95001.5 96751.0 68522.7 69823.0 70204.0 70998.0 81894.2 11030.6 11984.8 12429.3 12432.0 12617.7 24288.0 35408.0 38003.6 39245.6 39433.4 57674.7 64835.7 64983.4 67096.3 67140.7 16431.6 16504.8 16542.3 16636.4 16667.5 17876.5 18320.5 18330.9 18342.6 18463.4 16228.4 16473.3 16644.3 16700.9 17366.4 15145.8 17188.7 17729.8 18091.6 18533.9 16786.9 16964.0 17522.5 17626.3 17719.2 9454.0 11516.4 11831.5 11885.5 12157.0 12860.0 13782.8 13838.2 13863.7 13867.4 14:43:59 INFO - PID 1644 | -------- Summary: end -------- 14:43:59 INFO - PID 1644 | 14:44:00 INFO - TEST-INFO | 1644: exit 0 14:44:00 INFO - TEST-OK | dromaeo_css | took 1115315ms 14:44:00 INFO - TEST-START | kraken 14:44:00 INFO - operating with platform_type : mac_ 14:44:00 INFO - Initialising browser for kraken test... 14:44:00 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmpNF2SV2/profile http://localhost:49243/getInfo.html) 14:44:02 INFO - PID 1654 | 2017-04-17 14:44:02.917 plugin-container[1655:10378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 14:44:02 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:02 INFO - PID 1654 | 2017-04-17 14:44:02.919 plugin-container[1655:10378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:44:02 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:02 INFO - PID 1654 | 2017-04-17 14:44:02.919 plugin-container[1655:10378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:44:03 INFO - PID 1654 | __metrics Screen width/height:1600/1200 14:44:03 INFO - PID 1654 | colorDepth:24 14:44:03 INFO - PID 1654 | Browser inner width/height: 1024/689 14:44:03 INFO - PID 1654 | __metrics 14:44:03 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 14:44:04 INFO - TEST-INFO | 1654: exit 0 14:44:04 INFO - Browser initialized. 14:44:04 INFO - Running cycle 1/1 for kraken test... 14:44:04 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/T/tmpNF2SV2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:44:06 INFO - PID 1656 | 2017-04-17 14:44:06.588 plugin-container[1657:10497] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 14:44:06 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:06 INFO - PID 1656 | 2017-04-17 14:44:06.589 plugin-container[1657:10497] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 14:44:06 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:44:06 INFO - PID 1656 | 2017-04-17 14:44:06.589 plugin-container[1657:10497] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:44:16 INFO - PID 1656 | RSS: Main: 236785664 14:44:16 INFO - PID 1656 | 14:44:18 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 14:44:19 INFO - PID 1656 | RSS: Main: 248377344 14:44:19 INFO - PID 1656 | 14:44:22 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 14:44:23 INFO - PID 1656 | RSS: Main: 256626688 14:44:23 INFO - PID 1656 | 14:44:26 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 14:44:27 INFO - PID 1656 | RSS: Main: 259276800 14:44:27 INFO - PID 1656 | 14:44:29 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 14:44:29 INFO - PID 1656 | RSS: Main: 260059136 14:44:29 INFO - PID 1656 | 14:44:31 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:44:32 INFO - PID 1656 | RSS: Main: 260571136 14:44:32 INFO - PID 1656 | 14:44:35 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 14:44:36 INFO - PID 1656 | RSS: Main: 266063872 14:44:36 INFO - PID 1656 | 14:44:39 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 14:44:39 INFO - PID 1656 | RSS: Main: 267694080 14:44:39 INFO - PID 1656 | 14:44:42 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 14:44:43 INFO - PID 1656 | RSS: Main: 267137024 14:44:43 INFO - PID 1656 | 14:44:44 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:44:45 INFO - PID 1656 | RSS: Main: 267874304 14:44:45 INFO - PID 1656 | 14:44:47 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:44:47 INFO - PID 1656 | RSS: Main: 268206080 14:44:47 INFO - PID 1656 | 14:44:49 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:50 INFO - PID 1656 | RSS: Main: 267599872 14:44:50 INFO - PID 1656 | 14:44:53 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:54 INFO - PID 1656 | RSS: Main: 267726848 14:44:54 INFO - PID 1656 | 14:44:57 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:58 INFO - PID 1656 | RSS: Main: 265175040 14:44:58 INFO - PID 1656 | 14:44:59 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 14:45:00 INFO - PID 1656 | RSS: Main: 266850304 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | __start_tp_report 14:45:00 INFO - PID 1656 | _x_x_mozilla_page_load 14:45:00 INFO - PID 1656 | _x_x_mozilla_page_load_details 14:45:00 INFO - PID 1656 | |i|pagename|runs| 14:45:00 INFO - PID 1656 | |0;ai-astar;103;117;116;115;114;115;115;115;114;118 14:45:00 INFO - PID 1656 | |1;audio-beat-detection;149;110;134;188;148;115;142;90;157;148 14:45:00 INFO - PID 1656 | |2;audio-dft;202;204;213;223;217;207;255;225;198;205 14:45:00 INFO - PID 1656 | |3;audio-fft;78;57;60;87;56;59;63;78;94;86 14:45:00 INFO - PID 1656 | |4;audio-oscillator;85;71;85;70;69;70;92;70;71;88 14:45:00 INFO - PID 1656 | |5;imaging-gaussian-blur;93;112;100;92;93;92;103;92;91;93 14:45:00 INFO - PID 1656 | |6;imaging-darkroom;99;99;99;99;99;99;104;99;99;99 14:45:00 INFO - PID 1656 | |7;imaging-desaturate;89;94;101;90;89;90;90;87;90;90 14:45:00 INFO - PID 1656 | |8;json-parse-financial;51;52;53;53;53;52;52;52;52;52 14:45:00 INFO - PID 1656 | |9;json-stringify-tinderbox;59;63;61;59;62;61;57;57;57;56 14:45:00 INFO - PID 1656 | |10;stanford-crypto-aes;84;85;82;83;82;83;84;85;83;85 14:45:00 INFO - PID 1656 | |11;stanford-crypto-ccm;140;137;139;153;132;153;161;146;200;139 14:45:00 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;186;215;242;193;224;162;207;243;217;186 14:45:00 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;72;71;71;69;70;74;99;85;69;71 14:45:00 INFO - PID 1656 | __end_tp_report 14:45:00 INFO - PID 1656 | __start_cc_report 14:45:00 INFO - PID 1656 | _x_x_mozilla_cycle_collect,989 14:45:00 INFO - PID 1656 | __end_cc_report 14:45:00 INFO - PID 1656 | __startTimestamp1492465500058__endTimestamp 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | ------- Summary: start ------- 14:45:00 INFO - PID 1656 | Number of tests: 14 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:4.13 (3.6%) stddev-sans-first:1.33 14:45:00 INFO - PID 1656 | Values: 103.0 117.0 116.0 115.0 114.0 115.0 115.0 115.0 114.0 118.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:148.50 stddev:27.55 (18.6%) stddev-sans-first:28.94 14:45:00 INFO - PID 1656 | Values: 149.0 110.0 134.0 188.0 148.0 115.0 142.0 90.0 157.0 148.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:214.90 Median:215.00 stddev:16.72 (7.8%) stddev-sans-first:17.07 14:45:00 INFO - PID 1656 | Values: 202.0 204.0 213.0 223.0 217.0 207.0 255.0 225.0 198.0 205.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:71.80 Median:78.00 stddev:14.34 (18.4%) stddev-sans-first:15.04 14:45:00 INFO - PID 1656 | Values: 78.0 57.0 60.0 87.0 56.0 59.0 63.0 78.0 94.0 86.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.00 stddev:9.17 (11.8%) stddev-sans-first:9.27 14:45:00 INFO - PID 1656 | Values: 85.0 71.0 85.0 70.0 69.0 70.0 92.0 70.0 71.0 88.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:92.00 stddev:6.84 (7.4%) stddev-sans-first:7.16 14:45:00 INFO - PID 1656 | Values: 93.0 112.0 100.0 92.0 93.0 92.0 103.0 92.0 91.0 93.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:99.00 stddev:1.58 (1.6%) stddev-sans-first:1.67 14:45:00 INFO - PID 1656 | Values: 99.0 99.0 99.0 99.0 99.0 99.0 104.0 99.0 99.0 99.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:90.00 stddev:3.92 (4.4%) stddev-sans-first:4.09 14:45:00 INFO - PID 1656 | Values: 89.0 94.0 101.0 90.0 89.0 90.0 90.0 87.0 90.0 90.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.50 14:45:00 INFO - PID 1656 | Values: 51.0 52.0 53.0 53.0 53.0 52.0 52.0 52.0 52.0 52.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:60.00 stddev:2.44 (4.1%) stddev-sans-first:2.59 14:45:00 INFO - PID 1656 | Values: 59.0 63.0 61.0 59.0 62.0 61.0 57.0 57.0 57.0 56.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 14:45:00 INFO - PID 1656 | Values: 84.0 85.0 82.0 83.0 82.0 83.0 84.0 85.0 83.0 85.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:149.50 stddev:19.69 (13.2%) stddev-sans-first:20.55 14:45:00 INFO - PID 1656 | Values: 140.0 137.0 139.0 153.0 132.0 153.0 161.0 146.0 200.0 139.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.50 Median:216.00 stddev:25.98 (12.0%) stddev-sans-first:26.36 14:45:00 INFO - PID 1656 | Values: 186.0 215.0 242.0 193.0 224.0 162.0 207.0 243.0 217.0 186.0 14:45:00 INFO - PID 1656 | 14:45:00 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:71.50 stddev:9.61 (13.4%) stddev-sans-first:10.13 14:45:00 INFO - PID 1656 | Values: 72.0 71.0 71.0 69.0 70.0 74.0 99.0 85.0 69.0 71.0 14:45:00 INFO - PID 1656 | -------- Summary: end -------- 14:45:00 INFO - PID 1656 | 14:45:01 INFO - TEST-INFO | 1656: exit 0 14:45:01 INFO - TEST-OK | kraken | took 61136ms 14:45:01 INFO - SUITE-END | took 1176s 14:45:01 INFO - Completed test suite (00:19:36) 14:45:01 INFO - javascript benchmark 14:45:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7884.731488389986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.3735252949414, 3331.816750078746, 3402.523646689464, 3659.963400365997, 3672.540932383452, 4791.568758811706, 6144.941444616059, 6186.690665466731, 6284.245890493135, 6340.58786178898, 5962.463378295953, 6182.969085154579, 6235.438810507054, 6270.153529273547, 6290.811275661726, 5502.8349149525575, 5515.117581187011, 5522.751476183581, 5530.668159910399, 5545.334559852823, 4923.383851103444, 5538.086215774392, 5621.156826476041, 5631.549476041927, 5651.2653355063785, 5375.8118465853895, 5460.290162278879, 5549.112142057292, 5550.028744969654, 5586.972065139668, 5452.1276595744885, 5455.645383050089, 5459.69971651559, 5481.095619222863, 5500.697461639608, 4206.326987681956, 5435.945640543583, 5440.265564148829, 5513.255710479114, 5522.834314970557, 6151.108089327023, 6189.381061893775, 6256.937430625727, 6265.9060114097865, 6275.843103922392, 5510.421405752419, 6426.710798014054, 6524.575902566318, 6687.765928192539, 6697.531172817905, 6744.224414192382, 6793.286704895964, 6813.557118787313, 6824.590524568542, 6854.0404343391965, 6303.747850086037, 6337.176167098294, 6340.175777148941, 6359.20509936258, 6364.077208804743, 6718.630475323904, 6839.521233513607, 7023.227444981048, 7031.753888613874, 7033.613151276627, 6462.127612772216, 6575.572587781779, 6614.735410583523, 6639.701213445406, 6644.468442524587, 6754.797356079325, 6772.424343930723, 6784.3894049535775, 6792.01515780219, 6799.218089919723, 6417.679116044179, 6607.6365799880505, 6638.800835974928, 6643.86712265752, 6699.497537684693, 6492.415682588589, 6632.801015969432, 6662.600243985376, 6713.697883595152, 6730.865382692319, 5361.705106219196, 5370.221317908881, 5371.328583927009, 5373.328333958255, 5400.297961265089, 4756.762161891892, 4766.142094423037, 4780.306855505932, 4798.880027999258, 4831.565159135695, 6262.937370626327, 6276.623402595767, 6342.143810585512, 6342.334054924258, 6399.232092148972, 5876.6180198286975, 6563.573367731082, 6786.830329241809, 6849.972504124322, 6880.071190389333, 6371.681415929185, 6380.904286435707, 6389.552731308764, 6401.0, 6421.197350331208, 4943.382077240345, 5255.842324730188, 5475.780968761284, 5938.792142275, 6041.154238406539, 6894.793156205322, 6930.896036559355, 6942.166939967236, 6951.582905025714, 6962.303769622998, 6524.739010439529, 6630.46956243509, 6721.865562688817, 6800.693968771318, 6807.115075040411, 6837.418819400406, 6893.620850853051, 6938.271481494572, 6938.861222775416, 6964.094667693167, 6638.734450621921, 6644.4020038196795, 6660.83347916306, 6665.466762659073, 6672.599644021374, 6480.740770369132, 6633.800985970429, 6672.266050734513, 6723.697433615401, 6783.491238157257, 5519.3652729936575, 6214.9067763984485, 6477.77327793525, 6499.0, 6712.563683360566, 4987.476314986874, 6555.573887697285, 6603.537752357481, 6614.503912206507, 6622.602643841385, 6369.745210191726, 6444.589810297607, 6490.967545162244, 6498.772542960974, 6517.869642607026, 6297.811065668037, 6388.776392826228, 6476.384743449365, 6542.0, 6613.2394774601535, 6400.743970241138, 6405.0, 6411.166548348685, 6412.775552855627, 6422.743090276336], "value": 6094.25775153942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2279050021225, 797.3382092862923, 825.8926339575854, 1265.6645988812966, 1278.852931912829, 38158.23683526331, 38761.80619096901, 38777.806110969475, 38813.0, 38865.22269554611, 38498.422523662164, 38939.41590876139, 38952.0, 39003.609963900424, 39014.60985390152, 8042.914206582095, 8216.917830821674, 8654.264387527068, 8878.778030549223, 8893.644254229823, 8660.783480412978, 8753.47479151253, 8756.299496040301, 8758.60586273616, 8774.517401542913, 8685.609147588342, 8703.390762646617, 8736.0, 8755.649774009033, 8769.912300876973, 8289.129641387657, 8716.912830871674, 8747.606357713887, 8751.168638979287, 8758.386912916098, 7446.73936412223, 8240.21717936795, 8469.618867150994, 8471.788205294917, 8548.74353769388, 37898.43152352717, 38052.809735951145, 38055.0, 38106.61893381058, 38126.61873381286, 3646.9635303646887, 3673.008287762316, 3678.521792167028, 3696.704263658901, 3705.2404257127223, 30862.691373086207, 31129.0, 31238.0, 31240.0, 31482.37035259282, 2938.0, 3086.706762857525, 3189.6331921829055, 3203.119142235904, 3204.086835251942, 250421.0, 299789.0, 301203.0, 309745.0, 311919.0, 46967.76516117398, 47083.5291647086, 47234.29148562774, 47244.0, 47292.7635361821, 39509.01227469336, 50297.24554131691, 51993.48006519886, 53577.1963420549, 53621.391358259316, 14466.566003019927, 14501.709965800625, 14560.980731348916, 14600.85399145995, 14613.269336533343, 11626.593069242535, 11687.0, 11687.824682629767, 11716.121290903217, 11725.941370293265, 13821.516246931309, 13943.721125577431, 13965.650858728613, 14001.579952601438, 14090.647733806736, 5918.141869428995, 5920.4773159969745, 5975.19334889793, 5977.163197152402, 5982.73077711504, 861.8319427711662, 1006.2050979726081, 1025.74869157057, 1027.994860025695, 1069.6790962711154, 18131.64012699053, 23842.761572384054, 24652.0, 24709.87645061799, 25047.62428563573, 1106.3748981825242, 1112.1325366214205, 1141.0529260713754, 1142.9257098288585, 1148.0815347721789, 12023.89395558845, 12472.126951113334, 12493.750124997448, 12551.497940082294, 12570.308633025088, 280532.0, 337979.0, 338665.0, 339259.0, 340459.0, 54519.72740136353, 54756.452435475934, 54926.901461970534, 54991.45008549943, 55058.72470637621, 1488.1740633948264, 1531.1655147944398, 1533.4786172701336, 1554.8989315694444, 1559.7426424640034, 23724.881375593013, 23730.050797967888, 23841.523169536165, 23974.880125599262, 24029.51940961136, 37988.24023519569, 38560.0, 38575.807120964215, 38607.6139238604, 38612.8416147516, 279669.0, 281076.0, 281796.0, 282561.0, 282837.0, 34740.0, 35033.64966350304, 35035.64964350426, 35164.47253291152, 35494.0, 44319.33520997123, 45134.0, 45184.77407612941, 45196.54803451923, 45352.77323613361, 29423.0, 29937.85031074831, 30412.391752165277, 30677.53983690291, 31054.378912421173, 28613.42773144567, 29170.979015735196, 29449.705502944696, 29571.85214073916, 29633.555496668, 36242.8187859059, 36276.0, 36752.816235919716, 36852.81573592115, 36987.0, 30236.0, 30388.544171837, 31146.22134446657, 31204.843975780885, 31374.0, 22837.802707620613, 23412.765872341057, 24043.278701638978, 24467.877660611583, 24521.87739061293], "value": 17674.7049331787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.7093955123188, 424.8980244741263, 433.39974135821876, 439.3914428516505, 449.74589357013303, 21368.679469807947, 21425.785742142572, 21973.560528789414, 21999.34001979939, 22136.778632213674, 21765.67351489725, 22741.317760467173, 23085.422864428398, 23152.30543083706, 23360.64959025612, 4710.835120770774, 5534.418886016951, 5996.710707197952, 6115.357887421824, 6357.332480089593, 6287.371262873722, 6349.492040636738, 6362.5546211765195, 6363.140975968255, 6369.363063693617, 5138.845834624948, 5590.0, 5601.971990140044, 6319.905201421982, 6331.430171284584, 6184.783532576361, 6199.636080062402, 6224.190855188842, 6231.439170474634, 6251.843703907416, 4704.317873908299, 5465.344158700981, 5485.314335708036, 5508.063629183049, 5538.972305138489, 27363.315917102034, 27411.177664670093, 27447.451050978867, 27504.17487475379, 27629.86185069082, 2227.944301392462, 2286.565552545011, 2292.1748170658548, 2292.598795210831, 2293.415179129328, 16890.324387024506, 16995.49013529596, 17021.91489042547, 17211.397601084027, 17262.3958161465, 1967.7835438101797, 1988.0656091636909, 2029.4520479470461, 2030.9593808123755, 2031.6546187148072, 133905.0, 149914.0, 150905.24547377301, 151939.0, 156492.99999999886, 10487.370757754406, 12047.457864395948, 12683.112182147346, 12742.61772146837, 12757.681057973625, 16454.177291135635, 16471.752923706154, 16485.093319867283, 16499.0, 16537.007779533025, 8825.338099642553, 9042.367034307536, 9052.329562778996, 9138.268938484905, 9222.216111630452, 8663.003754568179, 8680.392372533863, 8689.478631282143, 8813.294936405073, 8827.735167944971, 7792.961035194788, 7894.250046245597, 7934.778262086625, 7937.920620793718, 7938.682452701943, 2196.681481185219, 2209.237812954528, 2211.7014203082376, 2218.7892150245702, 2398.088726284001, 775.4920527054788, 921.203159267229, 924.6717415317465, 936.9250459963187, 938.666773295484, 19235.51911202203, 19629.411117666492, 20464.0, 20516.07677654509, 20735.481612959797, 973.6154219083422, 976.4824642939253, 983.9163671088038, 1013.9036791504795, 1014.7822612864445, 10432.947835260928, 10794.650668666416, 10829.620963266249, 10900.400477973788, 10914.017738403581, 539290.9106363407, 587169.0, 595397.0, 598238.0, 600056.0, 101585.0, 112050.01724215463, 112494.43752781184, 113739.0, 119157.0, 1208.3897631696113, 1209.3711270139654, 1247.975040499203, 1249.6750844780422, 1253.8558065822365, 14225.715485690022, 18064.825786323847, 18161.909190453964, 18189.909050454662, 18472.630547389246, 54045.91908161894, 54446.72776636091, 55610.0, 55793.72103139458, 56965.575860603814, 54099.459005409444, 56084.0, 61553.76892462036, 77534.2246577527, 79518.20481795339, 8389.203025712548, 8417.452865563719, 8654.82690346202, 8669.869951950852, 8944.463332199828, 13649.590512284647, 13731.725365492834, 13858.584242472742, 13984.0, 14129.505467308594, 10029.796424429116, 11509.769804603693, 11631.568687237115, 11795.469203886018, 11831.0, 10694.786104277715, 10905.018548330689, 11020.834687479855, 11167.385793781095, 11168.441577921234, 11869.465874035517, 12085.274883507018, 12184.878151218374, 12192.451339689558, 12210.328431936328, 7249.7675395184, 8544.487330760174, 8616.138386161334, 8669.916260467442, 8752.431091979255, 10258.794824103625, 11620.593279235525, 11937.940310298392, 12045.133004384334, 12077.879221207675], "value": 10241.61522965372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.4286942353635, 1442.725882082405, 1443.4875619155207, 1446.8352975854439, 1479.9186044767537, 10717.571297148104, 11048.281861678985, 11338.659840204797, 11719.472623731932, 12187.817182742267, 11723.355215463145, 11963.940180299109, 11992.760144797121, 12020.038396928247, 12020.759584808298, 2507.636392723054, 2545.3127655532994, 2550.7066687331007, 2552.629868669042, 2556.4503631719176, 2402.387391215246, 2480.6651102101255, 2489.825712200147, 2523.5962246040635, 2526.898924043045, 2465.987670061656, 2504.8622325772076, 2511.7613826686434, 2521.1680145551923, 2523.1169090818157, 2443.4135807406183, 2497.113524698733, 2506.1103308325646, 2517.3706573356662, 2525.393905462685, 1923.2979962313796, 2411.493586346869, 2499.7750202481866, 2506.3358210074343, 2533.075427468979, 11839.704007399798, 11932.343721095336, 11932.70168245792, 11942.761144777056, 11947.701307467383, 6562.343765623447, 6776.830579235559, 6819.147606549182, 6821.658917054177, 6824.761133360358, 3542.4863394807867, 4119.752814831119, 4332.393464914914, 4387.078713470143, 4402.449693788277, 1245.5391505143064, 1265.6772523006666, 1266.9326634156007, 1275.5599318235195, 1292.4700872642172, 13498.865011349859, 16052.03687778737, 16451.341946322133, 16526.83473165265, 16552.5930295925, 4965.535167125707, 5520.530754885799, 5655.349634792052, 5830.679312637845, 5864.970675146682, 10051.296409251283, 12091.790820917839, 12453.75092498145, 12479.93760031194, 12479.937600312122, 5434.972825135849, 6635.601863888182, 6642.302558231413, 6650.3349665034075, 6651.767188148391, 6085.5435842312, 6159.199304090529, 6221.5333849961435, 6232.407921247474, 6246.906296405557, 4454.443194600675, 4512.954870451254, 4541.250693635513, 4550.271956486946, 4637.234856248681, 1239.4856134703996, 1315.8223639808696, 1325.1982550556775, 1336.245021562814, 1344.7781116115732, 684.7261095561815, 794.2454668065361, 802.835418739157, 821.6877586517205, 835.6949713354581, 6666.799996000128, 6798.150231221098, 6993.615351155735, 7013.719451221894, 7117.857642847114, 913.9314551408671, 939.910708482693, 951.8857737071596, 952.9428234305964, 959.3236768078488, 3367.983160084184, 4143.212789569972, 4335.609795118455, 4347.369631403429, 4522.751248681354, 14555.708885822436, 15010.049151294485, 15131.54605361841, 15164.24178791056, 15249.542513724606, 14881.627959300888, 15207.467738629095, 15209.087454752751, 15284.770728439082, 15302.158381289137, 5450.754716037788, 8559.786005349792, 8620.698275560326, 8711.738647840575, 8733.25767309773, 6457.6448295342325, 7160.964195178991, 7240.6017669026605, 7249.782506524813, 7250.673719682522, 12821.679458013625, 12845.678858028625, 12850.228986260854, 12869.806952895902, 13482.865171348161, 11152.776944461228, 13665.795013074612, 13942.302884855919, 14011.299435028004, 14062.859371406155, 8083.393745469231, 9356.719298421058, 9556.95221523888, 9660.613575456902, 9670.56482458305, 10762.246642734934, 10771.46142692878, 10778.514966826355, 10894.074003709457, 10932.0, 9259.35184537103, 9282.468392715127, 9288.11762882525, 9310.534473276173, 9332.72001839946, 7418.332350088518, 9036.728898133066, 9040.276777857887, 9063.592138353923, 9077.364584479286, 8083.474574152661, 8178.550179740171, 8218.794530136554, 8220.917790822015, 8222.424430289822, 6013.278406591237, 6126.264848218242, 6134.754609815557, 6192.81421557354, 6215.502759779297, 6030.969845150747, 6130.295016073031, 6197.907031394623, 6258.906116408349, 6340.524460665561], "value": 5401.849533426215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.656583621004, 404.9250888585612, 405.3919121318023, 406.92675318442684, 413.92342416652923, 5693.544516438686, 6277.591956522823, 6369.840753981152, 6370.585911915722, 6381.680915954201, 4507.504174540806, 4914.631402644807, 5967.075103358976, 6015.669138197398, 6076.605020673653, 3965.2267807777494, 4737.028909073631, 4739.52604739525, 4762.261849413347, 4777.617790576763, 4771.117343291485, 4783.325835957422, 4789.700943547099, 4791.952080479203, 4795.352627395292, 4336.002719374545, 4551.610404537611, 4618.953810461902, 4705.2236380997265, 4714.811407543694, 4277.508086570022, 4423.535528769481, 4662.603678687298, 4711.939813541926, 4734.880653831189, 3974.5627980922077, 4180.372944058385, 4187.2044311581, 4200.537940826537, 4206.26390381682, 5661.46216109469, 6025.9096113558335, 6079.422454866781, 6098.237720284965, 6201.224846894138, 4958.9008219835405, 5439.972800136014, 5440.401555828856, 5445.863853403657, 5454.509094181503, 5800.477956983892, 6045.183900173464, 6138.9693051534905, 6293.748250069992, 6697.6986035628515, 3511.682289688819, 4107.732997355162, 4376.912461750779, 4403.669724770655, 4423.424954755893, 6858.0, 6977.790666279969, 7073.858522829566, 7081.768044121191, 7095.858082838366, 3758.0, 4458.7547684877645, 4510.44389685558, 4511.05267893746, 4525.932111018337, 4597.954020459752, 4603.470600880942, 4603.608693261111, 4605.263157894788, 4656.16189085961, 4555.544445555484, 4658.930116048262, 5242.898991211812, 5439.728013599383, 5440.347158341025, 6203.31763506014, 6234.251889773256, 6519.152510173742, 6649.767258146038, 6672.86654266912, 1371.5542448704211, 1455.8571521355684, 1541.306412114553, 1569.1683407793887, 1571.395012920034, 749.0, 992.6327258914248, 997.6458357283205, 1004.3321191407778, 1019.0115587879744, 5637.633553818989, 6351.460125889259, 6377.968110159512, 6381.553291269566, 6397.840053998594, 5713.657400465789, 6012.368701286389, 6632.204135503771, 6915.446764258847, 6924.965375173092, 5283.5773138149625, 6048.243969503812, 6395.872082558416, 6434.581752186186, 6465.741370345134, 3473.513708080871, 3595.209054008114, 3635.4733460244875, 3640.7997560134445, 3648.6864728697647, 5875.353711091777, 6200.410960958701, 6933.965330173317, 7066.3993560546905, 7122.786316410516, 5719.542436605062, 6406.263279722798, 6480.4815614750705, 7009.598080383842, 7103.0, 6087.691146403545, 6553.737850485927, 7114.679839407239, 7142.5000249982, 7157.821054473679, 6928.911941954271, 6944.652767361713, 6954.235034146139, 6958.478114141561, 7015.368616824306, 5933.762649493972, 6457.964756564407, 6548.967255163694, 6851.314868513109, 6861.142357205349, 5843.795467158629, 6181.53638477125, 6766.4963963333885, 7103.82240443993, 7107.75122870697, 4577.267637178169, 4932.087563800708, 4991.3511243538105, 4996.300517927566, 4997.925031124609, 5926.436988486087, 6581.901271480836, 6919.515633905578, 6945.0, 6954.895676564956, 5439.4288599696465, 6561.40947314744, 6695.832604184934, 6696.1629796275465, 6701.262861085179, 6241.940159747363, 6383.680815959091, 6594.77996570636, 6700.966495167493, 6732.461403087839, 5450.373207081077, 6527.934720652733, 6530.608163510205, 6532.771353002622, 6540.803775886731, 5697.350731909682, 6068.666223357758, 6255.655938923403, 6532.477401807749, 6692.933070669231, 5163.974180129076, 5606.943930560806, 6445.452136568444, 6455.7740479083, 6533.052707357311], "value": 4814.530149746584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.3776096959039, 799.540264348, 802.5826570183505, 866.9263112635425, 886.2865393358346, 16384.59038524036, 16810.495685129452, 16817.906836055663, 18043.097845107724, 18718.0, 17761.06942354513, 17784.843985140957, 18005.459836204904, 18118.728219076693, 18429.44711658649, 952.7284723853703, 960.3325688646358, 963.6241865672393, 971.3491960386523, 978.6917121106865, 981.3866333541537, 987.2694206287367, 989.5596459575492, 990.6780296403698, 991.2169386184905, 1034.751659601694, 1036.2435422141841, 1037.2169012395632, 1040.0743338428804, 1040.2977989856815, 1023.4371095897227, 1033.3128469567728, 1033.8345864661655, 1035.0012238190106, 1036.5801850250662, 729.0777166883896, 741.4661443760538, 758.169804064554, 758.7003133762133, 760.224570937646, 16351.345946162139, 16400.917995410065, 16526.843120981535, 16537.503874883772, 16559.42042028523, 13684.794728079087, 17142.742858857127, 17144.05707686077, 17239.482815515556, 17410.651786964318, 13811.102278351875, 13882.028258021943, 14077.084989475652, 14085.295735213198, 14091.859081409157, 3430.485427185917, 3542.3446662367287, 3542.929141417183, 3559.199180184464, 3567.161716996504, 113261.73476530505, 121304.78695213023, 121665.78334216632, 121696.17455738172, 122500.38749806283, 13637.659058523615, 13857.436374270792, 13936.721265574835, 13958.232297223547, 13981.650458738613, 20647.380578582666, 25427.61858572123, 25887.870560647076, 26109.608355874676, 26188.738112619012, 7583.544987300779, 7864.567448790257, 7876.369890408753, 7884.17216192303, 7897.210278972172, 3938.8030598469963, 3979.263836190314, 3997.320455522568, 4026.0, 4037.9192416151513, 4316.899190706413, 4396.142752163361, 4399.780010999437, 4411.84558540456, 4424.513303536608, 919.4253591505309, 946.1626460582435, 961.3270710502676, 965.3676841668719, 965.8551217317319, 565.4204440448573, 659.1102012283379, 667.6361383046251, 680.0547239337325, 699.566268913277, 10512.789744205225, 10850.891491085145, 11791.29252244868, 11793.882061179278, 11983.0, 649.8667773106501, 667.3993405934698, 667.5894324990096, 680.1775412326627, 686.6909890549173, 4472.552744725502, 5008.874778130576, 5174.43081261061, 5390.838274851761, 5396.64921780083, 102848.0, 103169.0, 103387.48306258571, 104673.0, 105821.47089264504, 93813.0, 94322.0, 94509.52745236368, 95001.5249923746, 96751.0, 68522.65738671375, 69823.0, 70204.0, 70997.99999999897, 81894.18105818865, 11030.613928512463, 11984.820227696417, 12429.254244745343, 12431.954171227746, 12617.684557886127, 24288.0, 35408.0, 38003.61996380001, 39245.6075439242, 39433.40849887197, 57674.711626441596, 64835.67582162059, 64983.353495766416, 67096.32259193559, 67140.66429667821, 16431.58921026936, 16504.83495165033, 16542.255598498337, 16636.417725379553, 16667.499975000283, 17876.463706088838, 18320.450386487893, 18330.90834545819, 18342.633147337245, 18463.446096617125, 16228.432004879773, 16473.34106635721, 16644.251008704396, 16700.916495417445, 17366.39217627377, 15145.848541514884, 17188.656226875144, 17729.822701772817, 18091.638167236844, 18533.9073304638, 16786.916065419595, 16963.982161070377, 17522.474325770247, 17626.29494820244, 17719.20263588116, 9453.952730236304, 11516.356985077084, 11831.52673893069, 11885.465154067915, 12157.0, 12860.0, 13782.793258101337, 13838.238896860366, 13863.72272554523, 13867.375968081662], "value": 8374.394155694368, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 116.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 118.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 134.0, 188.0, 148.0, 115.0, 142.0, 90.0, 157.0, 148.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 204.0, 213.0, 223.0, 217.0, 207.0, 255.0, 225.0, 198.0, 205.0], "value": 214.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 60.0, 87.0, 56.0, 59.0, 63.0, 78.0, 94.0, 86.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 85.0, 70.0, 69.0, 70.0, 92.0, 70.0, 71.0, 88.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 112.0, 100.0, 92.0, 93.0, 92.0, 103.0, 92.0, 91.0, 93.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 99.0, 99.0, 99.0, 104.0, 99.0, 99.0, 99.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 101.0, 90.0, 89.0, 90.0, 90.0, 87.0, 90.0, 90.0], "value": 91.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 61.0, 59.0, 62.0, 61.0, 57.0, 57.0, 57.0, 56.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 83.0, 82.0, 83.0, 84.0, 85.0, 83.0, 85.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 139.0, 153.0, 132.0, 153.0, 161.0, 146.0, 200.0, 139.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 215.0, 242.0, 193.0, 224.0, 162.0, 207.0, 243.0, 217.0, 186.0], "value": 207.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 69.0, 70.0, 74.0, 99.0, 85.0, 69.0, 71.0], "value": 75.1, "unit": "score"}]}]} 14:45:01 INFO - Return code: 0 14:45:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:45:01 ERROR - # TBPL SUCCESS # 14:45:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:45:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:45:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:45:01 INFO - 2017-04-17 14:45:01.406 screenresolution[1662:10898] starting screenresolution argv=screenresolution get 14:45:01 INFO - 2017-04-17 14:45:01.409 screenresolution[1662:10898] Display 0: 1600x1200x32@60 14:45:01 INFO - 2017-04-17 14:45:01.415 screenresolution[1663:10901] starting screenresolution argv=screenresolution list 14:45:01 INFO - Available Modes on Display 0 14:45:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:45:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:45:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:45:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:45:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:45:01 INFO - Intel Iris: 14:45:01 INFO - Chipset Model: Intel Iris 14:45:01 INFO - Type: GPU 14:45:01 INFO - Bus: Built-In 14:45:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:45:01 INFO - Vendor: Intel (0x8086) 14:45:01 INFO - Device ID: 0x0a2e 14:45:01 INFO - Revision ID: 0x0009 14:45:01 INFO - Displays: 14:45:01 INFO - Display: 14:45:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:45:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:45:01 INFO - Display Serial Number: 1600x1200 60 14:45:01 INFO - Main Display: Yes 14:45:01 INFO - Mirror: Off 14:45:01 INFO - Online: Yes 14:45:01 INFO - Rotation: Supported 14:45:01 INFO - Return code: 0 14:45:01 INFO - Running post-action listener: _resource_record_post_action 14:45:01 INFO - [mozharness: 2017-04-17 21:45:01.665554Z] Finished run-tests step (success) 14:45:01 INFO - Running post-run listener: _resource_record_post_run 14:45:01 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 32567808; Write bytes: 516143104; Read time: 201; Write time: 1662 14:45:01 INFO - TinderboxPrint: CPU usage
54.1% 14:45:01 INFO - TinderboxPrint: I/O read bytes / time
32,567,808 / 201 14:45:01 INFO - TinderboxPrint: I/O write bytes / time
516,143,104 / 1,662 14:45:01 INFO - TinderboxPrint: CPU idle
2,197.7 (45.9%) 14:45:01 INFO - TinderboxPrint: CPU system
965.0 (20.1%) 14:45:01 INFO - TinderboxPrint: CPU user
1,627.1 (34.0%) 14:45:01 INFO - TinderboxPrint: Swap in / out
237,477,888 / 0 14:45:01 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204274176; Write bytes: 203407360; Read time: 16139; Write time: 426 14:45:01 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30671360; Write bytes: 305940480; Read time: 186; Write time: 1209 14:45:02 INFO - Running post-run listener: _upload_blobber_files 14:45:02 INFO - Blob upload gear active. 14:45:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:45:02 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 14:45:02 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:45:02 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:45:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:03 INFO - (blobuploader) - INFO - Done attempting. 14:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:04 INFO - (blobuploader) - INFO - Done attempting. 14:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:05 INFO - (blobuploader) - INFO - Done attempting. 14:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:45:07 INFO - (blobuploader) - INFO - Done attempting. 14:45:07 INFO - (blobuploader) - INFO - Iteration through files over. 14:45:07 INFO - Return code: 0 14:45:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:45:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:45:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7bfe10bd4171d7f7dc82cd70c5364e183a36967815fe834c7f542f1f7eb499960376bf38b2ffd1244ed5570b731f06ac39b7de834d16ec66f77bf7f5cbae5ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7bd9f35e6fa7f595a66b64e5f479e125c69c697cf24d363fee68e21f038345caa721fb6637118117c79438a4604767439cd332d298d75a96ddf90be8b13d5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/293e041d92f9ad3f1423b4075a12ed51d09dd3ec65ec112fc913c9f996a307822ee6e23857db121f3fabe6b5fa25a88c4bf38968d823086a90c4729068f81099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a060a60d16dad941527650802b9bca6ebe78610f26f3ca9adce19dcba14ae5080a741362a33b15fef9b56e074ecf88cde58e3ffb5f2f8c423bbca3d296f442f"} 14:45:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:45:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:45:07 INFO - Contents: 14:45:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7bfe10bd4171d7f7dc82cd70c5364e183a36967815fe834c7f542f1f7eb499960376bf38b2ffd1244ed5570b731f06ac39b7de834d16ec66f77bf7f5cbae5ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7bd9f35e6fa7f595a66b64e5f479e125c69c697cf24d363fee68e21f038345caa721fb6637118117c79438a4604767439cd332d298d75a96ddf90be8b13d5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/293e041d92f9ad3f1423b4075a12ed51d09dd3ec65ec112fc913c9f996a307822ee6e23857db121f3fabe6b5fa25a88c4bf38968d823086a90c4729068f81099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a060a60d16dad941527650802b9bca6ebe78610f26f3ca9adce19dcba14ae5080a741362a33b15fef9b56e074ecf88cde58e3ffb5f2f8c423bbca3d296f442f"} 14:45:07 INFO - Running post-run listener: copy_logs_to_upload_dir 14:45:07 INFO - Copying logs to upload dir... 14:45:07 INFO - mkdir: /builds/slave/test/build/upload/logs 14:45:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.489024 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-17 14:45:07.544371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:07.548271) ========= 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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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/Firefox/sha512/b7bfe10bd4171d7f7dc82cd70c5364e183a36967815fe834c7f542f1f7eb499960376bf38b2ffd1244ed5570b731f06ac39b7de834d16ec66f77bf7f5cbae5ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7bd9f35e6fa7f595a66b64e5f479e125c69c697cf24d363fee68e21f038345caa721fb6637118117c79438a4604767439cd332d298d75a96ddf90be8b13d5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/293e041d92f9ad3f1423b4075a12ed51d09dd3ec65ec112fc913c9f996a307822ee6e23857db121f3fabe6b5fa25a88c4bf38968d823086a90c4729068f81099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a060a60d16dad941527650802b9bca6ebe78610f26f3ca9adce19dcba14ae5080a741362a33b15fef9b56e074ecf88cde58e3ffb5f2f8c423bbca3d296f442f"} build_url:https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011126 build_url: 'https://queue.taskcluster.net/v1/task/QluvOt4aQQKXWpXRDe5ANQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b7bfe10bd4171d7f7dc82cd70c5364e183a36967815fe834c7f542f1f7eb499960376bf38b2ffd1244ed5570b731f06ac39b7de834d16ec66f77bf7f5cbae5ea", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7bd9f35e6fa7f595a66b64e5f479e125c69c697cf24d363fee68e21f038345caa721fb6637118117c79438a4604767439cd332d298d75a96ddf90be8b13d5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/293e041d92f9ad3f1423b4075a12ed51d09dd3ec65ec112fc913c9f996a307822ee6e23857db121f3fabe6b5fa25a88c4bf38968d823086a90c4729068f81099", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a060a60d16dad941527650802b9bca6ebe78610f26f3ca9adce19dcba14ae5080a741362a33b15fef9b56e074ecf88cde58e3ffb5f2f8c423bbca3d296f442f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:07.583683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:07.584069) ========= 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.WDIHx2qLnQ/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.8W0zW9bkV3/Listeners TMPDIR=/var/folders/tg/9cs16h3j7pn5rd3v0kkz9lgc00000w/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.004978 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 14:45:07.632773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 14:45:07.633091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 14:45:07.633443) ========= ========= Total master_lag: 0.48 =========