builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0180 starttime: 1492770229.89 results: success (0) buildid: 20170421015828 builduid: 5a90c7a08d2d47c79c99d00564b17b0a revision: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:49.894157) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:49.894673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:49.894992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:49.922039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:49.922486) ========= 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.mv6t6KMFST/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.Ml1GdZO86m/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-21 03:23:49-- 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% 164M=0s 2017-04-21 03:23:50 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:50.078847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:50.079245) ========= 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.mv6t6KMFST/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.Ml1GdZO86m/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.028522 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:50.129683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:23:50.130073) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 --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 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mv6t6KMFST/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.Ml1GdZO86m/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-21 03:23:50,234 truncating revision to first 12 chars 2017-04-21 03:23:50,234 Setting DEBUG logging. 2017-04-21 03:23:50,234 attempt 1/10 2017-04-21 03:23:50,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/950b641e2b9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 03:23:51,059 unpacking tar archive at: mozilla-central-950b641e2b9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.100577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:23:51.254749) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:51.255142) ========= script_repo_revision: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:51.255610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:51.255918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:23:51.275055) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-21 03:23:51.275477) ========= /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.mv6t6KMFST/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.Ml1GdZO86m/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:23:51 INFO - MultiFileLogger online at 20170421 03:23:51 in /builds/slave/test 03:23:51 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 03:23:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:51 INFO - {'append_to_log': False, 03:23:51 INFO - 'base_work_dir': '/builds/slave/test', 03:23:51 INFO - 'blob_upload_branch': 'Firefox', 03:23:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:51 INFO - 'branch': 'Firefox', 03:23:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:51 INFO - 'config_files': ('talos/mac_config.py',), 03:23:51 INFO - 'default_actions': ('clobber', 03:23:51 INFO - 'read-buildbot-config', 03:23:51 INFO - 'download-and-extract', 03:23:51 INFO - 'populate-webroot', 03:23:51 INFO - 'create-virtualenv', 03:23:51 INFO - 'install', 03:23:51 INFO - 'run-tests'), 03:23:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:51 INFO - 'download_minidump_stackwalk': True, 03:23:51 INFO - 'download_symbols': 'ondemand', 03:23:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:23:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:23:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:23:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:23:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:51 INFO - 'gecko_profile': False, 03:23:51 INFO - 'gecko_profile_interval': 0, 03:23:51 INFO - 'installer_path': 'installer.exe', 03:23:51 INFO - 'log_level': 'info', 03:23:51 INFO - 'log_name': 'talos', 03:23:51 INFO - 'log_to_console': True, 03:23:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:23:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:23:51 INFO - 'opt_config_files': (), 03:23:51 INFO - 'pip_index': False, 03:23:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:51 INFO - 'cmd': ('bash', 03:23:51 INFO - '-c', 03:23:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:51 INFO - 'enabled': True, 03:23:51 INFO - 'halt_on_failure': False, 03:23:51 INFO - 'name': 'check_screen_resolution'},), 03:23:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:23:51 INFO - 'cmd': ('bash', 03:23:51 INFO - '-c', 03:23:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:23:51 INFO - 'enabled': True, 03:23:51 INFO - 'halt_on_failure': False, 03:23:51 INFO - 'name': 'check_screen_resolution'},), 03:23:51 INFO - 'run_cmd_checks_enabled': True, 03:23:51 INFO - 'suite': 'dromaeojs-e10s', 03:23:51 INFO - 'system_bits': '32', 03:23:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:51 INFO - 'title': 't-yosemite-r7-0180', 03:23:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:51 INFO - 'use_talos_json': True, 03:23:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:51 INFO - 'work_dir': 'build'} 03:23:51 INFO - [mozharness: 2017-04-21 10:23:51.493374Z] Running clobber step. 03:23:51 INFO - Running pre-action listener: _resource_record_pre_action 03:23:51 INFO - Running main action method: clobber 03:23:51 INFO - rmtree: /builds/slave/test/build 03:23:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:54 INFO - Running post-action listener: _resource_record_post_action 03:23:54 INFO - [mozharness: 2017-04-21 10:23:54.032256Z] Finished clobber step (success) 03:23:54 INFO - [mozharness: 2017-04-21 10:23:54.032427Z] Running read-buildbot-config step. 03:23:54 INFO - Running pre-action listener: _resource_record_pre_action 03:23:54 INFO - Running main action method: read_buildbot_config 03:23:54 INFO - Using buildbot properties: 03:23:54 INFO - { 03:23:54 INFO - "project": "", 03:23:54 INFO - "product": "firefox", 03:23:54 INFO - "script_repo_revision": "production", 03:23:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:23:54 INFO - "repository": "", 03:23:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:23:54 INFO - "buildid": "20170421015828", 03:23:54 INFO - "pgo_build": "False", 03:23:54 INFO - "basedir": "/builds/slave/test", 03:23:54 INFO - "buildnumber": 34, 03:23:54 INFO - "slavename": "t-yosemite-r7-0180", 03:23:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:23:54 INFO - "platform": "yosemite_r7", 03:23:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:23:54 INFO - "branch": "mozilla-central", 03:23:54 INFO - "repo_path": "mozilla-central", 03:23:54 INFO - "revision": "950b641e2b9c5109ee8df6b2d39f09529d0f3c38", 03:23:54 INFO - "stage_platform": "macosx64", 03:23:54 INFO - "builduid": "5a90c7a08d2d47c79c99d00564b17b0a", 03:23:54 INFO - "slavebuilddir": "test" 03:23:54 INFO - } 03:23:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:23:54 INFO - Running post-action listener: _resource_record_post_action 03:23:54 INFO - [mozharness: 2017-04-21 10:23:54.035848Z] Finished read-buildbot-config step (success) 03:23:54 INFO - [mozharness: 2017-04-21 10:23:54.035982Z] Running download-and-extract step. 03:23:54 INFO - Running pre-action listener: _resource_record_pre_action 03:23:54 INFO - Running main action method: download_and_extract 03:23:54 INFO - mkdir: /builds/slave/test/build/tests 03:23:54 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')]} 03:23:54 INFO - trying https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:23:54 INFO - Downloading https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/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 03:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/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 03:23:55 INFO - Downloaded 1325 bytes. 03:23:55 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:23:55 INFO - Using the following test package requirements: 03:23:55 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:23:55 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:23:55 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:23:55 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:23:55 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'jsshell-mac.zip'], 03:23:55 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:23:55 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:23:55 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:23:55 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:23:55 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:23:55 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:23:55 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:23:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:23:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:23:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:23:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:23:57 INFO - Content-Length response header: 52522978 03:23:57 INFO - Bytes received: 52522978 03:24:13 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 03:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:24:14 INFO - Content-Length response header: 52522978 03:24:14 INFO - Bytes received: 52522978 03:24:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:24:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:24:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:24:31 INFO - Content-Length response header: 14408811 03:24:31 INFO - Bytes received: 14408811 03:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:31 INFO - trying https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:24:31 INFO - Downloading https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/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 03:24:33 INFO - Downloaded 71027314 bytes. 03:24:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:24:33 INFO - mkdir: /builds/slave/test/properties 03:24:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:33 INFO - Contents: 03:24:33 INFO - build_url:https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:24:34 INFO - Running post-action listener: _resource_record_post_action 03:24:34 INFO - Running post-action listener: set_extra_try_arguments 03:24:34 INFO - [mozharness: 2017-04-21 10:24:34.190663Z] Finished download-and-extract step (success) 03:24:34 INFO - [mozharness: 2017-04-21 10:24:34.190783Z] Running populate-webroot step. 03:24:34 INFO - Running pre-action listener: _resource_record_pre_action 03:24:34 INFO - Running main action method: populate_webroot 03:24:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:34 INFO - '--tppagecycles', 03:24:34 INFO - '7'], 03:24:34 INFO - 'tests': ['tsvgm']}}, 03:24:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['damp', 'tps']}, 03:24:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'tests': ['damp', 'tps']}, 03:24:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['dromaeo_dom']}, 03:24:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:24:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:24:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['a11yr', 03:24:34 INFO - 'ts_paint', 03:24:34 INFO - 'tpaint', 03:24:34 INFO - 'sessionrestore', 03:24:34 INFO - 'sessionrestore_no_auto_restore', 03:24:34 INFO - 'tabpaint']}, 03:24:34 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:24:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:24:34 INFO - 'bloom_basic_ref']}, 03:24:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tsvgx', 03:24:34 INFO - 'tsvgr_opacity', 03:24:34 INFO - 'tart', 03:24:34 INFO - 'tscrollx', 03:24:34 INFO - 'cart', 03:24:34 INFO - 'tsvg_static']}, 03:24:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:34 INFO - 'tsvgr_opacity', 03:24:34 INFO - 'tart', 03:24:34 INFO - 'tscrollx', 03:24:34 INFO - 'cart', 03:24:34 INFO - 'tsvg_static']}, 03:24:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s'], 03:24:34 INFO - 'tests': ['tp5o']}, 03:24:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:24:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'talos_options': ['--disable-e10s', 03:24:34 INFO - '--xperf_path', 03:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:34 INFO - 'tests': ['tp5n']}, 03:24:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:24:34 INFO - 'talos_options': ['--xperf_path', 03:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:34 INFO - 'tests': ['tp5n']}}, 03:24:34 INFO - 'talos.zip': {'path': '', 03:24:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:34 INFO - Running post-action listener: _resource_record_post_action 03:24:34 INFO - [mozharness: 2017-04-21 10:24:34.210483Z] Finished populate-webroot step (success) 03:24:34 INFO - [mozharness: 2017-04-21 10:24:34.210624Z] Running create-virtualenv step. 03:24:34 INFO - Running pre-action listener: _resource_record_pre_action 03:24:34 INFO - Running main action method: create_virtualenv 03:24:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:34 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 03:24:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:34 INFO - Using real prefix '/tools/python27' 03:24:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:37 INFO - Installing pip.................done. 03:24:37 INFO - Return code: 0 03:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:24:38 INFO - Reading from file tmpfile_stdout 03:24:38 INFO - Output received: 03:24:38 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) 03:24:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:38 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')]} 03:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:38 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')]} 03:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:38 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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:24:38 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 03:24:38 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 03:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:38 INFO - 'HOME': '/Users/cltbld', 03:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:38 INFO - 'LOGNAME': 'cltbld', 03:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:38 INFO - 'MOZ_NO_REMOTE': '1', 03:24:38 INFO - 'NO_EM_RESTART': '1', 03:24:38 INFO - 'PAGER': '/bin/cat', 03:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:38 INFO - 'PWD': '/builds/slave/test', 03:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:38 INFO - 'SHELL': '/bin/bash', 03:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:38 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:38 INFO - 'USER': 'cltbld', 03:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:38 INFO - 'XPC_FLAGS': '0x0', 03:24:38 INFO - 'XPC_SERVICE_NAME': '0', 03:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:38 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 03:24:38 INFO - Cleaning up... 03:24:38 INFO - Return code: 0 03:24:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:38 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')]} 03:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:38 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')]} 03:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:38 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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:24:38 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 03:24:38 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 03:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:38 INFO - 'HOME': '/Users/cltbld', 03:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:38 INFO - 'LOGNAME': 'cltbld', 03:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:38 INFO - 'MOZ_NO_REMOTE': '1', 03:24:38 INFO - 'NO_EM_RESTART': '1', 03:24:38 INFO - 'PAGER': '/bin/cat', 03:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:38 INFO - 'PWD': '/builds/slave/test', 03:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:38 INFO - 'SHELL': '/bin/bash', 03:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:38 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:38 INFO - 'USER': 'cltbld', 03:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:38 INFO - 'XPC_FLAGS': '0x0', 03:24:38 INFO - 'XPC_SERVICE_NAME': '0', 03:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:38 INFO - Downloading/unpacking psutil>=3.1.1 03:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:42 INFO - Installing collected packages: psutil 03:24:42 INFO - Running setup.py install for psutil 03:24:42 INFO - building 'psutil._psutil_osx' extension 03:24:42 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 03:24:42 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 03:24:43 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 03:24:43 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 03:24:43 INFO - building 'psutil._psutil_posix' extension 03:24:43 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 03:24:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:24:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:24:43 INFO - ^ 03:24:43 INFO - 1 warning generated. 03:24:43 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 03:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:43 INFO - Successfully installed psutil 03:24:43 INFO - Cleaning up... 03:24:43 INFO - Return code: 0 03:24:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03: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 mozsystemmonitor==0.3 03:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:43 INFO - 'HOME': '/Users/cltbld', 03:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:43 INFO - 'LOGNAME': 'cltbld', 03:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:43 INFO - 'MOZ_NO_REMOTE': '1', 03:24:43 INFO - 'NO_EM_RESTART': '1', 03:24:43 INFO - 'PAGER': '/bin/cat', 03:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:43 INFO - 'PWD': '/builds/slave/test', 03:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:43 INFO - 'SHELL': '/bin/bash', 03:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:43 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:43 INFO - 'USER': 'cltbld', 03:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:43 INFO - 'XPC_FLAGS': '0x0', 03:24:43 INFO - 'XPC_SERVICE_NAME': '0', 03:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:46 INFO - Installing collected packages: mozsystemmonitor 03:24:46 INFO - Running setup.py install for mozsystemmonitor 03:24:46 INFO - Successfully installed mozsystemmonitor 03:24:46 INFO - Cleaning up... 03:24:46 INFO - Return code: 0 03:24:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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', '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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03: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 jsonschema==2.5.1 03:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:47 INFO - 'HOME': '/Users/cltbld', 03:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:47 INFO - 'LOGNAME': 'cltbld', 03:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:47 INFO - 'MOZ_NO_REMOTE': '1', 03:24:47 INFO - 'NO_EM_RESTART': '1', 03:24:47 INFO - 'PAGER': '/bin/cat', 03:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:47 INFO - 'PWD': '/builds/slave/test', 03:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:47 INFO - 'SHELL': '/bin/bash', 03:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:47 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:47 INFO - 'USER': 'cltbld', 03:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:47 INFO - 'XPC_FLAGS': '0x0', 03:24:47 INFO - 'XPC_SERVICE_NAME': '0', 03:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:47 INFO - Downloading/unpacking jsonschema==2.5.1 03:24:47 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 03:24:47 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 03:24:47 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 03:24:47 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 03:24:47 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 03:24:47 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 03:24:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03: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 03: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 03: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 03: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 03: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 03: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 03:24:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:51 INFO - warning: no files found matching '*.txt' 03:24:51 INFO - no previously-included directories found matching 'build' 03:24:51 INFO - no previously-included directories found matching 'dist' 03:24:51 INFO - no previously-included directories found matching '.git*' 03:24:51 INFO - Installing collected packages: jsonschema, functools32 03:24:51 INFO - Running setup.py install for functools32 03:24:51 INFO - warning: no files found matching '*.txt' 03:24:51 INFO - no previously-included directories found matching 'build' 03:24:51 INFO - no previously-included directories found matching 'dist' 03:24:51 INFO - no previously-included directories found matching '.git*' 03:24:51 INFO - Successfully installed jsonschema functools32 03:24:51 INFO - Cleaning up... 03:24:51 INFO - Return code: 0 03:24:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:51 INFO - 'HOME': '/Users/cltbld', 03:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:51 INFO - 'LOGNAME': 'cltbld', 03:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:51 INFO - 'MOZ_NO_REMOTE': '1', 03:24:51 INFO - 'NO_EM_RESTART': '1', 03:24:51 INFO - 'PAGER': '/bin/cat', 03:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:51 INFO - 'PWD': '/builds/slave/test', 03:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:51 INFO - 'SHELL': '/bin/bash', 03:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:51 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:51 INFO - 'USER': 'cltbld', 03:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:51 INFO - 'XPC_FLAGS': '0x0', 03:24:51 INFO - 'XPC_SERVICE_NAME': '0', 03:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:24:51 INFO - Cleaning up... 03:24:51 INFO - Return code: 0 03:24:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:24:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:24:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:51 INFO - 'HOME': '/Users/cltbld', 03:24:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:51 INFO - 'LOGNAME': 'cltbld', 03:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:51 INFO - 'MOZ_NO_REMOTE': '1', 03:24:51 INFO - 'NO_EM_RESTART': '1', 03:24:51 INFO - 'PAGER': '/bin/cat', 03:24:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:51 INFO - 'PWD': '/builds/slave/test', 03:24:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:51 INFO - 'SHELL': '/bin/bash', 03:24:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:51 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:51 INFO - 'USER': 'cltbld', 03:24:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:51 INFO - 'XPC_FLAGS': '0x0', 03:24:51 INFO - 'XPC_SERVICE_NAME': '0', 03:24:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24:54 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 03:24:54 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 03:24:54 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 03:24:54 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 03:24:54 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 03:24:54 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 03:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:55 INFO - Downloading docopt-0.6.1.tar.gz 03:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:56 INFO - Running setup.py install for blobuploader 03:24:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:56 INFO - Running setup.py install for requests 03:24:56 INFO - Running setup.py install for docopt 03:24:56 INFO - Successfully installed blobuploader requests docopt 03:24:56 INFO - Cleaning up... 03:24:56 INFO - Return code: 0 03:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:56 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')]} 03:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:56 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')]} 03:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:56 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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:24:56 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 03:24:56 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 03:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:56 INFO - 'HOME': '/Users/cltbld', 03:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:56 INFO - 'LOGNAME': 'cltbld', 03:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:56 INFO - 'MOZ_NO_REMOTE': '1', 03:24:56 INFO - 'NO_EM_RESTART': '1', 03:24:56 INFO - 'PAGER': '/bin/cat', 03:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:56 INFO - 'PWD': '/builds/slave/test', 03:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:56 INFO - 'SHELL': '/bin/bash', 03:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:24:56 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:56 INFO - 'USER': 'cltbld', 03:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:56 INFO - 'XPC_FLAGS': '0x0', 03:24:56 INFO - 'XPC_SERVICE_NAME': '0', 03:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-qpZsKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SQDbpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tXRlab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-CQFvrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-TmEm93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-OB3Udo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-5hjZei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:57 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-PTfcSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-NcqYN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-oj31Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nY8RAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tEMYmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-TvaI3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_q64jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-FdQmXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nRL4Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-WfBuVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:58 INFO - Running setup.py install for manifestparser 03:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:59 INFO - Running setup.py install for mozcrash 03:24:59 INFO - Running setup.py install for mozdebug 03:24:59 INFO - Running setup.py install for mozdevice 03:24:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:59 INFO - Running setup.py install for mozfile 03:24:59 INFO - Running setup.py install for mozhttpd 03:24:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:59 INFO - Running setup.py install for mozinfo 03:24:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:59 INFO - Running setup.py install for mozInstall 03:25:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Running setup.py install for mozleak 03:25:00 INFO - Running setup.py install for mozlog 03:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Running setup.py install for moznetwork 03:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Running setup.py install for mozprocess 03:25:00 INFO - Running setup.py install for mozprofile 03:25:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:00 INFO - Running setup.py install for mozrunner 03:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:01 INFO - Running setup.py install for mozscreenshot 03:25:01 INFO - Running setup.py install for moztest 03:25:01 INFO - Running setup.py install for mozversion 03:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:01 INFO - Cleaning up... 03:25:01 INFO - Return code: 0 03:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:01 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')]} 03:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:01 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')]} 03:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:01 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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:25:01 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 03:25:01 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 03:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:01 INFO - 'HOME': '/Users/cltbld', 03:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:01 INFO - 'LOGNAME': 'cltbld', 03:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:01 INFO - 'MOZ_NO_REMOTE': '1', 03:25:01 INFO - 'NO_EM_RESTART': '1', 03:25:01 INFO - 'PAGER': '/bin/cat', 03:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:01 INFO - 'PWD': '/builds/slave/test', 03:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:01 INFO - 'SHELL': '/bin/bash', 03:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:25:01 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:01 INFO - 'USER': 'cltbld', 03:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:01 INFO - 'XPC_FLAGS': '0x0', 03:25:01 INFO - 'XPC_SERVICE_NAME': '0', 03:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-giXgzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:01 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)) 03:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:01 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VaoTHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-7MEv89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Wy4bfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Qbg8sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-okwuJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Xfo0nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-U3Zqr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gOgRMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-99qM_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wHeLSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:02 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)) 03:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-SArOk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:03 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)) 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-qAvZPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:03 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)) 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-l14VPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:03 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)) 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-RdLnwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:03 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)) 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-izeuoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:03 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)) 03:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-FAB4r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:03 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)) 03:25:03 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)) 03:25:03 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)) 03:25:03 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)) 03: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 mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:25:03 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)) 03:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:03 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 03:25:03 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 03:25:03 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 03:25:03 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 03:25:03 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 03:25:03 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 03:25:06 INFO - Downloading blessings-1.6.tar.gz 03:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:06 INFO - Installing collected packages: blessings 03:25:06 INFO - Running setup.py install for blessings 03:25:06 INFO - Successfully installed blessings 03:25:06 INFO - Cleaning up... 03:25:06 INFO - Return code: 0 03:25:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:06 INFO - Reading from file tmpfile_stdout 03:25:06 INFO - Current package versions: 03:25:06 INFO - blessings == 1.6 03:25:06 INFO - blobuploader == 1.2.4 03:25:06 INFO - docopt == 0.6.1 03:25:06 INFO - functools32 == 3.2.3-2 03:25:06 INFO - jsonschema == 2.5.1 03:25:06 INFO - manifestparser == 1.1 03:25:06 INFO - mozInstall == 1.12 03:25:06 INFO - mozcrash == 1.0 03:25:06 INFO - mozdebug == 0.1 03:25:06 INFO - mozdevice == 0.50 03:25:06 INFO - mozfile == 1.2 03:25:06 INFO - mozhttpd == 0.7 03:25:06 INFO - mozinfo == 0.9 03:25:06 INFO - mozleak == 0.1 03:25:06 INFO - mozlog == 3.4 03:25:06 INFO - moznetwork == 0.27 03:25:06 INFO - mozprocess == 0.25 03:25:06 INFO - mozprofile == 0.28 03:25:06 INFO - mozrunner == 6.13 03:25:06 INFO - mozscreenshot == 0.1 03:25:06 INFO - mozsystemmonitor == 0.3 03:25:06 INFO - moztest == 0.8 03:25:06 INFO - mozversion == 1.4 03:25:06 INFO - psutil == 3.1.1 03:25:06 INFO - requests == 1.2.3 03:25:06 INFO - wsgiref == 0.1.2 03:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:06 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')]} 03:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:06 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')]} 03:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:06 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 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:25:06 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 03:25:06 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 03:25:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:25:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:06 INFO - 'HOME': '/Users/cltbld', 03:25:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:06 INFO - 'LOGNAME': 'cltbld', 03:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:06 INFO - 'MOZ_NO_REMOTE': '1', 03:25:06 INFO - 'NO_EM_RESTART': '1', 03:25:06 INFO - 'PAGER': '/bin/cat', 03:25:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:06 INFO - 'PWD': '/builds/slave/test', 03:25:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:06 INFO - 'SHELL': '/bin/bash', 03:25:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:25:06 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:25:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:06 INFO - 'USER': 'cltbld', 03:25:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:06 INFO - 'XPC_FLAGS': '0x0', 03:25:06 INFO - 'XPC_SERVICE_NAME': '0', 03:25:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 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)) 03:25:07 INFO - Cleaning up... 03:25:07 INFO - Return code: 0 03:25:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110617b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11061a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae09dd2f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, '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.mv6t6KMFST/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.Ml1GdZO86m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 03:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:25:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:25:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:07 INFO - 'HOME': '/Users/cltbld', 03:25:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:07 INFO - 'LOGNAME': 'cltbld', 03:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:07 INFO - 'MOZ_NO_REMOTE': '1', 03:25:07 INFO - 'NO_EM_RESTART': '1', 03:25:07 INFO - 'PAGER': '/bin/cat', 03:25:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:07 INFO - 'PWD': '/builds/slave/test', 03:25:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:07 INFO - 'SHELL': '/bin/bash', 03:25:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:25:07 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:25:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:07 INFO - 'USER': 'cltbld', 03:25:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:07 INFO - 'XPC_FLAGS': '0x0', 03:25:07 INFO - 'XPC_SERVICE_NAME': '0', 03:25:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:07 INFO - Cleaning up... 03:25:07 INFO - Return code: 0 03:25:07 INFO - Running post-action listener: _resource_record_post_action 03:25:07 INFO - Running post-action listener: _start_resource_monitoring 03:25:07 INFO - Starting resource monitoring. 03:25:07 INFO - [mozharness: 2017-04-21 10:25:07.523737Z] Finished create-virtualenv step (success) 03:25:07 INFO - [mozharness: 2017-04-21 10:25:07.524703Z] Running install step. 03:25:07 INFO - Running pre-action listener: _resource_record_pre_action 03:25:07 INFO - Running main action method: install 03:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:07 INFO - Reading from file tmpfile_stdout 03:25:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:07 INFO - Reading from file tmpfile_stdout 03:25:07 INFO - Output received: 03:25:07 INFO - Usage: mozinstall [options] installer 03:25:07 INFO - Options: 03:25:07 INFO - -h, --help show this help message and exit 03:25:07 INFO - -d DEST, --destination=DEST 03:25:07 INFO - Directory to install application into. [default: 03:25:07 INFO - "/builds/slave/test"] 03:25:07 INFO - --app=APP Application being installed. [default: firefox] 03:25:07 INFO - mkdir: /builds/slave/test/build/application 03:25:07 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'] 03:25:07 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 03:25:27 INFO - Reading from file tmpfile_stdout 03:25:27 INFO - Output received: 03:25:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:25:27 INFO - Running post-action listener: _resource_record_post_action 03:25:27 INFO - [mozharness: 2017-04-21 10:25:27.525418Z] Finished install step (success) 03:25:27 INFO - [mozharness: 2017-04-21 10:25:27.525561Z] Running run-tests step. 03:25:27 INFO - Running pre-action listener: _resource_record_pre_action 03:25:27 INFO - Running main action method: run_tests 03:25:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:25:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:25:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:25:27 INFO - 2017-04-21 03:25:27.540 screenresolution[1636:7540] starting screenresolution argv=screenresolution get 03:25:27 INFO - 2017-04-21 03:25:27.543 screenresolution[1636:7540] Display 0: 1600x1200x32@60 03:25:27 INFO - 2017-04-21 03:25:27.549 screenresolution[1637:7542] starting screenresolution argv=screenresolution list 03:25:27 INFO - Available Modes on Display 0 03:25:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:25:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:25:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:25:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:25:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:25:27 INFO - Intel Iris: 03:25:27 INFO - Chipset Model: Intel Iris 03:25:27 INFO - Type: GPU 03:25:27 INFO - Bus: Built-In 03:25:27 INFO - VRAM (Dynamic, Max): 1536 MB 03:25:27 INFO - Vendor: Intel (0x8086) 03:25:27 INFO - Device ID: 0x0a2e 03:25:27 INFO - Revision ID: 0x0009 03:25:27 INFO - Displays: 03:25:27 INFO - Display: 03:25:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:25:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:25:27 INFO - Display Serial Number: 1600x1200 60 03:25:27 INFO - Main Display: Yes 03:25:27 INFO - Mirror: Off 03:25:27 INFO - Online: Yes 03:25:27 INFO - Rotation: Supported 03:25:27 INFO - Return code: 0 03:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:27 INFO - Python 2.7.3 03:25:27 INFO - Return code: 0 03:25:27 INFO - grabbing minidump binary from tooltool 03:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:27 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 0x1103f5d30>, '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 0x11031bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103eabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:27 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 03:25:27 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 03:25:27 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 03:25:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:27 INFO - Return code: 0 03:25:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:25:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:27 INFO - ENV: RUST_BACKTRACE is now 1 03:25:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:27 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/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 03:25:27 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/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --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 03:25:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mv6t6KMFST/Render', 03:25:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:27 INFO - 'HOME': '/Users/cltbld', 03:25:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:27 INFO - 'LOGNAME': 'cltbld', 03:25:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:27 INFO - 'MOZ_NO_REMOTE': '1', 03:25:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:27 INFO - 'NO_EM_RESTART': '1', 03:25:27 INFO - 'PAGER': '/bin/cat', 03:25:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:27 INFO - 'PWD': '/builds/slave/test', 03:25:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:27 INFO - 'RUST_BACKTRACE': '1', 03:25:27 INFO - 'SHELL': '/bin/bash', 03:25:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ml1GdZO86m/Listeners', 03:25:27 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:25:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:27 INFO - 'USER': 'cltbld', 03:25:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:27 INFO - 'XPC_FLAGS': '0x0', 03:25:27 INFO - 'XPC_SERVICE_NAME': '0', 03:25:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:27 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/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--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 03:25:28 INFO - mozversion application_buildid: 20170421015828 03:25:28 INFO - mozversion application_changeset: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 03:25:28 INFO - mozversion application_display_name: Nightly 03:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:28 INFO - mozversion application_name: Firefox 03:25:28 INFO - mozversion application_remotingname: firefox 03:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:25:28 INFO - mozversion application_vendor: Mozilla 03:25:28 INFO - mozversion application_version: 55.0a1 03:25:28 INFO - mozversion platform_buildid: 20170421015828 03:25:28 INFO - mozversion platform_changeset: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 03:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:25:28 INFO - mozversion platform_version: 55.0a1 03:25:28 INFO - using testdate: 1492770328 03:25:28 INFO - actual date: 1492770328 03:25:28 INFO - starting webserver on 'localhost:49241' 03:25:28 INFO - SUITE-START | Running 2 tests 03:25:28 INFO - TEST-START | dromaeo_css 03:25:28 INFO - operating with platform_type : mac_ 03:25:28 INFO - Initialising browser for dromaeo_css test... 03:25:28 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpzztGRy/profile http://localhost:49241/getInfo.html) 03:25:31 INFO - PID 1647 | 2017-04-21 03:25:31.150 plugin-container[1649:7731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983f, name = 'com.apple.tsm.portname' 03:25:31 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:25:31 INFO - PID 1647 | 2017-04-21 03:25:31.153 plugin-container[1649:7731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a27, name = 'com.apple.CFPasteboardClient' 03:25:31 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:25:31 INFO - PID 1647 | 2017-04-21 03:25:31.153 plugin-container[1649:7731] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:25:31 INFO - PID 1647 | __metrics Screen width/height:1600/1200 03:25:31 INFO - PID 1647 | colorDepth:24 03:25:31 INFO - PID 1647 | Browser inner width/height: 1024/689 03:25:31 INFO - PID 1647 | __metrics 03:25:31 ERROR - PID 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:25:32 INFO - TEST-INFO | 1647: exit 0 03:25:32 INFO - Browser initialized. 03:25:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:32 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpzztGRy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:34 INFO - PID 1650 | 2017-04-21 03:25:34.655 plugin-container[1651:7866] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9647, name = 'com.apple.tsm.portname' 03:25:34 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:25:34 INFO - PID 1650 | 2017-04-21 03:25:34.655 plugin-container[1651:7866] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4413, name = 'com.apple.CFPasteboardClient' 03:25:34 INFO - PID 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:25:34 INFO - PID 1650 | 2017-04-21 03:25:34.655 plugin-container[1651:7866] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:25:44 INFO - PID 1650 | RSS: Main: 236105728 03:25:44 INFO - PID 1650 | 03:28:47 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 03:28:49 INFO - PID 1650 | RSS: Main: 250814464 03:28:49 INFO - PID 1650 | 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | A coding exception was thrown and uncaught in a Task. 03:30:32 INFO - PID 1650 | 03:30:32 ERROR - PID 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:30:32 INFO - PID 1650 | Full stack: 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | A coding exception was thrown and uncaught in a Task. 03:30:32 INFO - PID 1650 | 03:30:32 ERROR - PID 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:30:32 INFO - PID 1650 | Full stack: 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | A coding exception was thrown and uncaught in a Task. 03:30:32 INFO - PID 1650 | 03:30:32 ERROR - PID 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:30:32 INFO - PID 1650 | Full stack: 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | ************************* 03:30:32 INFO - PID 1650 | A coding exception was thrown and uncaught in a Task. 03:30:32 INFO - PID 1650 | 03:30:32 ERROR - PID 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:30:32 INFO - PID 1650 | Full stack: 03:30:32 INFO - PID 1650 | ************************* 03:31:51 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 03:31:52 INFO - PID 1650 | RSS: Main: 258969600 03:31:52 INFO - PID 1650 | 03:34:53 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 03:34:54 INFO - PID 1650 | RSS: Main: 267780096 03:34:54 INFO - PID 1650 | 03:37:56 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 03:37:56 INFO - PID 1650 | RSS: Main: 260775936 03:37:56 INFO - PID 1650 | 03:40:59 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 03:41:00 INFO - PID 1650 | RSS: Main: 268492800 03:41:00 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 03:44:02 INFO - PID 1650 | RSS: Main: 264151040 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | __start_tp_report 03:44:02 INFO - PID 1650 | _x_x_mozilla_page_load 03:44:02 INFO - PID 1650 | _x_x_mozilla_page_load_details 03:44:02 INFO - PID 1650 | |i|pagename|runs| 03:44:02 INFO - PID 1650 | |0;dojo.html;3198.344339410421;3571.767835090719;3613.1328481164496;3620.094976255936;3627.1476203092275;6011;6153.784617538393;6156.5690401671845;6188.102725104863;6198.876022479548;6105.338445949974;6106.157323464397;6129.356417576158;6141.2405385826005;6208.348123447041;5211.322528071345;5363.356397232337;5377.085895397782;5425.945740542584;5475.233467314579;4778.593819525345;5377.139657654776;5416.187571864232;5485.985092757833;5491;5447.45525447456;5481.890362192754;5482.890342193154;5486.1222204447295;5514.751836167382;5236.921446178272;5299.973500132513;5302.310699609065;5373.462653734634;5402.459754024605;5331.946680533184;5347.491988261109;5362.91955620666;5366.731663416814;5415.187721841716;5967.761289548456;6121.418465245794;6193.752249909998;6213.161223234851;6255.562110652256;5496.972515137439;6364.745410183634;6416.51876109289;6531.575447595938;6615.86768264632;6699.162604674416;6722.932770672329;6723.899141512881;6735.494837887178;6735.797926062177;6297.622142671455;6313.621182729051;6322.936770632281;6329.36706329368;6333.46165575922;6584.440322572635;6658.43403310724;6771.492138089663;6777.8644427111185;6875.140607424072;4906.337644418029;5124.846254612367;5280.313559237275;6267.7806276781;6567.934320656732;5315.840524784263;6441.5490915635455;6455.806325810233;6570.540062195696;6687;5381.3811411687375;6504;6545.247296560957;6548.0384367457955;6580.243272023683;6284.465820405317;6494.707738151795;6557.540972132;6565.507586930999;6685.732570697118;5210.088234559013;5278.683279003272;5311.415744268127;5341.439148889388;5357.785688572491;4690.7654617269;4707.435107787088;4713.552212539803;4714.834980775657;4717.339572459859;6112.663803490762;6317.747290108436;6330.588511746721;6339.334369891095;6342.682865856781;4984.601231901439;6250.499960003189;6475.838104047342;6626.734930602818;6671.466282697373;6248.031555108965;6264.874702505925;6297.370262973666;6304.022876454157;6316.336784637639;5873.148393483007;5879.853003674943;5888.263967004124;5905.527557795366;5925.259342582177;6645.468362530889;6685.6322902240845;6878.174619045746;6918.10064691607;6935.063766391472;6730.596164230162;6743.696533655899;6769;6782.762603308861;6789.762358317435;6833.931660683528;6922.826929326807;6942.305769423219;6951.965240173767;6960.37356637905;5481.177823326533;6360.395762402564;6391.2330520337855;6523.6738163092605;6642.734290628321;6607;6644.103046088716;6650.567713098633;6675.7329706813125;6729.1252137221845;6455.419012288917;6456.128422663069;6472.902906456313;6486.740530378921;6503.414692677682;5266.210068489757;6267.968660156853;6321.146645203023;6390.680465976776;6457.3865482779065;6226.688665566613;6365.618062916054;6386.233651961795;6387.105805187371;6395.42441180296;6507.154069970874;6518.967405162944;6520.902186467301;6522.967385163233;6528.053432252392;6144.955357589131;6307.148534947723;6309;6343;6343.11196432509 03:44:02 INFO - PID 1650 | |1;ext.html;699.972001119955;724.0912654618453;802.7872613757354;1244.45866048269;1251.1304643272929;36895.63104368956;37905.431418528744;37910.620893791056;37998.81000594996;38098.66654667087;38288;38409.23181536367;38665.806670966675;38740.41889371662;38771.22457550847;7854;8051.798705032363;8251.876221856677;8458.87311690325;8468.280196183332;8335.124811894755;8362.16378362165;8423.452475589067;8439.789005274855;8445.873311900326;8360.247577718004;8396.45423047503;8466.619002144918;8478.406511544194;8482.406231563793;8423.199796019398;8441.240288374045;8447.704330348439;8462.449940753831;8468.830623387497;6928.757493487704;8290.46112002724;8323.542205178714;8348.039975402846;8354.498730076215;30295.545566816294;37118.62881371206;37256;37331.626683733084;37355.62644373576;3089.969100309013;3634.709223262159;3636.9636303637153;3643.2531331077066;3647.215848592565;30902.53646195309;30956.845215774003;30957.690423095704;30989.535156972663;31054.53418198729;3152.5271209318557;3184.3153721949893;3189.521571764231;3199.728023118038;3207.550942868;212397;269339;275458.6227068872;296513;296942;46810.5318946813;46867.531324687;46904.76547617308;46999;47031.35390261324;48781.26828097581;48831.75584122057;54483.72758136184;55268;55404.16893746597;14124.505642302676;14272.858171346268;14286.142831430148;14304.85695143056;14336.641583960276;11281.379524126252;11340.376279304552;11348.659540213806;11362;11371.260868043717;14085.366158522891;14108.365123569463;14113.153210807384;14175.149491030572;14227.28863556818;6137.785177518855;6151.323354431009;6210.782622608187;6220.222472190976;6232.59488133279;875.874501265883;977.1385510602314;1006.6577363696379;1027.8304079826894;1054.1198099586932;24381.024759009797;24508.26475205747;24724.505509889703;24761.876190618932;24788.38029049252;1108.4513165982728;1113.4377139544479;1138.2715062360096;1150;1159.3855256713955;10364.274500785023;12038.759224815454;12591.307478088609;12651.746965060647;13135.868641313657;319614;329099;331227;331296;331386;53827;54029;54322.45677543253;54417.1837422439;54690;1490.2921112471706;1517.4613012380446;1525.161161361247;1534.0948840184344;1544.088987497382;18529.629407411507;21651.35045948624;22316.442088947908;23966.041358345472;24083;35682.46476302806;37863;44018.119637607706;47100.52899470962;47164.7641761789;256588;302507;303027.48486257426;304226;308899;36048.21493743119;36206;36256.81871590625;36261.63738362688;36515;45111.32333014942;45267.77366113148;45854.54145458503;46123;46296;29399.412011760072;29907.700922991364;30319.848400757855;30857.8457107722;31026.379472410877;26495;28097.859510702314;30326.545101823933;30992.91524796621;31165.844170779;37450;37458.438123428714;37515.81242093772;37542.624573753914;37714.622853771114;23678.28965131049;30168.09495715132;30611;31261;31629.051128466184;21380.358589242347;23680.644790328504;24185.75814241835;24359.299922821792;24418.63372049385 03:44:02 INFO - PID 1650 | |2;jquery.html;388.59391935427476;441.8033974881178;443.72267332916925;447.26648296793246;460.6314948041568;19965.700514492295;21572.89213553932;21669;21777.128914843408;21920.99999999996;21875.79683117428;22182.334529964126;22290.88854555725;22336.88831555844;22412.32763017112;6083.1483592297;6241.625502469867;6264.655443950581;6272.059191121345;6273.811785646415;5079.593632509391;5806.274215723035;6053.757849686007;6224.8443788905415;6234.407731265545;5399.271098401705;5993.670348130851;6061.45446909778;6165.414285642857;6178.196834411543;4999.550040496373;6013.278406591194;6111.541634377417;6196.628202307854;6365.872682546369;5464.098423760075;5482.479164479368;5491.066518691832;5516.282883225195;5528.419515950848;25659;25724.87137564319;25728.614070788954;25891.352716182057;25965.610515842276;2316.501952080294;2322.1408079010707;2356.670066190735;2364.7280562735164;2368.7749663781915;15236.619084522976;16164.030158190546;17259.654806903916;17635.911820440815;17747.84638998461;2119.8092171704466;2179.4442417183677;2206.2388475975763;2234.977650223493;2243.069126312578;171276.1436192811;173121;173519;173591;175966;12765.680857978625;12883.22700637946;12892.677683057998;12903;12903.483860645469;16321.347146114022;16611.750823737653;16629.50111496657;16642.916785416237;16652.666946661;8800.181670978001;9119.498427586546;9137.40606860552;9247.398919070374;9251.67619133327;8675.349348798865;8685.91314086851;8688.044315125331;8705.695300664447;8863.113688631085;6612.94192929129;7882.960585197037;7901.486403383762;8012.639431225609;8102.7569172924905;2203.922862699798;2216.479127405091;2223.3663405929233;2226.9443263918533;2413.662087307778;755.5353457623522;959.6017652674202;974.6442548469757;994.3834822410007;1023.339317773797;17703;21206;21665.56668866614;21710.674339884914;22004.449888752908;1027.8406846938738;1035.35807799165;1059.6238335390826;1075.8816530181673;1077.0737166037202;10812.026917577456;11122.277051991594;11202.94398528002;11225.71935701614;11316.434178291218;564498;569786;576365;577936;579454;102729.48635256776;136556;136597;138879.36163511104;143883.2805835964;1099.5217080569978;1245.3337464456654;1282.3460035381836;1285.1582213650074;1288.6005338345144;22093.226737064124;22381;22417.887910560345;22516.88741556282;22689.205877794197;46045.309320360895;57202;59748;59795;60889.69555152373;83279;84748;86729.56635216784;86952.00051993849;88418.64056389897;8728.170823771732;8953.507557084424;8998;9049.502277374808;9074;13591.91264698802;13812.447502099803;13968.860311396757;14201.928990354982;14224.928875355557;10275.332103413255;11304.717382065513;11983.483468471719;12224.266544007389;12297.70874058211;11190.160737944523;11375.488103035217;11486.540538378371;11686.123540734648;11718.589849355232;11867.881321186678;11930.582429614922;12102.092343074128;12346.629601111981;12573.559925402567;8818.206361427503;8847.159519845605;8893.599788009684;8893.955530222307;9049.864252036356;11978.221415607957;12020.33888136161;12027.939860300643;12163.75672486563;12283.57007504733 03:44:02 INFO - PID 1650 | |3;mootools.html;1322.1670347680958;1396.2669598460807;1426;1441.7909403136553;1455.490578297596;11494.137939654527;11800.58697945572;11937.701557461069;11953.581624643139;12321.507139714424;11889.64331070067;12149.39253037349;12156.756864862697;12162.513499460034;12197.329146896916;2568.1653462624677;2570.9614355784583;2598.6751656042993;2603.2580714496276;2605.531004419204;2107.894605269738;2528.810339224556;2568.1653462624627;2569.0494517028633;2571.639970404145;2482.6648402465617;2528.9873550632315;2561.602951542514;2572.691277046757;2576.240009197282;2475.0471068638612;2532.5821239495554;2540.898364065435;2557.577999630059;2559.2194380713877;2269.6028195065796;2535.5055764126005;2549.7832684221676;2576.6779152605923;2582.5480540905264;11996.64010079699;12069.336186509738;12072.939635301855;12081;12085.939570302093;6108.114323423123;6652.50106242029;6862.176538815324;6881.41507971823;6899.103116594861;4169.812358443877;4422.646188304928;4476.082403107355;4487.730736155809;4516.909661806778;1254.8556915954691;1273.8344015278046;1315.83552055993;1317.1965101288206;1321.6365499487622;13846.93076534621;15774.369025238977;16720.6655866882;16852.578685532837;16853.41013064549;5242.868928276824;6028.638281703024;6092.421219984094;6350.5554611177695;6363.268224154282;13935.442582296595;14068.030475733405;14081.155130692192;14087.577372678836;14099.154050756782;6166.691665416712;6852.725890964405;6915.89626155608;6961.61711105894;6972.1284839395075;4886.438059623118;6058.21243238385;6216.844578885564;6245.469135123474;6338.366163383717;4682.063587282489;4839.637027222972;4857.514248575114;4878.268259761065;4945.752712364368;1499.025633338317;1536.64657128861;1537.4388348252808;1537.9000364976241;1553.7902383178127;776.7747353267603;779.111812533712;804.527714282861;805.5408417202138;807.5962018990505;6145.5698101133385;6213;6214.378562143749;6223.14165217568;6312.116303717391;595.1697382151874;596.5555661032472;611.458858909868;620.9099680546295;624.5659266809524;3715.20123173519;4103.692223083221;4122.855700050543;4314.309710446376;4450.910981780346;10646.840297395545;14445.49440769568;14535.345909434101;14575;15071.54785356441;14501.492447764489;14894.180820054784;14900.0314979526;14916.403343866341;14927.328270227867;8601.838751768557;8630.78423039429;8672.436291641023;8686.609102590399;8692.52191129494;6704.966475167593;7015.789526314219;7105.609191494311;7127.928720712934;7131.8573628528175;11630.360330181922;12245.265284082983;13667.248301343521;13700.794488082487;13722.039457237897;12195.024398047957;12848;13835.031547791557;13955.511557095453;14003.719925601634;8568.35737319716;8858.202761751474;9734.707958761248;9875.604975801174;9896.752581185528;10028.69913902584;11030.613928512463;11038.227324087236;11057.447127643747;11059.889401106208;8969.372143950122;9230.123138301851;9304.395214311047;9332.95333523328;9344.672936447192;7436.144843343085;8985.550722463982;9018.278537716837;9090;9165.587548560197;8103.230193131643;8144.470609410369;8238.958805206175;8270.338372930271;8270.627821747916;5178.922316165336;5940.7920722776225;6008.669523176267;6011.248593925759;6062.514998800174;5862.856742935257;6074.362191969956;6102.115193297036;6163.630182189083;6222.23998641049 03:44:02 INFO - PID 1650 | |4;prototype.html;372.5250305860028;405.7565460723566;410.3803257081809;416.175971576279;419.7124969395963;5402.297701298836;6096.969515152424;6135.8772824543485;6269.404406581379;6275.529335299853;5124.871878203037;5476.658218736406;6227.9688601557045;6246.500279977602;6265.404786545282;3803.3344164771192;4676.667149862282;4745.501722319159;4746.596539294164;4754.239321708527;4313.762743049131;4332.761698106603;4747.4540427850725;4771.856844294677;4788.80844766209;4081;4732.219183834663;4751.216049351853;4752.310914917335;4760.928586071212;4525.728456292633;4633.582977532038;4674.789634466457;4713.552212539803;4763.356946812188;3574.964250357489;4116.806126223391;4177.373393990895;4181.456410666624;4240.300350442173;4920.434150072751;6074;6080.452759251644;6099.865047233433;6105.481034112061;4664.5335466453425;5457.263269458612;5508.607510469927;5543.916841247345;5627.380988091307;5687.829365119053;6046.758129674808;6602.896638579859;6625.436837868787;6626.542160724633;4363.781810909473;4591.540845915415;4796.424429068499;4797.472278049412;4830.661853670244;6799.218089919624;6946.241824350336;7017.193022802392;7019.087518622547;7043;3996.360582306875;4043.757374557536;4062.6390159296375;4231.534531201565;4678.111158879802;4513.81944722214;4788.233882578771;4789.814773175799;4790.850195953016;4791.137595232892;5076.340075790124;5401.297831281908;5483.506484416342;5534.003879301684;5542.224088627595;5644.435556444405;5820.738066787005;6198.380161983766;6543;6640.269570347258;1437.73401920645;1699.566610514311;1721.3028723367056;1726.8791184617207;1728.7579738836573;965.7826988927435;1063.787282497953;1190.2085113399664;1192.66605350502;1195.58154645875;5676.7161641918565;5972.85067873298;6242.625442473466;6279.183706118175;6292.46514046302;6418.19772528434;6817.5568588041615;6823.795286141324;6834.266293482548;6862;4702.52974702527;5386.865328366822;6149.016157414792;6249.343818899041;6258.468030217391;3092.9793168254423;3121.7502599792415;3124.656287808339;3573.7855728656364;3591.6228795976567;5476.479734425223;6742.797716068526;7076.681549330293;7106.7157313706875;7158.427325813923;5906.940930590725;7094.751683691046;7119;7130.500864939509;7346.191918888918;5425.891482170335;6811.216710078305;7119.323664251888;7163.964180179066;7202.891956620655;5673.773049078156;6884.311568843075;6907.13660792401;6942.166939967236;6964.965175174092;6646.401823835878;6765.729370825309;6807.3873351398615;6815.318468153145;6849.554778939353;5668.752874367632;6818.727250909908;7009.7897063088185;7128.322809333105;7142.214356420894;4091.734037287567;4523;4533.54664533544;4536.72779633223;4552.544745525421;6627.1716035495565;6791.320867913367;6850.9314906850295;6929.133858267716;6947;5633.014222511126;6204.5967012144065;6618.437432818265;6643.555750921599;6668.799936001928;5664.518515926193;6118.418750218722;6263.248410190807;6498.902516462352;6625.536212465081;6417.582857114273;6496.70764815575;6508.023796430573;6520.739170433129;6563.606183628997;6221.595596286227;6648.767293144717;6669.699863506057;6670.433013193739;6682.398584127452;5497.725113744376;5633.324001119728;5862;6152.477039451696;6401.479186447528 03:44:02 INFO - PID 1650 | |5;yui.html;773.99613001935;786.2452046035805;821.437315438924;833.4874052457741;873.2141073034267;15757.84242157578;16233.594160146002;16264.186790660478;18036.54908627282;18777.061146942633;17016.744748828776;17176.39882604109;17444.38944636938;17584.736228956543;18155.818441815576;950.4059962523405;965.9420434773936;967.2020583019003;969.1907257440046;970.1365784451843;942.5334459442586;943.5140902435252;945.9952700236489;947.6730527967875;948.4167237149172;1012.7923775626016;1019.2050200843317;1022.2333250062453;1022.5551884930042;1023.3961962442157;1014.0518615094873;1014.6093753904726;1014.9847752283684;1016.4054028393399;1017.5115944346718;720.5640587444625;750.4034292737286;751.4176513202312;751.4889874885131;751.8045308219847;16486.093264870426;16773.7483937741;16804.075775832323;16821;16851.74722379165;16295.185240738034;16648.001119932844;16873;16984.150792460452;16996.915015424845;13653.795193072112;13711.45154193831;13929.651758706012;13944.302784860716;13991.790123148161;3389.3729660012978;3496.160921378876;3500.527428797105;3504.106452854531;3511.315293517765;110262;119035;119100;120468;122236;13259.138156019828;13351.933240333736;13501.189928604315;13520.526781562598;13587.660308492366;24379.39051523726;24879.378015549755;24942.875285623457;25203.495930081295;25307;7837.2162783722315;7952.960235198787;7959.482633628795;7970.9202907970175;7971;3893.3575959966856;3922.2155568886337;3935.153941902505;3967.7501587;3971.3447281198855;4130.483689538808;4274.807633656493;4316.935245971313;4342.804573794187;4344.695871288979;926.3746970794687;955.2262667239559;957.2820384711466;962.8122516109291;962.9470379129075;633;637.2926052082186;656.3633275722541;658.3021996683435;674.4199988010307;11219.214654974074;11862;11907.642770716893;13079.41142648583;13242.867571324163;634.5684934244758;655.2726473614284;655.8983357579583;664.1333060356282;687.6492988575862;5195.506426889515;5252.632315737938;5302.575793936476;5518.889622207614;5890.823275301748;98518;100023.49988250158;100142;104489;105540;89281.10718892858;95328;95696;97185;97690;83373;84674.5766271177;84712.30575388458;85346.71979920306;85397.99999999876;9882.604695812088;11639.825402618799;12239;12265.018798495921;12286.447109879899;34956.82521587376;37539;41491.7925410371;41765.37351939784;42312.78843605762;54688;55160;55278.72360638171;55844.44155558392;56314.718426407606;14450.060746051473;14489.275536222936;14591.781123283372;14654.340554674853;14662.973591848468;17626.030568318867;17685.292588296837;17876.91061544684;17936.282548697905;18028.188731507376;14494.927525362305;15834.574888260111;16386.590335241715;16642.251098700344;16761.664766704842;16126.758098628765;16139.031658100552;16253.67492650164;16371.918140409221;16409.753853692444;13251.933740331237;15992.840071599601;16174.272157753165;16243.944143630626;16338;10898.782024359627;11104.944475277573;11193;11412.31526108436;11841.5855445059;12303.753924921273;13310.933445332712;13521.72956540844;13630.318484075558;13646.385912634154 03:44:02 INFO - PID 1650 | __end_tp_report 03:44:02 INFO - PID 1650 | __start_cc_report 03:44:02 INFO - PID 1650 | _x_x_mozilla_cycle_collect,419 03:44:02 INFO - PID 1650 | __end_cc_report 03:44:02 INFO - PID 1650 | __startTimestamp1492771442308__endTimestamp 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | ------- Summary: start ------- 03:44:02 INFO - PID 1650 | Number of tests: 6 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | [#0] dojo.html Cycles:165 Average:6045.97 Median:6309.00 stddev:734.03 (11.6%) stddev-sans-first:701.47 03:44:02 INFO - PID 1650 | Values: 3198.3 3571.8 3613.1 3620.1 3627.1 6011.0 6153.8 6156.6 6188.1 6198.9 6105.3 6106.2 6129.4 6141.2 6208.3 5211.3 5363.4 5377.1 5425.9 5475.2 4778.6 5377.1 5416.2 5486.0 5491.0 5447.5 5481.9 5482.9 5486.1 5514.8 5236.9 5300.0 5302.3 5373.5 5402.5 5331.9 5347.5 5362.9 5366.7 5415.2 5967.8 6121.4 6193.8 6213.2 6255.6 5497.0 6364.7 6416.5 6531.6 6615.9 6699.2 6722.9 6723.9 6735.5 6735.8 6297.6 6313.6 6322.9 6329.4 6333.5 6584.4 6658.4 6771.5 6777.9 6875.1 4906.3 5124.8 5280.3 6267.8 6567.9 5315.8 6441.5 6455.8 6570.5 6687.0 5381.4 6504.0 6545.2 6548.0 6580.2 6284.5 6494.7 6557.5 6565.5 6685.7 5210.1 5278.7 5311.4 5341.4 5357.8 4690.8 4707.4 4713.6 4714.8 4717.3 6112.7 6317.7 6330.6 6339.3 6342.7 4984.6 6250.5 6475.8 6626.7 6671.5 6248.0 6264.9 6297.4 6304.0 6316.3 5873.1 5879.9 5888.3 5905.5 5925.3 6645.5 6685.6 6878.2 6918.1 6935.1 6730.6 6743.7 6769.0 6782.8 6789.8 6833.9 6922.8 6942.3 6952.0 6960.4 5481.2 6360.4 6391.2 6523.7 6642.7 6607.0 6644.1 6650.6 6675.7 6729.1 6455.4 6456.1 6472.9 6486.7 6503.4 5266.2 6268.0 6321.1 6390.7 6457.4 6226.7 6365.6 6386.2 6387.1 6395.4 6507.2 6519.0 6520.9 6523.0 6528.1 6145.0 6307.1 6309.0 6343.0 6343.1 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | [#1] ext.html Cycles:180 Average:45083.22 Median:331341.00 stddev:78617.06 (23.7%) stddev-sans-first:78766.98 03:44:02 INFO - PID 1650 | Values: 700.0 724.1 802.8 1244.5 1251.1 36895.6 37905.4 37910.6 37998.8 38098.7 38288.0 38409.2 38665.8 38740.4 38771.2 7854.0 8051.8 8251.9 8458.9 8468.3 8335.1 8362.2 8423.5 8439.8 8445.9 8360.2 8396.5 8466.6 8478.4 8482.4 8423.2 8441.2 8447.7 8462.4 8468.8 6928.8 8290.5 8323.5 8348.0 8354.5 30295.5 37118.6 37256.0 37331.6 37355.6 3090.0 3634.7 3637.0 3643.3 3647.2 30902.5 30956.8 30957.7 30989.5 31054.5 3152.5 3184.3 3189.5 3199.7 3207.6 212397.0 269339.0 275458.6 296513.0 296942.0 46810.5 46867.5 46904.8 46999.0 47031.4 48781.3 48831.8 54483.7 55268.0 55404.2 14124.5 14272.9 14286.1 14304.9 14336.6 11281.4 11340.4 11348.7 11362.0 11371.3 14085.4 14108.4 14113.2 14175.1 14227.3 6137.8 6151.3 6210.8 6220.2 6232.6 875.9 977.1 1006.7 1027.8 1054.1 24381.0 24508.3 24724.5 24761.9 24788.4 1108.5 1113.4 1138.3 1150.0 1159.4 10364.3 12038.8 12591.3 12651.7 13135.9 319614.0 329099.0 331227.0 331296.0 331386.0 53827.0 54029.0 54322.5 54417.2 54690.0 1490.3 1517.5 1525.2 1534.1 1544.1 18529.6 21651.4 22316.4 23966.0 24083.0 35682.5 37863.0 44018.1 47100.5 47164.8 256588.0 302507.0 303027.5 304226.0 308899.0 36048.2 36206.0 36256.8 36261.6 36515.0 45111.3 45267.8 45854.5 46123.0 46296.0 29399.4 29907.7 30319.8 30857.8 31026.4 26495.0 28097.9 30326.5 30992.9 31165.8 37450.0 37458.4 37515.8 37542.6 37714.6 23678.3 30168.1 30611.0 31261.0 31629.1 21380.4 23680.6 24185.8 24359.3 24418.6 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | [#2] jquery.html Cycles:180 Average:37120.83 Median:22415.11 stddev:97812.71 (436.4%) stddev-sans-first:98048.22 03:44:02 INFO - PID 1650 | Values: 388.6 441.8 443.7 447.3 460.6 19965.7 21572.9 21669.0 21777.1 21921.0 21875.8 22182.3 22290.9 22336.9 22412.3 6083.1 6241.6 6264.7 6272.1 6273.8 5079.6 5806.3 6053.8 6224.8 6234.4 5399.3 5993.7 6061.5 6165.4 6178.2 4999.6 6013.3 6111.5 6196.6 6365.9 5464.1 5482.5 5491.1 5516.3 5528.4 25659.0 25724.9 25728.6 25891.4 25965.6 2316.5 2322.1 2356.7 2364.7 2368.8 15236.6 16164.0 17259.7 17635.9 17747.8 2119.8 2179.4 2206.2 2235.0 2243.1 171276.1 173121.0 173519.0 173591.0 175966.0 12765.7 12883.2 12892.7 12903.0 12903.5 16321.3 16611.8 16629.5 16642.9 16652.7 8800.2 9119.5 9137.4 9247.4 9251.7 8675.3 8685.9 8688.0 8705.7 8863.1 6612.9 7883.0 7901.5 8012.6 8102.8 2203.9 2216.5 2223.4 2226.9 2413.7 755.5 959.6 974.6 994.4 1023.3 17703.0 21206.0 21665.6 21710.7 22004.4 1027.8 1035.4 1059.6 1075.9 1077.1 10812.0 11122.3 11202.9 11225.7 11316.4 564498.0 569786.0 576365.0 577936.0 579454.0 102729.5 136556.0 136597.0 138879.4 143883.3 1099.5 1245.3 1282.3 1285.2 1288.6 22093.2 22381.0 22417.9 22516.9 22689.2 46045.3 57202.0 59748.0 59795.0 60889.7 83279.0 84748.0 86729.6 86952.0 88418.6 8728.2 8953.5 8998.0 9049.5 9074.0 13591.9 13812.4 13968.9 14201.9 14224.9 10275.3 11304.7 11983.5 12224.3 12297.7 11190.2 11375.5 11486.5 11686.1 11718.6 11867.9 11930.6 12102.1 12346.6 12573.6 8818.2 8847.2 8893.6 8894.0 9049.9 11978.2 12020.3 12027.9 12163.8 12283.6 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | [#3] mootools.html Cycles:180 Average:7180.83 Median:3909.45 stddev:4508.68 (115.3%) stddev-sans-first:4499.83 03:44:02 INFO - PID 1650 | Values: 1322.2 1396.3 1426.0 1441.8 1455.5 11494.1 11800.6 11937.7 11953.6 12321.5 11889.6 12149.4 12156.8 12162.5 12197.3 2568.2 2571.0 2598.7 2603.3 2605.5 2107.9 2528.8 2568.2 2569.0 2571.6 2482.7 2529.0 2561.6 2572.7 2576.2 2475.0 2532.6 2540.9 2557.6 2559.2 2269.6 2535.5 2549.8 2576.7 2582.5 11996.6 12069.3 12072.9 12081.0 12085.9 6108.1 6652.5 6862.2 6881.4 6899.1 4169.8 4422.6 4476.1 4487.7 4516.9 1254.9 1273.8 1315.8 1317.2 1321.6 13846.9 15774.4 16720.7 16852.6 16853.4 5242.9 6028.6 6092.4 6350.6 6363.3 13935.4 14068.0 14081.2 14087.6 14099.2 6166.7 6852.7 6915.9 6961.6 6972.1 4886.4 6058.2 6216.8 6245.5 6338.4 4682.1 4839.6 4857.5 4878.3 4945.8 1499.0 1536.6 1537.4 1537.9 1553.8 776.8 779.1 804.5 805.5 807.6 6145.6 6213.0 6214.4 6223.1 6312.1 595.2 596.6 611.5 620.9 624.6 3715.2 4103.7 4122.9 4314.3 4450.9 10646.8 14445.5 14535.3 14575.0 15071.5 14501.5 14894.2 14900.0 14916.4 14927.3 8601.8 8630.8 8672.4 8686.6 8692.5 6705.0 7015.8 7105.6 7127.9 7131.9 11630.4 12245.3 13667.2 13700.8 13722.0 12195.0 12848.0 13835.0 13955.5 14003.7 8568.4 8858.2 9734.7 9875.6 9896.8 10028.7 11030.6 11038.2 11057.4 11059.9 8969.4 9230.1 9304.4 9333.0 9344.7 7436.1 8985.6 9018.3 9090.0 9165.6 8103.2 8144.5 8239.0 8270.3 8270.6 5178.9 5940.8 6008.7 6011.2 6062.5 5862.9 6074.4 6102.1 6163.6 6222.2 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | [#4] prototype.html Cycles:180 Average:5349.56 Median:5754.28 stddev:1655.90 (28.8%) stddev-sans-first:1617.86 03:44:02 INFO - PID 1650 | Values: 372.5 405.8 410.4 416.2 419.7 5402.3 6097.0 6135.9 6269.4 6275.5 5124.9 5476.7 6228.0 6246.5 6265.4 3803.3 4676.7 4745.5 4746.6 4754.2 4313.8 4332.8 4747.5 4771.9 4788.8 4081.0 4732.2 4751.2 4752.3 4760.9 4525.7 4633.6 4674.8 4713.6 4763.4 3575.0 4116.8 4177.4 4181.5 4240.3 4920.4 6074.0 6080.5 6099.9 6105.5 4664.5 5457.3 5508.6 5543.9 5627.4 5687.8 6046.8 6602.9 6625.4 6626.5 4363.8 4591.5 4796.4 4797.5 4830.7 6799.2 6946.2 7017.2 7019.1 7043.0 3996.4 4043.8 4062.6 4231.5 4678.1 4513.8 4788.2 4789.8 4790.9 4791.1 5076.3 5401.3 5483.5 5534.0 5542.2 5644.4 5820.7 6198.4 6543.0 6640.3 1437.7 1699.6 1721.3 1726.9 1728.8 965.8 1063.8 1190.2 1192.7 1195.6 5676.7 5972.9 6242.6 6279.2 6292.5 6418.2 6817.6 6823.8 6834.3 6862.0 4702.5 5386.9 6149.0 6249.3 6258.5 3093.0 3121.8 3124.7 3573.8 3591.6 5476.5 6742.8 7076.7 7106.7 7158.4 5906.9 7094.8 7119.0 7130.5 7346.2 5425.9 6811.2 7119.3 7164.0 7202.9 5673.8 6884.3 6907.1 6942.2 6965.0 6646.4 6765.7 6807.4 6815.3 6849.6 5668.8 6818.7 7009.8 7128.3 7142.2 4091.7 4523.0 4533.5 4536.7 4552.5 6627.2 6791.3 6850.9 6929.1 6947.0 5633.0 6204.6 6618.4 6643.6 6668.8 5664.5 6118.4 6263.2 6498.9 6625.5 6417.6 6496.7 6508.0 6520.7 6563.6 6221.6 6648.8 6669.7 6670.4 6682.4 5497.7 5633.3 5862.0 6152.5 6401.5 03:44:02 INFO - PID 1650 | 03:44:02 INFO - PID 1650 | [#5] yui.html Cycles:180 Average:21572.91 Median:18096.18 stddev:30201.47 (166.9%) stddev-sans-first:30245.81 03:44:02 INFO - PID 1650 | Values: 774.0 786.2 821.4 833.5 873.2 15757.8 16233.6 16264.2 18036.5 18777.1 17016.7 17176.4 17444.4 17584.7 18155.8 950.4 965.9 967.2 969.2 970.1 942.5 943.5 946.0 947.7 948.4 1012.8 1019.2 1022.2 1022.6 1023.4 1014.1 1014.6 1015.0 1016.4 1017.5 720.6 750.4 751.4 751.5 751.8 16486.1 16773.7 16804.1 16821.0 16851.7 16295.2 16648.0 16873.0 16984.2 16996.9 13653.8 13711.5 13929.7 13944.3 13991.8 3389.4 3496.2 3500.5 3504.1 3511.3 110262.0 119035.0 119100.0 120468.0 122236.0 13259.1 13351.9 13501.2 13520.5 13587.7 24379.4 24879.4 24942.9 25203.5 25307.0 7837.2 7953.0 7959.5 7970.9 7971.0 3893.4 3922.2 3935.2 3967.8 3971.3 4130.5 4274.8 4316.9 4342.8 4344.7 926.4 955.2 957.3 962.8 962.9 633.0 637.3 656.4 658.3 674.4 11219.2 11862.0 11907.6 13079.4 13242.9 634.6 655.3 655.9 664.1 687.6 5195.5 5252.6 5302.6 5518.9 5890.8 98518.0 100023.5 100142.0 104489.0 105540.0 89281.1 95328.0 95696.0 97185.0 97690.0 83373.0 84674.6 84712.3 85346.7 85398.0 9882.6 11639.8 12239.0 12265.0 12286.4 34956.8 37539.0 41491.8 41765.4 42312.8 54688.0 55160.0 55278.7 55844.4 56314.7 14450.1 14489.3 14591.8 14654.3 14663.0 17626.0 17685.3 17876.9 17936.3 18028.2 14494.9 15834.6 16386.6 16642.3 16761.7 16126.8 16139.0 16253.7 16371.9 16409.8 13251.9 15992.8 16174.3 16243.9 16338.0 10898.8 11104.9 11193.0 11412.3 11841.6 12303.8 13310.9 13521.7 13630.3 13646.4 03:44:02 INFO - PID 1650 | -------- Summary: end -------- 03:44:02 INFO - PID 1650 | 03:44:02 INFO - TEST-INFO | 1650: exit 0 03:44:02 INFO - TEST-OK | dromaeo_css | took 1114861ms 03:44:02 INFO - TEST-START | kraken 03:44:02 INFO - operating with platform_type : mac_ 03:44:02 INFO - Initialising browser for kraken test... 03:44:03 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpA7inpn/profile http://localhost:49241/getInfo.html) 03:44:05 INFO - PID 1686 | 2017-04-21 03:44:05.737 plugin-container[1687:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 03:44:05 INFO - PID 1686 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:44:05 INFO - PID 1686 | 2017-04-21 03:44:05.739 plugin-container[1687:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x990b, name = 'com.apple.CFPasteboardClient' 03:44:05 INFO - PID 1686 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:44:05 INFO - PID 1686 | 2017-04-21 03:44:05.740 plugin-container[1687:10274] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:44:05 INFO - PID 1686 | __metrics Screen width/height:1600/1200 03:44:05 INFO - PID 1686 | colorDepth:24 03:44:05 INFO - PID 1686 | Browser inner width/height: 1024/689 03:44:05 INFO - PID 1686 | __metrics 03:44:05 ERROR - PID 1686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:44:06 INFO - TEST-INFO | 1686: exit 0 03:44:06 INFO - Browser initialized. 03:44:06 INFO - Running cycle 1/1 for kraken test... 03:44:06 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpA7inpn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:09 INFO - PID 1688 | 2017-04-21 03:44:09.331 plugin-container[1689:10404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 03:44:09 INFO - PID 1688 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:44:09 INFO - PID 1688 | 2017-04-21 03:44:09.332 plugin-container[1689:10404] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 03:44:09 INFO - PID 1688 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:44:09 INFO - PID 1688 | 2017-04-21 03:44:09.332 plugin-container[1689:10404] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:44:19 INFO - PID 1688 | RSS: Main: 236789760 03:44:19 INFO - PID 1688 | 03:44:21 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:22 INFO - PID 1688 | RSS: Main: 248950784 03:44:22 INFO - PID 1688 | 03:44:25 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 03:44:25 INFO - PID 1688 | RSS: Main: 257105920 03:44:25 INFO - PID 1688 | 03:44:29 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 03:44:30 INFO - PID 1688 | RSS: Main: 259514368 03:44:30 INFO - PID 1688 | 03:44:31 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 03:44:32 INFO - PID 1688 | RSS: Main: 261824512 03:44:32 INFO - PID 1688 | 03:44:34 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:35 INFO - PID 1688 | RSS: Main: 261976064 03:44:35 INFO - PID 1688 | 03:44:38 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:38 INFO - PID 1688 | RSS: Main: 268197888 03:44:38 INFO - PID 1688 | 03:44:42 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:42 INFO - PID 1688 | RSS: Main: 268705792 03:44:42 INFO - PID 1688 | 03:44:45 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 03:44:46 INFO - PID 1688 | RSS: Main: 268730368 03:44:46 INFO - PID 1688 | 03:44:47 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:48 INFO - PID 1688 | RSS: Main: 268009472 03:44:48 INFO - PID 1688 | 03:44:50 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:50 INFO - PID 1688 | RSS: Main: 268374016 03:44:50 INFO - PID 1688 | 03:44:52 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:53 INFO - PID 1688 | RSS: Main: 267776000 03:44:53 INFO - PID 1688 | 03:44:56 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:57 INFO - PID 1688 | RSS: Main: 267890688 03:44:57 INFO - PID 1688 | 03:45:00 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:00 INFO - PID 1688 | RSS: Main: 268156928 03:45:00 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 03:45:02 INFO - PID 1688 | RSS: Main: 269770752 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | __start_tp_report 03:45:02 INFO - PID 1688 | _x_x_mozilla_page_load 03:45:02 INFO - PID 1688 | _x_x_mozilla_page_load_details 03:45:02 INFO - PID 1688 | |i|pagename|runs| 03:45:02 INFO - PID 1688 | |0;ai-astar;103;115;116;116;115;115;116;115;117;116 03:45:02 INFO - PID 1688 | |1;audio-beat-detection;146;112;111;176;153;113;108;112;143;114 03:45:02 INFO - PID 1688 | |2;audio-dft;196;198;200;213;208;232;261;208;177;266 03:45:02 INFO - PID 1688 | |3;audio-fft;82;59;61;85;61;61;63;63;80;69 03:45:02 INFO - PID 1688 | |4;audio-oscillator;86;70;87;75;69;68;88;70;71;91 03:45:02 INFO - PID 1688 | |5;imaging-gaussian-blur;91;77;80;139;137;82;139;137;89;89 03:45:02 INFO - PID 1688 | |6;imaging-darkroom;106;155;159;99;102;98;97;97;100;107 03:45:02 INFO - PID 1688 | |7;imaging-desaturate;91;94;90;92;111;106;91;91;100;93 03:45:02 INFO - PID 1688 | |8;json-parse-financial;51;52;54;71;77;79;78;70;51;51 03:45:02 INFO - PID 1688 | |9;json-stringify-tinderbox;55;63;58;62;66;61;56;57;56;56 03:45:02 INFO - PID 1688 | |10;stanford-crypto-aes;82;82;84;81;85;83;82;87;83;84 03:45:02 INFO - PID 1688 | |11;stanford-crypto-ccm;145;157;159;153;138;144;159;145;185;127 03:45:02 INFO - PID 1688 | |12;stanford-crypto-pbkdf2;188;187;180;183;185;182;191;186;184;188 03:45:02 INFO - PID 1688 | |13;stanford-crypto-sha256-iterative;71;70;69;69;70;67;67;67;69;69 03:45:02 INFO - PID 1688 | __end_tp_report 03:45:02 INFO - PID 1688 | __start_cc_report 03:45:02 INFO - PID 1688 | _x_x_mozilla_cycle_collect,1000 03:45:02 INFO - PID 1688 | __end_cc_report 03:45:02 INFO - PID 1688 | __startTimestamp1492771502914__endTimestamp 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | ------- Summary: start ------- 03:45:02 INFO - PID 1688 | Number of tests: 14 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#0] ai-astar Cycles:10 Average:114.40 Median:116.00 stddev:4.06 (3.5%) stddev-sans-first:0.71 03:45:02 INFO - PID 1688 | Values: 103.0 115.0 116.0 116.0 115.0 115.0 116.0 115.0 117.0 116.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:128.50 stddev:23.79 (18.5%) stddev-sans-first:24.41 03:45:02 INFO - PID 1688 | Values: 146.0 112.0 111.0 176.0 153.0 113.0 108.0 112.0 143.0 114.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#2] audio-dft Cycles:10 Average:215.90 Median:210.50 stddev:28.71 (13.6%) stddev-sans-first:29.54 03:45:02 INFO - PID 1688 | Values: 196.0 198.0 200.0 213.0 208.0 232.0 261.0 208.0 177.0 266.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#3] audio-fft Cycles:10 Average:68.40 Median:66.00 stddev:10.04 (15.2%) stddev-sans-first:9.36 03:45:02 INFO - PID 1688 | Values: 82.0 59.0 61.0 85.0 61.0 61.0 63.0 63.0 80.0 69.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:80.50 stddev:9.30 (11.6%) stddev-sans-first:9.34 03:45:02 INFO - PID 1688 | Values: 86.0 70.0 87.0 75.0 69.0 68.0 88.0 70.0 71.0 91.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:106.00 Median:81.00 stddev:27.88 (34.4%) stddev-sans-first:29.04 03:45:02 INFO - PID 1688 | Values: 91.0 77.0 80.0 139.0 137.0 82.0 139.0 137.0 89.0 89.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#6] imaging-darkroom Cycles:10 Average:112.00 Median:128.00 stddev:23.99 (18.7%) stddev-sans-first:25.34 03:45:02 INFO - PID 1688 | Values: 106.0 155.0 159.0 99.0 102.0 98.0 97.0 97.0 100.0 107.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:91.00 stddev:7.31 (8.0%) stddev-sans-first:7.54 03:45:02 INFO - PID 1688 | Values: 91.0 94.0 90.0 92.0 111.0 106.0 91.0 91.0 100.0 93.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:70.50 stddev:12.57 (17.8%) stddev-sans-first:12.51 03:45:02 INFO - PID 1688 | Values: 51.0 52.0 54.0 71.0 77.0 79.0 78.0 70.0 51.0 51.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.50 stddev:3.74 (6.3%) stddev-sans-first:3.68 03:45:02 INFO - PID 1688 | Values: 55.0 63.0 58.0 62.0 66.0 61.0 56.0 57.0 56.0 56.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:1.77 (2.1%) stddev-sans-first:1.81 03:45:02 INFO - PID 1688 | Values: 82.0 82.0 84.0 81.0 85.0 83.0 82.0 87.0 83.0 84.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:155.00 stddev:15.60 (10.1%) stddev-sans-first:16.38 03:45:02 INFO - PID 1688 | Values: 145.0 157.0 159.0 153.0 138.0 144.0 159.0 145.0 185.0 127.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:186.50 stddev:3.27 (1.8%) stddev-sans-first:3.33 03:45:02 INFO - PID 1688 | Values: 188.0 187.0 180.0 183.0 185.0 182.0 191.0 186.0 184.0 188.0 03:45:02 INFO - PID 1688 | 03:45:02 INFO - PID 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:1.24 03:45:02 INFO - PID 1688 | Values: 71.0 70.0 69.0 69.0 70.0 67.0 67.0 67.0 69.0 69.0 03:45:02 INFO - PID 1688 | -------- Summary: end -------- 03:45:02 INFO - PID 1688 | 03:45:03 INFO - TEST-INFO | 1688: exit 0 03:45:03 INFO - TEST-OK | kraken | took 60969ms 03:45:03 INFO - SUITE-END | took 1175s 03:45:04 INFO - Completed test suite (00:19:35) 03:45:04 INFO - javascript benchmark 03:45:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7899.976490943464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3198.344339410421, 3571.767835090719, 3613.1328481164496, 3620.094976255936, 3627.1476203092275, 6011.0, 6153.784617538393, 6156.5690401671845, 6188.102725104863, 6198.876022479548, 6105.338445949974, 6106.157323464397, 6129.356417576158, 6141.2405385826005, 6208.348123447041, 5211.322528071345, 5363.356397232337, 5377.085895397782, 5425.945740542584, 5475.233467314579, 4778.593819525345, 5377.139657654776, 5416.187571864232, 5485.985092757833, 5491.0, 5447.45525447456, 5481.890362192754, 5482.890342193154, 5486.1222204447295, 5514.751836167382, 5236.921446178272, 5299.973500132513, 5302.310699609065, 5373.462653734634, 5402.459754024605, 5331.946680533184, 5347.491988261109, 5362.91955620666, 5366.731663416814, 5415.187721841716, 5967.761289548456, 6121.418465245794, 6193.752249909998, 6213.161223234851, 6255.562110652256, 5496.972515137439, 6364.745410183634, 6416.51876109289, 6531.575447595938, 6615.86768264632, 6699.162604674416, 6722.932770672329, 6723.899141512881, 6735.494837887178, 6735.797926062177, 6297.622142671455, 6313.621182729051, 6322.936770632281, 6329.36706329368, 6333.46165575922, 6584.440322572635, 6658.43403310724, 6771.492138089663, 6777.8644427111185, 6875.140607424072, 4906.337644418029, 5124.846254612367, 5280.313559237275, 6267.7806276781, 6567.934320656732, 5315.840524784263, 6441.5490915635455, 6455.806325810233, 6570.540062195696, 6687.0, 5381.3811411687375, 6504.0, 6545.247296560957, 6548.0384367457955, 6580.243272023683, 6284.465820405317, 6494.707738151795, 6557.540972132, 6565.507586930999, 6685.732570697118, 5210.088234559013, 5278.683279003272, 5311.415744268127, 5341.439148889388, 5357.785688572491, 4690.7654617269, 4707.435107787088, 4713.552212539803, 4714.834980775657, 4717.339572459859, 6112.663803490762, 6317.747290108436, 6330.588511746721, 6339.334369891095, 6342.682865856781, 4984.601231901439, 6250.499960003189, 6475.838104047342, 6626.734930602818, 6671.466282697373, 6248.031555108965, 6264.874702505925, 6297.370262973666, 6304.022876454157, 6316.336784637639, 5873.148393483007, 5879.853003674943, 5888.263967004124, 5905.527557795366, 5925.259342582177, 6645.468362530889, 6685.6322902240845, 6878.174619045746, 6918.10064691607, 6935.063766391472, 6730.596164230162, 6743.696533655899, 6769.0, 6782.762603308861, 6789.762358317435, 6833.931660683528, 6922.826929326807, 6942.305769423219, 6951.965240173767, 6960.37356637905, 5481.177823326533, 6360.395762402564, 6391.2330520337855, 6523.6738163092605, 6642.734290628321, 6607.0, 6644.103046088716, 6650.567713098633, 6675.7329706813125, 6729.1252137221845, 6455.419012288917, 6456.128422663069, 6472.902906456313, 6486.740530378921, 6503.414692677682, 5266.210068489757, 6267.968660156853, 6321.146645203023, 6390.680465976776, 6457.3865482779065, 6226.688665566613, 6365.618062916054, 6386.233651961795, 6387.105805187371, 6395.42441180296, 6507.154069970874, 6518.967405162944, 6520.902186467301, 6522.967385163233, 6528.053432252392, 6144.955357589131, 6307.148534947723, 6309.0, 6343.0, 6343.11196432509], "value": 5999.7093997345855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.972001119955, 724.0912654618453, 802.7872613757354, 1244.45866048269, 1251.1304643272929, 36895.63104368956, 37905.431418528744, 37910.620893791056, 37998.81000594996, 38098.66654667087, 38288.0, 38409.23181536367, 38665.806670966675, 38740.41889371662, 38771.22457550847, 7854.0, 8051.798705032363, 8251.876221856677, 8458.87311690325, 8468.280196183332, 8335.124811894755, 8362.16378362165, 8423.452475589067, 8439.789005274855, 8445.873311900326, 8360.247577718004, 8396.45423047503, 8466.619002144918, 8478.406511544194, 8482.406231563793, 8423.199796019398, 8441.240288374045, 8447.704330348439, 8462.449940753831, 8468.830623387497, 6928.757493487704, 8290.46112002724, 8323.542205178714, 8348.039975402846, 8354.498730076215, 30295.545566816294, 37118.62881371206, 37256.0, 37331.626683733084, 37355.62644373576, 3089.969100309013, 3634.709223262159, 3636.9636303637153, 3643.2531331077066, 3647.215848592565, 30902.53646195309, 30956.845215774003, 30957.690423095704, 30989.535156972663, 31054.53418198729, 3152.5271209318557, 3184.3153721949893, 3189.521571764231, 3199.728023118038, 3207.550942868, 212397.0, 269339.0, 275458.6227068872, 296513.0, 296942.0, 46810.5318946813, 46867.531324687, 46904.76547617308, 46999.0, 47031.35390261324, 48781.26828097581, 48831.75584122057, 54483.72758136184, 55268.0, 55404.16893746597, 14124.505642302676, 14272.858171346268, 14286.142831430148, 14304.85695143056, 14336.641583960276, 11281.379524126252, 11340.376279304552, 11348.659540213806, 11362.0, 11371.260868043717, 14085.366158522891, 14108.365123569463, 14113.153210807384, 14175.149491030572, 14227.28863556818, 6137.785177518855, 6151.323354431009, 6210.782622608187, 6220.222472190976, 6232.59488133279, 875.874501265883, 977.1385510602314, 1006.6577363696379, 1027.8304079826894, 1054.1198099586932, 24381.024759009797, 24508.26475205747, 24724.505509889703, 24761.876190618932, 24788.38029049252, 1108.4513165982728, 1113.4377139544479, 1138.2715062360096, 1150.0, 1159.3855256713955, 10364.274500785023, 12038.759224815454, 12591.307478088609, 12651.746965060647, 13135.868641313657, 319614.0, 329099.0, 331227.0, 331296.0, 331386.0, 53827.0, 54029.0, 54322.45677543253, 54417.1837422439, 54690.0, 1490.2921112471706, 1517.4613012380446, 1525.161161361247, 1534.0948840184344, 1544.088987497382, 18529.629407411507, 21651.35045948624, 22316.442088947908, 23966.041358345472, 24083.0, 35682.46476302806, 37863.0, 44018.119637607706, 47100.52899470962, 47164.7641761789, 256588.0, 302507.0, 303027.48486257426, 304226.0, 308899.0, 36048.21493743119, 36206.0, 36256.81871590625, 36261.63738362688, 36515.0, 45111.32333014942, 45267.77366113148, 45854.54145458503, 46123.0, 46296.0, 29399.412011760072, 29907.700922991364, 30319.848400757855, 30857.8457107722, 31026.379472410877, 26495.0, 28097.859510702314, 30326.545101823933, 30992.91524796621, 31165.844170779, 37450.0, 37458.438123428714, 37515.81242093772, 37542.624573753914, 37714.622853771114, 23678.28965131049, 30168.09495715132, 30611.0, 31261.0, 31629.051128466184, 21380.358589242347, 23680.644790328504, 24185.75814241835, 24359.299922821792, 24418.63372049385], "value": 17553.188993216394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.59391935427476, 441.8033974881178, 443.72267332916925, 447.26648296793246, 460.6314948041568, 19965.700514492295, 21572.89213553932, 21669.0, 21777.128914843408, 21920.99999999996, 21875.79683117428, 22182.334529964126, 22290.88854555725, 22336.88831555844, 22412.32763017112, 6083.1483592297, 6241.625502469867, 6264.655443950581, 6272.059191121345, 6273.811785646415, 5079.593632509391, 5806.274215723035, 6053.757849686007, 6224.8443788905415, 6234.407731265545, 5399.271098401705, 5993.670348130851, 6061.45446909778, 6165.414285642857, 6178.196834411543, 4999.550040496373, 6013.278406591194, 6111.541634377417, 6196.628202307854, 6365.872682546369, 5464.098423760075, 5482.479164479368, 5491.066518691832, 5516.282883225195, 5528.419515950848, 25659.0, 25724.87137564319, 25728.614070788954, 25891.352716182057, 25965.610515842276, 2316.501952080294, 2322.1408079010707, 2356.670066190735, 2364.7280562735164, 2368.7749663781915, 15236.619084522976, 16164.030158190546, 17259.654806903916, 17635.911820440815, 17747.84638998461, 2119.8092171704466, 2179.4442417183677, 2206.2388475975763, 2234.977650223493, 2243.069126312578, 171276.1436192811, 173121.0, 173519.0, 173591.0, 175966.0, 12765.680857978625, 12883.22700637946, 12892.677683057998, 12903.0, 12903.483860645469, 16321.347146114022, 16611.750823737653, 16629.50111496657, 16642.916785416237, 16652.666946661, 8800.181670978001, 9119.498427586546, 9137.40606860552, 9247.398919070374, 9251.67619133327, 8675.349348798865, 8685.91314086851, 8688.044315125331, 8705.695300664447, 8863.113688631085, 6612.94192929129, 7882.960585197037, 7901.486403383762, 8012.639431225609, 8102.7569172924905, 2203.922862699798, 2216.479127405091, 2223.3663405929233, 2226.9443263918533, 2413.662087307778, 755.5353457623522, 959.6017652674202, 974.6442548469757, 994.3834822410007, 1023.339317773797, 17703.0, 21206.0, 21665.56668866614, 21710.674339884914, 22004.449888752908, 1027.8406846938738, 1035.35807799165, 1059.6238335390826, 1075.8816530181673, 1077.0737166037202, 10812.026917577456, 11122.277051991594, 11202.94398528002, 11225.71935701614, 11316.434178291218, 564498.0, 569786.0, 576365.0, 577936.0, 579454.0, 102729.48635256776, 136556.0, 136597.0, 138879.36163511104, 143883.2805835964, 1099.5217080569978, 1245.3337464456654, 1282.3460035381836, 1285.1582213650074, 1288.6005338345144, 22093.226737064124, 22381.0, 22417.887910560345, 22516.88741556282, 22689.205877794197, 46045.309320360895, 57202.0, 59748.0, 59795.0, 60889.69555152373, 83279.0, 84748.0, 86729.56635216784, 86952.00051993849, 88418.64056389897, 8728.170823771732, 8953.507557084424, 8998.0, 9049.502277374808, 9074.0, 13591.91264698802, 13812.447502099803, 13968.860311396757, 14201.928990354982, 14224.928875355557, 10275.332103413255, 11304.717382065513, 11983.483468471719, 12224.266544007389, 12297.70874058211, 11190.160737944523, 11375.488103035217, 11486.540538378371, 11686.123540734648, 11718.589849355232, 11867.881321186678, 11930.582429614922, 12102.092343074128, 12346.629601111981, 12573.559925402567, 8818.206361427503, 8847.159519845605, 8893.599788009684, 8893.955530222307, 9049.864252036356, 11978.221415607957, 12020.33888136161, 12027.939860300643, 12163.75672486563, 12283.57007504733], "value": 10621.792789606083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.1670347680958, 1396.2669598460807, 1426.0, 1441.7909403136553, 1455.490578297596, 11494.137939654527, 11800.58697945572, 11937.701557461069, 11953.581624643139, 12321.507139714424, 11889.64331070067, 12149.39253037349, 12156.756864862697, 12162.513499460034, 12197.329146896916, 2568.1653462624677, 2570.9614355784583, 2598.6751656042993, 2603.2580714496276, 2605.531004419204, 2107.894605269738, 2528.810339224556, 2568.1653462624627, 2569.0494517028633, 2571.639970404145, 2482.6648402465617, 2528.9873550632315, 2561.602951542514, 2572.691277046757, 2576.240009197282, 2475.0471068638612, 2532.5821239495554, 2540.898364065435, 2557.577999630059, 2559.2194380713877, 2269.6028195065796, 2535.5055764126005, 2549.7832684221676, 2576.6779152605923, 2582.5480540905264, 11996.64010079699, 12069.336186509738, 12072.939635301855, 12081.0, 12085.939570302093, 6108.114323423123, 6652.50106242029, 6862.176538815324, 6881.41507971823, 6899.103116594861, 4169.812358443877, 4422.646188304928, 4476.082403107355, 4487.730736155809, 4516.909661806778, 1254.8556915954691, 1273.8344015278046, 1315.83552055993, 1317.1965101288206, 1321.6365499487622, 13846.93076534621, 15774.369025238977, 16720.6655866882, 16852.578685532837, 16853.41013064549, 5242.868928276824, 6028.638281703024, 6092.421219984094, 6350.5554611177695, 6363.268224154282, 13935.442582296595, 14068.030475733405, 14081.155130692192, 14087.577372678836, 14099.154050756782, 6166.691665416712, 6852.725890964405, 6915.89626155608, 6961.61711105894, 6972.1284839395075, 4886.438059623118, 6058.21243238385, 6216.844578885564, 6245.469135123474, 6338.366163383717, 4682.063587282489, 4839.637027222972, 4857.514248575114, 4878.268259761065, 4945.752712364368, 1499.025633338317, 1536.64657128861, 1537.4388348252808, 1537.9000364976241, 1553.7902383178127, 776.7747353267603, 779.111812533712, 804.527714282861, 805.5408417202138, 807.5962018990505, 6145.5698101133385, 6213.0, 6214.378562143749, 6223.14165217568, 6312.116303717391, 595.1697382151874, 596.5555661032472, 611.458858909868, 620.9099680546295, 624.5659266809524, 3715.20123173519, 4103.692223083221, 4122.855700050543, 4314.309710446376, 4450.910981780346, 10646.840297395545, 14445.49440769568, 14535.345909434101, 14575.0, 15071.54785356441, 14501.492447764489, 14894.180820054784, 14900.0314979526, 14916.403343866341, 14927.328270227867, 8601.838751768557, 8630.78423039429, 8672.436291641023, 8686.609102590399, 8692.52191129494, 6704.966475167593, 7015.789526314219, 7105.609191494311, 7127.928720712934, 7131.8573628528175, 11630.360330181922, 12245.265284082983, 13667.248301343521, 13700.794488082487, 13722.039457237897, 12195.024398047957, 12848.0, 13835.031547791557, 13955.511557095453, 14003.719925601634, 8568.35737319716, 8858.202761751474, 9734.707958761248, 9875.604975801174, 9896.752581185528, 10028.69913902584, 11030.613928512463, 11038.227324087236, 11057.447127643747, 11059.889401106208, 8969.372143950122, 9230.123138301851, 9304.395214311047, 9332.95333523328, 9344.672936447192, 7436.144843343085, 8985.550722463982, 9018.278537716837, 9090.0, 9165.587548560197, 8103.230193131643, 8144.470609410369, 8238.958805206175, 8270.338372930271, 8270.627821747916, 5178.922316165336, 5940.7920722776225, 6008.669523176267, 6011.248593925759, 6062.514998800174, 5862.856742935257, 6074.362191969956, 6102.115193297036, 6163.630182189083, 6222.23998641049], "value": 5413.5625281612165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.5250305860028, 405.7565460723566, 410.3803257081809, 416.175971576279, 419.7124969395963, 5402.297701298836, 6096.969515152424, 6135.8772824543485, 6269.404406581379, 6275.529335299853, 5124.871878203037, 5476.658218736406, 6227.9688601557045, 6246.500279977602, 6265.404786545282, 3803.3344164771192, 4676.667149862282, 4745.501722319159, 4746.596539294164, 4754.239321708527, 4313.762743049131, 4332.761698106603, 4747.4540427850725, 4771.856844294677, 4788.80844766209, 4081.0, 4732.219183834663, 4751.216049351853, 4752.310914917335, 4760.928586071212, 4525.728456292633, 4633.582977532038, 4674.789634466457, 4713.552212539803, 4763.356946812188, 3574.964250357489, 4116.806126223391, 4177.373393990895, 4181.456410666624, 4240.300350442173, 4920.434150072751, 6074.0, 6080.452759251644, 6099.865047233433, 6105.481034112061, 4664.5335466453425, 5457.263269458612, 5508.607510469927, 5543.916841247345, 5627.380988091307, 5687.829365119053, 6046.758129674808, 6602.896638579859, 6625.436837868787, 6626.542160724633, 4363.781810909473, 4591.540845915415, 4796.424429068499, 4797.472278049412, 4830.661853670244, 6799.218089919624, 6946.241824350336, 7017.193022802392, 7019.087518622547, 7043.0, 3996.360582306875, 4043.757374557536, 4062.6390159296375, 4231.534531201565, 4678.111158879802, 4513.81944722214, 4788.233882578771, 4789.814773175799, 4790.850195953016, 4791.137595232892, 5076.340075790124, 5401.297831281908, 5483.506484416342, 5534.003879301684, 5542.224088627595, 5644.435556444405, 5820.738066787005, 6198.380161983766, 6543.0, 6640.269570347258, 1437.73401920645, 1699.566610514311, 1721.3028723367056, 1726.8791184617207, 1728.7579738836573, 965.7826988927435, 1063.787282497953, 1190.2085113399664, 1192.66605350502, 1195.58154645875, 5676.7161641918565, 5972.85067873298, 6242.625442473466, 6279.183706118175, 6292.46514046302, 6418.19772528434, 6817.5568588041615, 6823.795286141324, 6834.266293482548, 6862.0, 4702.52974702527, 5386.865328366822, 6149.016157414792, 6249.343818899041, 6258.468030217391, 3092.9793168254423, 3121.7502599792415, 3124.656287808339, 3573.7855728656364, 3591.6228795976567, 5476.479734425223, 6742.797716068526, 7076.681549330293, 7106.7157313706875, 7158.427325813923, 5906.940930590725, 7094.751683691046, 7119.0, 7130.500864939509, 7346.191918888918, 5425.891482170335, 6811.216710078305, 7119.323664251888, 7163.964180179066, 7202.891956620655, 5673.773049078156, 6884.311568843075, 6907.13660792401, 6942.166939967236, 6964.965175174092, 6646.401823835878, 6765.729370825309, 6807.3873351398615, 6815.318468153145, 6849.554778939353, 5668.752874367632, 6818.727250909908, 7009.7897063088185, 7128.322809333105, 7142.214356420894, 4091.734037287567, 4523.0, 4533.54664533544, 4536.72779633223, 4552.544745525421, 6627.1716035495565, 6791.320867913367, 6850.9314906850295, 6929.133858267716, 6947.0, 5633.014222511126, 6204.5967012144065, 6618.437432818265, 6643.555750921599, 6668.799936001928, 5664.518515926193, 6118.418750218722, 6263.248410190807, 6498.902516462352, 6625.536212465081, 6417.582857114273, 6496.70764815575, 6508.023796430573, 6520.739170433129, 6563.606183628997, 6221.595596286227, 6648.767293144717, 6669.699863506057, 6670.433013193739, 6682.398584127452, 5497.725113744376, 5633.324001119728, 5862.0, 6152.477039451696, 6401.479186447528], "value": 4847.14040891739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.99613001935, 786.2452046035805, 821.437315438924, 833.4874052457741, 873.2141073034267, 15757.84242157578, 16233.594160146002, 16264.186790660478, 18036.54908627282, 18777.061146942633, 17016.744748828776, 17176.39882604109, 17444.38944636938, 17584.736228956543, 18155.818441815576, 950.4059962523405, 965.9420434773936, 967.2020583019003, 969.1907257440046, 970.1365784451843, 942.5334459442586, 943.5140902435252, 945.9952700236489, 947.6730527967875, 948.4167237149172, 1012.7923775626016, 1019.2050200843317, 1022.2333250062453, 1022.5551884930042, 1023.3961962442157, 1014.0518615094873, 1014.6093753904726, 1014.9847752283684, 1016.4054028393399, 1017.5115944346718, 720.5640587444625, 750.4034292737286, 751.4176513202312, 751.4889874885131, 751.8045308219847, 16486.093264870426, 16773.7483937741, 16804.075775832323, 16821.0, 16851.74722379165, 16295.185240738034, 16648.001119932844, 16873.0, 16984.150792460452, 16996.915015424845, 13653.795193072112, 13711.45154193831, 13929.651758706012, 13944.302784860716, 13991.790123148161, 3389.3729660012978, 3496.160921378876, 3500.527428797105, 3504.106452854531, 3511.315293517765, 110262.0, 119035.0, 119100.0, 120468.0, 122236.0, 13259.138156019828, 13351.933240333736, 13501.189928604315, 13520.526781562598, 13587.660308492366, 24379.39051523726, 24879.378015549755, 24942.875285623457, 25203.495930081295, 25307.0, 7837.2162783722315, 7952.960235198787, 7959.482633628795, 7970.9202907970175, 7971.0, 3893.3575959966856, 3922.2155568886337, 3935.153941902505, 3967.7501587, 3971.3447281198855, 4130.483689538808, 4274.807633656493, 4316.935245971313, 4342.804573794187, 4344.695871288979, 926.3746970794687, 955.2262667239559, 957.2820384711466, 962.8122516109291, 962.9470379129075, 633.0, 637.2926052082186, 656.3633275722541, 658.3021996683435, 674.4199988010307, 11219.214654974074, 11862.0, 11907.642770716893, 13079.41142648583, 13242.867571324163, 634.5684934244758, 655.2726473614284, 655.8983357579583, 664.1333060356282, 687.6492988575862, 5195.506426889515, 5252.632315737938, 5302.575793936476, 5518.889622207614, 5890.823275301748, 98518.0, 100023.49988250158, 100142.0, 104489.0, 105540.0, 89281.10718892858, 95328.0, 95696.0, 97185.0, 97690.0, 83373.0, 84674.5766271177, 84712.30575388458, 85346.71979920306, 85397.99999999876, 9882.604695812088, 11639.825402618799, 12239.0, 12265.018798495921, 12286.447109879899, 34956.82521587376, 37539.0, 41491.7925410371, 41765.37351939784, 42312.78843605762, 54688.0, 55160.0, 55278.72360638171, 55844.44155558392, 56314.718426407606, 14450.060746051473, 14489.275536222936, 14591.781123283372, 14654.340554674853, 14662.973591848468, 17626.030568318867, 17685.292588296837, 17876.91061544684, 17936.282548697905, 18028.188731507376, 14494.927525362305, 15834.574888260111, 16386.590335241715, 16642.251098700344, 16761.664766704842, 16126.758098628765, 16139.031658100552, 16253.67492650164, 16371.918140409221, 16409.753853692444, 13251.933740331237, 15992.840071599601, 16174.272157753165, 16243.944143630626, 16338.0, 10898.782024359627, 11104.944475277573, 11193.0, 11412.31526108436, 11841.5855445059, 12303.753924921273, 13310.933445332712, 13521.72956540844, 13630.318484075558, 13646.385912634154], "value": 8280.785531107907, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 116.0, 116.0, 115.0, 115.0, 116.0, 115.0, 117.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 111.0, 176.0, 153.0, 113.0, 108.0, 112.0, 143.0, 114.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 200.0, 213.0, 208.0, 232.0, 261.0, 208.0, 177.0, 266.0], "value": 215.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 61.0, 85.0, 61.0, 61.0, 63.0, 63.0, 80.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 75.0, 69.0, 68.0, 88.0, 70.0, 71.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 77.0, 80.0, 139.0, 137.0, 82.0, 139.0, 137.0, 89.0, 89.0], "value": 106.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 155.0, 159.0, 99.0, 102.0, 98.0, 97.0, 97.0, 100.0, 107.0], "value": 112.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 90.0, 92.0, 111.0, 106.0, 91.0, 91.0, 100.0, 93.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 71.0, 77.0, 79.0, 78.0, 70.0, 51.0, 51.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 58.0, 62.0, 66.0, 61.0, 56.0, 57.0, 56.0, 56.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 84.0, 81.0, 85.0, 83.0, 82.0, 87.0, 83.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 157.0, 159.0, 153.0, 138.0, 144.0, 159.0, 145.0, 185.0, 127.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 180.0, 183.0, 185.0, 182.0, 191.0, 186.0, 184.0, 188.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 69.0, 70.0, 67.0, 67.0, 67.0, 69.0, 69.0], "value": 68.8, "unit": "score"}]}]} 03:45:04 INFO - Return code: 0 03:45:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:04 ERROR - # TBPL SUCCESS # 03:45:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:45:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:45:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:45:04 INFO - 2017-04-21 03:45:04.236 screenresolution[1693:10789] starting screenresolution argv=screenresolution get 03:45:04 INFO - 2017-04-21 03:45:04.239 screenresolution[1693:10789] Display 0: 1600x1200x32@60 03:45:04 INFO - 2017-04-21 03:45:04.246 screenresolution[1694:10792] starting screenresolution argv=screenresolution list 03:45:04 INFO - Available Modes on Display 0 03:45:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:45:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:45:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:45:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:45:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:45:04 INFO - Intel Iris: 03:45:04 INFO - Chipset Model: Intel Iris 03:45:04 INFO - Type: GPU 03:45:04 INFO - Bus: Built-In 03:45:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:45:04 INFO - Vendor: Intel (0x8086) 03:45:04 INFO - Device ID: 0x0a2e 03:45:04 INFO - Revision ID: 0x0009 03:45:04 INFO - Displays: 03:45:04 INFO - Display: 03:45:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:45:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:45:04 INFO - Display Serial Number: 1600x1200 60 03:45:04 INFO - Main Display: Yes 03:45:04 INFO - Mirror: Off 03:45:04 INFO - Online: Yes 03:45:04 INFO - Rotation: Supported 03:45:04 INFO - Return code: 0 03:45:04 INFO - Running post-action listener: _resource_record_post_action 03:45:04 INFO - [mozharness: 2017-04-21 10:45:04.488235Z] Finished run-tests step (success) 03:45:04 INFO - Running post-run listener: _resource_record_post_run 03:45:04 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 40446464; Write bytes: 517880832; Read time: 393; Write time: 1842 03:45:04 INFO - TinderboxPrint: CPU usage
54.1% 03:45:04 INFO - TinderboxPrint: I/O read bytes / time
40,446,464 / 393 03:45:04 INFO - TinderboxPrint: I/O write bytes / time
517,880,832 / 1,842 03:45:04 INFO - TinderboxPrint: CPU idle
2,196.1 (45.9%) 03:45:04 INFO - TinderboxPrint: CPU system
962.9 (20.1%) 03:45:04 INFO - TinderboxPrint: CPU user
1,626.5 (34.0%) 03:45:04 INFO - TinderboxPrint: Swap in / out
248,098,816 / 0 03:45:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193063424; Write bytes: 194594304; Read time: 14997; Write time: 403 03:45:04 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 39463424; Write bytes: 306460160; Read time: 377; Write time: 1386 03:45:04 INFO - Running post-run listener: _upload_blobber_files 03:45:04 INFO - Blob upload gear active. 03:45:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:04 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 03:45:04 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'] 03:45:04 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 03:45:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:06 INFO - (blobuploader) - INFO - Done attempting. 03:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:06 INFO - (blobuploader) - INFO - Done attempting. 03:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:07 INFO - (blobuploader) - INFO - Done attempting. 03:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:10 INFO - (blobuploader) - INFO - Done attempting. 03:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:10 INFO - Return code: 0 03:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41cb38e32efd87a426b337ad3bc7ab7adfd4077cfc4ad0e2f063c66a79ecafe734d9e8fe7151a98d22c58ffc0c74888ef8f8b519119acbdf29c2d1ed4f94c37d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80dc37048b906dbefed8c849396769de43abc9bc64a040ece1ecfebfd237eab6d72fc1f8785e133800f5e1019d5de56aa87d58738f98e845bfc1fc07414b66a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/563d8fbe43031439e5eb3651edaadfe7a020e0b716678c3ce102a51a823883bd893b85ca0174aed5554630ab1045207e8dda9596058030c6e21a24ddd332d81d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9790efdd29657bb2699ac53516114901cc817d03b3ff05ad4b22d429c6ae001bdc76803f47c8d6171aa06d37db54b6d3ec6170482228f305a6cf44694fdf0c54"} 03:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:10 INFO - Contents: 03:45:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41cb38e32efd87a426b337ad3bc7ab7adfd4077cfc4ad0e2f063c66a79ecafe734d9e8fe7151a98d22c58ffc0c74888ef8f8b519119acbdf29c2d1ed4f94c37d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80dc37048b906dbefed8c849396769de43abc9bc64a040ece1ecfebfd237eab6d72fc1f8785e133800f5e1019d5de56aa87d58738f98e845bfc1fc07414b66a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/563d8fbe43031439e5eb3651edaadfe7a020e0b716678c3ce102a51a823883bd893b85ca0174aed5554630ab1045207e8dda9596058030c6e21a24ddd332d81d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9790efdd29657bb2699ac53516114901cc817d03b3ff05ad4b22d429c6ae001bdc76803f47c8d6171aa06d37db54b6d3ec6170482228f305a6cf44694fdf0c54"} 03:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:10 INFO - Copying logs to upload dir... 03:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.057663 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-04-21 03:45:10.238192) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:45:10.241763) ========= 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.mv6t6KMFST/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.Ml1GdZO86m/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/41cb38e32efd87a426b337ad3bc7ab7adfd4077cfc4ad0e2f063c66a79ecafe734d9e8fe7151a98d22c58ffc0c74888ef8f8b519119acbdf29c2d1ed4f94c37d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80dc37048b906dbefed8c849396769de43abc9bc64a040ece1ecfebfd237eab6d72fc1f8785e133800f5e1019d5de56aa87d58738f98e845bfc1fc07414b66a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/563d8fbe43031439e5eb3651edaadfe7a020e0b716678c3ce102a51a823883bd893b85ca0174aed5554630ab1045207e8dda9596058030c6e21a24ddd332d81d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9790efdd29657bb2699ac53516114901cc817d03b3ff05ad4b22d429c6ae001bdc76803f47c8d6171aa06d37db54b6d3ec6170482228f305a6cf44694fdf0c54"} build_url:https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010942 build_url: 'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/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/41cb38e32efd87a426b337ad3bc7ab7adfd4077cfc4ad0e2f063c66a79ecafe734d9e8fe7151a98d22c58ffc0c74888ef8f8b519119acbdf29c2d1ed4f94c37d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80dc37048b906dbefed8c849396769de43abc9bc64a040ece1ecfebfd237eab6d72fc1f8785e133800f5e1019d5de56aa87d58738f98e845bfc1fc07414b66a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/563d8fbe43031439e5eb3651edaadfe7a020e0b716678c3ce102a51a823883bd893b85ca0174aed5554630ab1045207e8dda9596058030c6e21a24ddd332d81d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9790efdd29657bb2699ac53516114901cc817d03b3ff05ad4b22d429c6ae001bdc76803f47c8d6171aa06d37db54b6d3ec6170482228f305a6cf44694fdf0c54"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:45:10.276526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:45:10.276884) ========= 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.mv6t6KMFST/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.Ml1GdZO86m/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:45:10.326794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:45:10.327147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:45:10.327521) ========= ========= Total master_lag: 0.04 =========