builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0030 starttime: 1493032347.53 results: success (0) buildid: 20170424030211 builduid: d867f5e265b34ca1a51c4f50052f3caf revision: 73752931e273091185e1e4b5231c28beed657cc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.530580) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.531073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.531349) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.559349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.559967) ========= 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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-24 04:12:27-- 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% 26.2M=0s 2017-04-24 04:12:27 (26.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084046 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.671732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:27.672065) ========= 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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.037490 ========= master_lag: 0.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:28.144429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 04:12:28.144783) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73752931e273091185e1e4b5231c28beed657cc8 --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 73752931e273091185e1e4b5231c28beed657cc8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HpmunIgAsq/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.gfxOH4Xwiu/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-24 04:12:28,246 truncating revision to first 12 chars 2017-04-24 04:12:28,246 Setting DEBUG logging. 2017-04-24 04:12:28,246 attempt 1/10 2017-04-24 04:12:28,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73752931e273?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 04:12:29,206 unpacking tar archive at: mozilla-central-73752931e273/testing/mozharness/ program finished with exit code 0 elapsedTime=1.228338 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 04:12:29.397566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:29.397902) ========= script_repo_revision: 73752931e273091185e1e4b5231c28beed657cc8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:29.398330) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:29.398601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:29.419301) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-24 04:12:29.419689) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HpmunIgAsq/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.gfxOH4Xwiu/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:12:29 INFO - MultiFileLogger online at 20170424 04:12:29 in /builds/slave/test 04:12:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:12:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:29 INFO - {'append_to_log': False, 04:12:29 INFO - 'base_work_dir': '/builds/slave/test', 04:12:29 INFO - 'blob_upload_branch': 'Firefox', 04:12:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:29 INFO - 'branch': 'Firefox', 04:12:29 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:29 INFO - 'config_files': ('talos/mac_config.py',), 04:12:29 INFO - 'default_actions': ('clobber', 04:12:29 INFO - 'read-buildbot-config', 04:12:29 INFO - 'download-and-extract', 04:12:29 INFO - 'populate-webroot', 04:12:29 INFO - 'create-virtualenv', 04:12:29 INFO - 'install', 04:12:29 INFO - 'run-tests'), 04:12:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:29 INFO - 'download_minidump_stackwalk': True, 04:12:29 INFO - 'download_symbols': 'ondemand', 04:12:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:29 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:29 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:29 INFO - 'gecko_profile': False, 04:12:29 INFO - 'gecko_profile_interval': 0, 04:12:29 INFO - 'installer_path': 'installer.exe', 04:12:29 INFO - 'log_level': 'info', 04:12:29 INFO - 'log_name': 'talos', 04:12:29 INFO - 'log_to_console': True, 04:12:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:12:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:12:29 INFO - 'opt_config_files': (), 04:12:29 INFO - 'pip_index': False, 04:12:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:12:29 INFO - 'cmd': ('bash', 04:12:29 INFO - '-c', 04:12:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:12:29 INFO - 'enabled': True, 04:12:29 INFO - 'halt_on_failure': False, 04:12:29 INFO - 'name': 'check_screen_resolution'},), 04:12:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:12:29 INFO - 'cmd': ('bash', 04:12:29 INFO - '-c', 04:12:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:12:29 INFO - 'enabled': True, 04:12:29 INFO - 'halt_on_failure': False, 04:12:29 INFO - 'name': 'check_screen_resolution'},), 04:12:29 INFO - 'run_cmd_checks_enabled': True, 04:12:29 INFO - 'suite': 'dromaeojs-e10s', 04:12:29 INFO - 'system_bits': '32', 04:12:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:29 INFO - 'title': 't-yosemite-r7-0030', 04:12:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:29 INFO - 'use_talos_json': True, 04:12:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:29 INFO - 'work_dir': 'build'} 04:12:29 INFO - [mozharness: 2017-04-24 11:12:29.631440Z] Running clobber step. 04:12:29 INFO - Running pre-action listener: _resource_record_pre_action 04:12:29 INFO - Running main action method: clobber 04:12:29 INFO - rmtree: /builds/slave/test/build 04:12:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:32 INFO - Running post-action listener: _resource_record_post_action 04:12:32 INFO - [mozharness: 2017-04-24 11:12:32.144962Z] Finished clobber step (success) 04:12:32 INFO - [mozharness: 2017-04-24 11:12:32.145093Z] Running read-buildbot-config step. 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: read_buildbot_config 04:12:32 INFO - Using buildbot properties: 04:12:32 INFO - { 04:12:32 INFO - "project": "", 04:12:32 INFO - "product": "firefox", 04:12:32 INFO - "script_repo_revision": "production", 04:12:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:12:32 INFO - "repository": "", 04:12:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:12:32 INFO - "buildid": "20170424030211", 04:12:32 INFO - "stage_platform": "macosx64", 04:12:32 INFO - "basedir": "/builds/slave/test", 04:12:32 INFO - "nightly_build": "True", 04:12:32 INFO - "buildnumber": 202, 04:12:32 INFO - "slavename": "t-yosemite-r7-0030", 04:12:32 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:12:32 INFO - "platform": "yosemite_r7", 04:12:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:12:32 INFO - "branch": "mozilla-central", 04:12:32 INFO - "repo_path": "mozilla-central", 04:12:32 INFO - "revision": "73752931e273091185e1e4b5231c28beed657cc8", 04:12:32 INFO - "pgo_build": "False", 04:12:32 INFO - "builduid": "d867f5e265b34ca1a51c4f50052f3caf", 04:12:32 INFO - "slavebuilddir": "test" 04:12:32 INFO - } 04:12:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:12:32 INFO - Running post-action listener: _resource_record_post_action 04:12:32 INFO - [mozharness: 2017-04-24 11:12:32.148333Z] Finished read-buildbot-config step (success) 04:12:32 INFO - [mozharness: 2017-04-24 11:12:32.148414Z] Running download-and-extract step. 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: download_and_extract 04:12:32 INFO - mkdir: /builds/slave/test/build/tests 04:12:32 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')]} 04:12:32 INFO - trying https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:12:32 INFO - Downloading https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/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 04:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/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 04:12:33 INFO - Downloaded 1325 bytes. 04:12:33 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:12:33 INFO - Using the following test package requirements: 04:12:33 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:12:33 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:12:33 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:12:33 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:12:33 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'jsshell-mac.zip'], 04:12:33 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:12:33 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:12:33 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:12:33 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:12:33 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:12:33 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:12:33 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:12:33 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:12:35 INFO - Content-Length response header: 52526318 04:12:35 INFO - Bytes received: 52526318 04:12:51 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 04:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:12:53 INFO - Content-Length response header: 52526318 04:12:53 INFO - Bytes received: 52526318 04:13:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:13:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:13:09 INFO - Fetch https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:13:10 INFO - Content-Length response header: 14408822 04:13:10 INFO - Bytes received: 14408822 04:13:10 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')]} 04:13:10 INFO - trying https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:13:10 INFO - Downloading https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/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 04:13:12 INFO - Downloaded 71115004 bytes. 04:13:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:13:12 INFO - mkdir: /builds/slave/test/properties 04:13:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:12 INFO - Contents: 04:13:12 INFO - build_url:https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:13:13 INFO - Running post-action listener: _resource_record_post_action 04:13:13 INFO - Running post-action listener: set_extra_try_arguments 04:13:13 INFO - [mozharness: 2017-04-24 11:13:13.476712Z] Finished download-and-extract step (success) 04:13:13 INFO - [mozharness: 2017-04-24 11:13:13.476813Z] Running populate-webroot step. 04:13:13 INFO - Running pre-action listener: _resource_record_pre_action 04:13:13 INFO - Running main action method: populate_webroot 04:13:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:13 INFO - '--tppagecycles', 04:13:13 INFO - '7'], 04:13:13 INFO - 'tests': ['tsvgm']}}, 04:13:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['damp', 'tps']}, 04:13:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'tests': ['damp', 'tps']}, 04:13:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['dromaeo_dom']}, 04:13:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:13:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:13:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['a11yr', 04:13:13 INFO - 'ts_paint', 04:13:13 INFO - 'tpaint', 04:13:13 INFO - 'sessionrestore', 04:13:13 INFO - 'sessionrestore_no_auto_restore', 04:13:13 INFO - 'tabpaint']}, 04:13:13 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:13 INFO - 'ts_paint', 04:13:13 INFO - 'tpaint', 04:13:13 INFO - 'sessionrestore', 04:13:13 INFO - 'sessionrestore_no_auto_restore', 04:13:13 INFO - 'tabpaint']}, 04:13:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:13 INFO - 'ts_paint', 04:13:13 INFO - 'tpaint', 04:13:13 INFO - 'sessionrestore', 04:13:13 INFO - 'sessionrestore_no_auto_restore', 04:13:13 INFO - 'tabpaint']}, 04:13:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:13 INFO - 'ts_paint', 04:13:13 INFO - 'tpaint', 04:13:13 INFO - 'sessionrestore', 04:13:13 INFO - 'sessionrestore_no_auto_restore', 04:13:13 INFO - 'tabpaint']}, 04:13:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['a11yr', 04:13:13 INFO - 'ts_paint', 04:13:13 INFO - 'tpaint', 04:13:13 INFO - 'sessionrestore', 04:13:13 INFO - 'sessionrestore_no_auto_restore', 04:13:13 INFO - 'tabpaint']}, 04:13:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['a11yr', 04:13:13 INFO - 'ts_paint', 04:13:13 INFO - 'tpaint', 04:13:13 INFO - 'sessionrestore', 04:13:13 INFO - 'sessionrestore_no_auto_restore', 04:13:13 INFO - 'tabpaint']}, 04:13:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:13:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:13:13 INFO - 'bloom_basic_ref']}, 04:13:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['tsvgx', 04:13:13 INFO - 'tsvgr_opacity', 04:13:13 INFO - 'tart', 04:13:13 INFO - 'tscrollx', 04:13:13 INFO - 'cart', 04:13:13 INFO - 'tsvg_static']}, 04:13:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:13 INFO - 'tsvgr_opacity', 04:13:13 INFO - 'tart', 04:13:13 INFO - 'tscrollx', 04:13:13 INFO - 'cart', 04:13:13 INFO - 'tsvg_static']}, 04:13:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'talos_options': ['--disable-e10s'], 04:13:13 INFO - 'tests': ['tp5o']}, 04:13:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:13:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'talos_options': ['--disable-e10s', 04:13:13 INFO - '--xperf_path', 04:13:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:13 INFO - 'tests': ['tp5n']}, 04:13:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:13:13 INFO - 'talos_options': ['--xperf_path', 04:13:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:13 INFO - 'tests': ['tp5n']}}, 04:13:13 INFO - 'talos.zip': {'path': '', 04:13:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:13 INFO - Running post-action listener: _resource_record_post_action 04:13:13 INFO - [mozharness: 2017-04-24 11:13:13.496179Z] Finished populate-webroot step (success) 04:13:13 INFO - [mozharness: 2017-04-24 11:13:13.496268Z] Running create-virtualenv step. 04:13:13 INFO - Running pre-action listener: _resource_record_pre_action 04:13:13 INFO - Running main action method: create_virtualenv 04:13:13 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:13 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 04:13:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:13 INFO - Using real prefix '/tools/python27' 04:13:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:17 INFO - Installing pip.................done. 04:13:17 INFO - Return code: 0 04:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:13:17 INFO - Reading from file tmpfile_stdout 04:13:17 INFO - Output received: 04:13:17 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) 04:13:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:17 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:17 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 04:13:17 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 04:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:17 INFO - 'HOME': '/Users/cltbld', 04:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:17 INFO - 'LOGNAME': 'cltbld', 04:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:17 INFO - 'MOZ_NO_REMOTE': '1', 04:13:17 INFO - 'NO_EM_RESTART': '1', 04:13:17 INFO - 'PAGER': '/bin/cat', 04:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:17 INFO - 'PWD': '/builds/slave/test', 04:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:17 INFO - 'SHELL': '/bin/bash', 04:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:17 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:17 INFO - 'USER': 'cltbld', 04:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:17 INFO - 'XPC_FLAGS': '0x0', 04:13:17 INFO - 'XPC_SERVICE_NAME': '0', 04:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:17 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 04:13:17 INFO - Cleaning up... 04:13:17 INFO - Return code: 0 04:13:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:17 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:17 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 04:13:17 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 04:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:17 INFO - 'HOME': '/Users/cltbld', 04:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:17 INFO - 'LOGNAME': 'cltbld', 04:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:17 INFO - 'MOZ_NO_REMOTE': '1', 04:13:17 INFO - 'NO_EM_RESTART': '1', 04:13:17 INFO - 'PAGER': '/bin/cat', 04:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:17 INFO - 'PWD': '/builds/slave/test', 04:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:17 INFO - 'SHELL': '/bin/bash', 04:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:17 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:17 INFO - 'USER': 'cltbld', 04:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:17 INFO - 'XPC_FLAGS': '0x0', 04:13:17 INFO - 'XPC_SERVICE_NAME': '0', 04:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:18 INFO - Downloading/unpacking psutil>=3.1.1 04:13:18 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 04:13:18 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 04:13:18 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 04:13:18 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 04:13:18 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 04:13:18 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 04:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:21 INFO - Installing collected packages: psutil 04:13:21 INFO - Running setup.py install for psutil 04:13:21 INFO - building 'psutil._psutil_osx' extension 04:13:21 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 04:13:22 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 04:13:22 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 04:13:22 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 04:13:22 INFO - building 'psutil._psutil_posix' extension 04:13:22 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 04:13:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:13:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:13:22 INFO - ^ 04:13:22 INFO - 1 warning generated. 04:13:22 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 04:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:22 INFO - Successfully installed psutil 04:13:22 INFO - Cleaning up... 04:13:22 INFO - Return code: 0 04:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:23 INFO - 'HOME': '/Users/cltbld', 04:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:23 INFO - 'LOGNAME': 'cltbld', 04:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:23 INFO - 'MOZ_NO_REMOTE': '1', 04:13:23 INFO - 'NO_EM_RESTART': '1', 04:13:23 INFO - 'PAGER': '/bin/cat', 04:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:23 INFO - 'PWD': '/builds/slave/test', 04:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:23 INFO - 'SHELL': '/bin/bash', 04:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:23 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:23 INFO - 'USER': 'cltbld', 04:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:23 INFO - 'XPC_FLAGS': '0x0', 04:13:23 INFO - 'XPC_SERVICE_NAME': '0', 04:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:23 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 04:13:23 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 04:13:23 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 04:13:23 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 04:13:23 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 04:13:23 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 04:13:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:26 INFO - Installing collected packages: mozsystemmonitor 04:13:26 INFO - Running setup.py install for mozsystemmonitor 04:13:26 INFO - Successfully installed mozsystemmonitor 04:13:26 INFO - Cleaning up... 04:13:26 INFO - Return code: 0 04:13:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:26 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')]} 04:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:26 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')]} 04:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:26 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:26 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 04:13:26 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 04:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:26 INFO - 'HOME': '/Users/cltbld', 04:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:26 INFO - 'LOGNAME': 'cltbld', 04:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:26 INFO - 'MOZ_NO_REMOTE': '1', 04:13:26 INFO - 'NO_EM_RESTART': '1', 04:13:26 INFO - 'PAGER': '/bin/cat', 04:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:26 INFO - 'PWD': '/builds/slave/test', 04:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:26 INFO - 'SHELL': '/bin/bash', 04:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:26 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:26 INFO - 'USER': 'cltbld', 04:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:26 INFO - 'XPC_FLAGS': '0x0', 04:13:26 INFO - 'XPC_SERVICE_NAME': '0', 04:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:26 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 04:13:26 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 04:13:26 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 04:13:26 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 04:13:26 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 04:13:26 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 04:13:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:29 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 04:13:29 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 04:13:29 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 04:13:29 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 04:13:29 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 04:13:29 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 04:13:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:29 INFO - warning: no files found matching '*.txt' 04:13:29 INFO - no previously-included directories found matching 'build' 04:13:29 INFO - no previously-included directories found matching 'dist' 04:13:29 INFO - no previously-included directories found matching '.git*' 04:13:30 INFO - Installing collected packages: jsonschema, functools32 04:13:30 INFO - Running setup.py install for functools32 04:13:30 INFO - warning: no files found matching '*.txt' 04:13:30 INFO - no previously-included directories found matching 'build' 04:13:30 INFO - no previously-included directories found matching 'dist' 04:13:30 INFO - no previously-included directories found matching '.git*' 04:13:30 INFO - Successfully installed jsonschema functools32 04:13:30 INFO - Cleaning up... 04:13:30 INFO - Return code: 0 04:13:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:30 INFO - 'HOME': '/Users/cltbld', 04:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PAGER': '/bin/cat', 04:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:30 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - 'XPC_FLAGS': '0x0', 04:13:30 INFO - 'XPC_SERVICE_NAME': '0', 04:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:13:30 INFO - Cleaning up... 04:13:30 INFO - Return code: 0 04:13:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:13:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:30 INFO - 'HOME': '/Users/cltbld', 04:13:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PAGER': '/bin/cat', 04:13:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:30 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - 'XPC_FLAGS': '0x0', 04:13:30 INFO - 'XPC_SERVICE_NAME': '0', 04:13:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:35 INFO - Downloading docopt-0.6.1.tar.gz 04:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:35 INFO - Running setup.py install for blobuploader 04:13:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:35 INFO - Running setup.py install for requests 04:13:35 INFO - Running setup.py install for docopt 04:13:35 INFO - Successfully installed blobuploader requests docopt 04:13:35 INFO - Cleaning up... 04:13:36 INFO - Return code: 0 04:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:36 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')]} 04:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:36 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')]} 04:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:36 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:36 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 04:13:36 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 04:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:36 INFO - 'HOME': '/Users/cltbld', 04:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:36 INFO - 'LOGNAME': 'cltbld', 04:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:36 INFO - 'MOZ_NO_REMOTE': '1', 04:13:36 INFO - 'NO_EM_RESTART': '1', 04:13:36 INFO - 'PAGER': '/bin/cat', 04:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:36 INFO - 'PWD': '/builds/slave/test', 04:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:36 INFO - 'SHELL': '/bin/bash', 04:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:36 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:36 INFO - 'USER': 'cltbld', 04:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:36 INFO - 'XPC_FLAGS': '0x0', 04:13:36 INFO - 'XPC_SERVICE_NAME': '0', 04:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-tbaR1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-86exjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-cNQvOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-JCaSVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VlvPv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oXTUBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-1HwWiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-hBRjEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-DhmPqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-nCnpfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-NWq7i5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-pZzyzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-EFfA4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QV1csy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Trg0AJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-P60cj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-do3Qol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:38 INFO - Running setup.py install for manifestparser 04:13:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozcrash 04:13:38 INFO - Running setup.py install for mozdebug 04:13:38 INFO - Running setup.py install for mozdevice 04:13:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozfile 04:13:38 INFO - Running setup.py install for mozhttpd 04:13:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:38 INFO - Running setup.py install for mozinfo 04:13:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Running setup.py install for mozInstall 04:13:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Running setup.py install for mozleak 04:13:39 INFO - Running setup.py install for mozlog 04:13:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Running setup.py install for moznetwork 04:13:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Running setup.py install for mozprocess 04:13:39 INFO - Running setup.py install for mozprofile 04:13:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:39 INFO - Running setup.py install for mozrunner 04:13:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Running setup.py install for mozscreenshot 04:13:40 INFO - Running setup.py install for moztest 04:13:40 INFO - Running setup.py install for mozversion 04:13:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:40 INFO - Cleaning up... 04:13:40 INFO - Return code: 0 04:13:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:40 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:40 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 04:13:40 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 04:13:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:40 INFO - 'HOME': '/Users/cltbld', 04:13:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:40 INFO - 'LOGNAME': 'cltbld', 04:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:40 INFO - 'MOZ_NO_REMOTE': '1', 04:13:40 INFO - 'NO_EM_RESTART': '1', 04:13:40 INFO - 'PAGER': '/bin/cat', 04:13:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:40 INFO - 'PWD': '/builds/slave/test', 04:13:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:40 INFO - 'SHELL': '/bin/bash', 04:13:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:40 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:40 INFO - 'USER': 'cltbld', 04:13:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:40 INFO - 'XPC_FLAGS': '0x0', 04:13:40 INFO - 'XPC_SERVICE_NAME': '0', 04:13:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:40 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oAzin9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-gTkYx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8NvxR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VdQaaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QPDsuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-3AV6Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-T85TLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-hx8DhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-BAuMZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-TaSKd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:41 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)) 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-XkMxiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-hHVuP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-qJOiV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Xsi_Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-_atf24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-u1lKPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:42 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)) 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-WIEF6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:42 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)) 04:13:42 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)) 04:13:42 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)) 04:13:42 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)) 04:13:42 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)) 04:13:42 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)) 04:13:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13:42 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 04:13:42 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 04:13:42 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 04:13:42 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 04:13:42 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 04:13:42 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 04:13:45 INFO - Downloading blessings-1.6.tar.gz 04:13:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:45 INFO - Installing collected packages: blessings 04:13:45 INFO - Running setup.py install for blessings 04:13:45 INFO - Successfully installed blessings 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:46 INFO - Reading from file tmpfile_stdout 04:13:46 INFO - Current package versions: 04:13:46 INFO - blessings == 1.6 04:13:46 INFO - blobuploader == 1.2.4 04:13:46 INFO - docopt == 0.6.1 04:13:46 INFO - functools32 == 3.2.3-2 04:13:46 INFO - jsonschema == 2.5.1 04:13:46 INFO - manifestparser == 1.1 04:13:46 INFO - mozInstall == 1.12 04:13:46 INFO - mozcrash == 1.0 04:13:46 INFO - mozdebug == 0.1 04:13:46 INFO - mozdevice == 0.50 04:13:46 INFO - mozfile == 1.2 04:13:46 INFO - mozhttpd == 0.7 04:13:46 INFO - mozinfo == 0.9 04:13:46 INFO - mozleak == 0.1 04:13:46 INFO - mozlog == 3.4 04:13:46 INFO - moznetwork == 0.27 04:13:46 INFO - mozprocess == 0.25 04:13:46 INFO - mozprofile == 0.28 04:13:46 INFO - mozrunner == 6.13 04:13:46 INFO - mozscreenshot == 0.1 04:13:46 INFO - mozsystemmonitor == 0.3 04:13:46 INFO - moztest == 0.8 04:13:46 INFO - mozversion == 1.4 04:13:46 INFO - psutil == 3.1.1 04:13:46 INFO - requests == 1.2.3 04:13:46 INFO - wsgiref == 0.1.2 04:13:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:46 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 04:13:46 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 04:13:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:46 INFO - 'HOME': '/Users/cltbld', 04:13:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:46 INFO - 'LOGNAME': 'cltbld', 04:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:46 INFO - 'MOZ_NO_REMOTE': '1', 04:13:46 INFO - 'NO_EM_RESTART': '1', 04:13:46 INFO - 'PAGER': '/bin/cat', 04:13:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:46 INFO - 'PWD': '/builds/slave/test', 04:13:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:46 INFO - 'SHELL': '/bin/bash', 04:13:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:46 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:46 INFO - 'USER': 'cltbld', 04:13:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:46 INFO - 'XPC_FLAGS': '0x0', 04:13:46 INFO - 'XPC_SERVICE_NAME': '0', 04:13:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 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)) 04:13:46 INFO - Cleaning up... 04:13:46 INFO - Return code: 0 04:13:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:46 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 0x10d08ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d08d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8f124a87d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, '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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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 04:13:46 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 04:13:46 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 04:13:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:13:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:46 INFO - 'HOME': '/Users/cltbld', 04:13:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:46 INFO - 'LOGNAME': 'cltbld', 04:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:46 INFO - 'MOZ_NO_REMOTE': '1', 04:13:46 INFO - 'NO_EM_RESTART': '1', 04:13:46 INFO - 'PAGER': '/bin/cat', 04:13:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:46 INFO - 'PWD': '/builds/slave/test', 04:13:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:46 INFO - 'SHELL': '/bin/bash', 04:13:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:13:46 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:13:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:46 INFO - 'USER': 'cltbld', 04:13:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:46 INFO - 'XPC_FLAGS': '0x0', 04:13:46 INFO - 'XPC_SERVICE_NAME': '0', 04:13:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:46 INFO - Cleaning up... 04:13:46 INFO - Return code: 0 04:13:46 INFO - Running post-action listener: _resource_record_post_action 04:13:46 INFO - Running post-action listener: _start_resource_monitoring 04:13:46 INFO - Starting resource monitoring. 04:13:46 INFO - [mozharness: 2017-04-24 11:13:46.588727Z] Finished create-virtualenv step (success) 04:13:46 INFO - [mozharness: 2017-04-24 11:13:46.589702Z] Running install step. 04:13:46 INFO - Running pre-action listener: _resource_record_pre_action 04:13:46 INFO - Running main action method: install 04:13:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:46 INFO - Reading from file tmpfile_stdout 04:13:46 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:46 INFO - Reading from file tmpfile_stdout 04:13:46 INFO - Output received: 04:13:46 INFO - Usage: mozinstall [options] installer 04:13:46 INFO - Options: 04:13:46 INFO - -h, --help show this help message and exit 04:13:46 INFO - -d DEST, --destination=DEST 04:13:46 INFO - Directory to install application into. [default: 04:13:46 INFO - "/builds/slave/test"] 04:13:46 INFO - --app=APP Application being installed. [default: firefox] 04:13:46 INFO - mkdir: /builds/slave/test/build/application 04:13:46 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'] 04:13:46 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 04:14:07 INFO - Reading from file tmpfile_stdout 04:14:07 INFO - Output received: 04:14:07 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:14:07 INFO - Running post-action listener: _resource_record_post_action 04:14:07 INFO - [mozharness: 2017-04-24 11:14:07.116714Z] Finished install step (success) 04:14:07 INFO - [mozharness: 2017-04-24 11:14:07.116879Z] Running run-tests step. 04:14:07 INFO - Running pre-action listener: _resource_record_pre_action 04:14:07 INFO - Running main action method: run_tests 04:14:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:14:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:14:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:14:07 INFO - 2017-04-24 04:14:07.131 screenresolution[1625:7528] starting screenresolution argv=screenresolution get 04:14:07 INFO - 2017-04-24 04:14:07.134 screenresolution[1625:7528] Display 0: 1600x1200x32@60 04:14:07 INFO - 2017-04-24 04:14:07.139 screenresolution[1626:7531] starting screenresolution argv=screenresolution list 04:14:07 INFO - Available Modes on Display 0 04:14:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:14:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:14:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:14:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:14:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:14:07 INFO - Intel Iris: 04:14:07 INFO - Chipset Model: Intel Iris 04:14:07 INFO - Type: GPU 04:14:07 INFO - Bus: Built-In 04:14:07 INFO - VRAM (Dynamic, Max): 1536 MB 04:14:07 INFO - Vendor: Intel (0x8086) 04:14:07 INFO - Device ID: 0x0a2e 04:14:07 INFO - Revision ID: 0x0009 04:14:07 INFO - Displays: 04:14:07 INFO - Display: 04:14:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:14:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:14:07 INFO - Display Serial Number: 1600x1200 60 04:14:07 INFO - Main Display: Yes 04:14:07 INFO - Mirror: Off 04:14:07 INFO - Online: Yes 04:14:07 INFO - Rotation: Supported 04:14:07 INFO - Return code: 0 04:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:07 INFO - Python 2.7.3 04:14:07 INFO - Return code: 0 04:14:07 INFO - grabbing minidump binary from tooltool 04:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:07 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 0x10ce68d30>, '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 0x10cd8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce5dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:07 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 04:14:07 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 04:14:07 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 04:14:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:07 INFO - Return code: 0 04:14:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:14:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:07 INFO - ENV: RUST_BACKTRACE is now 1 04:14:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:14:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HpmunIgAsq/Render', 04:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:14:07 INFO - 'HOME': '/Users/cltbld', 04:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:14:07 INFO - 'LOGNAME': 'cltbld', 04:14:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:07 INFO - 'MOZ_NO_REMOTE': '1', 04:14:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:07 INFO - 'NO_EM_RESTART': '1', 04:14:07 INFO - 'PAGER': '/bin/cat', 04:14:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:07 INFO - 'PWD': '/builds/slave/test', 04:14:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:14:07 INFO - 'RUST_BACKTRACE': '1', 04:14:07 INFO - 'SHELL': '/bin/bash', 04:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gfxOH4Xwiu/Listeners', 04:14:07 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 04:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:14:07 INFO - 'USER': 'cltbld', 04:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:07 INFO - 'XPC_FLAGS': '0x0', 04:14:07 INFO - 'XPC_SERVICE_NAME': '0', 04:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:14:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:14:07 INFO - mozversion application_buildid: 20170424030211 04:14:07 INFO - mozversion application_changeset: 73752931e273091185e1e4b5231c28beed657cc8 04:14:07 INFO - mozversion application_display_name: Nightly 04:14:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:07 INFO - mozversion application_name: Firefox 04:14:07 INFO - mozversion application_remotingname: firefox 04:14:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:07 INFO - mozversion application_vendor: Mozilla 04:14:07 INFO - mozversion application_version: 55.0a1 04:14:07 INFO - mozversion platform_buildid: 20170424030211 04:14:07 INFO - mozversion platform_changeset: 73752931e273091185e1e4b5231c28beed657cc8 04:14:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:07 INFO - mozversion platform_version: 55.0a1 04:14:07 INFO - using testdate: 1493032447 04:14:07 INFO - actual date: 1493032447 04:14:07 INFO - starting webserver on 'localhost:49246' 04:14:07 INFO - SUITE-START | Running 2 tests 04:14:07 INFO - TEST-START | dromaeo_css 04:14:07 INFO - operating with platform_type : mac_ 04:14:07 INFO - Initialising browser for dromaeo_css test... 04:14:07 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpnP1qoA/profile http://localhost:49246/getInfo.html) 04:14:10 INFO - PID 1636 | 2017-04-24 04:14:10.720 plugin-container[1639:7722] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e43, name = 'com.apple.tsm.portname' 04:14:10 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:10 INFO - PID 1636 | 2017-04-24 04:14:10.721 plugin-container[1639:7722] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c23, name = 'com.apple.CFPasteboardClient' 04:14:10 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:10 INFO - PID 1636 | 2017-04-24 04:14:10.721 plugin-container[1639:7722] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:14:10 INFO - PID 1636 | __metrics Screen width/height:1600/1200 04:14:10 INFO - PID 1636 | colorDepth:24 04:14:10 INFO - PID 1636 | Browser inner width/height: 1024/689 04:14:10 INFO - PID 1636 | __metrics 04:14:10 ERROR - PID 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:14:11 INFO - TEST-INFO | 1636: exit 0 04:14:11 INFO - Browser initialized. 04:14:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:11 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpnP1qoA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:14 INFO - PID 1640 | 2017-04-24 04:14:14.564 plugin-container[1641:7969] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 04:14:14 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:14 INFO - PID 1640 | 2017-04-24 04:14:14.564 plugin-container[1641:7969] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 04:14:14 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:14:14 INFO - PID 1640 | 2017-04-24 04:14:14.564 plugin-container[1641:7969] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:14:24 INFO - PID 1640 | RSS: Main: 236163072 04:14:24 INFO - PID 1640 | 04:17:27 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 04:17:29 INFO - PID 1640 | RSS: Main: 252342272 04:17:29 INFO - PID 1640 | 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:19:12 INFO - PID 1640 | 04:19:12 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:12 INFO - PID 1640 | Full stack: 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:19:12 INFO - PID 1640 | 04:19:12 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:12 INFO - PID 1640 | Full stack: 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:19:12 INFO - PID 1640 | 04:19:12 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:12 INFO - PID 1640 | Full stack: 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | ************************* 04:19:12 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 04:19:12 INFO - PID 1640 | 04:19:12 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:19:12 INFO - PID 1640 | Full stack: 04:19:12 INFO - PID 1640 | ************************* 04:20:31 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 04:20:32 INFO - PID 1640 | RSS: Main: 258605056 04:20:32 INFO - PID 1640 | 04:23:34 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 04:23:34 INFO - PID 1640 | RSS: Main: 268664832 04:23:34 INFO - PID 1640 | 04:26:36 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 04:26:37 INFO - PID 1640 | RSS: Main: 261894144 04:26:37 INFO - PID 1640 | 04:29:40 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 04:29:40 INFO - PID 1640 | RSS: Main: 270577664 04:29:40 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 04:32:42 INFO - PID 1640 | RSS: Main: 265277440 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | __start_tp_report 04:32:42 INFO - PID 1640 | _x_x_mozilla_page_load 04:32:42 INFO - PID 1640 | _x_x_mozilla_page_load_details 04:32:42 INFO - PID 1640 | |i|pagename|runs| 04:32:42 INFO - PID 1640 | |0;dojo.html;3141.9371612567747;3599.082234030322;3606.621304763;3666.230091680746;3667.2298817248375;5077.263796749469;5369.5167434930845;5816.243888294526;6109.2528441424865;6235.095911092894;5837.5913686041995;6096.980278560381;6241.937580624192;6264.843378915518;6323.20959880015;5415.998040362526;5442.346918369801;5452.318460192476;5486.478784515464;5524.723763811813;4851.651427505144;5191.506806853343;5484.561235101202;5548.500634942854;5637.746301416426;5357.901630165807;5396.487333703292;5429.782808687648;5505.311836020457;5534.308211473566;5466.316710411199;5475.479829416199;5478.561715062785;5516.200150978086;5549.889002219973;4243.321068629036;4944.678595891256;5348.652337598082;5455.918161227545;5457.426970168115;5494.80768173116;6137.254412462268;6142.723577439026;6215.06773983906;6228.408301211378;5995.730192141321;6418.229812422493;6734.8316292092595;6741.292164322725;6759.019942108367;6845.828854278633;6858.211305699859;6869.690863911136;6877.071595334616;6878.518503704692;6115.090145714991;6168;6369.235691717024;6385.297617262097;6406.967965160145;5790.942090579125;6874.243833178346;6954;6959.095317608679;6976.197737260179;6335.334789847;6378.489720822323;6570.310117437601;6589.110470086573;6638.435732962752;6699.062131301622;6738.898916516257;6814.454843612499;6828.795136145924;6831.28271531492;6467.805965821033;6503.7073331700185;6544.574602650812;6721.529492935448;6745.966270168716;5625.774969001276;6556.049372840911;6637.6349300788925;6653.301403352675;6737.393634572912;4491.595756381876;5332.093544097513;5339.946600534023;5347.1979203119845;5381.13901775714;4759.1671457495495;4759.976200119047;4767.308740232646;4774.7135171889795;4802.73584952824;4925.778339974638;6171.506279497629;6174.5060395168275;6311.305756366796;6327.715252813635;6839.418649414855;6853.246142924274;6859.142607174103;6868.896966545506;6900.137482814648;6277.686115694289;6278.372162783777;6347.904781428282;6354.809355719336;6399.104125422352;5747.224124743107;5820.563457740686;5977.850553736192;5981.611195272293;6004;7059.5058345915295;7093.964530177523;7102.857942841218;7108;7117.644117793986;6793.388595026471;6822.658867056726;6846.110005699227;6858.965705171442;6883.724651013903;6697.631630260383;6809.353111454404;6935.514513983972;6979.511434199558;7049.753258635923;6672.966635166793;6710.228323742636;6713.932860671331;6749.493787965824;6755.93244067553;6774.356436138559;6824.488163387667;6847.62338071391;6849.1438570178725;6874.450043996369;6291.1192433058495;6381.3937675920715;6540;6647.60114393138;6648.667566621746;6634.137562116894;6636.27001029896;6643.169603799525;6651.667416629246;6669.699863506057;5833.79581714638;5901.29184497863;6496.187976502937;6507.414332710079;6515.902261466176;6305.747770089329;6394.744210231539;6483.384078512534;6522.739090436329;6629.569078009914;6384.968075159594;6419.518536109717;6475.255345635123;6475.287718351072;6492.285848556749 04:32:42 INFO - PID 1640 | |1;ext.html;680.4114441008528;718.4862823081498;811.655046605193;1050.3592808386882;1246.4640204711982;36774;37765.81117094411;37924.81037594815;37963.62036379632;38048;31882.52176217353;37930.8103459483;38197;38476.615233847726;38523.22953540928;7850.528968261894;8016.997875265592;8347.998240211153;8554.187352201561;8593;8397.580120993956;8445.619947102396;8485.0666426693;8486.0665326814;8504.192101750325;6462.5153113516435;8454.196851299148;8490;8494.277986371166;8502.957485212597;8438.535880526568;8475.915240847575;8479.2792612628;8484.36367272457;8488.236058754741;8375.41372103953;8438.113998030241;8438.36712246584;8441.324694024463;8456.8731469028;37579.24841503154;37798.055048623726;37814.865554033146;37829;37851;3624.6375362463805;3641.235340578455;3654.4152935530187;3655.3054919565197;3656.177360093984;31004.37991240185;31025;31138.532922006187;31151.532727009115;31211.37577248442;3135.3102317490116;3157.463231250693;3158.96841031589;3178.300773829754;3179.9205019874457;232167;235336.82331588404;279044;280671;281110;46095.76952115218;46560.37038703697;46686.29970550445;46860.59418217459;46977.530224698;48064;48076;48407.757961209965;48499;48510.5148948506;13786.448542058206;13840.100393474391;13890.93054534741;13941.58175254744;13966.022378433412;11335.206535542433;11341.979221870071;11342.659720208407;11352.716182095513;11371.488283027284;10947.671569852917;13332.800007999887;13472.730545389037;13522.12106213093;13639.045266831425;5352.732363381815;5492.203630473559;5763.435271304229;5776.740046697909;5879.353271140171;1006.7281833904951;1025.6358992557684;1030.3251370352432;1059.9682009539727;1068.060107105742;23248.76751232466;24197.7580224199;24241.030358785803;24366.390840229134;24514.877425612758;1083.3608171178885;1106.8782433932422;1121.2711737370773;1139.515705825021;1148.1503687271359;12137.812454703113;12196.298156038283;12272.276245286728;12277.288653756425;12305.323207223688;306616;308543;308746;309228;309284;43480.78259608745;53099.73450132802;53205.2019219712;53217.20174197313;53294.73352633289;1493.9103653780808;1529.5870115069092;1531.6170957260686;1536.8386319436297;1554.0597938247197;22575.75833329117;23170.652440213074;23284.53430931406;23477.530449390575;23800.761992379856;30178.698213018466;37902.810485948496;38258.61741382551;38296.80851595836;38345;237474;241597;289265;289484;289495;33497.16257093495;33689.831550842086;36085;36617.81691091634;36681.44977825281;44762;45146.09707805891;45312.77343613261;45360;45441.318380224984;24388.26835194947;28761.856190718914;30926.536101958038;30927.91752288659;31277.84361078271;30671.693283067776;30723.2319192022;30954;31054.22364440907;31059;29512.704872950995;36523;37192;37611.05972350713;37631;28187.013454528995;30138;30545.08364749061;31287;31558.053258401367;17797.288108475517;21915.452113696647;22740.545189096458;24115.638265426383;24639.01443942294 04:32:42 INFO - PID 1640 | |2;jquery.html;436.90169711814826;438.60087320538304;442.0143080929527;450.25707582488894;460.73507733053503;20799.68800467994;21137.15451381945;21506.032228549713;21557.46106347342;21676.132954681812;17809.910950445228;21175.894120529414;21597.67603485945;21770.673439898415;22139.778602213973;5943.13824495449;6174.073888916676;6237.095621134933;6243.937560624404;6250.312465628777;5869.354371019184;6081.087836824468;6084.239470066242;6133.785317513888;6143.631382117065;5913.497352725023;6052.152698622196;6089.725962331706;6104.877902441948;6114.991026480626;5471.972640136813;5899.557533185007;6074.301455332649;6094.786682466137;6094.96952515239;5376.946230537684;5410.97294513525;5437.075697131497;5452.6455780374545;5553.305836770403;26690.5996410054;26702.46595068088;26941.86529067342;26971.730282697117;27156.864215678794;2217.944551386212;2274.1358283852196;2286.119843860126;2288.313505948209;2290.0725206291477;14779.482718104922;17605.29578816846;17702.91148544249;18200.998945058018;18269.63460730778;2140.058374315296;2162.232407495348;2188.037263604025;2193.605151072806;2196.6595177747477;160586;160665;162732.18633906756;164326.1783691086;165057;11550.498435203537;11559.942200288944;12610.747785044432;12731.363431828371;12898.290594017231;16164.838351616569;16440.6711865762;16441.91779041121;16456.506304810875;16493.010419374878;8566.400351975302;8809.295256379473;8822.779430514289;8928.821423571491;8972.37193396456;8200.384971127189;8315.8336833263;8336.749897503085;8490.981082270167;8497.36269779769;7761.650725717356;7866.72466463671;7923.088844782808;7938.325242354349;7951.85901568877;2154.8922553872244;2169.7721739217473;2169.934901952944;2170.251263314154;2370.2889133260296;946.2666433514082;947.8672985781996;954.5895265035962;976.3897564022486;987.9654212102541;20317.069878361533;20728.896355518427;20739;21218.469538261666;21354;789.0058526256843;889.3685483306796;955.2214944819949;1014.4572653630272;1019.2050200843354;9066.773330666787;10495.947520262502;10909.563617455371;10938.289011214245;10948.084085285043;554282;556496;570972;573775;576126;116031.41984290193;116086;124882;127971.1224545924;128669;1127.1658972360558;1141.5376772407021;1170.5785917069848;1172.7654469106212;1174.448009435564;17594.328538788795;17897.73153402726;18012.00933948593;18027.369042083465;18322.725159122358;41819.581804181566;55298.44701553094;56089.719551401984;56095;56375.15437268526;72363.91454128298;73424;75188;75269;75535.62232188803;8503.277221436247;8697.391182617155;8697.434666746642;8713.25937295337;8834.95582522109;13875.514356997457;13976.091554048955;14008.369623366769;14206.360713768112;14333.211673358066;9995.150412215044;11293.974181489159;11398.487068081791;11740.882591173979;12056.156069075081;11292.491837867152;11307.830382544103;11379.43102844871;11554.711132221762;11610;11721.472533735832;12003.75992480163;12213.145079844326;12222.75554488923;12293.262404255773;8651;8803.911960880308;8935.285177185939;9058.139476749699;9076.228520575825;9546.809063818824;11828.290302581872;11998.280103193836;12024.038076953997;12060.396980151132 04:32:42 INFO - PID 1640 | |3;mootools.html;1230.6123571075111;1345.4954392102961;1438.5828109848144;1442.2428225181777;1445.0823726933395;11516.942415287922;11827.231229970068;12071.818922716166;12090.274583524995;12253.877461225407;9788;11573.13201509888;11807.586734464296;11997.880021199786;12006.099542534323;2530.0512307884496;2558.4371438283547;2560.9103681371157;2568.3964268396912;2574.150530324998;2486.4032632168332;2525.9621105683427;2549.146036077916;2550.0437335999;2552.374668206283;2460.2865169100937;2501.8999240030375;2528.962065569018;2555.7699807017366;2569.087973769313;2481.553320402327;2510.0587279769993;2529.7723204911554;2538.82228244023;2539.3397716593636;2450.1179575352858;2526.191618682004;2542.745725427461;2557.974420255792;2561.9615705764427;11687.824682629767;11688.649340519798;11778.941105294505;11783.882161178364;11820.527178912833;6644.667766611698;6760.18877734675;6859.314068593101;6860.794176174722;6886.793396198122;4015.8996025099314;4318.935215971763;4399.428074350314;4401.2517871961845;4402.5597440255715;1239.3493415956605;1258.2199036597276;1301.1217428235902;1306.040060555491;1308.869113088693;14642.04826686262;15143.621409464742;16674.33302667892;16815.74776378343;16837.242324095445;5039.974800125976;5719.399463056402;5809.331926828384;5958.612690175125;6013.759449621966;10455.84316235257;12396.256224626552;12410.627681169579;12492.50029998808;12513.249205047545;6636;6690;6708.262091169968;6719.361660642231;6726.697298621574;6018.879622407528;6250.9062364064575;6275.058741188858;6306.968465157736;6328.6835658216905;4315.482142142963;4441.378207051015;4458.687891847604;4487.910241795146;4497.820087196541;1270.4791035675514;1301.5184381778613;1316.2300054468244;1316.9473221071241;1322.76982406363;763.3092051693227;776.4875182379602;778.0857492446353;780.2665494435213;785.9685612575433;5187.818426355059;6253.874922501524;6320.8419789504715;6411.134496842867;6419.390157934989;571.8941995730803;572.8399753004275;600.1477901380051;602.1299222623268;609.411917499615;3760.646167379741;4258;4394.406755088086;4444.11117776446;4479.46246450428;14579.927100364643;14864.256787160599;15061.096334219981;15397.692046159014;15406.460773873085;14730.705385892223;15094.924525377302;15276.541703748906;15340.15629140408;15428.074315540878;8405.159484051668;8563.015253245956;8654.134586541295;8716.38985271025;8736.344774141964;6968.442524598121;7116.857662846817;7152.141742990874;7227.349538541556;7274.8908766369605;13042.673933151747;13374.598762037154;13405.396757146147;13684.794728079285;13833.584992450242;11473.82789258145;13870.861291386957;14102.435902564193;14115.22366269865;14211.715765684421;9525.857112143462;9758.072983066597;9771.169450596779;9783.266255031043;9805.166560842123;10648.361098334124;10789.460526973777;10802.243842930919;10859.945700271448;10985.560577576807;9235.861462078208;9276.907230927603;9327.953360233156;9387.10822471864;9422.199113075465;8987.505687187268;9031.50326732036;9151.771205719644;9180.127887850644;9375.296852735935;8369.581520923808;8380.287675547646;8383.706570270011;8455.30893821226;8462.365322600706;6088.786892458743;6184.81445556634;6206;6245.156903817927;6303.275123360689;6092.543059270483;6167.290761562298;6231.2522497300615;6303.306636270098;6374.553781235269 04:32:42 INFO - PID 1640 | |4;prototype.html;404.175482016686;409.21635068843176;411.4178437510922;421.7069136949819;421.94092827004204;5202.32369791927;6246.500839798449;6346.841328966778;6365.777197798078;6367.9363206367925;5096.980603879229;5973.671448070354;6127.295361033483;6168.814935551929;6189.823933452641;4483.036147228345;4507.684462087655;4677.953220467786;4718.787654555545;4750.429948406196;4524.936639889624;4722.574968252857;4725.416985309926;4737.791863074911;4740.502247264022;3985.5416627087966;4127.442795222637;4637.652176086807;4651.7441540715245;4656.767161641905;3953.7034722395647;4597.494275629678;4671.696339737923;4677.836275730333;4721.24460086388;3478.4956181353564;4158.355454904495;4168.645665118469;4179.519355274152;4182.330827067654;4692.6245900327895;4742.383490146293;4846.5880400166025;6021.548383871227;6084.695765211722;5178.14560597501;5507.531859791922;5584;5588.804391846306;5633.718314084279;5787.672088549059;6327.778527751507;6347.714352854086;6584.5061620378665;6621.73513059477;4706.505816889212;4719.764011799396;4720;4730.479647238801;4755.619550435957;5746.367899531048;6076.848078798022;6385.5210859185745;6842.521023528355;6961.23426423093;4190.072566619389;4296.656267498593;4306.966328081238;4463.799129039201;4537.8411755588395;4081.673466122703;4082.081311862033;4580.106879158532;4607.00949295903;4649.302604609268;4169.374593810892;4678.695884767547;4730.17888113079;5356.035913535601;5395.325584301962;6600.372964568358;6626.768063117865;6634.900476492857;6671.532262902154;6675;1563.6872625474723;1574.7795308656798;1575.2360105348896;1576.7556028815552;1577.0695289779085;843.6836186430089;922.9907700923039;1020.78563501664;1039.365986748083;1048.7745134796055;5276.34045744282;5519.558435325164;6265.715528316684;6284.874302513924;6296.874062518724;6038.818835434944;6323.936760632335;6626.271110177877;6874;6888.207856096613;5287.709175995357;5642.855714828339;5739.852029594098;6260.248770147611;6283.403076707706;3380.560527131457;3612.6567976042234;3616.8010759407957;3623.58328792187;3646.635336466385;6295.559310848288;6794.694238759268;7125.394341480928;7159.498835081495;7172.426205903515;7071.363577277967;7074.893876591856;7118.86769821277;7124.251953544906;7151.928480715231;6104.901117798839;6780.694868730919;6978.720851165896;7182.533135346186;7194.625773494734;5494.7802087917635;5853.8048231913035;6920.4809639276245;6961.860762784817;6966.616836074065;6346.143270658402;6445.5165862561435;6822.522423430312;6830.658467076726;6859.691313890987;5698.943010569841;7011;7137.750178743719;7166.319199676022;7252.818679533054;3919.5884432134217;4000.7599544027453;4111.938320925248;4483.775811209362;4539.977300113478;5845.444682755132;6124.763327355226;6937.583744975116;6972.930270697431;7095.716171353088;6691.59850408977;6698.83252918681;6727.125473688585;6733.865322693421;6754.223264324665;6445.516586255956;6677.465802735866;6705.295943926013;6716.865662686817;6743.819831529365;5140.46025167352;5239.842804715865;6142.40669208518;6469.061986012096;6507.7722279721875;5901.3213480448585;6175.722092505758;6735.158105236846;6746.224184218878;6785.762498312535;5203.349581302337;6168.228971378578;6480.481561475165;6486.599958015565;6514.869702606016 04:32:42 INFO - PID 1640 | |5;yui.html;807.5316316536409;850.8425941200877;855.589317127779;875.9357380782349;888.355941942092;13898.93050534747;14554.27228638569;16522.75215871763;18175.363862264825;18818.15318310676;14772.852271477283;16511.256993435294;17563.5609109772;17928.64142717145;17963.550911227227;792.7185849023572;824.7443292579289;962.0475729028246;973.6981535723913;975.0298453039236;982.641335912394;983.6557204978236;985.8816941966938;986.1863962231153;986.4180133721103;1010.1817527802503;1028.059325716968;1029.4646783672524;1030.0111892583093;1030.7062487191151;1012.8430093335545;1023.5803320638539;1026.296986564206;1026.3687831983352;1028.598846449885;638.7863060185638;659.7624855052177;688.9517733758639;743.0080842075836;746.5073051785795;16326.510204693877;16691.41580044705;16871.409500667418;16872.493825185265;16894.662106757794;16705.164741762987;16790.58023549409;16837.410690625893;16933.3226670933;17205.139743012798;13749.31253437324;13967.231802250872;14095.295235238196;14098.718025639533;14105.506307279196;3529.4176460883923;3548.27260411615;3568.3041806847673;3575.570931488212;3592.568891733009;135150.97273540904;135760.32119839438;136385;137473;139201.3039934804;12525;12595.748085038247;12646.114771965875;12798.808017879739;12806.743865122646;23697.7630223699;24209.273721788373;24405.145819896217;24910.750892490843;25419.983200672137;7560.319571238615;7604.429667774828;7646.3118319350415;7733.110692270348;7757.146713861471;3884.2037382336553;3938.5076865391825;3954.6440820326306;3960.386140148282;3965.988672888395;4342.08816148606;4397.802098905557;4427.645788336926;4446.177457170369;4460.241758900995;890.9486805569491;941.6863475451706;956.8134213828375;964.8793900762405;966.2270183852889;585.5842351930092;624.7719582352408;627.4854619212202;638.9616872582054;664.6909187227963;10997.945010274898;11264.211505194558;11872.10959178065;11974.58088966882;12107.818382724266;533.2534451767557;637.8883695353295;661.1471202149173;678.4775722693498;684.1414025398094;5308.734563271821;5315.160820754174;5358.33020872391;5399.946000540023;5469.480399362054;104599;104973.47513262538;105461.47269263605;105958.47020764847;107977.38033929498;82952.58523707344;92311;93869.53065234631;94274.05725942652;95203;57650.13524797215;76938.61530692311;78975.23586674439;79676;82209;9261.814763704822;10472.266941314036;10614.8407773885;11133.276337038067;12523.93738031304;32186.678133218367;40316;40448.1910361797;40455.79772101121;41137.38293925534;42115.578844211166;54090.18864716954;54103;54145;54793;13142.60572182836;15928.773615303842;15966.840331596535;16000.359985600446;16198.676026479168;14616.196109214095;14831;14839.777403339174;14966.251687415368;14975.550733478012;16025.519234422985;16372.263248153624;16421.507354779376;16490.75263871019;16621.252043657823;15936.681266374375;15999.040057596581;16098.195090245206;16186.433474828795;16270.755938661167;15916.522504324888;16066;16172.595685107966;16189.190540473164;16250.9436886602;11269.267497612629;11400.714982125513;11709.180357374902;11789.764204715686;11867.76264474723;11902.702432439259;11917.82123268169;12368.257904525397;12404.131710780159;12473.064520160842 04:32:42 INFO - PID 1640 | __end_tp_report 04:32:42 INFO - PID 1640 | __start_cc_report 04:32:42 INFO - PID 1640 | _x_x_mozilla_cycle_collect,424 04:32:42 INFO - PID 1640 | __end_cc_report 04:32:42 INFO - PID 1640 | __startTimestamp1493033562635__endTimestamp 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | ------- Summary: start ------- 04:32:42 INFO - PID 1640 | Number of tests: 6 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6143.95 Median:6384.97 stddev:790.26 (12.4%) stddev-sans-first:756.77 04:32:42 INFO - PID 1640 | Values: 3141.9 3599.1 3606.6 3666.2 3667.2 5077.3 5369.5 5816.2 6109.3 6235.1 5837.6 6097.0 6241.9 6264.8 6323.2 5416.0 5442.3 5452.3 5486.5 5524.7 4851.7 5191.5 5484.6 5548.5 5637.7 5357.9 5396.5 5429.8 5505.3 5534.3 5466.3 5475.5 5478.6 5516.2 5549.9 4243.3 4944.7 5348.7 5455.9 5457.4 5494.8 6137.3 6142.7 6215.1 6228.4 5995.7 6418.2 6734.8 6741.3 6759.0 6845.8 6858.2 6869.7 6877.1 6878.5 6115.1 6168.0 6369.2 6385.3 6407.0 5790.9 6874.2 6954.0 6959.1 6976.2 6335.3 6378.5 6570.3 6589.1 6638.4 6699.1 6738.9 6814.5 6828.8 6831.3 6467.8 6503.7 6544.6 6721.5 6746.0 5625.8 6556.0 6637.6 6653.3 6737.4 4491.6 5332.1 5339.9 5347.2 5381.1 4759.2 4760.0 4767.3 4774.7 4802.7 4925.8 6171.5 6174.5 6311.3 6327.7 6839.4 6853.2 6859.1 6868.9 6900.1 6277.7 6278.4 6347.9 6354.8 6399.1 5747.2 5820.6 5977.9 5981.6 6004.0 7059.5 7094.0 7102.9 7108.0 7117.6 6793.4 6822.7 6846.1 6859.0 6883.7 6697.6 6809.4 6935.5 6979.5 7049.8 6673.0 6710.2 6713.9 6749.5 6755.9 6774.4 6824.5 6847.6 6849.1 6874.5 6291.1 6381.4 6540.0 6647.6 6648.7 6634.1 6636.3 6643.2 6651.7 6669.7 5833.8 5901.3 6496.2 6507.4 6515.9 6305.7 6394.7 6483.4 6522.7 6629.6 6385.0 6419.5 6475.3 6475.3 6492.3 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:43098.33 Median:3158.22 stddev:73647.16 (2331.9%) stddev-sans-first:73784.89 04:32:42 INFO - PID 1640 | Values: 680.4 718.5 811.7 1050.4 1246.5 36774.0 37765.8 37924.8 37963.6 38048.0 31882.5 37930.8 38197.0 38476.6 38523.2 7850.5 8017.0 8348.0 8554.2 8593.0 8397.6 8445.6 8485.1 8486.1 8504.2 6462.5 8454.2 8490.0 8494.3 8503.0 8438.5 8475.9 8479.3 8484.4 8488.2 8375.4 8438.1 8438.4 8441.3 8456.9 37579.2 37798.1 37814.9 37829.0 37851.0 3624.6 3641.2 3654.4 3655.3 3656.2 31004.4 31025.0 31138.5 31151.5 31211.4 3135.3 3157.5 3159.0 3178.3 3179.9 232167.0 235336.8 279044.0 280671.0 281110.0 46095.8 46560.4 46686.3 46860.6 46977.5 48064.0 48076.0 48407.8 48499.0 48510.5 13786.4 13840.1 13890.9 13941.6 13966.0 11335.2 11342.0 11342.7 11352.7 11371.5 10947.7 13332.8 13472.7 13522.1 13639.0 5352.7 5492.2 5763.4 5776.7 5879.4 1006.7 1025.6 1030.3 1060.0 1068.1 23248.8 24197.8 24241.0 24366.4 24514.9 1083.4 1106.9 1121.3 1139.5 1148.2 12137.8 12196.3 12272.3 12277.3 12305.3 306616.0 308543.0 308746.0 309228.0 309284.0 43480.8 53099.7 53205.2 53217.2 53294.7 1493.9 1529.6 1531.6 1536.8 1554.1 22575.8 23170.7 23284.5 23477.5 23800.8 30178.7 37902.8 38258.6 38296.8 38345.0 237474.0 241597.0 289265.0 289484.0 289495.0 33497.2 33689.8 36085.0 36617.8 36681.4 44762.0 45146.1 45312.8 45360.0 45441.3 24388.3 28761.9 30926.5 30927.9 31277.8 30671.7 30723.2 30954.0 31054.2 31059.0 29512.7 36523.0 37192.0 37611.1 37631.0 28187.0 30138.0 30545.1 31287.0 31558.1 17797.3 21915.5 22740.5 24115.6 24639.0 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:35736.61 Median:2287.22 stddev:95905.85 (4193.1%) stddev-sans-first:96138.27 04:32:42 INFO - PID 1640 | Values: 436.9 438.6 442.0 450.3 460.7 20799.7 21137.2 21506.0 21557.5 21676.1 17809.9 21175.9 21597.7 21770.7 22139.8 5943.1 6174.1 6237.1 6243.9 6250.3 5869.4 6081.1 6084.2 6133.8 6143.6 5913.5 6052.2 6089.7 6104.9 6115.0 5472.0 5899.6 6074.3 6094.8 6095.0 5376.9 5411.0 5437.1 5452.6 5553.3 26690.6 26702.5 26941.9 26971.7 27156.9 2217.9 2274.1 2286.1 2288.3 2290.1 14779.5 17605.3 17702.9 18201.0 18269.6 2140.1 2162.2 2188.0 2193.6 2196.7 160586.0 160665.0 162732.2 164326.2 165057.0 11550.5 11559.9 12610.7 12731.4 12898.3 16164.8 16440.7 16441.9 16456.5 16493.0 8566.4 8809.3 8822.8 8928.8 8972.4 8200.4 8315.8 8336.7 8491.0 8497.4 7761.7 7866.7 7923.1 7938.3 7951.9 2154.9 2169.8 2169.9 2170.3 2370.3 946.3 947.9 954.6 976.4 988.0 20317.1 20728.9 20739.0 21218.5 21354.0 789.0 889.4 955.2 1014.5 1019.2 9066.8 10495.9 10909.6 10938.3 10948.1 554282.0 556496.0 570972.0 573775.0 576126.0 116031.4 116086.0 124882.0 127971.1 128669.0 1127.2 1141.5 1170.6 1172.8 1174.4 17594.3 17897.7 18012.0 18027.4 18322.7 41819.6 55298.4 56089.7 56095.0 56375.2 72363.9 73424.0 75188.0 75269.0 75535.6 8503.3 8697.4 8697.4 8713.3 8835.0 13875.5 13976.1 14008.4 14206.4 14333.2 9995.2 11294.0 11398.5 11740.9 12056.2 11292.5 11307.8 11379.4 11554.7 11610.0 11721.5 12003.8 12213.1 12222.8 12293.3 8651.0 8803.9 8935.3 9058.1 9076.2 9546.8 11828.3 11998.3 12024.0 12060.4 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7185.64 Median:4136.95 stddev:4521.45 (109.3%) stddev-sans-first:4511.98 04:32:42 INFO - PID 1640 | Values: 1230.6 1345.5 1438.6 1442.2 1445.1 11516.9 11827.2 12071.8 12090.3 12253.9 9788.0 11573.1 11807.6 11997.9 12006.1 2530.1 2558.4 2560.9 2568.4 2574.2 2486.4 2526.0 2549.1 2550.0 2552.4 2460.3 2501.9 2529.0 2555.8 2569.1 2481.6 2510.1 2529.8 2538.8 2539.3 2450.1 2526.2 2542.7 2558.0 2562.0 11687.8 11688.6 11778.9 11783.9 11820.5 6644.7 6760.2 6859.3 6860.8 6886.8 4015.9 4318.9 4399.4 4401.3 4402.6 1239.3 1258.2 1301.1 1306.0 1308.9 14642.0 15143.6 16674.3 16815.7 16837.2 5040.0 5719.4 5809.3 5958.6 6013.8 10455.8 12396.3 12410.6 12492.5 12513.2 6636.0 6690.0 6708.3 6719.4 6726.7 6018.9 6250.9 6275.1 6307.0 6328.7 4315.5 4441.4 4458.7 4487.9 4497.8 1270.5 1301.5 1316.2 1316.9 1322.8 763.3 776.5 778.1 780.3 786.0 5187.8 6253.9 6320.8 6411.1 6419.4 571.9 572.8 600.1 602.1 609.4 3760.6 4258.0 4394.4 4444.1 4479.5 14579.9 14864.3 15061.1 15397.7 15406.5 14730.7 15094.9 15276.5 15340.2 15428.1 8405.2 8563.0 8654.1 8716.4 8736.3 6968.4 7116.9 7152.1 7227.3 7274.9 13042.7 13374.6 13405.4 13684.8 13833.6 11473.8 13870.9 14102.4 14115.2 14211.7 9525.9 9758.1 9771.2 9783.3 9805.2 10648.4 10789.5 10802.2 10859.9 10985.6 9235.9 9276.9 9328.0 9387.1 9422.2 8987.5 9031.5 9151.8 9180.1 9375.3 8369.6 8380.3 8383.7 8455.3 8462.4 6088.8 6184.8 6206.0 6245.2 6303.3 6092.5 6167.3 6231.3 6303.3 6374.6 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5311.53 Median:5849.62 stddev:1672.69 (28.6%) stddev-sans-first:1636.33 04:32:42 INFO - PID 1640 | Values: 404.2 409.2 411.4 421.7 421.9 5202.3 6246.5 6346.8 6365.8 6367.9 5097.0 5973.7 6127.3 6168.8 6189.8 4483.0 4507.7 4678.0 4718.8 4750.4 4524.9 4722.6 4725.4 4737.8 4740.5 3985.5 4127.4 4637.7 4651.7 4656.8 3953.7 4597.5 4671.7 4677.8 4721.2 3478.5 4158.4 4168.6 4179.5 4182.3 4692.6 4742.4 4846.6 6021.5 6084.7 5178.1 5507.5 5584.0 5588.8 5633.7 5787.7 6327.8 6347.7 6584.5 6621.7 4706.5 4719.8 4720.0 4730.5 4755.6 5746.4 6076.8 6385.5 6842.5 6961.2 4190.1 4296.7 4307.0 4463.8 4537.8 4081.7 4082.1 4580.1 4607.0 4649.3 4169.4 4678.7 4730.2 5356.0 5395.3 6600.4 6626.8 6634.9 6671.5 6675.0 1563.7 1574.8 1575.2 1576.8 1577.1 843.7 923.0 1020.8 1039.4 1048.8 5276.3 5519.6 6265.7 6284.9 6296.9 6038.8 6323.9 6626.3 6874.0 6888.2 5287.7 5642.9 5739.9 6260.2 6283.4 3380.6 3612.7 3616.8 3623.6 3646.6 6295.6 6794.7 7125.4 7159.5 7172.4 7071.4 7074.9 7118.9 7124.3 7151.9 6104.9 6780.7 6978.7 7182.5 7194.6 5494.8 5853.8 6920.5 6961.9 6966.6 6346.1 6445.5 6822.5 6830.7 6859.7 5698.9 7011.0 7137.8 7166.3 7252.8 3919.6 4000.8 4111.9 4483.8 4540.0 5845.4 6124.8 6937.6 6972.9 7095.7 6691.6 6698.8 6727.1 6733.9 6754.2 6445.5 6677.5 6705.3 6716.9 6743.8 5140.5 5239.8 6142.4 6469.1 6507.8 5901.3 6175.7 6735.2 6746.2 6785.8 5203.3 6168.2 6480.5 6486.6 6514.9 04:32:42 INFO - PID 1640 | 04:32:42 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:21559.58 Median:17946.10 stddev:31523.58 (175.7%) stddev-sans-first:31573.51 04:32:42 INFO - PID 1640 | Values: 807.5 850.8 855.6 875.9 888.4 13898.9 14554.3 16522.8 18175.4 18818.2 14772.9 16511.3 17563.6 17928.6 17963.6 792.7 824.7 962.0 973.7 975.0 982.6 983.7 985.9 986.2 986.4 1010.2 1028.1 1029.5 1030.0 1030.7 1012.8 1023.6 1026.3 1026.4 1028.6 638.8 659.8 689.0 743.0 746.5 16326.5 16691.4 16871.4 16872.5 16894.7 16705.2 16790.6 16837.4 16933.3 17205.1 13749.3 13967.2 14095.3 14098.7 14105.5 3529.4 3548.3 3568.3 3575.6 3592.6 135151.0 135760.3 136385.0 137473.0 139201.3 12525.0 12595.7 12646.1 12798.8 12806.7 23697.8 24209.3 24405.1 24910.8 25420.0 7560.3 7604.4 7646.3 7733.1 7757.1 3884.2 3938.5 3954.6 3960.4 3966.0 4342.1 4397.8 4427.6 4446.2 4460.2 890.9 941.7 956.8 964.9 966.2 585.6 624.8 627.5 639.0 664.7 10997.9 11264.2 11872.1 11974.6 12107.8 533.3 637.9 661.1 678.5 684.1 5308.7 5315.2 5358.3 5399.9 5469.5 104599.0 104973.5 105461.5 105958.5 107977.4 82952.6 92311.0 93869.5 94274.1 95203.0 57650.1 76938.6 78975.2 79676.0 82209.0 9261.8 10472.3 10614.8 11133.3 12523.9 32186.7 40316.0 40448.2 40455.8 41137.4 42115.6 54090.2 54103.0 54145.0 54793.0 13142.6 15928.8 15966.8 16000.4 16198.7 14616.2 14831.0 14839.8 14966.3 14975.6 16025.5 16372.3 16421.5 16490.8 16621.3 15936.7 15999.0 16098.2 16186.4 16270.8 15916.5 16066.0 16172.6 16189.2 16250.9 11269.3 11400.7 11709.2 11789.8 11867.8 11902.7 11917.8 12368.3 12404.1 12473.1 04:32:42 INFO - PID 1640 | -------- Summary: end -------- 04:32:42 INFO - PID 1640 | 04:32:43 INFO - TEST-INFO | 1640: exit 0 04:32:43 INFO - TEST-OK | dromaeo_css | took 1115579ms 04:32:43 INFO - TEST-START | kraken 04:32:43 INFO - operating with platform_type : mac_ 04:32:43 INFO - Initialising browser for kraken test... 04:32:43 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpOAa41p/profile http://localhost:49246/getInfo.html) 04:32:46 INFO - PID 1653 | 2017-04-24 04:32:46.169 plugin-container[1655:10396] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 04:32:46 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:46 INFO - PID 1653 | 2017-04-24 04:32:46.170 plugin-container[1655:10396] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.CFPasteboardClient' 04:32:46 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:46 INFO - PID 1653 | 2017-04-24 04:32:46.170 plugin-container[1655:10396] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:46 INFO - PID 1653 | __metrics Screen width/height:1600/1200 04:32:46 INFO - PID 1653 | colorDepth:24 04:32:46 INFO - PID 1653 | Browser inner width/height: 1024/689 04:32:46 INFO - PID 1653 | __metrics 04:32:46 ERROR - PID 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 04:32:47 INFO - TEST-INFO | 1653: exit 0 04:32:47 INFO - Browser initialized. 04:32:47 INFO - Running cycle 1/1 for kraken test... 04:32:47 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpOAa41p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:49 INFO - PID 1656 | 2017-04-24 04:32:49.641 plugin-container[1657:10521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954f, name = 'com.apple.tsm.portname' 04:32:49 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:49 INFO - PID 1656 | 2017-04-24 04:32:49.642 plugin-container[1657:10521] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 04:32:49 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:49 INFO - PID 1656 | 2017-04-24 04:32:49.642 plugin-container[1657:10521] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:59 INFO - PID 1656 | RSS: Main: 236912640 04:32:59 INFO - PID 1656 | 04:33:01 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:02 INFO - PID 1656 | RSS: Main: 249401344 04:33:02 INFO - PID 1656 | 04:33:05 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 04:33:06 INFO - PID 1656 | RSS: Main: 257536000 04:33:06 INFO - PID 1656 | 04:33:09 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 04:33:10 INFO - PID 1656 | RSS: Main: 259874816 04:33:10 INFO - PID 1656 | 04:33:12 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 04:33:12 INFO - PID 1656 | RSS: Main: 261165056 04:33:12 INFO - PID 1656 | 04:33:14 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:15 INFO - PID 1656 | RSS: Main: 261509120 04:33:15 INFO - PID 1656 | 04:33:18 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:18 INFO - PID 1656 | RSS: Main: 267137024 04:33:18 INFO - PID 1656 | 04:33:21 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:22 INFO - PID 1656 | RSS: Main: 269058048 04:33:22 INFO - PID 1656 | 04:33:25 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 04:33:26 INFO - PID 1656 | RSS: Main: 269619200 04:33:26 INFO - PID 1656 | 04:33:27 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:28 INFO - PID 1656 | RSS: Main: 269058048 04:33:28 INFO - PID 1656 | 04:33:30 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:30 INFO - PID 1656 | RSS: Main: 269148160 04:33:30 INFO - PID 1656 | 04:33:33 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:33 INFO - PID 1656 | RSS: Main: 268713984 04:33:33 INFO - PID 1656 | 04:33:36 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:37 INFO - PID 1656 | RSS: Main: 269000704 04:33:37 INFO - PID 1656 | 04:33:40 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:41 INFO - PID 1656 | RSS: Main: 269029376 04:33:41 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 04:33:43 INFO - PID 1656 | RSS: Main: 270729216 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | __start_tp_report 04:33:43 INFO - PID 1656 | _x_x_mozilla_page_load 04:33:43 INFO - PID 1656 | _x_x_mozilla_page_load_details 04:33:43 INFO - PID 1656 | |i|pagename|runs| 04:33:43 INFO - PID 1656 | |0;ai-astar;97;116;115;115;114;113;114;115;116;112 04:33:43 INFO - PID 1656 | |1;audio-beat-detection;146;113;128;157;112;111;107;107;143;116 04:33:43 INFO - PID 1656 | |2;audio-dft;201;194;200;204;237;278;199;202;198;197 04:33:43 INFO - PID 1656 | |3;audio-fft;82;87;50;72;50;48;84;86;86;82 04:33:43 INFO - PID 1656 | |4;audio-oscillator;83;70;82;73;71;57;92;102;59;93 04:33:43 INFO - PID 1656 | |5;imaging-gaussian-blur;90;90;89;89;95;89;89;89;98;110 04:33:43 INFO - PID 1656 | |6;imaging-darkroom;101;105;96;98;98;97;147;96;96;97 04:33:43 INFO - PID 1656 | |7;imaging-desaturate;92;91;91;117;83;143;145;99;98;143 04:33:43 INFO - PID 1656 | |8;json-parse-financial;51;51;50;50;52;49;74;76;74;75 04:33:43 INFO - PID 1656 | |9;json-stringify-tinderbox;57;63;62;69;61;59;54;61;57;57 04:33:43 INFO - PID 1656 | |10;stanford-crypto-aes;89;105;101;105;75;104;101;102;107;75 04:33:43 INFO - PID 1656 | |11;stanford-crypto-ccm;160;162;148;133;158;132;150;150;198;136 04:33:43 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;176;223;230;225;181;181;182;235;181;180 04:33:43 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;68;69;69;65;69;68;77;65;68;70 04:33:43 INFO - PID 1656 | __end_tp_report 04:33:43 INFO - PID 1656 | __start_cc_report 04:33:43 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1001 04:33:43 INFO - PID 1656 | __end_cc_report 04:33:43 INFO - PID 1656 | __startTimestamp1493033623260__endTimestamp 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | ------- Summary: start ------- 04:33:43 INFO - PID 1656 | Number of tests: 14 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:112.70 Median:115.00 stddev:5.66 (4.9%) stddev-sans-first:1.33 04:33:43 INFO - PID 1656 | Values: 97.0 116.0 115.0 115.0 114.0 113.0 114.0 115.0 116.0 112.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:122.00 stddev:18.34 (15.0%) stddev-sans-first:17.64 04:33:43 INFO - PID 1656 | Values: 146.0 113.0 128.0 157.0 112.0 111.0 107.0 107.0 143.0 116.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:211.00 Median:201.50 stddev:26.49 (13.1%) stddev-sans-first:27.85 04:33:43 INFO - PID 1656 | Values: 201.0 194.0 200.0 204.0 237.0 278.0 199.0 202.0 198.0 197.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:72.70 Median:83.00 stddev:16.67 (20.1%) stddev-sans-first:17.33 04:33:43 INFO - PID 1656 | Values: 82.0 87.0 50.0 72.0 50.0 48.0 84.0 86.0 86.0 82.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:77.50 stddev:14.82 (19.1%) stddev-sans-first:15.62 04:33:43 INFO - PID 1656 | Values: 83.0 70.0 82.0 73.0 71.0 57.0 92.0 102.0 59.0 93.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:89.50 stddev:6.80 (7.6%) stddev-sans-first:7.13 04:33:43 INFO - PID 1656 | Values: 90.0 90.0 89.0 89.0 95.0 89.0 89.0 89.0 98.0 110.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:96.50 stddev:15.68 (16.2%) stddev-sans-first:16.61 04:33:43 INFO - PID 1656 | Values: 101.0 105.0 96.0 98.0 98.0 97.0 147.0 96.0 96.0 97.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:110.20 Median:91.00 stddev:24.70 (27.1%) stddev-sans-first:25.31 04:33:43 INFO - PID 1656 | Values: 92.0 91.0 91.0 117.0 83.0 143.0 145.0 99.0 98.0 143.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:63.00 stddev:12.56 (19.9%) stddev-sans-first:12.87 04:33:43 INFO - PID 1656 | Values: 51.0 51.0 50.0 50.0 52.0 49.0 74.0 76.0 74.0 75.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:61.00 stddev:4.22 (6.9%) stddev-sans-first:4.33 04:33:43 INFO - PID 1656 | Values: 57.0 63.0 62.0 69.0 61.0 59.0 54.0 61.0 57.0 57.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:96.40 Median:106.00 stddev:12.30 (11.6%) stddev-sans-first:12.76 04:33:43 INFO - PID 1656 | Values: 89.0 105.0 101.0 105.0 75.0 104.0 101.0 102.0 107.0 75.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:154.00 stddev:19.30 (12.5%) stddev-sans-first:20.29 04:33:43 INFO - PID 1656 | Values: 160.0 162.0 148.0 133.0 158.0 132.0 150.0 150.0 198.0 136.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.40 Median:202.50 stddev:25.07 (12.4%) stddev-sans-first:25.12 04:33:43 INFO - PID 1656 | Values: 176.0 223.0 230.0 225.0 181.0 181.0 182.0 235.0 181.0 180.0 04:33:43 INFO - PID 1656 | 04:33:43 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:3.33 (4.8%) stddev-sans-first:3.52 04:33:43 INFO - PID 1656 | Values: 68.0 69.0 69.0 65.0 69.0 68.0 77.0 65.0 68.0 70.0 04:33:43 INFO - PID 1656 | -------- Summary: end -------- 04:33:43 INFO - PID 1656 | 04:33:44 INFO - TEST-INFO | 1656: exit 0 04:33:44 INFO - TEST-OK | kraken | took 60990ms 04:33:44 INFO - SUITE-END | took 1176s 04:33:44 INFO - Completed test suite (00:19:36) 04:33:44 INFO - javascript benchmark 04:33:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7815.362529825736, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.9371612567747, 3599.082234030322, 3606.621304763, 3666.230091680746, 3667.2298817248375, 5077.263796749469, 5369.5167434930845, 5816.243888294526, 6109.2528441424865, 6235.095911092894, 5837.5913686041995, 6096.980278560381, 6241.937580624192, 6264.843378915518, 6323.20959880015, 5415.998040362526, 5442.346918369801, 5452.318460192476, 5486.478784515464, 5524.723763811813, 4851.651427505144, 5191.506806853343, 5484.561235101202, 5548.500634942854, 5637.746301416426, 5357.901630165807, 5396.487333703292, 5429.782808687648, 5505.311836020457, 5534.308211473566, 5466.316710411199, 5475.479829416199, 5478.561715062785, 5516.200150978086, 5549.889002219973, 4243.321068629036, 4944.678595891256, 5348.652337598082, 5455.918161227545, 5457.426970168115, 5494.80768173116, 6137.254412462268, 6142.723577439026, 6215.06773983906, 6228.408301211378, 5995.730192141321, 6418.229812422493, 6734.8316292092595, 6741.292164322725, 6759.019942108367, 6845.828854278633, 6858.211305699859, 6869.690863911136, 6877.071595334616, 6878.518503704692, 6115.090145714991, 6168.0, 6369.235691717024, 6385.297617262097, 6406.967965160145, 5790.942090579125, 6874.243833178346, 6954.0, 6959.095317608679, 6976.197737260179, 6335.334789847, 6378.489720822323, 6570.310117437601, 6589.110470086573, 6638.435732962752, 6699.062131301622, 6738.898916516257, 6814.454843612499, 6828.795136145924, 6831.28271531492, 6467.805965821033, 6503.7073331700185, 6544.574602650812, 6721.529492935448, 6745.966270168716, 5625.774969001276, 6556.049372840911, 6637.6349300788925, 6653.301403352675, 6737.393634572912, 4491.595756381876, 5332.093544097513, 5339.946600534023, 5347.1979203119845, 5381.13901775714, 4759.1671457495495, 4759.976200119047, 4767.308740232646, 4774.7135171889795, 4802.73584952824, 4925.778339974638, 6171.506279497629, 6174.5060395168275, 6311.305756366796, 6327.715252813635, 6839.418649414855, 6853.246142924274, 6859.142607174103, 6868.896966545506, 6900.137482814648, 6277.686115694289, 6278.372162783777, 6347.904781428282, 6354.809355719336, 6399.104125422352, 5747.224124743107, 5820.563457740686, 5977.850553736192, 5981.611195272293, 6004.0, 7059.5058345915295, 7093.964530177523, 7102.857942841218, 7108.0, 7117.644117793986, 6793.388595026471, 6822.658867056726, 6846.110005699227, 6858.965705171442, 6883.724651013903, 6697.631630260383, 6809.353111454404, 6935.514513983972, 6979.511434199558, 7049.753258635923, 6672.966635166793, 6710.228323742636, 6713.932860671331, 6749.493787965824, 6755.93244067553, 6774.356436138559, 6824.488163387667, 6847.62338071391, 6849.1438570178725, 6874.450043996369, 6291.1192433058495, 6381.3937675920715, 6540.0, 6647.60114393138, 6648.667566621746, 6634.137562116894, 6636.27001029896, 6643.169603799525, 6651.667416629246, 6669.699863506057, 5833.79581714638, 5901.29184497863, 6496.187976502937, 6507.414332710079, 6515.902261466176, 6305.747770089329, 6394.744210231539, 6483.384078512534, 6522.739090436329, 6629.569078009914, 6384.968075159594, 6419.518536109717, 6475.255345635123, 6475.287718351072, 6492.285848556749], "value": 6089.916420416828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.4114441008528, 718.4862823081498, 811.655046605193, 1050.3592808386882, 1246.4640204711982, 36774.0, 37765.81117094411, 37924.81037594815, 37963.62036379632, 38048.0, 31882.52176217353, 37930.8103459483, 38197.0, 38476.615233847726, 38523.22953540928, 7850.528968261894, 8016.997875265592, 8347.998240211153, 8554.187352201561, 8593.0, 8397.580120993956, 8445.619947102396, 8485.0666426693, 8486.0665326814, 8504.192101750325, 6462.5153113516435, 8454.196851299148, 8490.0, 8494.277986371166, 8502.957485212597, 8438.535880526568, 8475.915240847575, 8479.2792612628, 8484.36367272457, 8488.236058754741, 8375.41372103953, 8438.113998030241, 8438.36712246584, 8441.324694024463, 8456.8731469028, 37579.24841503154, 37798.055048623726, 37814.865554033146, 37829.0, 37851.0, 3624.6375362463805, 3641.235340578455, 3654.4152935530187, 3655.3054919565197, 3656.177360093984, 31004.37991240185, 31025.0, 31138.532922006187, 31151.532727009115, 31211.37577248442, 3135.3102317490116, 3157.463231250693, 3158.96841031589, 3178.300773829754, 3179.9205019874457, 232167.0, 235336.82331588404, 279044.0, 280671.0, 281110.0, 46095.76952115218, 46560.37038703697, 46686.29970550445, 46860.59418217459, 46977.530224698, 48064.0, 48076.0, 48407.757961209965, 48499.0, 48510.5148948506, 13786.448542058206, 13840.100393474391, 13890.93054534741, 13941.58175254744, 13966.022378433412, 11335.206535542433, 11341.979221870071, 11342.659720208407, 11352.716182095513, 11371.488283027284, 10947.671569852917, 13332.800007999887, 13472.730545389037, 13522.12106213093, 13639.045266831425, 5352.732363381815, 5492.203630473559, 5763.435271304229, 5776.740046697909, 5879.353271140171, 1006.7281833904951, 1025.6358992557684, 1030.3251370352432, 1059.9682009539727, 1068.060107105742, 23248.76751232466, 24197.7580224199, 24241.030358785803, 24366.390840229134, 24514.877425612758, 1083.3608171178885, 1106.8782433932422, 1121.2711737370773, 1139.515705825021, 1148.1503687271359, 12137.812454703113, 12196.298156038283, 12272.276245286728, 12277.288653756425, 12305.323207223688, 306616.0, 308543.0, 308746.0, 309228.0, 309284.0, 43480.78259608745, 53099.73450132802, 53205.2019219712, 53217.20174197313, 53294.73352633289, 1493.9103653780808, 1529.5870115069092, 1531.6170957260686, 1536.8386319436297, 1554.0597938247197, 22575.75833329117, 23170.652440213074, 23284.53430931406, 23477.530449390575, 23800.761992379856, 30178.698213018466, 37902.810485948496, 38258.61741382551, 38296.80851595836, 38345.0, 237474.0, 241597.0, 289265.0, 289484.0, 289495.0, 33497.16257093495, 33689.831550842086, 36085.0, 36617.81691091634, 36681.44977825281, 44762.0, 45146.09707805891, 45312.77343613261, 45360.0, 45441.318380224984, 24388.26835194947, 28761.856190718914, 30926.536101958038, 30927.91752288659, 31277.84361078271, 30671.693283067776, 30723.2319192022, 30954.0, 31054.22364440907, 31059.0, 29512.704872950995, 36523.0, 37192.0, 37611.05972350713, 37631.0, 28187.013454528995, 30138.0, 30545.08364749061, 31287.0, 31558.053258401367, 17797.288108475517, 21915.452113696647, 22740.545189096458, 24115.638265426383, 24639.01443942294], "value": 17216.041370045263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.90169711814826, 438.60087320538304, 442.0143080929527, 450.25707582488894, 460.73507733053503, 20799.68800467994, 21137.15451381945, 21506.032228549713, 21557.46106347342, 21676.132954681812, 17809.910950445228, 21175.894120529414, 21597.67603485945, 21770.673439898415, 22139.778602213973, 5943.13824495449, 6174.073888916676, 6237.095621134933, 6243.937560624404, 6250.312465628777, 5869.354371019184, 6081.087836824468, 6084.239470066242, 6133.785317513888, 6143.631382117065, 5913.497352725023, 6052.152698622196, 6089.725962331706, 6104.877902441948, 6114.991026480626, 5471.972640136813, 5899.557533185007, 6074.301455332649, 6094.786682466137, 6094.96952515239, 5376.946230537684, 5410.97294513525, 5437.075697131497, 5452.6455780374545, 5553.305836770403, 26690.5996410054, 26702.46595068088, 26941.86529067342, 26971.730282697117, 27156.864215678794, 2217.944551386212, 2274.1358283852196, 2286.119843860126, 2288.313505948209, 2290.0725206291477, 14779.482718104922, 17605.29578816846, 17702.91148544249, 18200.998945058018, 18269.63460730778, 2140.058374315296, 2162.232407495348, 2188.037263604025, 2193.605151072806, 2196.6595177747477, 160586.0, 160665.0, 162732.18633906756, 164326.1783691086, 165057.0, 11550.498435203537, 11559.942200288944, 12610.747785044432, 12731.363431828371, 12898.290594017231, 16164.838351616569, 16440.6711865762, 16441.91779041121, 16456.506304810875, 16493.010419374878, 8566.400351975302, 8809.295256379473, 8822.779430514289, 8928.821423571491, 8972.37193396456, 8200.384971127189, 8315.8336833263, 8336.749897503085, 8490.981082270167, 8497.36269779769, 7761.650725717356, 7866.72466463671, 7923.088844782808, 7938.325242354349, 7951.85901568877, 2154.8922553872244, 2169.7721739217473, 2169.934901952944, 2170.251263314154, 2370.2889133260296, 946.2666433514082, 947.8672985781996, 954.5895265035962, 976.3897564022486, 987.9654212102541, 20317.069878361533, 20728.896355518427, 20739.0, 21218.469538261666, 21354.0, 789.0058526256843, 889.3685483306796, 955.2214944819949, 1014.4572653630272, 1019.2050200843354, 9066.773330666787, 10495.947520262502, 10909.563617455371, 10938.289011214245, 10948.084085285043, 554282.0, 556496.0, 570972.0, 573775.0, 576126.0, 116031.41984290193, 116086.0, 124882.0, 127971.1224545924, 128669.0, 1127.1658972360558, 1141.5376772407021, 1170.5785917069848, 1172.7654469106212, 1174.448009435564, 17594.328538788795, 17897.73153402726, 18012.00933948593, 18027.369042083465, 18322.725159122358, 41819.581804181566, 55298.44701553094, 56089.719551401984, 56095.0, 56375.15437268526, 72363.91454128298, 73424.0, 75188.0, 75269.0, 75535.62232188803, 8503.277221436247, 8697.391182617155, 8697.434666746642, 8713.25937295337, 8834.95582522109, 13875.514356997457, 13976.091554048955, 14008.369623366769, 14206.360713768112, 14333.211673358066, 9995.150412215044, 11293.974181489159, 11398.487068081791, 11740.882591173979, 12056.156069075081, 11292.491837867152, 11307.830382544103, 11379.43102844871, 11554.711132221762, 11610.0, 11721.472533735832, 12003.75992480163, 12213.145079844326, 12222.75554488923, 12293.262404255773, 8651.0, 8803.911960880308, 8935.285177185939, 9058.139476749699, 9076.228520575825, 9546.809063818824, 11828.290302581872, 11998.280103193836, 12024.038076953997, 12060.396980151132], "value": 10319.229165939314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.6123571075111, 1345.4954392102961, 1438.5828109848144, 1442.2428225181777, 1445.0823726933395, 11516.942415287922, 11827.231229970068, 12071.818922716166, 12090.274583524995, 12253.877461225407, 9788.0, 11573.13201509888, 11807.586734464296, 11997.880021199786, 12006.099542534323, 2530.0512307884496, 2558.4371438283547, 2560.9103681371157, 2568.3964268396912, 2574.150530324998, 2486.4032632168332, 2525.9621105683427, 2549.146036077916, 2550.0437335999, 2552.374668206283, 2460.2865169100937, 2501.8999240030375, 2528.962065569018, 2555.7699807017366, 2569.087973769313, 2481.553320402327, 2510.0587279769993, 2529.7723204911554, 2538.82228244023, 2539.3397716593636, 2450.1179575352858, 2526.191618682004, 2542.745725427461, 2557.974420255792, 2561.9615705764427, 11687.824682629767, 11688.649340519798, 11778.941105294505, 11783.882161178364, 11820.527178912833, 6644.667766611698, 6760.18877734675, 6859.314068593101, 6860.794176174722, 6886.793396198122, 4015.8996025099314, 4318.935215971763, 4399.428074350314, 4401.2517871961845, 4402.5597440255715, 1239.3493415956605, 1258.2199036597276, 1301.1217428235902, 1306.040060555491, 1308.869113088693, 14642.04826686262, 15143.621409464742, 16674.33302667892, 16815.74776378343, 16837.242324095445, 5039.974800125976, 5719.399463056402, 5809.331926828384, 5958.612690175125, 6013.759449621966, 10455.84316235257, 12396.256224626552, 12410.627681169579, 12492.50029998808, 12513.249205047545, 6636.0, 6690.0, 6708.262091169968, 6719.361660642231, 6726.697298621574, 6018.879622407528, 6250.9062364064575, 6275.058741188858, 6306.968465157736, 6328.6835658216905, 4315.482142142963, 4441.378207051015, 4458.687891847604, 4487.910241795146, 4497.820087196541, 1270.4791035675514, 1301.5184381778613, 1316.2300054468244, 1316.9473221071241, 1322.76982406363, 763.3092051693227, 776.4875182379602, 778.0857492446353, 780.2665494435213, 785.9685612575433, 5187.818426355059, 6253.874922501524, 6320.8419789504715, 6411.134496842867, 6419.390157934989, 571.8941995730803, 572.8399753004275, 600.1477901380051, 602.1299222623268, 609.411917499615, 3760.646167379741, 4258.0, 4394.406755088086, 4444.11117776446, 4479.46246450428, 14579.927100364643, 14864.256787160599, 15061.096334219981, 15397.692046159014, 15406.460773873085, 14730.705385892223, 15094.924525377302, 15276.541703748906, 15340.15629140408, 15428.074315540878, 8405.159484051668, 8563.015253245956, 8654.134586541295, 8716.38985271025, 8736.344774141964, 6968.442524598121, 7116.857662846817, 7152.141742990874, 7227.349538541556, 7274.8908766369605, 13042.673933151747, 13374.598762037154, 13405.396757146147, 13684.794728079285, 13833.584992450242, 11473.82789258145, 13870.861291386957, 14102.435902564193, 14115.22366269865, 14211.715765684421, 9525.857112143462, 9758.072983066597, 9771.169450596779, 9783.266255031043, 9805.166560842123, 10648.361098334124, 10789.460526973777, 10802.243842930919, 10859.945700271448, 10985.560577576807, 9235.861462078208, 9276.907230927603, 9327.953360233156, 9387.10822471864, 9422.199113075465, 8987.505687187268, 9031.50326732036, 9151.771205719644, 9180.127887850644, 9375.296852735935, 8369.581520923808, 8380.287675547646, 8383.706570270011, 8455.30893821226, 8462.365322600706, 6088.786892458743, 6184.81445556634, 6206.0, 6245.156903817927, 6303.275123360689, 6092.543059270483, 6167.290761562298, 6231.2522497300615, 6303.306636270098, 6374.553781235269], "value": 5384.3308900321945, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.175482016686, 409.21635068843176, 411.4178437510922, 421.7069136949819, 421.94092827004204, 5202.32369791927, 6246.500839798449, 6346.841328966778, 6365.777197798078, 6367.9363206367925, 5096.980603879229, 5973.671448070354, 6127.295361033483, 6168.814935551929, 6189.823933452641, 4483.036147228345, 4507.684462087655, 4677.953220467786, 4718.787654555545, 4750.429948406196, 4524.936639889624, 4722.574968252857, 4725.416985309926, 4737.791863074911, 4740.502247264022, 3985.5416627087966, 4127.442795222637, 4637.652176086807, 4651.7441540715245, 4656.767161641905, 3953.7034722395647, 4597.494275629678, 4671.696339737923, 4677.836275730333, 4721.24460086388, 3478.4956181353564, 4158.355454904495, 4168.645665118469, 4179.519355274152, 4182.330827067654, 4692.6245900327895, 4742.383490146293, 4846.5880400166025, 6021.548383871227, 6084.695765211722, 5178.14560597501, 5507.531859791922, 5584.0, 5588.804391846306, 5633.718314084279, 5787.672088549059, 6327.778527751507, 6347.714352854086, 6584.5061620378665, 6621.73513059477, 4706.505816889212, 4719.764011799396, 4720.0, 4730.479647238801, 4755.619550435957, 5746.367899531048, 6076.848078798022, 6385.5210859185745, 6842.521023528355, 6961.23426423093, 4190.072566619389, 4296.656267498593, 4306.966328081238, 4463.799129039201, 4537.8411755588395, 4081.673466122703, 4082.081311862033, 4580.106879158532, 4607.00949295903, 4649.302604609268, 4169.374593810892, 4678.695884767547, 4730.17888113079, 5356.035913535601, 5395.325584301962, 6600.372964568358, 6626.768063117865, 6634.900476492857, 6671.532262902154, 6675.0, 1563.6872625474723, 1574.7795308656798, 1575.2360105348896, 1576.7556028815552, 1577.0695289779085, 843.6836186430089, 922.9907700923039, 1020.78563501664, 1039.365986748083, 1048.7745134796055, 5276.34045744282, 5519.558435325164, 6265.715528316684, 6284.874302513924, 6296.874062518724, 6038.818835434944, 6323.936760632335, 6626.271110177877, 6874.0, 6888.207856096613, 5287.709175995357, 5642.855714828339, 5739.852029594098, 6260.248770147611, 6283.403076707706, 3380.560527131457, 3612.6567976042234, 3616.8010759407957, 3623.58328792187, 3646.635336466385, 6295.559310848288, 6794.694238759268, 7125.394341480928, 7159.498835081495, 7172.426205903515, 7071.363577277967, 7074.893876591856, 7118.86769821277, 7124.251953544906, 7151.928480715231, 6104.901117798839, 6780.694868730919, 6978.720851165896, 7182.533135346186, 7194.625773494734, 5494.7802087917635, 5853.8048231913035, 6920.4809639276245, 6961.860762784817, 6966.616836074065, 6346.143270658402, 6445.5165862561435, 6822.522423430312, 6830.658467076726, 6859.691313890987, 5698.943010569841, 7011.0, 7137.750178743719, 7166.319199676022, 7252.818679533054, 3919.5884432134217, 4000.7599544027453, 4111.938320925248, 4483.775811209362, 4539.977300113478, 5845.444682755132, 6124.763327355226, 6937.583744975116, 6972.930270697431, 7095.716171353088, 6691.59850408977, 6698.83252918681, 6727.125473688585, 6733.865322693421, 6754.223264324665, 6445.516586255956, 6677.465802735866, 6705.295943926013, 6716.865662686817, 6743.819831529365, 5140.46025167352, 5239.842804715865, 6142.40669208518, 6469.061986012096, 6507.7722279721875, 5901.3213480448585, 6175.722092505758, 6735.158105236846, 6746.224184218878, 6785.762498312535, 5203.349581302337, 6168.228971378578, 6480.481561475165, 6486.599958015565, 6514.869702606016], "value": 4796.053550758206, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.5316316536409, 850.8425941200877, 855.589317127779, 875.9357380782349, 888.355941942092, 13898.93050534747, 14554.27228638569, 16522.75215871763, 18175.363862264825, 18818.15318310676, 14772.852271477283, 16511.256993435294, 17563.5609109772, 17928.64142717145, 17963.550911227227, 792.7185849023572, 824.7443292579289, 962.0475729028246, 973.6981535723913, 975.0298453039236, 982.641335912394, 983.6557204978236, 985.8816941966938, 986.1863962231153, 986.4180133721103, 1010.1817527802503, 1028.059325716968, 1029.4646783672524, 1030.0111892583093, 1030.7062487191151, 1012.8430093335545, 1023.5803320638539, 1026.296986564206, 1026.3687831983352, 1028.598846449885, 638.7863060185638, 659.7624855052177, 688.9517733758639, 743.0080842075836, 746.5073051785795, 16326.510204693877, 16691.41580044705, 16871.409500667418, 16872.493825185265, 16894.662106757794, 16705.164741762987, 16790.58023549409, 16837.410690625893, 16933.3226670933, 17205.139743012798, 13749.31253437324, 13967.231802250872, 14095.295235238196, 14098.718025639533, 14105.506307279196, 3529.4176460883923, 3548.27260411615, 3568.3041806847673, 3575.570931488212, 3592.568891733009, 135150.97273540904, 135760.32119839438, 136385.0, 137473.0, 139201.3039934804, 12525.0, 12595.748085038247, 12646.114771965875, 12798.808017879739, 12806.743865122646, 23697.7630223699, 24209.273721788373, 24405.145819896217, 24910.750892490843, 25419.983200672137, 7560.319571238615, 7604.429667774828, 7646.3118319350415, 7733.110692270348, 7757.146713861471, 3884.2037382336553, 3938.5076865391825, 3954.6440820326306, 3960.386140148282, 3965.988672888395, 4342.08816148606, 4397.802098905557, 4427.645788336926, 4446.177457170369, 4460.241758900995, 890.9486805569491, 941.6863475451706, 956.8134213828375, 964.8793900762405, 966.2270183852889, 585.5842351930092, 624.7719582352408, 627.4854619212202, 638.9616872582054, 664.6909187227963, 10997.945010274898, 11264.211505194558, 11872.10959178065, 11974.58088966882, 12107.818382724266, 533.2534451767557, 637.8883695353295, 661.1471202149173, 678.4775722693498, 684.1414025398094, 5308.734563271821, 5315.160820754174, 5358.33020872391, 5399.946000540023, 5469.480399362054, 104599.0, 104973.47513262538, 105461.47269263605, 105958.47020764847, 107977.38033929498, 82952.58523707344, 92311.0, 93869.53065234631, 94274.05725942652, 95203.0, 57650.13524797215, 76938.61530692311, 78975.23586674439, 79676.0, 82209.0, 9261.814763704822, 10472.266941314036, 10614.8407773885, 11133.276337038067, 12523.93738031304, 32186.678133218367, 40316.0, 40448.1910361797, 40455.79772101121, 41137.38293925534, 42115.578844211166, 54090.18864716954, 54103.0, 54145.0, 54793.0, 13142.60572182836, 15928.773615303842, 15966.840331596535, 16000.359985600446, 16198.676026479168, 14616.196109214095, 14831.0, 14839.777403339174, 14966.251687415368, 14975.550733478012, 16025.519234422985, 16372.263248153624, 16421.507354779376, 16490.75263871019, 16621.252043657823, 15936.681266374375, 15999.040057596581, 16098.195090245206, 16186.433474828795, 16270.755938661167, 15916.522504324888, 16066.0, 16172.595685107966, 16189.190540473164, 16250.9436886602, 11269.267497612629, 11400.714982125513, 11709.180357374902, 11789.764204715686, 11867.76264474723, 11902.702432439259, 11917.82123268169, 12368.257904525397, 12404.131710780159, 12473.064520160842], "value": 8155.62885119528, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 116.0, 115.0, 115.0, 114.0, 113.0, 114.0, 115.0, 116.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 128.0, 157.0, 112.0, 111.0, 107.0, 107.0, 143.0, 116.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 194.0, 200.0, 204.0, 237.0, 278.0, 199.0, 202.0, 198.0, 197.0], "value": 211.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 50.0, 72.0, 50.0, 48.0, 84.0, 86.0, 86.0, 82.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 82.0, 73.0, 71.0, 57.0, 92.0, 102.0, 59.0, 93.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 89.0, 95.0, 89.0, 89.0, 89.0, 98.0, 110.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 105.0, 96.0, 98.0, 98.0, 97.0, 147.0, 96.0, 96.0, 97.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 117.0, 83.0, 143.0, 145.0, 99.0, 98.0, 143.0], "value": 110.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 52.0, 49.0, 74.0, 76.0, 74.0, 75.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 62.0, 69.0, 61.0, 59.0, 54.0, 61.0, 57.0, 57.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 105.0, 101.0, 105.0, 75.0, 104.0, 101.0, 102.0, 107.0, 75.0], "value": 96.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 148.0, 133.0, 158.0, 132.0, 150.0, 150.0, 198.0, 136.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 223.0, 230.0, 225.0, 181.0, 181.0, 182.0, 235.0, 181.0, 180.0], "value": 199.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 65.0, 69.0, 68.0, 77.0, 65.0, 68.0, 70.0], "value": 68.8, "unit": "score"}]}]} 04:33:44 INFO - Return code: 0 04:33:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:44 ERROR - # TBPL SUCCESS # 04:33:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:44 INFO - 2017-04-24 04:33:44.585 screenresolution[1661:10921] starting screenresolution argv=screenresolution get 04:33:44 INFO - 2017-04-24 04:33:44.588 screenresolution[1661:10921] Display 0: 1600x1200x32@60 04:33:44 INFO - 2017-04-24 04:33:44.594 screenresolution[1662:10924] starting screenresolution argv=screenresolution list 04:33:44 INFO - Available Modes on Display 0 04:33:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:44 INFO - Intel Iris: 04:33:44 INFO - Chipset Model: Intel Iris 04:33:44 INFO - Type: GPU 04:33:44 INFO - Bus: Built-In 04:33:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:44 INFO - Vendor: Intel (0x8086) 04:33:44 INFO - Device ID: 0x0a2e 04:33:44 INFO - Revision ID: 0x0009 04:33:44 INFO - Displays: 04:33:44 INFO - Display: 04:33:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:44 INFO - Display Serial Number: 1600x1200 60 04:33:44 INFO - Main Display: Yes 04:33:44 INFO - Mirror: Off 04:33:44 INFO - Online: Yes 04:33:44 INFO - Rotation: Supported 04:33:44 INFO - Return code: 0 04:33:44 INFO - Running post-action listener: _resource_record_post_action 04:33:44 INFO - [mozharness: 2017-04-24 11:33:44.845835Z] Finished run-tests step (success) 04:33:44 INFO - Running post-run listener: _resource_record_post_run 04:33:44 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 44689408; Write bytes: 511157760; Read time: 458; Write time: 1643 04:33:44 INFO - TinderboxPrint: CPU usage
54.3% 04:33:44 INFO - TinderboxPrint: I/O read bytes / time
44,689,408 / 458 04:33:44 INFO - TinderboxPrint: I/O write bytes / time
511,157,760 / 1,643 04:33:44 INFO - TinderboxPrint: CPU idle
2,190.9 (45.7%) 04:33:44 INFO - TinderboxPrint: CPU system
969.2 (20.2%) 04:33:44 INFO - TinderboxPrint: CPU user
1,629.6 (34.0%) 04:33:44 INFO - TinderboxPrint: Swap in / out
249,282,560 / 0 04:33:44 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204020224; Write bytes: 204711424; Read time: 15725; Write time: 410 04:33:44 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 42633216; Write bytes: 299671552; Read time: 432; Write time: 1206 04:33:45 INFO - Running post-run listener: _upload_blobber_files 04:33:45 INFO - Blob upload gear active. 04:33:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:45 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 04:33:45 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'] 04:33:45 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 04:33:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:33:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:33:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:46 INFO - (blobuploader) - INFO - Done attempting. 04:33:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:33:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:33:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:47 INFO - (blobuploader) - INFO - Done attempting. 04:33:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:33:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:49 INFO - (blobuploader) - INFO - Done attempting. 04:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:51 INFO - (blobuploader) - INFO - Done attempting. 04:33:51 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:51 INFO - Return code: 0 04:33:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60dbe739314c09099520511904c65cf5e69deb99f135383bd80a4a2376623d553324d424a4aaff54ac9315df8850af49f50f615a573a87f6a7ffd284febc73c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670a936cb122f5afdcfc46b04e0662b3a27681d7cf9a9341616346b3ffadf55bdd9f72937fed79f8ef5e30598295bc3d381134e8c4bb3308c1df09041914e298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a2db8a48146d2520e7312387af949d2dfe83c92502878abb86ccc11585ccc2161825626ca15efd660b87fff4f2a630375657aaccfbd01667d7731c73d2bef3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9280269e0d4cd6846b2aa50730d8a9838aaafd4812760f59cbc8bd2d5a69870f681f94b267782b6a5fd2415f1332411c66871ddf89093d9df1f50a6b643ea241"} 04:33:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:51 INFO - Contents: 04:33:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60dbe739314c09099520511904c65cf5e69deb99f135383bd80a4a2376623d553324d424a4aaff54ac9315df8850af49f50f615a573a87f6a7ffd284febc73c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670a936cb122f5afdcfc46b04e0662b3a27681d7cf9a9341616346b3ffadf55bdd9f72937fed79f8ef5e30598295bc3d381134e8c4bb3308c1df09041914e298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a2db8a48146d2520e7312387af949d2dfe83c92502878abb86ccc11585ccc2161825626ca15efd660b87fff4f2a630375657aaccfbd01667d7731c73d2bef3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9280269e0d4cd6846b2aa50730d8a9838aaafd4812760f59cbc8bd2d5a69870f681f94b267782b6a5fd2415f1332411c66871ddf89093d9df1f50a6b643ea241"} 04:33:51 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:51 INFO - Copying logs to upload dir... 04:33:51 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.881565 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-24 04:33:51.345447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:51.349438) ========= 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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60dbe739314c09099520511904c65cf5e69deb99f135383bd80a4a2376623d553324d424a4aaff54ac9315df8850af49f50f615a573a87f6a7ffd284febc73c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670a936cb122f5afdcfc46b04e0662b3a27681d7cf9a9341616346b3ffadf55bdd9f72937fed79f8ef5e30598295bc3d381134e8c4bb3308c1df09041914e298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a2db8a48146d2520e7312387af949d2dfe83c92502878abb86ccc11585ccc2161825626ca15efd660b87fff4f2a630375657aaccfbd01667d7731c73d2bef3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9280269e0d4cd6846b2aa50730d8a9838aaafd4812760f59cbc8bd2d5a69870f681f94b267782b6a5fd2415f1332411c66871ddf89093d9df1f50a6b643ea241"} build_url:https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60dbe739314c09099520511904c65cf5e69deb99f135383bd80a4a2376623d553324d424a4aaff54ac9315df8850af49f50f615a573a87f6a7ffd284febc73c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/670a936cb122f5afdcfc46b04e0662b3a27681d7cf9a9341616346b3ffadf55bdd9f72937fed79f8ef5e30598295bc3d381134e8c4bb3308c1df09041914e298", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6a2db8a48146d2520e7312387af949d2dfe83c92502878abb86ccc11585ccc2161825626ca15efd660b87fff4f2a630375657aaccfbd01667d7731c73d2bef3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9280269e0d4cd6846b2aa50730d8a9838aaafd4812760f59cbc8bd2d5a69870f681f94b267782b6a5fd2415f1332411c66871ddf89093d9df1f50a6b643ea241"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:51.409957) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:51.410387) ========= 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.HpmunIgAsq/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.gfxOH4Xwiu/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005227 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:51.462785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 04:33:51.463132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 04:33:51.463462) ========= ========= Total master_lag: 0.63 =========