builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1492770311.39 results: success (0) buildid: 20170421015828 builduid: 5a90c7a08d2d47c79c99d00564b17b0a revision: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.390511) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.391041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.391400) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.416983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.417400) ========= 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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:25:11-- 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% 78.5M=0s 2017-04-21 03:25:11 (78.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.529712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.530143) ========= 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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.022130 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:11.579003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:25:11.579385) ========= 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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:25:11,673 truncating revision to first 12 chars 2017-04-21 03:25:11,673 Setting DEBUG logging. 2017-04-21 03:25:11,673 attempt 1/10 2017-04-21 03:25:11,673 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:25:13,273 unpacking tar archive at: mozilla-central-950b641e2b9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.860269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-21 03:25:13.463625) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:13.464007) ========= script_repo_revision: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:13.464442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:13.464750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 03:25:13.484975) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 03:25:13.485395) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:25:13 INFO - MultiFileLogger online at 20170421 03:25:13 in /builds/slave/test 03:25:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:25:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:13 INFO - {'append_to_log': False, 03:25:13 INFO - 'base_work_dir': '/builds/slave/test', 03:25:13 INFO - 'blob_upload_branch': 'Firefox', 03:25:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:13 INFO - 'branch': 'Firefox', 03:25:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:13 INFO - 'config_files': ('talos/mac_config.py',), 03:25:13 INFO - 'default_actions': ('clobber', 03:25:13 INFO - 'read-buildbot-config', 03:25:13 INFO - 'download-and-extract', 03:25:13 INFO - 'populate-webroot', 03:25:13 INFO - 'create-virtualenv', 03:25:13 INFO - 'install', 03:25:13 INFO - 'run-tests'), 03:25:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:13 INFO - 'download_minidump_stackwalk': True, 03:25:13 INFO - 'download_symbols': 'ondemand', 03:25:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:13 INFO - 'gecko_profile': False, 03:25:13 INFO - 'gecko_profile_interval': 0, 03:25:13 INFO - 'installer_path': 'installer.exe', 03:25:13 INFO - 'log_level': 'info', 03:25:13 INFO - 'log_name': 'talos', 03:25:13 INFO - 'log_to_console': True, 03:25:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:25:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:25:13 INFO - 'opt_config_files': (), 03:25:13 INFO - 'pip_index': False, 03:25:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:25:13 INFO - 'cmd': ('bash', 03:25:13 INFO - '-c', 03:25:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:25:13 INFO - 'enabled': True, 03:25:13 INFO - 'halt_on_failure': False, 03:25:13 INFO - 'name': 'check_screen_resolution'},), 03:25:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:25:13 INFO - 'cmd': ('bash', 03:25:13 INFO - '-c', 03:25:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:25:13 INFO - 'enabled': True, 03:25:13 INFO - 'halt_on_failure': False, 03:25:13 INFO - 'name': 'check_screen_resolution'},), 03:25:13 INFO - 'run_cmd_checks_enabled': True, 03:25:13 INFO - 'suite': 'dromaeojs', 03:25:13 INFO - 'system_bits': '32', 03:25:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:13 INFO - 'title': 't-yosemite-r7-0225', 03:25:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:13 INFO - 'use_talos_json': True, 03:25:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:13 INFO - 'work_dir': 'build'} 03:25:13 INFO - [mozharness: 2017-04-21 10:25:13.698143Z] Running clobber step. 03:25:13 INFO - Running pre-action listener: _resource_record_pre_action 03:25:13 INFO - Running main action method: clobber 03:25:13 INFO - rmtree: /builds/slave/test/build 03:25:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:15 INFO - Running post-action listener: _resource_record_post_action 03:25:15 INFO - [mozharness: 2017-04-21 10:25:15.560445Z] Finished clobber step (success) 03:25:15 INFO - [mozharness: 2017-04-21 10:25:15.560578Z] Running read-buildbot-config step. 03:25:15 INFO - Running pre-action listener: _resource_record_pre_action 03:25:15 INFO - Running main action method: read_buildbot_config 03:25:15 INFO - Using buildbot properties: 03:25:15 INFO - { 03:25:15 INFO - "project": "", 03:25:15 INFO - "product": "firefox", 03:25:15 INFO - "script_repo_revision": "production", 03:25:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:25:15 INFO - "repository": "", 03:25:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:25:15 INFO - "buildid": "20170421015828", 03:25:15 INFO - "pgo_build": "False", 03:25:15 INFO - "basedir": "/builds/slave/test", 03:25:15 INFO - "buildnumber": 83, 03:25:15 INFO - "slavename": "t-yosemite-r7-0225", 03:25:15 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:25:15 INFO - "platform": "yosemite_r7", 03:25:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:25:15 INFO - "branch": "mozilla-central", 03:25:15 INFO - "repo_path": "mozilla-central", 03:25:15 INFO - "revision": "950b641e2b9c5109ee8df6b2d39f09529d0f3c38", 03:25:15 INFO - "stage_platform": "macosx64", 03:25:15 INFO - "builduid": "5a90c7a08d2d47c79c99d00564b17b0a", 03:25:15 INFO - "slavebuilddir": "test" 03:25:15 INFO - } 03:25:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:25:15 INFO - Running post-action listener: _resource_record_post_action 03:25:15 INFO - [mozharness: 2017-04-21 10:25:15.563996Z] Finished read-buildbot-config step (success) 03:25:15 INFO - [mozharness: 2017-04-21 10:25:15.564127Z] Running download-and-extract step. 03:25:15 INFO - Running pre-action listener: _resource_record_pre_action 03:25:15 INFO - Running main action method: download_and_extract 03:25:15 INFO - mkdir: /builds/slave/test/build/tests 03:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:15 INFO - trying https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:25:15 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:25:15 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:25:16 INFO - Downloaded 1325 bytes. 03:25:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:25:16 INFO - Using the following test package requirements: 03:25:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:25:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:25:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:25:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:25:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'jsshell-mac.zip'], 03:25:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:25:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:25:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:25:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:25:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:25:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:25:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:25:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:25:16 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:25:16 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:25:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:25:18 INFO - Content-Length response header: 52522978 03:25:18 INFO - Bytes received: 52522978 03:25:34 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:25:34 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:25:34 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:25:34 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:25:36 INFO - Content-Length response header: 52522978 03:25:36 INFO - Bytes received: 52522978 03:25:51 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:25:51 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:25:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:25:53 INFO - Content-Length response header: 14408811 03:25:53 INFO - Bytes received: 14408811 03:25:53 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:53 INFO - trying https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:25:53 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:25:53 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:25:55 INFO - Downloaded 71027314 bytes. 03:25:55 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:25:55 INFO - mkdir: /builds/slave/test/properties 03:25:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:55 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:55 INFO - Contents: 03:25:55 INFO - build_url:https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:25:56 INFO - Running post-action listener: _resource_record_post_action 03:25:56 INFO - Running post-action listener: set_extra_try_arguments 03:25:56 INFO - [mozharness: 2017-04-21 10:25:56.109946Z] Finished download-and-extract step (success) 03:25:56 INFO - [mozharness: 2017-04-21 10:25:56.110062Z] Running populate-webroot step. 03:25:56 INFO - Running pre-action listener: _resource_record_pre_action 03:25:56 INFO - Running main action method: populate_webroot 03:25:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:56 INFO - '--tppagecycles', 03:25:56 INFO - '7'], 03:25:56 INFO - 'tests': ['tsvgm']}}, 03:25:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['damp', 'tps']}, 03:25:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'tests': ['damp', 'tps']}, 03:25:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['dromaeo_dom']}, 03:25:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:25:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['a11yr', 03:25:56 INFO - 'ts_paint', 03:25:56 INFO - 'tpaint', 03:25:56 INFO - 'sessionrestore', 03:25:56 INFO - 'sessionrestore_no_auto_restore', 03:25:56 INFO - 'tabpaint']}, 03:25:56 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:56 INFO - 'ts_paint', 03:25:56 INFO - 'tpaint', 03:25:56 INFO - 'sessionrestore', 03:25:56 INFO - 'sessionrestore_no_auto_restore', 03:25:56 INFO - 'tabpaint']}, 03:25:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:56 INFO - 'ts_paint', 03:25:56 INFO - 'tpaint', 03:25:56 INFO - 'sessionrestore', 03:25:56 INFO - 'sessionrestore_no_auto_restore', 03:25:56 INFO - 'tabpaint']}, 03:25:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:56 INFO - 'ts_paint', 03:25:56 INFO - 'tpaint', 03:25:56 INFO - 'sessionrestore', 03:25:56 INFO - 'sessionrestore_no_auto_restore', 03:25:56 INFO - 'tabpaint']}, 03:25:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['a11yr', 03:25:56 INFO - 'ts_paint', 03:25:56 INFO - 'tpaint', 03:25:56 INFO - 'sessionrestore', 03:25:56 INFO - 'sessionrestore_no_auto_restore', 03:25:56 INFO - 'tabpaint']}, 03:25:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['a11yr', 03:25:56 INFO - 'ts_paint', 03:25:56 INFO - 'tpaint', 03:25:56 INFO - 'sessionrestore', 03:25:56 INFO - 'sessionrestore_no_auto_restore', 03:25:56 INFO - 'tabpaint']}, 03:25:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:25:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:25:56 INFO - 'bloom_basic_ref']}, 03:25:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['tsvgx', 03:25:56 INFO - 'tsvgr_opacity', 03:25:56 INFO - 'tart', 03:25:56 INFO - 'tscrollx', 03:25:56 INFO - 'cart', 03:25:56 INFO - 'tsvg_static']}, 03:25:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:56 INFO - 'tsvgr_opacity', 03:25:56 INFO - 'tart', 03:25:56 INFO - 'tscrollx', 03:25:56 INFO - 'cart', 03:25:56 INFO - 'tsvg_static']}, 03:25:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'talos_options': ['--disable-e10s'], 03:25:56 INFO - 'tests': ['tp5o']}, 03:25:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'talos_options': ['--disable-e10s', 03:25:56 INFO - '--xperf_path', 03:25:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:56 INFO - 'tests': ['tp5n']}, 03:25:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:56 INFO - 'talos_options': ['--xperf_path', 03:25:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:56 INFO - 'tests': ['tp5n']}}, 03:25:56 INFO - 'talos.zip': {'path': '', 03:25:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:56 INFO - Running post-action listener: _resource_record_post_action 03:25:56 INFO - [mozharness: 2017-04-21 10:25:56.128824Z] Finished populate-webroot step (success) 03:25:56 INFO - [mozharness: 2017-04-21 10:25:56.128961Z] Running create-virtualenv step. 03:25:56 INFO - Running pre-action listener: _resource_record_pre_action 03:25:56 INFO - Running main action method: create_virtualenv 03:25:56 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:56 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:25:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:56 INFO - Using real prefix '/tools/python27' 03:25:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:56 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:59 INFO - Installing pip.................done. 03:25:59 INFO - Return code: 0 03:25:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:26:00 INFO - Reading from file tmpfile_stdout 03:26:00 INFO - Output received: 03:26:00 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:26:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:00 INFO - 'HOME': '/Users/cltbld', 03:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:00 INFO - 'LOGNAME': 'cltbld', 03:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:00 INFO - 'MOZ_NO_REMOTE': '1', 03:26:00 INFO - 'NO_EM_RESTART': '1', 03:26:00 INFO - 'PAGER': '/bin/cat', 03:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:00 INFO - 'PWD': '/builds/slave/test', 03:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:00 INFO - 'SHELL': '/bin/bash', 03:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:00 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:00 INFO - 'USER': 'cltbld', 03:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:00 INFO - 'XPC_FLAGS': '0x0', 03:26:00 INFO - 'XPC_SERVICE_NAME': '0', 03:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:00 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:26:00 INFO - Cleaning up... 03:26:00 INFO - Return code: 0 03:26:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:00 INFO - 'HOME': '/Users/cltbld', 03:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:00 INFO - 'LOGNAME': 'cltbld', 03:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:00 INFO - 'MOZ_NO_REMOTE': '1', 03:26:00 INFO - 'NO_EM_RESTART': '1', 03:26:00 INFO - 'PAGER': '/bin/cat', 03:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:00 INFO - 'PWD': '/builds/slave/test', 03:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:00 INFO - 'SHELL': '/bin/bash', 03:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:00 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:00 INFO - 'USER': 'cltbld', 03:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:00 INFO - 'XPC_FLAGS': '0x0', 03:26:00 INFO - 'XPC_SERVICE_NAME': '0', 03:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:00 INFO - Downloading/unpacking psutil>=3.1.1 03:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:26:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:04 INFO - Installing collected packages: psutil 03:26:04 INFO - Running setup.py install for psutil 03:26:04 INFO - building 'psutil._psutil_osx' extension 03:26:04 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:26:04 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:26:04 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:26:04 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:26:04 INFO - building 'psutil._psutil_posix' extension 03:26:04 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:26:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:26:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:26:04 INFO - ^ 03:26:04 INFO - 1 warning generated. 03:26:04 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:26:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:26:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:26:04 INFO - Successfully installed psutil 03:26:04 INFO - Cleaning up... 03:26:04 INFO - Return code: 0 03:26:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:26:04 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:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:04 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:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:04 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:04 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:26:04 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:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:04 INFO - 'HOME': '/Users/cltbld', 03:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:04 INFO - 'LOGNAME': 'cltbld', 03:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:04 INFO - 'MOZ_NO_REMOTE': '1', 03:26:04 INFO - 'NO_EM_RESTART': '1', 03:26:04 INFO - 'PAGER': '/bin/cat', 03:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:04 INFO - 'PWD': '/builds/slave/test', 03:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:04 INFO - 'SHELL': '/bin/bash', 03:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:04 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:04 INFO - 'USER': 'cltbld', 03:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:04 INFO - 'XPC_FLAGS': '0x0', 03:26:04 INFO - 'XPC_SERVICE_NAME': '0', 03:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:26:05 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:26:05 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:26:05 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:26:05 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:26:05 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:26:05 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:26:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:26:07 INFO - Installing collected packages: mozsystemmonitor 03:26:07 INFO - Running setup.py install for mozsystemmonitor 03:26:08 INFO - Successfully installed mozsystemmonitor 03:26:08 INFO - Cleaning up... 03:26:08 INFO - Return code: 0 03:26:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:26:08 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:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 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:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:08 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:26:08 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:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:08 INFO - 'HOME': '/Users/cltbld', 03:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:08 INFO - 'LOGNAME': 'cltbld', 03:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:08 INFO - 'MOZ_NO_REMOTE': '1', 03:26:08 INFO - 'NO_EM_RESTART': '1', 03:26:08 INFO - 'PAGER': '/bin/cat', 03:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:08 INFO - 'PWD': '/builds/slave/test', 03:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:08 INFO - 'SHELL': '/bin/bash', 03:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:08 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:08 INFO - 'USER': 'cltbld', 03:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:08 INFO - 'XPC_FLAGS': '0x0', 03:26:08 INFO - 'XPC_SERVICE_NAME': '0', 03:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:08 INFO - Downloading/unpacking jsonschema==2.5.1 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:12 INFO - warning: no files found matching '*.txt' 03:26:12 INFO - no previously-included directories found matching 'build' 03:26:12 INFO - no previously-included directories found matching 'dist' 03:26:12 INFO - no previously-included directories found matching '.git*' 03:26:12 INFO - Installing collected packages: jsonschema, functools32 03:26:12 INFO - Running setup.py install for functools32 03:26:12 INFO - warning: no files found matching '*.txt' 03:26:12 INFO - no previously-included directories found matching 'build' 03:26:12 INFO - no previously-included directories found matching 'dist' 03:26:12 INFO - no previously-included directories found matching '.git*' 03:26:12 INFO - Successfully installed jsonschema functools32 03:26:12 INFO - Cleaning up... 03:26:12 INFO - Return code: 0 03:26:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:12 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:26:12 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:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:12 INFO - 'HOME': '/Users/cltbld', 03:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:12 INFO - 'LOGNAME': 'cltbld', 03:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:12 INFO - 'MOZ_NO_REMOTE': '1', 03:26:12 INFO - 'NO_EM_RESTART': '1', 03:26:12 INFO - 'PAGER': '/bin/cat', 03:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:12 INFO - 'PWD': '/builds/slave/test', 03:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:12 INFO - 'SHELL': '/bin/bash', 03:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:12 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:12 INFO - 'USER': 'cltbld', 03:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:12 INFO - 'XPC_FLAGS': '0x0', 03:26:12 INFO - 'XPC_SERVICE_NAME': '0', 03:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:26:12 INFO - Cleaning up... 03:26:12 INFO - Return code: 0 03:26:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:12 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:26:12 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:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:12 INFO - 'HOME': '/Users/cltbld', 03:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:12 INFO - 'LOGNAME': 'cltbld', 03:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:12 INFO - 'MOZ_NO_REMOTE': '1', 03:26:12 INFO - 'NO_EM_RESTART': '1', 03:26:12 INFO - 'PAGER': '/bin/cat', 03:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:12 INFO - 'PWD': '/builds/slave/test', 03:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:12 INFO - 'SHELL': '/bin/bash', 03:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:12 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:12 INFO - 'USER': 'cltbld', 03:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:12 INFO - 'XPC_FLAGS': '0x0', 03:26:12 INFO - 'XPC_SERVICE_NAME': '0', 03:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:13 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:13 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:26:13 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:26:13 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:26:13 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:26:13 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:26:13 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:26:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:16 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:26:16 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:26:16 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:26:16 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:26:16 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:26:16 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:26:17 INFO - Downloading docopt-0.6.1.tar.gz 03:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:17 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:17 INFO - Running setup.py install for blobuploader 03:26:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:17 INFO - Running setup.py install for requests 03:26:17 INFO - Running setup.py install for docopt 03:26:17 INFO - Successfully installed blobuploader requests docopt 03:26:17 INFO - Cleaning up... 03:26:18 INFO - Return code: 0 03:26:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:18 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:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:18 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:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:18 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:18 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:26:18 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:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:18 INFO - 'HOME': '/Users/cltbld', 03:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:18 INFO - 'LOGNAME': 'cltbld', 03:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:18 INFO - 'MOZ_NO_REMOTE': '1', 03:26:18 INFO - 'NO_EM_RESTART': '1', 03:26:18 INFO - 'PAGER': '/bin/cat', 03:26:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:18 INFO - 'PWD': '/builds/slave/test', 03:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:18 INFO - 'SHELL': '/bin/bash', 03:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:18 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:18 INFO - 'USER': 'cltbld', 03:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:18 INFO - 'XPC_FLAGS': '0x0', 03:26:18 INFO - 'XPC_SERVICE_NAME': '0', 03:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-06HYDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Q27unt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-EnYWqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-eXl5Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2F8jlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-hrMG6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:18 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-E8SFkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-7RAUJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-bnHlmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-5ZOiz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-yQt6wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-hiP47c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-G8zZks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-SORWp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-9QMr6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-tddj2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:19 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-JdEWWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:20 INFO - Running setup.py install for manifestparser 03:26:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:20 INFO - Running setup.py install for mozcrash 03:26:20 INFO - Running setup.py install for mozdebug 03:26:20 INFO - Running setup.py install for mozdevice 03:26:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:20 INFO - Running setup.py install for mozfile 03:26:20 INFO - Running setup.py install for mozhttpd 03:26:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:20 INFO - Running setup.py install for mozinfo 03:26:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Running setup.py install for mozInstall 03:26:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Running setup.py install for mozleak 03:26:21 INFO - Running setup.py install for mozlog 03:26:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Running setup.py install for moznetwork 03:26:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:21 INFO - Running setup.py install for mozprocess 03:26:21 INFO - Running setup.py install for mozprofile 03:26:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:22 INFO - Running setup.py install for mozrunner 03:26:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:22 INFO - Running setup.py install for mozscreenshot 03:26:22 INFO - Running setup.py install for moztest 03:26:22 INFO - Running setup.py install for mozversion 03:26:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:22 INFO - Cleaning up... 03:26:22 INFO - Return code: 0 03:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:22 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:22 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:26:22 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:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:22 INFO - 'HOME': '/Users/cltbld', 03:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:22 INFO - 'LOGNAME': 'cltbld', 03:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:22 INFO - 'MOZ_NO_REMOTE': '1', 03:26:22 INFO - 'NO_EM_RESTART': '1', 03:26:22 INFO - 'PAGER': '/bin/cat', 03:26:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:22 INFO - 'PWD': '/builds/slave/test', 03:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:22 INFO - 'SHELL': '/bin/bash', 03:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:22 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:22 INFO - 'USER': 'cltbld', 03:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:22 INFO - 'XPC_FLAGS': '0x0', 03:26:22 INFO - 'XPC_SERVICE_NAME': '0', 03:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:22 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-gdeYF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-KZepTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-kB2BJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-yXCwT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-A3kaTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-7LUYVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-XOgCz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-YFlfQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xr0SWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-BIDpU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:23 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:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:23 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-zQUAfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-VD3Grp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-UNAPvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-E2MTl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-mBmAy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-AL1fyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:24 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:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:24 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-HKHqYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:24 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:26:24 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:26:24 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:26:24 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:26:24 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:26:24 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:26:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:27 INFO - Downloading blessings-1.6.tar.gz 03:26:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:27 INFO - Installing collected packages: blessings 03:26:27 INFO - Running setup.py install for blessings 03:26:27 INFO - Successfully installed blessings 03:26:27 INFO - Cleaning up... 03:26:27 INFO - Return code: 0 03:26:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:27 INFO - Reading from file tmpfile_stdout 03:26:27 INFO - Current package versions: 03:26:27 INFO - blessings == 1.6 03:26:27 INFO - blobuploader == 1.2.4 03:26:27 INFO - docopt == 0.6.1 03:26:27 INFO - functools32 == 3.2.3-2 03:26:27 INFO - jsonschema == 2.5.1 03:26:27 INFO - manifestparser == 1.1 03:26:27 INFO - mozInstall == 1.12 03:26:27 INFO - mozcrash == 1.0 03:26:27 INFO - mozdebug == 0.1 03:26:27 INFO - mozdevice == 0.50 03:26:27 INFO - mozfile == 1.2 03:26:27 INFO - mozhttpd == 0.7 03:26:27 INFO - mozinfo == 0.9 03:26:27 INFO - mozleak == 0.1 03:26:27 INFO - mozlog == 3.4 03:26:27 INFO - moznetwork == 0.27 03:26:27 INFO - mozprocess == 0.25 03:26:27 INFO - mozprofile == 0.28 03:26:27 INFO - mozrunner == 6.13 03:26:27 INFO - mozscreenshot == 0.1 03:26:27 INFO - mozsystemmonitor == 0.3 03:26:27 INFO - moztest == 0.8 03:26:27 INFO - mozversion == 1.4 03:26:27 INFO - psutil == 3.1.1 03:26:27 INFO - requests == 1.2.3 03:26:27 INFO - wsgiref == 0.1.2 03:26:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26: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:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26: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:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:27 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 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:27 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:26:27 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:26:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:27 INFO - 'HOME': '/Users/cltbld', 03:26:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:27 INFO - 'LOGNAME': 'cltbld', 03:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:27 INFO - 'MOZ_NO_REMOTE': '1', 03:26:27 INFO - 'NO_EM_RESTART': '1', 03:26:27 INFO - 'PAGER': '/bin/cat', 03:26:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:27 INFO - 'PWD': '/builds/slave/test', 03:26:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:27 INFO - 'SHELL': '/bin/bash', 03:26:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:27 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:27 INFO - 'USER': 'cltbld', 03:26:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:27 INFO - 'XPC_FLAGS': '0x0', 03:26:27 INFO - 'XPC_SERVICE_NAME': '0', 03:26:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 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:26:28 INFO - Cleaning up... 03:26:28 INFO - Return code: 0 03:26:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f771b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f774768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95ebc76980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, '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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:28 INFO - 'HOME': '/Users/cltbld', 03:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:28 INFO - 'LOGNAME': 'cltbld', 03:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:28 INFO - 'MOZ_NO_REMOTE': '1', 03:26:28 INFO - 'NO_EM_RESTART': '1', 03:26:28 INFO - 'PAGER': '/bin/cat', 03:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:28 INFO - 'PWD': '/builds/slave/test', 03:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:28 INFO - 'SHELL': '/bin/bash', 03:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:28 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:28 INFO - 'USER': 'cltbld', 03:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:28 INFO - 'XPC_FLAGS': '0x0', 03:26:28 INFO - 'XPC_SERVICE_NAME': '0', 03:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:26:28 INFO - Cleaning up... 03:26:28 INFO - Return code: 0 03:26:28 INFO - Running post-action listener: _resource_record_post_action 03:26:28 INFO - Running post-action listener: _start_resource_monitoring 03:26:28 INFO - Starting resource monitoring. 03:26:28 INFO - [mozharness: 2017-04-21 10:26:28.530778Z] Finished create-virtualenv step (success) 03:26:28 INFO - [mozharness: 2017-04-21 10:26:28.531834Z] Running install step. 03:26:28 INFO - Running pre-action listener: _resource_record_pre_action 03:26:28 INFO - Running main action method: install 03:26:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:28 INFO - Reading from file tmpfile_stdout 03:26:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:28 INFO - Reading from file tmpfile_stdout 03:26:28 INFO - Output received: 03:26:28 INFO - Usage: mozinstall [options] installer 03:26:28 INFO - Options: 03:26:28 INFO - -h, --help show this help message and exit 03:26:28 INFO - -d DEST, --destination=DEST 03:26:28 INFO - Directory to install application into. [default: 03:26:28 INFO - "/builds/slave/test"] 03:26:28 INFO - --app=APP Application being installed. [default: firefox] 03:26:28 INFO - mkdir: /builds/slave/test/build/application 03:26:28 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:26:28 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:26:48 INFO - Reading from file tmpfile_stdout 03:26:48 INFO - Output received: 03:26:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:26:48 INFO - Running post-action listener: _resource_record_post_action 03:26:48 INFO - [mozharness: 2017-04-21 10:26:48.734660Z] Finished install step (success) 03:26:48 INFO - [mozharness: 2017-04-21 10:26:48.734776Z] Running run-tests step. 03:26:48 INFO - Running pre-action listener: _resource_record_pre_action 03:26:48 INFO - Running main action method: run_tests 03:26:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:26:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:26:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:26:48 INFO - 2017-04-21 03:26:48.749 screenresolution[2464:37461] starting screenresolution argv=screenresolution get 03:26:48 INFO - 2017-04-21 03:26:48.752 screenresolution[2464:37461] Display 0: 1600x1200x32@60 03:26:48 INFO - 2017-04-21 03:26:48.758 screenresolution[2465:37464] starting screenresolution argv=screenresolution list 03:26:48 INFO - Available Modes on Display 0 03:26:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:26:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:26:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:26:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:26:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:26:48 INFO - Intel Iris: 03:26:48 INFO - Chipset Model: Intel Iris 03:26:48 INFO - Type: GPU 03:26:48 INFO - Bus: Built-In 03:26:48 INFO - VRAM (Dynamic, Max): 1536 MB 03:26:48 INFO - Vendor: Intel (0x8086) 03:26:48 INFO - Device ID: 0x0a2e 03:26:48 INFO - Revision ID: 0x0009 03:26:48 INFO - Displays: 03:26:48 INFO - Display: 03:26:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:26:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:26:48 INFO - Display Serial Number: 1600x1200 60 03:26:48 INFO - Main Display: Yes 03:26:48 INFO - Mirror: Off 03:26:48 INFO - Online: Yes 03:26:48 INFO - Rotation: Supported 03:26:48 INFO - Return code: 0 03:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:48 INFO - Python 2.7.3 03:26:48 INFO - Return code: 0 03:26:48 INFO - grabbing minidump binary from tooltool 03:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:26:48 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 0x10f54fd30>, '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 0x10f475db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f544be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:48 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:26:48 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:26:48 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:26:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:49 INFO - Return code: 0 03:26:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:26:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:49 INFO - ENV: RUST_BACKTRACE is now 1 03:26:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:26:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--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-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --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-0225 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.meWfNLyhrF/Render', 03:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:26:49 INFO - 'HOME': '/Users/cltbld', 03:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:26:49 INFO - 'LOGNAME': 'cltbld', 03:26:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:49 INFO - 'MOZ_NO_REMOTE': '1', 03:26:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:49 INFO - 'NO_EM_RESTART': '1', 03:26:49 INFO - 'PAGER': '/bin/cat', 03:26:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:49 INFO - 'PWD': '/builds/slave/test', 03:26:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:26:49 INFO - 'RUST_BACKTRACE': '1', 03:26:49 INFO - 'SHELL': '/bin/bash', 03:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gd5V8NJ8G5/Listeners', 03:26:49 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 03:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:26:49 INFO - 'USER': 'cltbld', 03:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:49 INFO - 'XPC_FLAGS': '0x0', 03:26:49 INFO - 'XPC_SERVICE_NAME': '0', 03:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:26:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--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-0225', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:26:49 INFO - mozversion application_buildid: 20170421015828 03:26:49 INFO - mozversion application_changeset: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 03:26:49 INFO - mozversion application_display_name: Nightly 03:26:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:49 INFO - mozversion application_name: Firefox 03:26:49 INFO - mozversion application_remotingname: firefox 03:26:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:26:49 INFO - mozversion application_vendor: Mozilla 03:26:49 INFO - mozversion application_version: 55.0a1 03:26:49 INFO - mozversion platform_buildid: 20170421015828 03:26:49 INFO - mozversion platform_changeset: 950b641e2b9c5109ee8df6b2d39f09529d0f3c38 03:26:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:26:49 INFO - mozversion platform_version: 55.0a1 03:26:49 INFO - using testdate: 1492770409 03:26:49 INFO - actual date: 1492770409 03:26:49 INFO - starting webserver on 'localhost:60544' 03:26:49 INFO - SUITE-START | Running 2 tests 03:26:49 INFO - TEST-START | dromaeo_css 03:26:49 INFO - operating with platform_type : mac_ 03:26:49 INFO - Initialising browser for dromaeo_css test... 03:26:49 INFO - TEST-INFO | started process 2475 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpiHUVQb/profile http://localhost:60544/getInfo.html) 03:26:51 INFO - PID 2475 | __metrics Screen width/height:1600/1200 03:26:51 INFO - PID 2475 | colorDepth:24 03:26:51 INFO - PID 2475 | Browser inner width/height: 1024/689 03:26:51 INFO - PID 2475 | __metrics 03:26:51 INFO - PID 2475 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:26:51 INFO - PID 2475 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:26:53 INFO - TEST-INFO | 2475: exit 0 03:26:53 INFO - Browser initialized. 03:26:53 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:53 INFO - TEST-INFO | started process 2477 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpiHUVQb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:05 INFO - PID 2477 | RSS: Main: 242110464 03:27:05 INFO - PID 2477 | 03:30:09 INFO - PID 2477 | Cycle 1(1): loaded http://localhost:60544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60544/tests/dromaeo/cssquery-ext.html) 03:30:11 INFO - PID 2477 | RSS: Main: 341102592 03:30:11 INFO - PID 2477 | 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | A coding exception was thrown and uncaught in a Task. 03:31:54 INFO - PID 2477 | 03:31:54 ERROR - PID 2477 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:31:54 INFO - PID 2477 | Full stack: 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | A coding exception was thrown and uncaught in a Task. 03:31:54 INFO - PID 2477 | 03:31:54 ERROR - PID 2477 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:31:54 INFO - PID 2477 | Full stack: 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | A coding exception was thrown and uncaught in a Task. 03:31:54 INFO - PID 2477 | 03:31:54 ERROR - PID 2477 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:31:54 INFO - PID 2477 | Full stack: 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | ************************* 03:31:54 INFO - PID 2477 | A coding exception was thrown and uncaught in a Task. 03:31:54 INFO - PID 2477 | 03:31:54 ERROR - PID 2477 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:31:54 INFO - PID 2477 | Full stack: 03:31:54 INFO - PID 2477 | ************************* 03:33:14 INFO - PID 2477 | Cycle 1(1): loaded http://localhost:60544/tests/dromaeo/cssquery-ext.html (next: http://localhost:60544/tests/dromaeo/cssquery-jquery.html) 03:33:15 INFO - PID 2477 | RSS: Main: 369319936 03:33:15 INFO - PID 2477 | 03:36:17 INFO - PID 2477 | Cycle 1(1): loaded http://localhost:60544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60544/tests/dromaeo/cssquery-mootools.html) 03:36:18 INFO - PID 2477 | RSS: Main: 335953920 03:36:18 INFO - PID 2477 | 03:39:20 INFO - PID 2477 | Cycle 1(1): loaded http://localhost:60544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60544/tests/dromaeo/cssquery-prototype.html) 03:39:21 INFO - PID 2477 | RSS: Main: 323506176 03:39:21 INFO - PID 2477 | 03:42:24 INFO - PID 2477 | Cycle 1(1): loaded http://localhost:60544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60544/tests/dromaeo/cssquery-yui.html) 03:42:25 INFO - PID 2477 | RSS: Main: 334839808 03:42:25 INFO - PID 2477 | 03:45:27 INFO - PID 2477 | Cycle 1(1): loaded http://localhost:60544/tests/dromaeo/cssquery-yui.html (next: http://localhost:60544/tests/dromaeo/cssquery-dojo.html) 03:45:28 INFO - PID 2477 | RSS: Main: 370069504 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | __start_tp_report 03:45:28 INFO - PID 2477 | _x_x_mozilla_page_load 03:45:28 INFO - PID 2477 | _x_x_mozilla_page_load_details 03:45:28 INFO - PID 2477 | |i|pagename|runs| 03:45:28 INFO - PID 2477 | |0;dojo.html;3495.3533596284706;3514.7891126532404;3521.841517131729;3532.470129480578;3569.3039857227836;5981.88036239275;6098.886104840108;6172.105044768511;6195.628262304259;6199.318075011751;6003.339632640406;6057.182280392146;6065.818025459233;6066.636001839893;6091.208142941423;5229.8954020919555;5231.503007214318;5249.055170069386;5266.683998960056;5384.838454846361;4455.554444555551;5318.521333080022;5357.8392648220615;5373;5378.515933565978;4145.502539695241;5418.864528386783;5422.91865622016;5428.131498960148;5458.781648734046;5397.379301380313;5405.567554595623;5424.674519528801;5428.511433970962;5449.455054494559;5201.08980928336;5259.368875734898;5263.578913686934;5335.386430560497;5433.782648694048;4598.724076555417;5979.999999999956;6010.128531362971;6099.054646529795;6124.5100391968535;6406.743730250831;6409.070684750685;6417.647029413381;6418.679066046679;6423.389777971085;6413.807585772434;6500.577462464972;6504.349565043505;6511.641859697715;6514.478841692653;6105.823680184376;6119.969325458939;6132.080187971751;6140.754369825202;6236.282827474808;6787.321267873173;6790.11728475305;6792.150981127359;6828.453723702092;6834.794956151323;6406.67966601668;6411.711472983727;6432.163818703632;6438.098666186737;6468.2561505427475;6416.32628573993;6486.902696459557;6604.735810567524;6634.336566343327;6636.037774522667;6290.622562646256;6366.522510811707;6453.580517266362;6509.576877502947;6512.023196520465;6384.7126879290545;6478.190226221723;6508.381703738138;6552.312007239267;6571.9671401643645;5284.260203571503;5286.784039670821;5288.338957630296;5289.3652761668845;5293.417724050351;3949.447077409165;4648.907021859543;4691.085238378483;4743.02767932573;4762.309465127537;6105.358937311518;6145.8156255312415;6149.046897730859;6158.568900177034;6166;6598.571092878948;6637.103990961255;6658.234303055211;6662.133922590032;6667.833304167435;6194.318624951252;6222.439980401786;6230.127782110508;6230.252369715663;6242.656653883989;5665.3768085510565;5734.885302293931;5753.367129615739;5771.797987070432;5821.359650438449;6803.93196068033;6869.0383346332555;6877.1747390313485;6889.448844092561;6895.827604309932;6624.735010599522;6625.503087268377;6632.204135503771;6632.50256230775;6640.037194606658;6595.769148079794;6718.563293385914;6791.830204244736;6849;6869.969504574154;6347.174867267226;6357.396047375492;6472.255690595642;6496.935030649633;6516.543841931019;6487.708053137714;6609.4712423007;6613.768518101843;6622.470202383702;6629.602223866584;6384.553081284451;6433.356664333529;6437.163168788027;6440.774572889926;6449.4840412765925;6244.188255526752;6261.217347831521;6262.499000079892;6390.5526613136635;6404.871902562016;6263.060540918898;6291.528135389773;6312.715927783169;6316.210473690789;6325.936740632719;6202.658853762906;6215.906761398673;6231.688415579293;6420.807375778734;6424.775132870514;4508.819647214074;4606.930896036495;4875.536824001714;6157.230346206724;6282.623042617458 03:45:28 INFO - PID 2477 | |1;ext.html;795.2762985683028;808.2039191396475;1005.401785937367;1110.4947249001705;1132.597927735654;27571.897124115036;37692.86921392356;37722;37805.05487362821;37823.86528404145;40263.798681006556;40611;40709;40737;40769.38845917306;8264.504129752218;8505.957470212672;8514.361422893277;8514.361422893307;8522.318214542853;5998.1602575639445;6109.9918513445455;6117.357677443871;6121.418465245794;6129.478994285469;8227.300679442254;8397.034341050796;8404.03353614333;8408.495490270603;8423.663053477854;8295.875561866576;8373.665053397857;8380.161983801632;8384.664613415456;8397.706080287191;5956.583039187259;8240.299574536171;8343.374246931504;8344.41589088764;8347.207015333533;27334;29524.409511809645;36868;36888;36988.890333290045;3563.518924945151;3587.94618080729;3589.6948759355487;3590.1383667919513;3592.425211966099;30675.69324306773;30804;30817.921372751847;30828.537571936216;30943.535846962313;3167.081546351555;3202.327511222646;3214.3089235814414;3216.485362342014;3221.1624977505785;267057;272366;272526;272776;273449.63275183697;39479.40780888289;47525.76237118792;47639;47696.5230347699;47724.761376192895;39695.80152099279;41939;50570;50625;50694;13325.600231993056;13407.731845363038;13450.596482105357;13459.932700336436;13462.596122116352;10862.45687715611;10876.782464350668;10883.020528152505;10888.945555272332;10891.891081089088;12869.678258043437;12875.77680120387;12889.806652900214;12890.935545322402;12969.41637626309;4557.72653640776;5551.583631227674;5556.527695145877;5585.357683866408;5605.131204663284;969.6024629901707;972.1542258235239;972.2465089555651;990.7721224118493;1011.8128146292812;19453.4163975081;23704.40738981539;23779.762202377755;24071.605219726993;24109.794510274416;981.3915372469115;1063.6489958313894;1086.266769930294;1105.9115270778318;1113.660333598244;11068.391238481961;11605.941970290263;12204.816927746091;12270.018398528096;12289.877101229053;300156;300495;300593;300632;300996.4950175235;53885.46114538804;53910.730446347516;54039.729801351525;54059;54091.72954135204;1478.4825311141014;1480.8741256993276;1519.9620009499852;1521.2013692811142;1537.6079099829697;21398.893005534872;23475.530489389774;23512;23523.88238058867;23599.174028908907;37701.62298377091;37818.62181378261;37835;37838.24323513569;37858.24283514259;282078;282554;283455;283711;283999;29719;29864.805407784315;34231.31537369189;34390;34639.65360346465;43164;43947.34078988882;43979.34030989474;44038;44218.77890610655;29398.55902161512;29537;30069.849650751607;30132;30603;26830;27332.453350932472;28025.45859977721;30238.395232094794;30293.33703058212;25397;35986;36250;36689.44965825568;36766.89699309025;23930.521389571764;28033.719662803112;29893.95371161999;30296;31000.534991974688;17573.472795816146;21632.593881397657;23107.6533851989;23596.764032359457;23666.52666946617 03:45:28 INFO - PID 2477 | |2;jquery.html;443.8868088637397;445.30087762213316;446.32381941358847;453.5555155947172;469.4249544308223;21331.57336853262;21789.019494122764;22062.88968555157;22654.207102751367;22845.885770571123;22941.54116917665;23465;23501;23697.76302236977;23873.761262387372;5224.712640804754;6161.691915404223;6277.403646653561;6381.712822922979;6403.231612206541;6178.536609754264;6280.214973128359;6286.119943207955;6289.528285378592;6290.779822706206;5951.6726580038085;6190.133381326618;6245.968770156142;6253.968730156343;6256.37436256373;5986.371430999726;6175.814725558241;6186.876262474748;6197.101420294055;6208.813735587917;5568.916466253009;5572.832815015556;5574.58190635704;5575.135853942646;5592.944070559283;25917;26377.472450551075;26958.865205674043;27045.323866903287;27498.587521187197;2173.6196165671104;2210.2264207527237;2215.0475295622878;2218.1792736687366;2219.3563866478703;16619.252133654016;17275.395361162424;17792.84346517485;17808.37670681533;18050.382694509353;1822.7812662480455;2060.8763474191446;2111.366590023002;2152.2359562355296;2154.052217024504;134870;138754.3062284692;138780.30609846988;139703;140762;11841.625136836132;12260.81218883079;12275.877241227652;12313.56902508408;12345.074119441078;16330.428435004955;16337.101459419608;16394;16440.342386304415;16466.01203927768;8577.95711021441;8697.608607612672;8784.692535761218;8888.60001299943;8917.464952102895;8237.670493180205;8259.8348033039;8426;8442.451240669337;8451.182995655963;7369.144303346964;7652.73215437457;7672.386209103258;7673.928039429435;7682.7311044113185;2009.8392128629675;2081.3131666550003;2083.8226402082773;2092.514314836483;2096.5702031083592;833.2667252817603;855.9657613695507;865.6710450029075;883.3728053082383;894.7271082319955;18242;18827;18890.488760899094;18905.810941890406;19174.520636984187;763.6792547130219;888.4092078767547;924.67174153176;931.9767005824773;952.4047470331043;10749;11671;13060.608181754562;13108.606741797761;13709.931450342685;501174;503811;504954;517147;525431;129859.35070324776;130587;132279;132454.33772831075;133956;1176.2707121584672;1193.8507686539183;1226.6810629236463;1231.8398608180878;1232.9136960412684;19256.807431926063;21434.785652143903;21488;21606.462642845177;21718.674219886398;45580.08839823251;55531.444685552626;56996.715016424656;57717.42282577288;57934.13098803437;77142;77352;78958.6052069736;80337.3932521358;81544;8785.253253473526;8872.33457490678;8914.974777900365;8999.010108888147;9245.583948722458;13790.379432925341;13981.650458738613;14007.159570425807;14402.85597144015;14415.711685766017;10121.746956325856;11777.81078271188;11784.4696988634;11924.344161071225;12107.818382724443;9500.572474238814;9805.117539421486;11172.497237624164;11188.440577970907;11566.826497602711;11948;11963.700907477383;12235.082368822552;12240.02079833629;12318.753624927273;8732.825343493221;8970.775730606787;9105.053708745956;9145.496997664926;9179.816403672023;11716.648500544998;11925.10561707858;12086.274823510617;12096.153269271066;12149.514019439124 03:45:28 INFO - PID 2477 | |3;mootools.html;1135.8864113588647;1282.2114399644217;1378.531299358218;1396.2739375524727;1407.4159223922072;9720.270979676527;10207.642732504364;11707;11752.647420577376;11965.940170299158;11395.715107122325;11505.942470287659;11510.884891151087;11523.539058437653;11559.01748351389;2057.2593866208153;2545.414554652431;2548.9107881224163;2549.4646124313917;2552.7447255274415;2083.5207902182506;2145.1205005947563;2221.1448592292004;2487.763662452064;2580.8064395170345;2514.735952724965;2519.143491212987;2537.733537978513;2542.1102614085016;2543.49130173965;2509.7113831909382;2530.3927057506157;2532.9493410131786;2552.6553915221393;2559.372953626355;2195.8252335000857;2403.735589085199;2505.3235626380956;2520.1053625962704;2526.7240043777774;11650.475728592233;11699.766004679945;11786.35175065371;11793.410329483491;11805.94097029518;6534.346565343475;6760.8309792255095;6763.560368576027;6772.119624448839;6790.5246632735725;3976.5426975897853;4237.406763053175;4401.581849724271;4413.514513403523;4425.601695847389;1245.6138597034949;1246.962591122268;1268.7462507498537;1291.593148158327;1300.655326338521;16929.238184281738;16932.23804928781;16941.32234710598;16946;16957.406490772886;5821.27234095738;5920.467157955719;6003.849903752441;6033.577649564489;6101.908471372933;13909.035924761394;13927.791083133761;13939.303034848217;13945.302734863217;13964.301784910715;5625.353084395347;6641.86716265672;6723.495737819683;6747.7638282660855;6752.155980502437;5203.817866374735;6033.379319962299;6038.9396106038375;6193;6209.161763161916;4166.395872598457;4262.65898728101;4267.701260911706;4272.145570885836;4275.166342563232;1218.7867123253395;1228.570000499818;1338.3107699534748;1453.6220582648587;1501.8873584481207;766.9808254793675;767.7735068154908;782;783.4437549340032;783.9176886426843;6246.3441338659695;6391.328910464427;6597.60414375139;6624.735010599618;6764.0530325754435;889.9466032037969;899.7750562359411;903.336048004716;904.31272233102;939.5255396024963;3513.683768460851;3590.1024743814046;3616.3129005488872;3658.432942893856;3707.647773461517;13325.800112998313;13433.19400835953;13832.239226842621;14379.568612941628;15429.537113886601;13277.535286265127;14712.632184195481;15103.018303810217;15145.62135946588;15314.693706125816;8372.288355489729;8409.663613455394;8423;8472.830543389098;8551.990282283658;6210.161628180138;6874.587524748531;6903.861922761617;6919.546895152074;7076.433885289061;13364.532241371506;13389.732205355644;13520.25638589887;13729.45082196701;13756.931215343859;13763.38064787067;13975.440982360999;14081.788773168206;14101.435942562182;14121.788173177205;9124.589393477443;9374.906250937403;9463.148316651534;9467.573959171716;9470.337076404585;10654.254202205771;10801;10823.945880270549;10835.945820270848;10840.970107839743;8876.77808054778;9110.908890911007;9123.498207598646;9215.354925155174;9250.537473126182;8947.06055864125;9043.63825447001;9059.36584439083;9138.725838224864;9155.954220228856;8145.185481452045;8345.499270043816;8347.081820999807;8359.331253499584;8363.996320441343;5865.648061116347;5887.558433117448;6030.1256317832795;6077.149199112039;6152.876942461216;5961.433663801932;6154.922888494406;6170.722317495633;6226.719797609027;6276.968615156895 03:45:28 INFO - PID 2477 | |4;prototype.html;394.85785117357756;398.53769627232396;402.98186581603835;404.71872048925974;411.6644934378483;5453.936482385936;5845.707714614268;5924.822255332336;5946.197263369444;5953.255843019622;4572.702774319675;5203.973980130094;5274.156135018397;5462.235287059805;5723.198752174699;4035.61661642145;4218.367244913272;4429.623482004034;4465.843695470659;4470.926977525387;3883.26218018577;4459.331100334944;4461.397711308964;4469.000244780919;4471.686981911267;4233.6824738144605;4387.758673272969;4448.310511870649;4464.754438505881;4479.193745125876;3735.6364926801657;4326.307790753464;4337.804798784062;4413.514513403523;4419.73481591104;3211.373782112489;3251.7561182911377;3880.7865567393783;3892.3966785148345;3924.529056513237;5415.620906536544;5599.748011339459;5632.690202038886;5689.317281926195;5708.690917446773;5271.525562699337;5279.86800329991;5315.335583052119;5319.308489896327;5321.946780532184;4782.760861956923;5331.760070796823;6076.756929722806;6151.0474972013235;6158.351908679266;3893.5133108361456;4184.748915065105;4430.202563538562;4445.199864024475;4451;6197.659128747917;6391.233052033739;6417.711202995876;6474.352564743535;6474.9244109048295;3622.3117607654463;4012.29784787661;4253.872723728215;4382;4429.424174857248;4428.977855110768;4487.371767952489;4577.908441831145;4603.148417542699;4617.376654151713;4117.197146556393;4970.527799859007;5003.3488948646855;5070.391553013588;5287.259783630295;5139.203423469368;5296.3909150447425;6167;6178.258608966953;6183;1353.8830464866523;1487.761958086701;1490.4187366926908;1493.4617344135559;1498.0337682194922;888.9288856891433;971.771633666088;990.8216521026285;990.8266053440619;1007.0282177698556;5447.891042179213;5860.446981549892;5861.443162899518;5883.235179426647;5904.881902361929;6366.172397588284;6368.936310636927;6384.201974753156;6387.680615969183;6401.295857455676;5172.172452407672;5342.8512869733195;5558.499735023867;5856.707164641751;5898.793542226002;3113.735332496718;3342.2479942013338;3350.748693847971;3354.295597924463;3361.32773445307;6493.642849643315;6583.703733332011;6625.469962403093;6649.833754156185;6710.261871194165;5080.720560369141;6498.675066246668;6505.934940650533;6515.762005218993;6572.441342485847;6271.118664400753;6589.472842172615;6613.107230523818;6646.803575356385;6653.567518111307;6064.241969753781;6305.5901366411035;6400.327965563549;6416.197975253093;6436.356364363526;5744.926464341557;6014.909776353271;6018.849528761816;6289.371062893674;6292.653904035322;4387.692861499664;5570.6657600544095;5794.565407594531;6300.653464059521;6401.903971440525;3720.6837418819705;3744.513213282256;4251.319788833772;4252.319628859368;4317.956820431756;6221.657808820558;6324.620522768649;6357.55497115216;6391.808245752635;6454;5337.653052551572;5624.690642014729;6163.19878415803;6186.505079593531;6285.182926219562;5101.500264870113;5948.762049517971;6184.76304739045;6187.597806142587;6237.594556353823;5060.468650791614;5885.941140588539;6013.879722405615;6026.819195424145;6033.487153591994;5342.3705769739045;6134.4172303631085;6166.1983942087245;6196.628202307876;6206.72069756871;4677.672562920563;5155.968806238692;5839.5036421904615;5995.5803093783015;6016.849578760391 03:45:28 INFO - PID 2477 | |5;yui.html;712.5119293284104;844.2359664503624;855.1320409784066;866.3588944181307;875.0593112404165;12825.871741282584;16835.15824208789;17165.313387464517;17338.306467741306;17374.91312543439;17112.57218569533;17166.39917602884;17232.913835430805;17418.56453588661;17435.91282043588;951.6574033347989;964.3827950111934;983.4590974963777;984.4929861121528;984.9458279794609;662.4236913884927;680.8672308899767;981.2199301555245;984.9556769945334;995.2933417273708;951.4719330771419;1000.9549570269319;1001.2990906365537;1001.8296889528798;1004.1314263162349;987.693814917378;991.7768502086973;993.5777294649745;995.1044060345674;1000.3297790480395;740.9885506283938;741.998302291907;744.8957145999565;746.2723844251865;751.4476859508258;15559.611009724735;15814.841851581452;15995.040297582065;16521.504354869252;16543.503694889052;13682.863171368357;16316.592085197846;16576.254068566945;16849.157542122968;16944.3222271109;13360.86639133606;13624.93187534056;13628.318584070757;13841.238731869744;13857.792133118011;2980.463516567039;3391.5930088389305;3417.3507033663773;3425.5718035245595;3426.400379933502;82606;111906.88093119046;112163.43918280437;112397.43801281023;113452.43273783661;10804.837927431096;11148.163887708455;11552.884471155348;11673.649790506299;11790.469428875722;15291.770623440658;23075;23424.531509369717;23646.7635323648;23866.925988330568;7454.440916931252;7630.847383052308;7638.50349727266;7641.808954776064;7642.426817988673;3607.981960090183;3608.548931383577;3659.7255205859665;3828.8085595720104;3916.2167566486246;4213.220554197484;4299.355096735515;4302.225599392077;4304.397384366192;4310.418093557392;873.8077622922947;875.3347455933409;890.875277461156;891.7458524320667;891.9331050171263;546.8988237176135;634.4480302137079;648.8994205897999;655.7147640776277;661.2527843536773;9076.954615227014;11064.612738554111;11656.766864662828;11760.411979401168;11850.822237666442;587.9970600146972;630;638.6870433487558;643.9098526206335;651.4495500708379;5274.5780337572905;5371.113766228606;5395.406505284415;5453.945460545344;5551.139573366135;97881;101093.49453252833;103747;104197.47901260445;106344.93655063504;84236.15763842406;87940;90820.54589727009;90971;91813.54093229625;69324.96012559715;69432;76916;77475.22524774793;79862.4027519458;10345.27583069208;11853;12341.50633974631;12414.813777793159;12568;32442.540085695728;34284.31431371409;36497.63502365049;38325.61674383221;39557.40663889986;43959;63932.360676392644;63950.3604963963;64062;64096;15735.763963540327;15779.605509861885;15973.961692489951;15983.840161598235;16000.439984600484;17060.23228954725;17676.646467070845;17714.20286087155;17738.467845964125;17766.46700598984;12397.690057748629;16096;16123.274452649894;16196.676066478369;16396.426125085563;15782.289796958934;15973.361065557248;16006.279717412977;16015.279312430735;16115.274812633224;15399.923000385375;15529.84470155284;15708.92145539265;15800.051996880224;15818.367265309258;9231.446113233227;11128;11272;11407.315561066363;11435.428228588371;12310.138290319592;13471.663208419868;13480.86519134796;13488.190708557519;13510.594682159552 03:45:28 INFO - PID 2477 | __end_tp_report 03:45:28 INFO - PID 2477 | __start_cc_report 03:45:28 INFO - PID 2477 | _x_x_mozilla_cycle_collect,2505 03:45:28 INFO - PID 2477 | __end_cc_report 03:45:28 INFO - PID 2477 | __startTimestamp1492771528045__endTimestamp 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | ------- Summary: start ------- 03:45:28 INFO - PID 2477 | Number of tests: 6 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | [#0] dojo.html Cycles:165 Average:6003.72 Median:6244.19 stddev:757.29 (12.1%) stddev-sans-first:733.60 03:45:28 INFO - PID 2477 | Values: 3495.4 3514.8 3521.8 3532.5 3569.3 5981.9 6098.9 6172.1 6195.6 6199.3 6003.3 6057.2 6065.8 6066.6 6091.2 5229.9 5231.5 5249.1 5266.7 5384.8 4455.6 5318.5 5357.8 5373.0 5378.5 4145.5 5418.9 5422.9 5428.1 5458.8 5397.4 5405.6 5424.7 5428.5 5449.5 5201.1 5259.4 5263.6 5335.4 5433.8 4598.7 5980.0 6010.1 6099.1 6124.5 6406.7 6409.1 6417.6 6418.7 6423.4 6413.8 6500.6 6504.3 6511.6 6514.5 6105.8 6120.0 6132.1 6140.8 6236.3 6787.3 6790.1 6792.2 6828.5 6834.8 6406.7 6411.7 6432.2 6438.1 6468.3 6416.3 6486.9 6604.7 6634.3 6636.0 6290.6 6366.5 6453.6 6509.6 6512.0 6384.7 6478.2 6508.4 6552.3 6572.0 5284.3 5286.8 5288.3 5289.4 5293.4 3949.4 4648.9 4691.1 4743.0 4762.3 6105.4 6145.8 6149.0 6158.6 6166.0 6598.6 6637.1 6658.2 6662.1 6667.8 6194.3 6222.4 6230.1 6230.3 6242.7 5665.4 5734.9 5753.4 5771.8 5821.4 6803.9 6869.0 6877.2 6889.4 6895.8 6624.7 6625.5 6632.2 6632.5 6640.0 6595.8 6718.6 6791.8 6849.0 6870.0 6347.2 6357.4 6472.3 6496.9 6516.5 6487.7 6609.5 6613.8 6622.5 6629.6 6384.6 6433.4 6437.2 6440.8 6449.5 6244.2 6261.2 6262.5 6390.6 6404.9 6263.1 6291.5 6312.7 6316.2 6325.9 6202.7 6215.9 6231.7 6420.8 6424.8 4508.8 4606.9 4875.5 6157.2 6282.6 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | [#1] ext.html Cycles:180 Average:43092.10 Median:3208.32 stddev:74823.39 (2332.2%) stddev-sans-first:74965.90 03:45:28 INFO - PID 2477 | Values: 795.3 808.2 1005.4 1110.5 1132.6 27571.9 37692.9 37722.0 37805.1 37823.9 40263.8 40611.0 40709.0 40737.0 40769.4 8264.5 8506.0 8514.4 8514.4 8522.3 5998.2 6110.0 6117.4 6121.4 6129.5 8227.3 8397.0 8404.0 8408.5 8423.7 8295.9 8373.7 8380.2 8384.7 8397.7 5956.6 8240.3 8343.4 8344.4 8347.2 27334.0 29524.4 36868.0 36888.0 36988.9 3563.5 3587.9 3589.7 3590.1 3592.4 30675.7 30804.0 30817.9 30828.5 30943.5 3167.1 3202.3 3214.3 3216.5 3221.2 267057.0 272366.0 272526.0 272776.0 273449.6 39479.4 47525.8 47639.0 47696.5 47724.8 39695.8 41939.0 50570.0 50625.0 50694.0 13325.6 13407.7 13450.6 13459.9 13462.6 10862.5 10876.8 10883.0 10888.9 10891.9 12869.7 12875.8 12889.8 12890.9 12969.4 4557.7 5551.6 5556.5 5585.4 5605.1 969.6 972.2 972.2 990.8 1011.8 19453.4 23704.4 23779.8 24071.6 24109.8 981.4 1063.6 1086.3 1105.9 1113.7 11068.4 11605.9 12204.8 12270.0 12289.9 300156.0 300495.0 300593.0 300632.0 300996.5 53885.5 53910.7 54039.7 54059.0 54091.7 1478.5 1480.9 1520.0 1521.2 1537.6 21398.9 23475.5 23512.0 23523.9 23599.2 37701.6 37818.6 37835.0 37838.2 37858.2 282078.0 282554.0 283455.0 283711.0 283999.0 29719.0 29864.8 34231.3 34390.0 34639.7 43164.0 43947.3 43979.3 44038.0 44218.8 29398.6 29537.0 30069.8 30132.0 30603.0 26830.0 27332.5 28025.5 30238.4 30293.3 25397.0 35986.0 36250.0 36689.4 36766.9 23930.5 28033.7 29894.0 30296.0 31000.5 17573.5 21632.6 23107.7 23596.8 23666.5 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | [#2] jquery.html Cycles:180 Average:34133.39 Median:23599.38 stddev:86741.63 (367.6%) stddev-sans-first:86948.08 03:45:28 INFO - PID 2477 | Values: 443.9 445.3 446.3 453.6 469.4 21331.6 21789.0 22062.9 22654.2 22845.9 22941.5 23465.0 23501.0 23697.8 23873.8 5224.7 6161.7 6277.4 6381.7 6403.2 6178.5 6280.2 6286.1 6289.5 6290.8 5951.7 6190.1 6246.0 6254.0 6256.4 5986.4 6175.8 6186.9 6197.1 6208.8 5568.9 5572.8 5574.6 5575.1 5592.9 25917.0 26377.5 26958.9 27045.3 27498.6 2173.6 2210.2 2215.0 2218.2 2219.4 16619.3 17275.4 17792.8 17808.4 18050.4 1822.8 2060.9 2111.4 2152.2 2154.1 134870.0 138754.3 138780.3 139703.0 140762.0 11841.6 12260.8 12275.9 12313.6 12345.1 16330.4 16337.1 16394.0 16440.3 16466.0 8578.0 8697.6 8784.7 8888.6 8917.5 8237.7 8259.8 8426.0 8442.5 8451.2 7369.1 7652.7 7672.4 7673.9 7682.7 2009.8 2081.3 2083.8 2092.5 2096.6 833.3 856.0 865.7 883.4 894.7 18242.0 18827.0 18890.5 18905.8 19174.5 763.7 888.4 924.7 932.0 952.4 10749.0 11671.0 13060.6 13108.6 13709.9 501174.0 503811.0 504954.0 517147.0 525431.0 129859.4 130587.0 132279.0 132454.3 133956.0 1176.3 1193.9 1226.7 1231.8 1232.9 19256.8 21434.8 21488.0 21606.5 21718.7 45580.1 55531.4 56996.7 57717.4 57934.1 77142.0 77352.0 78958.6 80337.4 81544.0 8785.3 8872.3 8915.0 8999.0 9245.6 13790.4 13981.7 14007.2 14402.9 14415.7 10121.7 11777.8 11784.5 11924.3 12107.8 9500.6 9805.1 11172.5 11188.4 11566.8 11948.0 11963.7 12235.1 12240.0 12318.8 8732.8 8970.8 9105.1 9145.5 9179.8 11716.6 11925.1 12086.3 12096.2 12149.5 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | [#3] mootools.html Cycles:180 Average:7147.53 Median:3603.21 stddev:4576.28 (127.0%) stddev-sans-first:4566.82 03:45:28 INFO - PID 2477 | Values: 1135.9 1282.2 1378.5 1396.3 1407.4 9720.3 10207.6 11707.0 11752.6 11965.9 11395.7 11505.9 11510.9 11523.5 11559.0 2057.3 2545.4 2548.9 2549.5 2552.7 2083.5 2145.1 2221.1 2487.8 2580.8 2514.7 2519.1 2537.7 2542.1 2543.5 2509.7 2530.4 2532.9 2552.7 2559.4 2195.8 2403.7 2505.3 2520.1 2526.7 11650.5 11699.8 11786.4 11793.4 11805.9 6534.3 6760.8 6763.6 6772.1 6790.5 3976.5 4237.4 4401.6 4413.5 4425.6 1245.6 1247.0 1268.7 1291.6 1300.7 16929.2 16932.2 16941.3 16946.0 16957.4 5821.3 5920.5 6003.8 6033.6 6101.9 13909.0 13927.8 13939.3 13945.3 13964.3 5625.4 6641.9 6723.5 6747.8 6752.2 5203.8 6033.4 6038.9 6193.0 6209.2 4166.4 4262.7 4267.7 4272.1 4275.2 1218.8 1228.6 1338.3 1453.6 1501.9 767.0 767.8 782.0 783.4 783.9 6246.3 6391.3 6597.6 6624.7 6764.1 889.9 899.8 903.3 904.3 939.5 3513.7 3590.1 3616.3 3658.4 3707.6 13325.8 13433.2 13832.2 14379.6 15429.5 13277.5 14712.6 15103.0 15145.6 15314.7 8372.3 8409.7 8423.0 8472.8 8552.0 6210.2 6874.6 6903.9 6919.5 7076.4 13364.5 13389.7 13520.3 13729.5 13756.9 13763.4 13975.4 14081.8 14101.4 14121.8 9124.6 9374.9 9463.1 9467.6 9470.3 10654.3 10801.0 10823.9 10835.9 10841.0 8876.8 9110.9 9123.5 9215.4 9250.5 8947.1 9043.6 9059.4 9138.7 9156.0 8145.2 8345.5 8347.1 8359.3 8364.0 5865.6 5887.6 6030.1 6077.1 6152.9 5961.4 6154.9 6170.7 6226.7 6277.0 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | [#4] prototype.html Cycles:180 Average:4990.41 Median:5458.09 stddev:1537.40 (28.2%) stddev-sans-first:1502.52 03:45:28 INFO - PID 2477 | Values: 394.9 398.5 403.0 404.7 411.7 5453.9 5845.7 5924.8 5946.2 5953.3 4572.7 5204.0 5274.2 5462.2 5723.2 4035.6 4218.4 4429.6 4465.8 4470.9 3883.3 4459.3 4461.4 4469.0 4471.7 4233.7 4387.8 4448.3 4464.8 4479.2 3735.6 4326.3 4337.8 4413.5 4419.7 3211.4 3251.8 3880.8 3892.4 3924.5 5415.6 5599.7 5632.7 5689.3 5708.7 5271.5 5279.9 5315.3 5319.3 5321.9 4782.8 5331.8 6076.8 6151.0 6158.4 3893.5 4184.7 4430.2 4445.2 4451.0 6197.7 6391.2 6417.7 6474.4 6474.9 3622.3 4012.3 4253.9 4382.0 4429.4 4429.0 4487.4 4577.9 4603.1 4617.4 4117.2 4970.5 5003.3 5070.4 5287.3 5139.2 5296.4 6167.0 6178.3 6183.0 1353.9 1487.8 1490.4 1493.5 1498.0 888.9 971.8 990.8 990.8 1007.0 5447.9 5860.4 5861.4 5883.2 5904.9 6366.2 6368.9 6384.2 6387.7 6401.3 5172.2 5342.9 5558.5 5856.7 5898.8 3113.7 3342.2 3350.7 3354.3 3361.3 6493.6 6583.7 6625.5 6649.8 6710.3 5080.7 6498.7 6505.9 6515.8 6572.4 6271.1 6589.5 6613.1 6646.8 6653.6 6064.2 6305.6 6400.3 6416.2 6436.4 5744.9 6014.9 6018.8 6289.4 6292.7 4387.7 5570.7 5794.6 6300.7 6401.9 3720.7 3744.5 4251.3 4252.3 4318.0 6221.7 6324.6 6357.6 6391.8 6454.0 5337.7 5624.7 6163.2 6186.5 6285.2 5101.5 5948.8 6184.8 6187.6 6237.6 5060.5 5885.9 6013.9 6026.8 6033.5 5342.4 6134.4 6166.2 6196.6 6206.7 4677.7 5156.0 5839.5 5995.6 6016.8 03:45:28 INFO - PID 2477 | 03:45:28 INFO - PID 2477 | [#5] yui.html Cycles:180 Average:20593.86 Median:13423.69 stddev:28550.80 (212.7%) stddev-sans-first:28591.86 03:45:28 INFO - PID 2477 | Values: 712.5 844.2 855.1 866.4 875.1 12825.9 16835.2 17165.3 17338.3 17374.9 17112.6 17166.4 17232.9 17418.6 17435.9 951.7 964.4 983.5 984.5 984.9 662.4 680.9 981.2 985.0 995.3 951.5 1001.0 1001.3 1001.8 1004.1 987.7 991.8 993.6 995.1 1000.3 741.0 742.0 744.9 746.3 751.4 15559.6 15814.8 15995.0 16521.5 16543.5 13682.9 16316.6 16576.3 16849.2 16944.3 13360.9 13624.9 13628.3 13841.2 13857.8 2980.5 3391.6 3417.4 3425.6 3426.4 82606.0 111906.9 112163.4 112397.4 113452.4 10804.8 11148.2 11552.9 11673.6 11790.5 15291.8 23075.0 23424.5 23646.8 23866.9 7454.4 7630.8 7638.5 7641.8 7642.4 3608.0 3608.5 3659.7 3828.8 3916.2 4213.2 4299.4 4302.2 4304.4 4310.4 873.8 875.3 890.9 891.7 891.9 546.9 634.4 648.9 655.7 661.3 9077.0 11064.6 11656.8 11760.4 11850.8 588.0 630.0 638.7 643.9 651.4 5274.6 5371.1 5395.4 5453.9 5551.1 97881.0 101093.5 103747.0 104197.5 106344.9 84236.2 87940.0 90820.5 90971.0 91813.5 69325.0 69432.0 76916.0 77475.2 79862.4 10345.3 11853.0 12341.5 12414.8 12568.0 32442.5 34284.3 36497.6 38325.6 39557.4 43959.0 63932.4 63950.4 64062.0 64096.0 15735.8 15779.6 15974.0 15983.8 16000.4 17060.2 17676.6 17714.2 17738.5 17766.5 12397.7 16096.0 16123.3 16196.7 16396.4 15782.3 15973.4 16006.3 16015.3 16115.3 15399.9 15529.8 15708.9 15800.1 15818.4 9231.4 11128.0 11272.0 11407.3 11435.4 12310.1 13471.7 13480.9 13488.2 13510.6 03:45:28 INFO - PID 2477 | -------- Summary: end -------- 03:45:28 INFO - PID 2477 | 03:45:28 INFO - TEST-INFO | 2477: exit 0 03:45:28 INFO - TEST-OK | dromaeo_css | took 1119400ms 03:45:28 INFO - TEST-START | kraken 03:45:28 INFO - operating with platform_type : mac_ 03:45:28 INFO - Initialising browser for kraken test... 03:45:28 INFO - TEST-INFO | started process 2503 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmp8pEZwu/profile http://localhost:60544/getInfo.html) 03:45:31 INFO - PID 2503 | __metrics Screen width/height:1600/1200 03:45:31 INFO - PID 2503 | colorDepth:24 03:45:31 INFO - PID 2503 | Browser inner width/height: 1024/689 03:45:31 INFO - PID 2503 | __metrics 03:45:31 INFO - PID 2503 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:45:31 INFO - PID 2503 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:45:32 INFO - TEST-INFO | 2503: exit 0 03:45:32 INFO - Browser initialized. 03:45:32 INFO - Running cycle 1/1 for kraken test... 03:45:32 INFO - TEST-INFO | started process 2504 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmp8pEZwu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:44 INFO - PID 2504 | RSS: Main: 241987584 03:45:44 INFO - PID 2504 | 03:45:47 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60544/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:48 INFO - PID 2504 | RSS: Main: 312291328 03:45:48 INFO - PID 2504 | 03:45:50 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60544/tests/kraken/driver.html?testName=audio-dft) 03:45:51 INFO - PID 2504 | RSS: Main: 293720064 03:45:51 INFO - PID 2504 | 03:45:54 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60544/tests/kraken/driver.html?testName=audio-fft) 03:45:55 INFO - PID 2504 | RSS: Main: 385277952 03:45:55 INFO - PID 2504 | 03:45:56 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60544/tests/kraken/driver.html?testName=audio-oscillator) 03:45:57 INFO - PID 2504 | RSS: Main: 288710656 03:45:57 INFO - PID 2504 | 03:45:59 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:00 INFO - PID 2504 | RSS: Main: 292122624 03:46:00 INFO - PID 2504 | 03:46:02 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60544/tests/kraken/driver.html?testName=imaging-darkroom) 03:46:03 INFO - PID 2504 | RSS: Main: 354029568 03:46:03 INFO - PID 2504 | 03:46:06 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60544/tests/kraken/driver.html?testName=imaging-desaturate) 03:46:07 INFO - PID 2504 | RSS: Main: 378970112 03:46:07 INFO - PID 2504 | 03:46:09 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60544/tests/kraken/driver.html?testName=json-parse-financial) 03:46:10 INFO - PID 2504 | RSS: Main: 391159808 03:46:10 INFO - PID 2504 | 03:46:11 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:46:12 INFO - PID 2504 | RSS: Main: 332795904 03:46:12 INFO - PID 2504 | 03:46:14 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:46:15 INFO - PID 2504 | RSS: Main: 335773696 03:46:15 INFO - PID 2504 | 03:46:17 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:46:18 INFO - PID 2504 | RSS: Main: 317956096 03:46:18 INFO - PID 2504 | 03:46:20 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:46:21 INFO - PID 2504 | RSS: Main: 352899072 03:46:21 INFO - PID 2504 | 03:46:24 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:25 INFO - PID 2504 | RSS: Main: 344612864 03:46:25 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | Cycle 1(1): loaded http://localhost:60544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60544/tests/kraken/driver.html?testName=ai-astar) 03:46:27 INFO - PID 2504 | RSS: Main: 387317760 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | __start_tp_report 03:46:27 INFO - PID 2504 | _x_x_mozilla_page_load 03:46:27 INFO - PID 2504 | _x_x_mozilla_page_load_details 03:46:27 INFO - PID 2504 | |i|pagename|runs| 03:46:27 INFO - PID 2504 | |0;ai-astar;112;111;110;111;110;110;111;111;110;112 03:46:27 INFO - PID 2504 | |1;audio-beat-detection;141;113;110;149;109;111;109;101;134;105 03:46:27 INFO - PID 2504 | |2;audio-dft;186;186;184;185;187;184;185;184;185;183 03:46:27 INFO - PID 2504 | |3;audio-fft;80;60;60;91;66;58;58;57;82;57 03:46:27 INFO - PID 2504 | |4;audio-oscillator;94;68;84;69;69;68;88;68;68;88 03:46:27 INFO - PID 2504 | |5;imaging-gaussian-blur;86;86;87;86;86;86;86;86;87;85 03:46:27 INFO - PID 2504 | |6;imaging-darkroom;94;95;96;94;93;95;95;119;96;94 03:46:27 INFO - PID 2504 | |7;imaging-desaturate;86;84;85;86;83;84;83;83;85;89 03:46:27 INFO - PID 2504 | |8;json-parse-financial;50;49;49;48;48;49;49;49;49;50 03:46:27 INFO - PID 2504 | |9;json-stringify-tinderbox;54;59;65;71;61;62;57;58;58;58 03:46:27 INFO - PID 2504 | |10;stanford-crypto-aes;98;108;107;72;98;96;107;105;81;82 03:46:27 INFO - PID 2504 | |11;stanford-crypto-ccm;135;145;147;138;138;128;125;139;183;181 03:46:27 INFO - PID 2504 | |12;stanford-crypto-pbkdf2;184;188;188;184;188;192;184;186;183;185 03:46:27 INFO - PID 2504 | |13;stanford-crypto-sha256-iterative;69;79;80;68;67;71;67;68;67;67 03:46:27 INFO - PID 2504 | __end_tp_report 03:46:27 INFO - PID 2504 | __start_cc_report 03:46:27 INFO - PID 2504 | _x_x_mozilla_cycle_collect,2179 03:46:27 INFO - PID 2504 | __end_cc_report 03:46:27 INFO - PID 2504 | __startTimestamp1492771587477__endTimestamp 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | ------- Summary: start ------- 03:46:27 INFO - PID 2504 | Number of tests: 14 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 03:46:27 INFO - PID 2504 | Values: 112.0 111.0 110.0 111.0 110.0 110.0 111.0 111.0 110.0 112.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#1] audio-beat-detection Cycles:10 Average:118.20 Median:112.00 stddev:16.68 (14.9%) stddev-sans-first:15.52 03:46:27 INFO - PID 2504 | Values: 141.0 113.0 110.0 149.0 109.0 111.0 109.0 101.0 134.0 105.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.20 (0.6%) stddev-sans-first:1.20 03:46:27 INFO - PID 2504 | Values: 186.0 186.0 184.0 185.0 187.0 184.0 185.0 184.0 185.0 183.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#3] audio-fft Cycles:10 Average:66.90 Median:63.00 stddev:12.61 (20.0%) stddev-sans-first:12.45 03:46:27 INFO - PID 2504 | Values: 80.0 60.0 60.0 91.0 66.0 58.0 58.0 57.0 82.0 57.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:76.50 stddev:10.69 (14.0%) stddev-sans-first:9.25 03:46:27 INFO - PID 2504 | Values: 94.0 68.0 84.0 69.0 69.0 68.0 88.0 68.0 68.0 88.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 03:46:27 INFO - PID 2504 | Values: 86.0 86.0 87.0 86.0 86.0 86.0 86.0 86.0 87.0 85.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:95.00 stddev:7.75 (8.2%) stddev-sans-first:8.14 03:46:27 INFO - PID 2504 | Values: 94.0 95.0 96.0 94.0 93.0 95.0 95.0 119.0 96.0 94.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.87 (2.2%) stddev-sans-first:1.94 03:46:27 INFO - PID 2504 | Values: 86.0 84.0 85.0 86.0 83.0 84.0 83.0 83.0 85.0 89.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.00 stddev:0.67 (1.4%) stddev-sans-first:0.60 03:46:27 INFO - PID 2504 | Values: 50.0 49.0 49.0 48.0 48.0 49.0 49.0 49.0 49.0 50.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:4.81 (8.0%) stddev-sans-first:4.53 03:46:27 INFO - PID 2504 | Values: 54.0 59.0 65.0 71.0 61.0 62.0 57.0 58.0 58.0 58.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:81.50 stddev:12.77 (15.7%) stddev-sans-first:13.51 03:46:27 INFO - PID 2504 | Values: 98.0 108.0 107.0 72.0 98.0 96.0 107.0 105.0 81.0 82.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:142.00 stddev:20.16 (14.2%) stddev-sans-first:21.00 03:46:27 INFO - PID 2504 | Values: 135.0 145.0 147.0 138.0 138.0 128.0 125.0 139.0 183.0 181.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:187.00 stddev:2.78 (1.5%) stddev-sans-first:2.83 03:46:27 INFO - PID 2504 | Values: 184.0 188.0 188.0 184.0 188.0 192.0 184.0 186.0 183.0 185.0 03:46:27 INFO - PID 2504 | 03:46:27 INFO - PID 2504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:68.50 stddev:5.01 (7.3%) stddev-sans-first:5.29 03:46:27 INFO - PID 2504 | Values: 69.0 79.0 80.0 68.0 67.0 71.0 67.0 68.0 67.0 67.0 03:46:27 INFO - PID 2504 | -------- Summary: end -------- 03:46:27 INFO - PID 2504 | 03:46:28 INFO - TEST-INFO | 2504: exit 0 03:46:28 INFO - TEST-OK | kraken | took 59831ms 03:46:28 INFO - SUITE-END | took 1179s 03:46:28 INFO - Completed test suite (00:19:39) 03:46:28 INFO - javascript benchmark 03:46:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7655.178566072577, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3495.3533596284706, 3514.7891126532404, 3521.841517131729, 3532.470129480578, 3569.3039857227836, 5981.88036239275, 6098.886104840108, 6172.105044768511, 6195.628262304259, 6199.318075011751, 6003.339632640406, 6057.182280392146, 6065.818025459233, 6066.636001839893, 6091.208142941423, 5229.8954020919555, 5231.503007214318, 5249.055170069386, 5266.683998960056, 5384.838454846361, 4455.554444555551, 5318.521333080022, 5357.8392648220615, 5373.0, 5378.515933565978, 4145.502539695241, 5418.864528386783, 5422.91865622016, 5428.131498960148, 5458.781648734046, 5397.379301380313, 5405.567554595623, 5424.674519528801, 5428.511433970962, 5449.455054494559, 5201.08980928336, 5259.368875734898, 5263.578913686934, 5335.386430560497, 5433.782648694048, 4598.724076555417, 5979.999999999956, 6010.128531362971, 6099.054646529795, 6124.5100391968535, 6406.743730250831, 6409.070684750685, 6417.647029413381, 6418.679066046679, 6423.389777971085, 6413.807585772434, 6500.577462464972, 6504.349565043505, 6511.641859697715, 6514.478841692653, 6105.823680184376, 6119.969325458939, 6132.080187971751, 6140.754369825202, 6236.282827474808, 6787.321267873173, 6790.11728475305, 6792.150981127359, 6828.453723702092, 6834.794956151323, 6406.67966601668, 6411.711472983727, 6432.163818703632, 6438.098666186737, 6468.2561505427475, 6416.32628573993, 6486.902696459557, 6604.735810567524, 6634.336566343327, 6636.037774522667, 6290.622562646256, 6366.522510811707, 6453.580517266362, 6509.576877502947, 6512.023196520465, 6384.7126879290545, 6478.190226221723, 6508.381703738138, 6552.312007239267, 6571.9671401643645, 5284.260203571503, 5286.784039670821, 5288.338957630296, 5289.3652761668845, 5293.417724050351, 3949.447077409165, 4648.907021859543, 4691.085238378483, 4743.02767932573, 4762.309465127537, 6105.358937311518, 6145.8156255312415, 6149.046897730859, 6158.568900177034, 6166.0, 6598.571092878948, 6637.103990961255, 6658.234303055211, 6662.133922590032, 6667.833304167435, 6194.318624951252, 6222.439980401786, 6230.127782110508, 6230.252369715663, 6242.656653883989, 5665.3768085510565, 5734.885302293931, 5753.367129615739, 5771.797987070432, 5821.359650438449, 6803.93196068033, 6869.0383346332555, 6877.1747390313485, 6889.448844092561, 6895.827604309932, 6624.735010599522, 6625.503087268377, 6632.204135503771, 6632.50256230775, 6640.037194606658, 6595.769148079794, 6718.563293385914, 6791.830204244736, 6849.0, 6869.969504574154, 6347.174867267226, 6357.396047375492, 6472.255690595642, 6496.935030649633, 6516.543841931019, 6487.708053137714, 6609.4712423007, 6613.768518101843, 6622.470202383702, 6629.602223866584, 6384.553081284451, 6433.356664333529, 6437.163168788027, 6440.774572889926, 6449.4840412765925, 6244.188255526752, 6261.217347831521, 6262.499000079892, 6390.5526613136635, 6404.871902562016, 6263.060540918898, 6291.528135389773, 6312.715927783169, 6316.210473690789, 6325.936740632719, 6202.658853762906, 6215.906761398673, 6231.688415579293, 6420.807375778734, 6424.775132870514, 4508.819647214074, 4606.930896036495, 4875.536824001714, 6157.230346206724, 6282.623042617458], "value": 5952.957881788963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.2762985683028, 808.2039191396475, 1005.401785937367, 1110.4947249001705, 1132.597927735654, 27571.897124115036, 37692.86921392356, 37722.0, 37805.05487362821, 37823.86528404145, 40263.798681006556, 40611.0, 40709.0, 40737.0, 40769.38845917306, 8264.504129752218, 8505.957470212672, 8514.361422893277, 8514.361422893307, 8522.318214542853, 5998.1602575639445, 6109.9918513445455, 6117.357677443871, 6121.418465245794, 6129.478994285469, 8227.300679442254, 8397.034341050796, 8404.03353614333, 8408.495490270603, 8423.663053477854, 8295.875561866576, 8373.665053397857, 8380.161983801632, 8384.664613415456, 8397.706080287191, 5956.583039187259, 8240.299574536171, 8343.374246931504, 8344.41589088764, 8347.207015333533, 27334.0, 29524.409511809645, 36868.0, 36888.0, 36988.890333290045, 3563.518924945151, 3587.94618080729, 3589.6948759355487, 3590.1383667919513, 3592.425211966099, 30675.69324306773, 30804.0, 30817.921372751847, 30828.537571936216, 30943.535846962313, 3167.081546351555, 3202.327511222646, 3214.3089235814414, 3216.485362342014, 3221.1624977505785, 267057.0, 272366.0, 272526.0, 272776.0, 273449.63275183697, 39479.40780888289, 47525.76237118792, 47639.0, 47696.5230347699, 47724.761376192895, 39695.80152099279, 41939.0, 50570.0, 50625.0, 50694.0, 13325.600231993056, 13407.731845363038, 13450.596482105357, 13459.932700336436, 13462.596122116352, 10862.45687715611, 10876.782464350668, 10883.020528152505, 10888.945555272332, 10891.891081089088, 12869.678258043437, 12875.77680120387, 12889.806652900214, 12890.935545322402, 12969.41637626309, 4557.72653640776, 5551.583631227674, 5556.527695145877, 5585.357683866408, 5605.131204663284, 969.6024629901707, 972.1542258235239, 972.2465089555651, 990.7721224118493, 1011.8128146292812, 19453.4163975081, 23704.40738981539, 23779.762202377755, 24071.605219726993, 24109.794510274416, 981.3915372469115, 1063.6489958313894, 1086.266769930294, 1105.9115270778318, 1113.660333598244, 11068.391238481961, 11605.941970290263, 12204.816927746091, 12270.018398528096, 12289.877101229053, 300156.0, 300495.0, 300593.0, 300632.0, 300996.4950175235, 53885.46114538804, 53910.730446347516, 54039.729801351525, 54059.0, 54091.72954135204, 1478.4825311141014, 1480.8741256993276, 1519.9620009499852, 1521.2013692811142, 1537.6079099829697, 21398.893005534872, 23475.530489389774, 23512.0, 23523.88238058867, 23599.174028908907, 37701.62298377091, 37818.62181378261, 37835.0, 37838.24323513569, 37858.24283514259, 282078.0, 282554.0, 283455.0, 283711.0, 283999.0, 29719.0, 29864.805407784315, 34231.31537369189, 34390.0, 34639.65360346465, 43164.0, 43947.34078988882, 43979.34030989474, 44038.0, 44218.77890610655, 29398.55902161512, 29537.0, 30069.849650751607, 30132.0, 30603.0, 26830.0, 27332.453350932472, 28025.45859977721, 30238.395232094794, 30293.33703058212, 25397.0, 35986.0, 36250.0, 36689.44965825568, 36766.89699309025, 23930.521389571764, 28033.719662803112, 29893.95371161999, 30296.0, 31000.534991974688, 17573.472795816146, 21632.593881397657, 23107.6533851989, 23596.764032359457, 23666.52666946617], "value": 16797.13959687136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.8868088637397, 445.30087762213316, 446.32381941358847, 453.5555155947172, 469.4249544308223, 21331.57336853262, 21789.019494122764, 22062.88968555157, 22654.207102751367, 22845.885770571123, 22941.54116917665, 23465.0, 23501.0, 23697.76302236977, 23873.761262387372, 5224.712640804754, 6161.691915404223, 6277.403646653561, 6381.712822922979, 6403.231612206541, 6178.536609754264, 6280.214973128359, 6286.119943207955, 6289.528285378592, 6290.779822706206, 5951.6726580038085, 6190.133381326618, 6245.968770156142, 6253.968730156343, 6256.37436256373, 5986.371430999726, 6175.814725558241, 6186.876262474748, 6197.101420294055, 6208.813735587917, 5568.916466253009, 5572.832815015556, 5574.58190635704, 5575.135853942646, 5592.944070559283, 25917.0, 26377.472450551075, 26958.865205674043, 27045.323866903287, 27498.587521187197, 2173.6196165671104, 2210.2264207527237, 2215.0475295622878, 2218.1792736687366, 2219.3563866478703, 16619.252133654016, 17275.395361162424, 17792.84346517485, 17808.37670681533, 18050.382694509353, 1822.7812662480455, 2060.8763474191446, 2111.366590023002, 2152.2359562355296, 2154.052217024504, 134870.0, 138754.3062284692, 138780.30609846988, 139703.0, 140762.0, 11841.625136836132, 12260.81218883079, 12275.877241227652, 12313.56902508408, 12345.074119441078, 16330.428435004955, 16337.101459419608, 16394.0, 16440.342386304415, 16466.01203927768, 8577.95711021441, 8697.608607612672, 8784.692535761218, 8888.60001299943, 8917.464952102895, 8237.670493180205, 8259.8348033039, 8426.0, 8442.451240669337, 8451.182995655963, 7369.144303346964, 7652.73215437457, 7672.386209103258, 7673.928039429435, 7682.7311044113185, 2009.8392128629675, 2081.3131666550003, 2083.8226402082773, 2092.514314836483, 2096.5702031083592, 833.2667252817603, 855.9657613695507, 865.6710450029075, 883.3728053082383, 894.7271082319955, 18242.0, 18827.0, 18890.488760899094, 18905.810941890406, 19174.520636984187, 763.6792547130219, 888.4092078767547, 924.67174153176, 931.9767005824773, 952.4047470331043, 10749.0, 11671.0, 13060.608181754562, 13108.606741797761, 13709.931450342685, 501174.0, 503811.0, 504954.0, 517147.0, 525431.0, 129859.35070324776, 130587.0, 132279.0, 132454.33772831075, 133956.0, 1176.2707121584672, 1193.8507686539183, 1226.6810629236463, 1231.8398608180878, 1232.9136960412684, 19256.807431926063, 21434.785652143903, 21488.0, 21606.462642845177, 21718.674219886398, 45580.08839823251, 55531.444685552626, 56996.715016424656, 57717.42282577288, 57934.13098803437, 77142.0, 77352.0, 78958.6052069736, 80337.3932521358, 81544.0, 8785.253253473526, 8872.33457490678, 8914.974777900365, 8999.010108888147, 9245.583948722458, 13790.379432925341, 13981.650458738613, 14007.159570425807, 14402.85597144015, 14415.711685766017, 10121.746956325856, 11777.81078271188, 11784.4696988634, 11924.344161071225, 12107.818382724443, 9500.572474238814, 9805.117539421486, 11172.497237624164, 11188.440577970907, 11566.826497602711, 11948.0, 11963.700907477383, 12235.082368822552, 12240.02079833629, 12318.753624927273, 8732.825343493221, 8970.775730606787, 9105.053708745956, 9145.496997664926, 9179.816403672023, 11716.648500544998, 11925.10561707858, 12086.274823510617, 12096.153269271066, 12149.514019439124], "value": 10362.889609657197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1135.8864113588647, 1282.2114399644217, 1378.531299358218, 1396.2739375524727, 1407.4159223922072, 9720.270979676527, 10207.642732504364, 11707.0, 11752.647420577376, 11965.940170299158, 11395.715107122325, 11505.942470287659, 11510.884891151087, 11523.539058437653, 11559.01748351389, 2057.2593866208153, 2545.414554652431, 2548.9107881224163, 2549.4646124313917, 2552.7447255274415, 2083.5207902182506, 2145.1205005947563, 2221.1448592292004, 2487.763662452064, 2580.8064395170345, 2514.735952724965, 2519.143491212987, 2537.733537978513, 2542.1102614085016, 2543.49130173965, 2509.7113831909382, 2530.3927057506157, 2532.9493410131786, 2552.6553915221393, 2559.372953626355, 2195.8252335000857, 2403.735589085199, 2505.3235626380956, 2520.1053625962704, 2526.7240043777774, 11650.475728592233, 11699.766004679945, 11786.35175065371, 11793.410329483491, 11805.94097029518, 6534.346565343475, 6760.8309792255095, 6763.560368576027, 6772.119624448839, 6790.5246632735725, 3976.5426975897853, 4237.406763053175, 4401.581849724271, 4413.514513403523, 4425.601695847389, 1245.6138597034949, 1246.962591122268, 1268.7462507498537, 1291.593148158327, 1300.655326338521, 16929.238184281738, 16932.23804928781, 16941.32234710598, 16946.0, 16957.406490772886, 5821.27234095738, 5920.467157955719, 6003.849903752441, 6033.577649564489, 6101.908471372933, 13909.035924761394, 13927.791083133761, 13939.303034848217, 13945.302734863217, 13964.301784910715, 5625.353084395347, 6641.86716265672, 6723.495737819683, 6747.7638282660855, 6752.155980502437, 5203.817866374735, 6033.379319962299, 6038.9396106038375, 6193.0, 6209.161763161916, 4166.395872598457, 4262.65898728101, 4267.701260911706, 4272.145570885836, 4275.166342563232, 1218.7867123253395, 1228.570000499818, 1338.3107699534748, 1453.6220582648587, 1501.8873584481207, 766.9808254793675, 767.7735068154908, 782.0, 783.4437549340032, 783.9176886426843, 6246.3441338659695, 6391.328910464427, 6597.60414375139, 6624.735010599618, 6764.0530325754435, 889.9466032037969, 899.7750562359411, 903.336048004716, 904.31272233102, 939.5255396024963, 3513.683768460851, 3590.1024743814046, 3616.3129005488872, 3658.432942893856, 3707.647773461517, 13325.800112998313, 13433.19400835953, 13832.239226842621, 14379.568612941628, 15429.537113886601, 13277.535286265127, 14712.632184195481, 15103.018303810217, 15145.62135946588, 15314.693706125816, 8372.288355489729, 8409.663613455394, 8423.0, 8472.830543389098, 8551.990282283658, 6210.161628180138, 6874.587524748531, 6903.861922761617, 6919.546895152074, 7076.433885289061, 13364.532241371506, 13389.732205355644, 13520.25638589887, 13729.45082196701, 13756.931215343859, 13763.38064787067, 13975.440982360999, 14081.788773168206, 14101.435942562182, 14121.788173177205, 9124.589393477443, 9374.906250937403, 9463.148316651534, 9467.573959171716, 9470.337076404585, 10654.254202205771, 10801.0, 10823.945880270549, 10835.945820270848, 10840.970107839743, 8876.77808054778, 9110.908890911007, 9123.498207598646, 9215.354925155174, 9250.537473126182, 8947.06055864125, 9043.63825447001, 9059.36584439083, 9138.725838224864, 9155.954220228856, 8145.185481452045, 8345.499270043816, 8347.081820999807, 8359.331253499584, 8363.996320441343, 5865.648061116347, 5887.558433117448, 6030.1256317832795, 6077.149199112039, 6152.876942461216, 5961.433663801932, 6154.922888494406, 6170.722317495633, 6226.719797609027, 6276.968615156895], "value": 5371.957989265532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.85785117357756, 398.53769627232396, 402.98186581603835, 404.71872048925974, 411.6644934378483, 5453.936482385936, 5845.707714614268, 5924.822255332336, 5946.197263369444, 5953.255843019622, 4572.702774319675, 5203.973980130094, 5274.156135018397, 5462.235287059805, 5723.198752174699, 4035.61661642145, 4218.367244913272, 4429.623482004034, 4465.843695470659, 4470.926977525387, 3883.26218018577, 4459.331100334944, 4461.397711308964, 4469.000244780919, 4471.686981911267, 4233.6824738144605, 4387.758673272969, 4448.310511870649, 4464.754438505881, 4479.193745125876, 3735.6364926801657, 4326.307790753464, 4337.804798784062, 4413.514513403523, 4419.73481591104, 3211.373782112489, 3251.7561182911377, 3880.7865567393783, 3892.3966785148345, 3924.529056513237, 5415.620906536544, 5599.748011339459, 5632.690202038886, 5689.317281926195, 5708.690917446773, 5271.525562699337, 5279.86800329991, 5315.335583052119, 5319.308489896327, 5321.946780532184, 4782.760861956923, 5331.760070796823, 6076.756929722806, 6151.0474972013235, 6158.351908679266, 3893.5133108361456, 4184.748915065105, 4430.202563538562, 4445.199864024475, 4451.0, 6197.659128747917, 6391.233052033739, 6417.711202995876, 6474.352564743535, 6474.9244109048295, 3622.3117607654463, 4012.29784787661, 4253.872723728215, 4382.0, 4429.424174857248, 4428.977855110768, 4487.371767952489, 4577.908441831145, 4603.148417542699, 4617.376654151713, 4117.197146556393, 4970.527799859007, 5003.3488948646855, 5070.391553013588, 5287.259783630295, 5139.203423469368, 5296.3909150447425, 6167.0, 6178.258608966953, 6183.0, 1353.8830464866523, 1487.761958086701, 1490.4187366926908, 1493.4617344135559, 1498.0337682194922, 888.9288856891433, 971.771633666088, 990.8216521026285, 990.8266053440619, 1007.0282177698556, 5447.891042179213, 5860.446981549892, 5861.443162899518, 5883.235179426647, 5904.881902361929, 6366.172397588284, 6368.936310636927, 6384.201974753156, 6387.680615969183, 6401.295857455676, 5172.172452407672, 5342.8512869733195, 5558.499735023867, 5856.707164641751, 5898.793542226002, 3113.735332496718, 3342.2479942013338, 3350.748693847971, 3354.295597924463, 3361.32773445307, 6493.642849643315, 6583.703733332011, 6625.469962403093, 6649.833754156185, 6710.261871194165, 5080.720560369141, 6498.675066246668, 6505.934940650533, 6515.762005218993, 6572.441342485847, 6271.118664400753, 6589.472842172615, 6613.107230523818, 6646.803575356385, 6653.567518111307, 6064.241969753781, 6305.5901366411035, 6400.327965563549, 6416.197975253093, 6436.356364363526, 5744.926464341557, 6014.909776353271, 6018.849528761816, 6289.371062893674, 6292.653904035322, 4387.692861499664, 5570.6657600544095, 5794.565407594531, 6300.653464059521, 6401.903971440525, 3720.6837418819705, 3744.513213282256, 4251.319788833772, 4252.319628859368, 4317.956820431756, 6221.657808820558, 6324.620522768649, 6357.55497115216, 6391.808245752635, 6454.0, 5337.653052551572, 5624.690642014729, 6163.19878415803, 6186.505079593531, 6285.182926219562, 5101.500264870113, 5948.762049517971, 6184.76304739045, 6187.597806142587, 6237.594556353823, 5060.468650791614, 5885.941140588539, 6013.879722405615, 6026.819195424145, 6033.487153591994, 5342.3705769739045, 6134.4172303631085, 6166.1983942087245, 6196.628202307876, 6206.72069756871, 4677.672562920563, 5155.968806238692, 5839.5036421904615, 5995.5803093783015, 6016.849578760391], "value": 4521.067040536811, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5119293284104, 844.2359664503624, 855.1320409784066, 866.3588944181307, 875.0593112404165, 12825.871741282584, 16835.15824208789, 17165.313387464517, 17338.306467741306, 17374.91312543439, 17112.57218569533, 17166.39917602884, 17232.913835430805, 17418.56453588661, 17435.91282043588, 951.6574033347989, 964.3827950111934, 983.4590974963777, 984.4929861121528, 984.9458279794609, 662.4236913884927, 680.8672308899767, 981.2199301555245, 984.9556769945334, 995.2933417273708, 951.4719330771419, 1000.9549570269319, 1001.2990906365537, 1001.8296889528798, 1004.1314263162349, 987.693814917378, 991.7768502086973, 993.5777294649745, 995.1044060345674, 1000.3297790480395, 740.9885506283938, 741.998302291907, 744.8957145999565, 746.2723844251865, 751.4476859508258, 15559.611009724735, 15814.841851581452, 15995.040297582065, 16521.504354869252, 16543.503694889052, 13682.863171368357, 16316.592085197846, 16576.254068566945, 16849.157542122968, 16944.3222271109, 13360.86639133606, 13624.93187534056, 13628.318584070757, 13841.238731869744, 13857.792133118011, 2980.463516567039, 3391.5930088389305, 3417.3507033663773, 3425.5718035245595, 3426.400379933502, 82606.0, 111906.88093119046, 112163.43918280437, 112397.43801281023, 113452.43273783661, 10804.837927431096, 11148.163887708455, 11552.884471155348, 11673.649790506299, 11790.469428875722, 15291.770623440658, 23075.0, 23424.531509369717, 23646.7635323648, 23866.925988330568, 7454.440916931252, 7630.847383052308, 7638.50349727266, 7641.808954776064, 7642.426817988673, 3607.981960090183, 3608.548931383577, 3659.7255205859665, 3828.8085595720104, 3916.2167566486246, 4213.220554197484, 4299.355096735515, 4302.225599392077, 4304.397384366192, 4310.418093557392, 873.8077622922947, 875.3347455933409, 890.875277461156, 891.7458524320667, 891.9331050171263, 546.8988237176135, 634.4480302137079, 648.8994205897999, 655.7147640776277, 661.2527843536773, 9076.954615227014, 11064.612738554111, 11656.766864662828, 11760.411979401168, 11850.822237666442, 587.9970600146972, 630.0, 638.6870433487558, 643.9098526206335, 651.4495500708379, 5274.5780337572905, 5371.113766228606, 5395.406505284415, 5453.945460545344, 5551.139573366135, 97881.0, 101093.49453252833, 103747.0, 104197.47901260445, 106344.93655063504, 84236.15763842406, 87940.0, 90820.54589727009, 90971.0, 91813.54093229625, 69324.96012559715, 69432.0, 76916.0, 77475.22524774793, 79862.4027519458, 10345.27583069208, 11853.0, 12341.50633974631, 12414.813777793159, 12568.0, 32442.540085695728, 34284.31431371409, 36497.63502365049, 38325.61674383221, 39557.40663889986, 43959.0, 63932.360676392644, 63950.3604963963, 64062.0, 64096.0, 15735.763963540327, 15779.605509861885, 15973.961692489951, 15983.840161598235, 16000.439984600484, 17060.23228954725, 17676.646467070845, 17714.20286087155, 17738.467845964125, 17766.46700598984, 12397.690057748629, 16096.0, 16123.274452649894, 16196.676066478369, 16396.426125085563, 15782.289796958934, 15973.361065557248, 16006.279717412977, 16015.279312430735, 16115.274812633224, 15399.923000385375, 15529.84470155284, 15708.92145539265, 15800.051996880224, 15818.367265309258, 9231.446113233227, 11128.0, 11272.0, 11407.315561066363, 11435.428228588371, 12310.138290319592, 13471.663208419868, 13480.86519134796, 13488.190708557519, 13510.594682159552], "value": 7996.093245722684, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 110.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 110.0, 149.0, 109.0, 111.0, 109.0, 101.0, 134.0, 105.0], "value": 118.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 185.0, 187.0, 184.0, 185.0, 184.0, 185.0, 183.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 91.0, 66.0, 58.0, 58.0, 57.0, 82.0, 57.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 68.0, 84.0, 69.0, 69.0, 68.0, 88.0, 68.0, 68.0, 88.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 86.0, 86.0, 87.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 93.0, 95.0, 95.0, 119.0, 96.0, 94.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 86.0, 83.0, 84.0, 83.0, 83.0, 85.0, 89.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 48.0, 49.0, 49.0, 49.0, 49.0, 50.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 65.0, 71.0, 61.0, 62.0, 57.0, 58.0, 58.0, 58.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 107.0, 72.0, 98.0, 96.0, 107.0, 105.0, 81.0, 82.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 145.0, 147.0, 138.0, 138.0, 128.0, 125.0, 139.0, 183.0, 181.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 188.0, 184.0, 188.0, 192.0, 184.0, 186.0, 183.0, 185.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 80.0, 68.0, 67.0, 71.0, 67.0, 68.0, 67.0, 67.0], "value": 70.3, "unit": "score"}]}]} 03:46:28 INFO - Return code: 0 03:46:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:46:28 ERROR - # TBPL SUCCESS # 03:46:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:46:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:46:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:46:28 INFO - 2017-04-21 03:46:28.802 screenresolution[2508:39542] starting screenresolution argv=screenresolution get 03:46:28 INFO - 2017-04-21 03:46:28.804 screenresolution[2508:39542] Display 0: 1600x1200x32@60 03:46:28 INFO - 2017-04-21 03:46:28.810 screenresolution[2509:39545] starting screenresolution argv=screenresolution list 03:46:28 INFO - Available Modes on Display 0 03:46:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:46:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:46:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:46:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:46:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:46:29 INFO - Intel Iris: 03:46:29 INFO - Chipset Model: Intel Iris 03:46:29 INFO - Type: GPU 03:46:29 INFO - Bus: Built-In 03:46:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:46:29 INFO - Vendor: Intel (0x8086) 03:46:29 INFO - Device ID: 0x0a2e 03:46:29 INFO - Revision ID: 0x0009 03:46:29 INFO - Displays: 03:46:29 INFO - Display: 03:46:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:46:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:46:29 INFO - Display Serial Number: 1600x1200 60 03:46:29 INFO - Main Display: Yes 03:46:29 INFO - Mirror: Off 03:46:29 INFO - Online: Yes 03:46:29 INFO - Rotation: Supported 03:46:29 INFO - Return code: 0 03:46:29 INFO - Running post-action listener: _resource_record_post_action 03:46:29 INFO - [mozharness: 2017-04-21 10:46:29.055278Z] Finished run-tests step (success) 03:46:29 INFO - Running post-run listener: _resource_record_post_run 03:46:29 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 1400832; Write bytes: 513245696; Read time: 8; Write time: 1593 03:46:29 INFO - TinderboxPrint: CPU usage
53.1% 03:46:29 INFO - TinderboxPrint: I/O read bytes / time
1,400,832 / 8 03:46:29 INFO - TinderboxPrint: I/O write bytes / time
513,245,696 / 1,593 03:46:29 INFO - TinderboxPrint: CPU idle
2,252.9 (46.9%) 03:46:29 INFO - TinderboxPrint: CPU system
950.9 (19.8%) 03:46:29 INFO - TinderboxPrint: CPU user
1,597.9 (33.3%) 03:46:29 INFO - TinderboxPrint: Swap in / out
208,912,384 / 0 03:46:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207366656; Write bytes: 203022336; Read time: 15781; Write time: 423 03:46:29 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 475136; Write bytes: 302981632; Read time: 4; Write time: 1137 03:46:29 INFO - Running post-run listener: _upload_blobber_files 03:46:29 INFO - Blob upload gear active. 03:46:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:29 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:46:29 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:46:29 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:46:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:46:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:31 INFO - (blobuploader) - INFO - Done attempting. 03:46:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:46:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:46:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:32 INFO - (blobuploader) - INFO - Done attempting. 03:46:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:46:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:46:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:33 INFO - (blobuploader) - INFO - Done attempting. 03:46:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:46:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:36 INFO - (blobuploader) - INFO - Done attempting. 03:46:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:36 INFO - Return code: 0 03:46:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf60b1af772dbf2bdf930d7b18511b993901ceea464335502bc904daa2f6ea6b6cdfe6140674972ae46e21f22209a8f65476b338001fa9b43f80202711f8f71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9ff93ade7e18301734de06b259c2ca657e061f7421cc45c79e615dd9bf77086d08851ab8b54806c05642aff9bbabed392f2e5fe0f467d4f3985afac91e28a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894a15e6a4fd1205ad6f49edfff140da03919506b7203d8bb1b5b8b0776ac0bc7f6494f9c45e78232e1097f5edce98cef3486154538451670afc59e96aadd54e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b8c1fcfad209ab23725aa39a37eacf6550978ac5d4be8775c82a5199f7ef3e175ce91c51602474ebf0affcec2dc2b78febaab1b36a9b67cc43e970892e3f48c"} 03:46:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:36 INFO - Contents: 03:46:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf60b1af772dbf2bdf930d7b18511b993901ceea464335502bc904daa2f6ea6b6cdfe6140674972ae46e21f22209a8f65476b338001fa9b43f80202711f8f71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9ff93ade7e18301734de06b259c2ca657e061f7421cc45c79e615dd9bf77086d08851ab8b54806c05642aff9bbabed392f2e5fe0f467d4f3985afac91e28a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894a15e6a4fd1205ad6f49edfff140da03919506b7203d8bb1b5b8b0776ac0bc7f6494f9c45e78232e1097f5edce98cef3486154538451670afc59e96aadd54e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b8c1fcfad209ab23725aa39a37eacf6550978ac5d4be8775c82a5199f7ef3e175ce91c51602474ebf0affcec2dc2b78febaab1b36a9b67cc43e970892e3f48c"} 03:46:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:36 INFO - Copying logs to upload dir... 03:46:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.621301 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 03:46:36.145848) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:46:36.149643) ========= 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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf60b1af772dbf2bdf930d7b18511b993901ceea464335502bc904daa2f6ea6b6cdfe6140674972ae46e21f22209a8f65476b338001fa9b43f80202711f8f71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9ff93ade7e18301734de06b259c2ca657e061f7421cc45c79e615dd9bf77086d08851ab8b54806c05642aff9bbabed392f2e5fe0f467d4f3985afac91e28a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894a15e6a4fd1205ad6f49edfff140da03919506b7203d8bb1b5b8b0776ac0bc7f6494f9c45e78232e1097f5edce98cef3486154538451670afc59e96aadd54e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b8c1fcfad209ab23725aa39a37eacf6550978ac5d4be8775c82a5199f7ef3e175ce91c51602474ebf0affcec2dc2b78febaab1b36a9b67cc43e970892e3f48c"} 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.011506 build_url: 'https://queue.taskcluster.net/v1/task/ZUJpb9bGR9yzqXRx8RDwMA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf60b1af772dbf2bdf930d7b18511b993901ceea464335502bc904daa2f6ea6b6cdfe6140674972ae46e21f22209a8f65476b338001fa9b43f80202711f8f71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8d9ff93ade7e18301734de06b259c2ca657e061f7421cc45c79e615dd9bf77086d08851ab8b54806c05642aff9bbabed392f2e5fe0f467d4f3985afac91e28a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/894a15e6a4fd1205ad6f49edfff140da03919506b7203d8bb1b5b8b0776ac0bc7f6494f9c45e78232e1097f5edce98cef3486154538451670afc59e96aadd54e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b8c1fcfad209ab23725aa39a37eacf6550978ac5d4be8775c82a5199f7ef3e175ce91c51602474ebf0affcec2dc2b78febaab1b36a9b67cc43e970892e3f48c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 03:46:36.184959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:46:36.185349) ========= 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.meWfNLyhrF/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.gd5V8NJ8G5/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005311 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 03:46:36.233923) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:46:36.234230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 03:46:36.234580) ========= ========= Total master_lag: 0.18 =========