builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1484279139.81 results: success (0) buildid: 20170112171016 builduid: 31378b68920747828e93725e8ffa0c65 revision: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.806942) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.807487) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.807814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.833254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.833700) ========= 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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-12 19:45:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 149M=0s 2017-01-12 19:45:39 (149 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.979727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:39.980254) ========= 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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.021463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:40.029596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 19:45:40.030005) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gJxFTwMxnP/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.VrNpYxDDYj/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-12 19:45:40,106 truncating revision to first 12 chars 2017-01-12 19:45:40,107 Setting DEBUG logging. 2017-01-12 19:45:40,107 attempt 1/10 2017-01-12 19:45:40,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1e322cd9c741?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 19:45:41,871 unpacking tar archive at: mozilla-aurora-1e322cd9c741/testing/mozharness/ program finished with exit code 0 elapsedTime=2.011222 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-12 19:45:42.066427) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:42.066877) ========= script_repo_revision: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:42.067376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:42.067784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 19:45:42.088064) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-12 19:45:42.088674) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gJxFTwMxnP/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.VrNpYxDDYj/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:45:42 INFO - MultiFileLogger online at 20170112 19:45:42 in /builds/slave/test 19:45:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:45:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:45:42 INFO - {'append_to_log': False, 19:45:42 INFO - 'base_work_dir': '/builds/slave/test', 19:45:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:45:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:45:42 INFO - 'branch': 'Mozilla-Aurora', 19:45:42 INFO - 'buildbot_json_path': 'buildprops.json', 19:45:42 INFO - 'config_files': ('talos/mac_config.py',), 19:45:42 INFO - 'default_actions': ('clobber', 19:45:42 INFO - 'read-buildbot-config', 19:45:42 INFO - 'download-and-extract', 19:45:42 INFO - 'populate-webroot', 19:45:42 INFO - 'create-virtualenv', 19:45:42 INFO - 'install', 19:45:42 INFO - 'run-tests'), 19:45:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:45:42 INFO - 'download_minidump_stackwalk': True, 19:45:42 INFO - 'download_symbols': 'ondemand', 19:45:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:45:42 INFO - 'tooltool.py': '/tools/tooltool.py', 19:45:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:45:42 INFO - '/tools/misc-python/virtualenv.py')}, 19:45:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:45:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:45:42 INFO - 'installer_path': 'installer.exe', 19:45:42 INFO - 'log_level': 'info', 19:45:42 INFO - 'log_name': 'talos', 19:45:42 INFO - 'log_to_console': True, 19:45:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:45:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:45:42 INFO - 'opt_config_files': (), 19:45:42 INFO - 'pip_index': False, 19:45:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:45:42 INFO - 'cmd': ('bash', 19:45:42 INFO - '-c', 19:45:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:45:42 INFO - 'enabled': True, 19:45:42 INFO - 'halt_on_failure': False, 19:45:42 INFO - 'name': 'check_screen_resolution'},), 19:45:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:45:42 INFO - 'cmd': ('bash', 19:45:42 INFO - '-c', 19:45:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:45:42 INFO - 'enabled': True, 19:45:42 INFO - 'halt_on_failure': False, 19:45:42 INFO - 'name': 'check_screen_resolution'},), 19:45:42 INFO - 'run_cmd_checks_enabled': True, 19:45:42 INFO - 'sps_profile': False, 19:45:42 INFO - 'sps_profile_interval': 0, 19:45:42 INFO - 'suite': 'dromaeojs', 19:45:42 INFO - 'system_bits': '32', 19:45:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:45:42 INFO - 'title': 't-yosemite-r7-0001', 19:45:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:45:42 INFO - 'use_talos_json': True, 19:45:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:45:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:45:42 INFO - 'work_dir': 'build'} 19:45:42 INFO - [mozharness: 2017-01-13 03:45:42.290308Z] Running clobber step. 19:45:42 INFO - Running pre-action listener: _resource_record_pre_action 19:45:42 INFO - Running main action method: clobber 19:45:42 INFO - rmtree: /builds/slave/test/build 19:45:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:45:43 INFO - Running post-action listener: _resource_record_post_action 19:45:43 INFO - [mozharness: 2017-01-13 03:45:43.911657Z] Finished clobber step (success) 19:45:43 INFO - [mozharness: 2017-01-13 03:45:43.911854Z] Running read-buildbot-config step. 19:45:43 INFO - Running pre-action listener: _resource_record_pre_action 19:45:43 INFO - Running main action method: read_buildbot_config 19:45:43 INFO - Using buildbot properties: 19:45:43 INFO - { 19:45:43 INFO - "project": "", 19:45:43 INFO - "product": "firefox", 19:45:43 INFO - "script_repo_revision": "production", 19:45:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 19:45:43 INFO - "repository": "", 19:45:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 19:45:43 INFO - "buildid": "20170112171016", 19:45:43 INFO - "pgo_build": "False", 19:45:43 INFO - "basedir": "/builds/slave/test", 19:45:43 INFO - "buildnumber": 73, 19:45:43 INFO - "slavename": "t-yosemite-r7-0001", 19:45:43 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:45:43 INFO - "platform": "yosemite_r7", 19:45:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:45:43 INFO - "branch": "mozilla-aurora", 19:45:43 INFO - "repo_path": "releases/mozilla-aurora", 19:45:43 INFO - "revision": "1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6", 19:45:43 INFO - "stage_platform": "macosx64", 19:45:43 INFO - "builduid": "31378b68920747828e93725e8ffa0c65", 19:45:43 INFO - "slavebuilddir": "test" 19:45:43 INFO - } 19:45:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 19:45:43 INFO - Running post-action listener: _resource_record_post_action 19:45:43 INFO - [mozharness: 2017-01-13 03:45:43.915233Z] Finished read-buildbot-config step (success) 19:45:43 INFO - [mozharness: 2017-01-13 03:45:43.915350Z] Running download-and-extract step. 19:45:43 INFO - Running pre-action listener: _resource_record_pre_action 19:45:43 INFO - Running main action method: download_and_extract 19:45:43 INFO - mkdir: /builds/slave/test/build/tests 19:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:43 INFO - trying https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 19:45:43 INFO - Downloading https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 19:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 19:45:45 INFO - Downloaded 1199 bytes. 19:45:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 19:45:45 INFO - Using the following test package requirements: 19:45:45 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 19:45:45 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 19:45:45 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 19:45:45 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'jsshell-mac.zip'], 19:45:45 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 19:45:45 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 19:45:45 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 19:45:45 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 19:45:45 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 19:45:45 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 19:45:45 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 19:45:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:45:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 19:45:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:45:45 INFO - Fetch https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 19:45:45 INFO - Http code: 200 19:45:45 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 19:45:45 INFO - x-amz-cf-id: qoH-PsziuRUxYjunwUZ_4OsdQtbd8iFx53uAIrU0eSk0Hg0akP5xig== 19:45:45 INFO - x-amz-version-id: 5SQRtfkzxjWQbeSI8hKYsmYHV0wMogT9 19:45:46 INFO - Expected file size: 16275781 19:45:46 INFO - Obtained file size: 16275781 19:45:52 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 19:45:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 19:45:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:45:52 INFO - Fetch https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 19:45:53 INFO - Http code: 200 19:45:53 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 19:45:53 INFO - x-amz-cf-id: Gtozxmwohpq01UdhMKSqbNl6IEnykBpepwXIXwu6yN4wB4zZl4sQ3Q== 19:45:53 INFO - x-amz-version-id: 5SQRtfkzxjWQbeSI8hKYsmYHV0wMogT9 19:45:53 INFO - Expected file size: 16275781 19:45:53 INFO - Obtained file size: 16275781 19:45:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 19:45:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:45:59 INFO - Fetch https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 19:46:00 INFO - Http code: 200 19:46:00 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 19:46:00 INFO - x-amz-cf-id: Z1SntHkZ8FaDl8Q7RPlkSIo1wgdT1-qYYbbY9Fm71lf3yOl_ItQAIQ== 19:46:00 INFO - x-amz-version-id: JyGEhEHfUhOLifRmKh.nEV2wLnb_v9Cx 19:46:00 INFO - Expected file size: 14409038 19:46:00 INFO - Obtained file size: 14409038 19:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:01 INFO - trying https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 19:46:01 INFO - Downloading https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 19:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 19:46:04 INFO - Downloaded 110000672 bytes. 19:46:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 19:46:04 INFO - mkdir: /builds/slave/test/properties 19:46:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:46:04 INFO - Writing to file /builds/slave/test/properties/build_url 19:46:04 INFO - Contents: 19:46:04 INFO - build_url:https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 19:46:05 INFO - Running post-action listener: _resource_record_post_action 19:46:05 INFO - Running post-action listener: set_extra_try_arguments 19:46:05 INFO - [mozharness: 2017-01-13 03:46:05.084109Z] Finished download-and-extract step (success) 19:46:05 INFO - [mozharness: 2017-01-13 03:46:05.084251Z] Running populate-webroot step. 19:46:05 INFO - Running pre-action listener: _resource_record_pre_action 19:46:05 INFO - Running main action method: populate_webroot 19:46:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:05 INFO - '--tppagecycles', 19:46:05 INFO - '7'], 19:46:05 INFO - 'tests': ['tsvgm']}}, 19:46:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:46:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:46:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:46:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['damp', 'tps']}, 19:46:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'tests': ['damp', 'tps']}, 19:46:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['dromaeo_dom']}, 19:46:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['basic_compositor_video']}, 19:46:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:46:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['a11yr', 19:46:05 INFO - 'ts_paint', 19:46:05 INFO - 'tpaint', 19:46:05 INFO - 'sessionrestore', 19:46:05 INFO - 'sessionrestore_no_auto_restore', 19:46:05 INFO - 'tabpaint']}, 19:46:05 INFO - 'other-e10s': {'tests': ['a11yr', 19:46:05 INFO - 'ts_paint', 19:46:05 INFO - 'tpaint', 19:46:05 INFO - 'sessionrestore', 19:46:05 INFO - 'sessionrestore_no_auto_restore', 19:46:05 INFO - 'tabpaint']}, 19:46:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:46:05 INFO - 'ts_paint', 19:46:05 INFO - 'tpaint', 19:46:05 INFO - 'sessionrestore', 19:46:05 INFO - 'sessionrestore_no_auto_restore', 19:46:05 INFO - 'tabpaint']}, 19:46:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:46:05 INFO - 'ts_paint', 19:46:05 INFO - 'tpaint', 19:46:05 INFO - 'sessionrestore', 19:46:05 INFO - 'sessionrestore_no_auto_restore', 19:46:05 INFO - 'tabpaint']}, 19:46:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['a11yr', 19:46:05 INFO - 'ts_paint', 19:46:05 INFO - 'tpaint', 19:46:05 INFO - 'sessionrestore', 19:46:05 INFO - 'sessionrestore_no_auto_restore', 19:46:05 INFO - 'tabpaint']}, 19:46:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['a11yr', 19:46:05 INFO - 'ts_paint', 19:46:05 INFO - 'tpaint', 19:46:05 INFO - 'sessionrestore', 19:46:05 INFO - 'sessionrestore_no_auto_restore', 19:46:05 INFO - 'tabpaint']}, 19:46:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['tsvgx', 19:46:05 INFO - 'tsvgr_opacity', 19:46:05 INFO - 'tart', 19:46:05 INFO - 'tscrollx', 19:46:05 INFO - 'cart']}, 19:46:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:46:05 INFO - 'tsvgr_opacity', 19:46:05 INFO - 'tart', 19:46:05 INFO - 'tscrollx', 19:46:05 INFO - 'cart']}, 19:46:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'talos_options': ['--disable-e10s'], 19:46:05 INFO - 'tests': ['tp5o']}, 19:46:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'tests': ['tp5o']}, 19:46:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'talos_options': ['--disable-e10s', 19:46:05 INFO - '--xperf_path', 19:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:05 INFO - 'tests': ['tp5n']}, 19:46:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:05 INFO - 'talos_options': ['--xperf_path', 19:46:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:05 INFO - 'tests': ['tp5n']}}, 19:46:05 INFO - 'talos.zip': {'path': '', 19:46:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:05 INFO - Running post-action listener: _resource_record_post_action 19:46:05 INFO - [mozharness: 2017-01-13 03:46:05.103104Z] Finished populate-webroot step (success) 19:46:05 INFO - [mozharness: 2017-01-13 03:46:05.103234Z] Running create-virtualenv step. 19:46:05 INFO - Running pre-action listener: _resource_record_pre_action 19:46:05 INFO - Running main action method: create_virtualenv 19:46:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:46:05 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 19:46:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:46:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:05 INFO - Using real prefix '/tools/python27' 19:46:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:46:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:08 INFO - Installing pip.................done. 19:46:08 INFO - Return code: 0 19:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:46:09 INFO - Reading from file tmpfile_stdout 19:46:09 INFO - Output received: 19:46:09 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) 19:46:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:46:09 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')]} 19:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:09 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')]} 19:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:09 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:09 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 19:46:09 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 19:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:09 INFO - 'HOME': '/Users/cltbld', 19:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:09 INFO - 'LOGNAME': 'cltbld', 19:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:09 INFO - 'MOZ_NO_REMOTE': '1', 19:46:09 INFO - 'NO_EM_RESTART': '1', 19:46:09 INFO - 'PAGER': '/bin/cat', 19:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:09 INFO - 'PWD': '/builds/slave/test', 19:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:09 INFO - 'SHELL': '/bin/bash', 19:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:09 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:09 INFO - 'USER': 'cltbld', 19:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:09 INFO - 'XPC_FLAGS': '0x0', 19:46:09 INFO - 'XPC_SERVICE_NAME': '0', 19:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:09 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 19:46:09 INFO - Cleaning up... 19:46:09 INFO - Return code: 0 19:46:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:46:09 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')]} 19:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:09 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')]} 19:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:09 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:09 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 19:46:09 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 19:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:09 INFO - 'HOME': '/Users/cltbld', 19:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:09 INFO - 'LOGNAME': 'cltbld', 19:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:09 INFO - 'MOZ_NO_REMOTE': '1', 19:46:09 INFO - 'NO_EM_RESTART': '1', 19:46:09 INFO - 'PAGER': '/bin/cat', 19:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:09 INFO - 'PWD': '/builds/slave/test', 19:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:09 INFO - 'SHELL': '/bin/bash', 19:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:09 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:09 INFO - 'USER': 'cltbld', 19:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:09 INFO - 'XPC_FLAGS': '0x0', 19:46:09 INFO - 'XPC_SERVICE_NAME': '0', 19:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:09 INFO - Downloading/unpacking psutil>=3.1.1 19:46:09 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 19:46:09 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 19:46:09 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 19:46:09 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 19:46:09 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 19:46:09 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 19:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:13 INFO - Installing collected packages: psutil 19:46:13 INFO - Running setup.py install for psutil 19:46:13 INFO - building 'psutil._psutil_osx' extension 19:46:13 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 19:46:13 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 19:46:13 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 19:46:13 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 19:46:13 INFO - building 'psutil._psutil_posix' extension 19:46:13 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 19:46:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:46:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:46:13 INFO - ^ 19:46:13 INFO - 1 warning generated. 19:46:13 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 19:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:13 INFO - Successfully installed psutil 19:46:13 INFO - Cleaning up... 19:46:14 INFO - Return code: 0 19:46:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:46:14 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')]} 19:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:14 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')]} 19:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:14 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:14 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 19:46:14 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 19:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:14 INFO - 'HOME': '/Users/cltbld', 19:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:14 INFO - 'LOGNAME': 'cltbld', 19:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:14 INFO - 'MOZ_NO_REMOTE': '1', 19:46:14 INFO - 'NO_EM_RESTART': '1', 19:46:14 INFO - 'PAGER': '/bin/cat', 19:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:14 INFO - 'PWD': '/builds/slave/test', 19:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:14 INFO - 'SHELL': '/bin/bash', 19:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:14 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:14 INFO - 'USER': 'cltbld', 19:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:14 INFO - 'XPC_FLAGS': '0x0', 19:46:14 INFO - 'XPC_SERVICE_NAME': '0', 19:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:46:14 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 19:46:14 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 19:46:14 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 19:46:14 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 19:46:14 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 19:46:14 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 19:46:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:46:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:46:17 INFO - Installing collected packages: mozsystemmonitor 19:46:17 INFO - Running setup.py install for mozsystemmonitor 19:46:17 INFO - Successfully installed mozsystemmonitor 19:46:17 INFO - Cleaning up... 19:46:17 INFO - Return code: 0 19:46:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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', '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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:46: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 jsonschema==2.5.1 19:46:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:17 INFO - 'HOME': '/Users/cltbld', 19:46:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:17 INFO - 'LOGNAME': 'cltbld', 19:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:17 INFO - 'MOZ_NO_REMOTE': '1', 19:46:17 INFO - 'NO_EM_RESTART': '1', 19:46:17 INFO - 'PAGER': '/bin/cat', 19:46:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:17 INFO - 'PWD': '/builds/slave/test', 19:46:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:17 INFO - 'SHELL': '/bin/bash', 19:46:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:17 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:17 INFO - 'USER': 'cltbld', 19:46:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:17 INFO - 'XPC_FLAGS': '0x0', 19:46:17 INFO - 'XPC_SERVICE_NAME': '0', 19:46:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:17 INFO - Downloading/unpacking jsonschema==2.5.1 19:46:17 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 19:46:17 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 19:46:17 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 19:46:17 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 19:46:17 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 19:46:17 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 19:46:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:46:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:46:20 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 19:46:20 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 19:46:20 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 19:46:20 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 19:46:20 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 19:46:20 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 19:46:20 INFO - Downloading functools32-3.2.3-2.tar.gz 19:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:46:20 INFO - warning: no files found matching '*.txt' 19:46:20 INFO - no previously-included directories found matching 'build' 19:46:20 INFO - no previously-included directories found matching 'dist' 19:46:20 INFO - no previously-included directories found matching '.git*' 19:46:20 INFO - Installing collected packages: jsonschema, functools32 19:46:20 INFO - Running setup.py install for functools32 19:46:20 INFO - warning: no files found matching '*.txt' 19:46:20 INFO - no previously-included directories found matching 'build' 19:46:20 INFO - no previously-included directories found matching 'dist' 19:46:20 INFO - no previously-included directories found matching '.git*' 19:46:20 INFO - Successfully installed jsonschema functools32 19:46:20 INFO - Cleaning up... 19:46:20 INFO - Return code: 0 19:46:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:46:20 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')]} 19:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:20 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')]} 19:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:20 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:20 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 19:46:20 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 19:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:20 INFO - 'HOME': '/Users/cltbld', 19:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:20 INFO - 'LOGNAME': 'cltbld', 19:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:20 INFO - 'MOZ_NO_REMOTE': '1', 19:46:20 INFO - 'NO_EM_RESTART': '1', 19:46:20 INFO - 'PAGER': '/bin/cat', 19:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:20 INFO - 'PWD': '/builds/slave/test', 19:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:20 INFO - 'SHELL': '/bin/bash', 19:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:20 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:20 INFO - 'USER': 'cltbld', 19:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:20 INFO - 'XPC_FLAGS': '0x0', 19:46:20 INFO - 'XPC_SERVICE_NAME': '0', 19:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:46:21 INFO - Cleaning up... 19:46:21 INFO - Return code: 0 19:46:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:46:21 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')]} 19:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:21 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')]} 19:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:21 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:21 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 19:46:21 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 19:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:21 INFO - 'HOME': '/Users/cltbld', 19:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:21 INFO - 'LOGNAME': 'cltbld', 19:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:21 INFO - 'MOZ_NO_REMOTE': '1', 19:46:21 INFO - 'NO_EM_RESTART': '1', 19:46:21 INFO - 'PAGER': '/bin/cat', 19:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:21 INFO - 'PWD': '/builds/slave/test', 19:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:21 INFO - 'SHELL': '/bin/bash', 19:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:21 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:21 INFO - 'USER': 'cltbld', 19:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:21 INFO - 'XPC_FLAGS': '0x0', 19:46:21 INFO - 'XPC_SERVICE_NAME': '0', 19:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:21 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 19:46:21 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 19:46:21 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 19:46:21 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 19:46:21 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 19:46:21 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 19:46:24 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:46:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:25 INFO - Downloading docopt-0.6.1.tar.gz 19:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:25 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:25 INFO - Running setup.py install for blobuploader 19:46:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:46:25 INFO - Running setup.py install for requests 19:46:26 INFO - Running setup.py install for docopt 19:46:26 INFO - Successfully installed blobuploader requests docopt 19:46:26 INFO - Cleaning up... 19:46:26 INFO - Return code: 0 19:46:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:26 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:26 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 19:46:26 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 19:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:26 INFO - 'HOME': '/Users/cltbld', 19:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:26 INFO - 'LOGNAME': 'cltbld', 19:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:26 INFO - 'MOZ_NO_REMOTE': '1', 19:46:26 INFO - 'NO_EM_RESTART': '1', 19:46:26 INFO - 'PAGER': '/bin/cat', 19:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:26 INFO - 'PWD': '/builds/slave/test', 19:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:26 INFO - 'SHELL': '/bin/bash', 19:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:26 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:26 INFO - 'USER': 'cltbld', 19:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:26 INFO - 'XPC_FLAGS': '0x0', 19:46:26 INFO - 'XPC_SERVICE_NAME': '0', 19:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:26 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-3A_lLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:26 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-I7kMHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:26 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-lO3lSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:26 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-jnD_k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-l8qSXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-am8R09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PCIZmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-A_xyP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-h1AmLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-5mFswX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-RJQzMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-KxRaRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:27 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-pMMvT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-PCScpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-o907tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-47AVwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:28 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-qokem4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:28 INFO - Running setup.py install for manifestparser 19:46:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:46:28 INFO - Running setup.py install for mozcrash 19:46:28 INFO - Running setup.py install for mozdebug 19:46:28 INFO - Running setup.py install for mozdevice 19:46:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozfile 19:46:29 INFO - Running setup.py install for mozhttpd 19:46:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozinfo 19:46:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozInstall 19:46:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for mozleak 19:46:29 INFO - Running setup.py install for mozlog 19:46:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:46:29 INFO - Running setup.py install for moznetwork 19:46:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for mozprocess 19:46:30 INFO - Running setup.py install for mozprofile 19:46:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for mozrunner 19:46:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Running setup.py install for mozscreenshot 19:46:30 INFO - Running setup.py install for moztest 19:46:30 INFO - Running setup.py install for mozversion 19:46:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:46:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:30 INFO - Cleaning up... 19:46:31 INFO - Return code: 0 19:46:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:31 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:31 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 19:46:31 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 19:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:31 INFO - 'HOME': '/Users/cltbld', 19:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:31 INFO - 'LOGNAME': 'cltbld', 19:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:31 INFO - 'MOZ_NO_REMOTE': '1', 19:46:31 INFO - 'NO_EM_RESTART': '1', 19:46:31 INFO - 'PAGER': '/bin/cat', 19:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:31 INFO - 'PWD': '/builds/slave/test', 19:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:31 INFO - 'SHELL': '/bin/bash', 19:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:31 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:31 INFO - 'USER': 'cltbld', 19:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:31 INFO - 'XPC_FLAGS': '0x0', 19:46:31 INFO - 'XPC_SERVICE_NAME': '0', 19:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-lu5xNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:31 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-7CpoCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:31 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-CAXcd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:31 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Al35Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-i0sqNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:31 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-c4atqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:31 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)) 19:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:31 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-sVGjAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-lSzPuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-AdmaTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-rrduOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Gbk6Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-CIueSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-vaJLl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-8HUxWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-vBmTGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:32 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)) 19:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:32 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-YxXZW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:33 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)) 19:46:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:33 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-OppEpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:33 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)) 19:46:33 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)) 19:46:33 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)) 19:46:33 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)) 19:46:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:33 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:35 INFO - Downloading blessings-1.6.tar.gz 19:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:46:35 INFO - Installing collected packages: blessings 19:46:35 INFO - Running setup.py install for blessings 19:46:36 INFO - Successfully installed blessings 19:46:36 INFO - Cleaning up... 19:46:36 INFO - Return code: 0 19:46:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:36 INFO - Reading from file tmpfile_stdout 19:46:36 INFO - Current package versions: 19:46:36 INFO - blessings == 1.6 19:46:36 INFO - blobuploader == 1.2.4 19:46:36 INFO - docopt == 0.6.1 19:46:36 INFO - functools32 == 3.2.3-2 19:46:36 INFO - jsonschema == 2.5.1 19:46:36 INFO - manifestparser == 1.1 19:46:36 INFO - mozInstall == 1.12 19:46:36 INFO - mozcrash == 1.0 19:46:36 INFO - mozdebug == 0.1 19:46:36 INFO - mozdevice == 0.48 19:46:36 INFO - mozfile == 1.2 19:46:36 INFO - mozhttpd == 0.7 19:46:36 INFO - mozinfo == 0.9 19:46:36 INFO - mozleak == 0.1 19:46:36 INFO - mozlog == 3.4 19:46:36 INFO - moznetwork == 0.27 19:46:36 INFO - mozprocess == 0.23 19:46:36 INFO - mozprofile == 0.28 19:46:36 INFO - mozrunner == 6.13 19:46:36 INFO - mozscreenshot == 0.1 19:46:36 INFO - mozsystemmonitor == 0.3 19:46:36 INFO - moztest == 0.8 19:46:36 INFO - mozversion == 1.4 19:46:36 INFO - psutil == 3.1.1 19:46:36 INFO - requests == 1.2.3 19:46:36 INFO - wsgiref == 0.1.2 19:46:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 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 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:37 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 19:46:37 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 19:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:37 INFO - 'HOME': '/Users/cltbld', 19:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:37 INFO - 'LOGNAME': 'cltbld', 19:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:37 INFO - 'MOZ_NO_REMOTE': '1', 19:46:37 INFO - 'NO_EM_RESTART': '1', 19:46:37 INFO - 'PAGER': '/bin/cat', 19:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:37 INFO - 'PWD': '/builds/slave/test', 19:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:37 INFO - 'SHELL': '/bin/bash', 19:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:37 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:37 INFO - 'USER': 'cltbld', 19:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:37 INFO - 'XPC_FLAGS': '0x0', 19:46:37 INFO - 'XPC_SERVICE_NAME': '0', 19:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 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)) 19:46:37 INFO - Cleaning up... 19:46:37 INFO - Return code: 0 19:46:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:46:37 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')]} 19:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:37 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')]} 19:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab52490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aac8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa923589ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, '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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 19:46:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:38 INFO - 'HOME': '/Users/cltbld', 19:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:38 INFO - 'LOGNAME': 'cltbld', 19:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:38 INFO - 'MOZ_NO_REMOTE': '1', 19:46:38 INFO - 'NO_EM_RESTART': '1', 19:46:38 INFO - 'PAGER': '/bin/cat', 19:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:38 INFO - 'PWD': '/builds/slave/test', 19:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:38 INFO - 'SHELL': '/bin/bash', 19:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:46:38 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:38 INFO - 'USER': 'cltbld', 19:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:38 INFO - 'XPC_FLAGS': '0x0', 19:46:38 INFO - 'XPC_SERVICE_NAME': '0', 19:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:46:38 INFO - Cleaning up... 19:46:38 INFO - Return code: 0 19:46:38 INFO - Running post-action listener: _resource_record_post_action 19:46:38 INFO - Running post-action listener: _start_resource_monitoring 19:46:38 INFO - Starting resource monitoring. 19:46:38 INFO - [mozharness: 2017-01-13 03:46:38.329757Z] Finished create-virtualenv step (success) 19:46:38 INFO - [mozharness: 2017-01-13 03:46:38.330586Z] Running install step. 19:46:38 INFO - Running pre-action listener: _resource_record_pre_action 19:46:38 INFO - Running main action method: install 19:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:38 INFO - Reading from file tmpfile_stdout 19:46:38 INFO - Detecting whether we're running mozinstall >=1.0... 19:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:46:38 INFO - Reading from file tmpfile_stdout 19:46:38 INFO - Output received: 19:46:38 INFO - Usage: mozinstall [options] installer 19:46:38 INFO - Options: 19:46:38 INFO - -h, --help show this help message and exit 19:46:38 INFO - -d DEST, --destination=DEST 19:46:38 INFO - Directory to install application into. [default: 19:46:38 INFO - "/builds/slave/test"] 19:46:38 INFO - --app=APP Application being installed. [default: firefox] 19:46:38 INFO - mkdir: /builds/slave/test/build/application 19:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 19:47:09 INFO - Reading from file tmpfile_stdout 19:47:09 INFO - Output received: 19:47:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:47:09 INFO - Running post-action listener: _resource_record_post_action 19:47:09 INFO - [mozharness: 2017-01-13 03:47:09.841483Z] Finished install step (success) 19:47:09 INFO - [mozharness: 2017-01-13 03:47:09.841635Z] Running run-tests step. 19:47:09 INFO - Running pre-action listener: _resource_record_pre_action 19:47:09 INFO - Running main action method: run_tests 19:47:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:09 INFO - 2017-01-12 19:47:09.855 screenresolution[1908:16507] starting screenresolution argv=screenresolution get 19:47:09 INFO - 2017-01-12 19:47:09.858 screenresolution[1908:16507] Display 0: 1600x1200x32@60 19:47:09 INFO - 2017-01-12 19:47:09.864 screenresolution[1909:16509] starting screenresolution argv=screenresolution list 19:47:09 INFO - Available Modes on Display 0 19:47:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:10 INFO - Intel Iris: 19:47:10 INFO - Chipset Model: Intel Iris 19:47:10 INFO - Type: GPU 19:47:10 INFO - Bus: Built-In 19:47:10 INFO - VRAM (Dynamic, Max): 1536 MB 19:47:10 INFO - Vendor: Intel (0x8086) 19:47:10 INFO - Device ID: 0x0a2e 19:47:10 INFO - Revision ID: 0x0009 19:47:10 INFO - Displays: 19:47:10 INFO - Display: 19:47:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:10 INFO - Display Serial Number: 1600x1200 60 19:47:10 INFO - Main Display: Yes 19:47:10 INFO - Mirror: Off 19:47:10 INFO - Online: Yes 19:47:10 INFO - Rotation: Supported 19:47:10 INFO - Return code: 0 19:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:47:10 INFO - Python 2.7.3 19:47:10 INFO - Return code: 0 19:47:10 INFO - grabbing minidump binary from tooltool 19:47: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')]} 19:47:10 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 0x10a966d30>, '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 0x10a7ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a95eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:47:10 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 19:47:10 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 19:47:10 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 19:47:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:10 INFO - Return code: 0 19:47:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:47:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:47:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:47:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:47:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gJxFTwMxnP/Render', 19:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:10 INFO - 'HOME': '/Users/cltbld', 19:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:10 INFO - 'LOGNAME': 'cltbld', 19:47:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:47:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:10 INFO - 'MOZ_NO_REMOTE': '1', 19:47:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:47:10 INFO - 'NO_EM_RESTART': '1', 19:47:10 INFO - 'PAGER': '/bin/cat', 19:47:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:10 INFO - 'PWD': '/builds/slave/test', 19:47:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:10 INFO - 'SHELL': '/bin/bash', 19:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VrNpYxDDYj/Listeners', 19:47:10 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 19:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:10 INFO - 'USER': 'cltbld', 19:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:10 INFO - 'XPC_FLAGS': '0x0', 19:47:10 INFO - 'XPC_SERVICE_NAME': '0', 19:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:47:10 INFO - mozversion application_buildid: 20170112171016 19:47:10 INFO - mozversion application_changeset: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 19:47:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:47:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:10 INFO - mozversion application_name: Firefox 19:47:10 INFO - mozversion application_remotingname: firefox-dev 19:47:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:47:10 INFO - mozversion application_vendor: Mozilla 19:47:10 INFO - mozversion application_version: 52.0a2 19:47:10 INFO - mozversion platform_buildid: 20170112171016 19:47:10 INFO - mozversion platform_changeset: 1e322cd9c7410917d4c5f1fa5b2cd78eb4a79ec6 19:47:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:47:10 INFO - mozversion platform_version: 52.0a2 19:47:10 INFO - using testdate: 1484279230 19:47:10 INFO - actual date: 1484279230 19:47:10 INFO - starting webserver on 'localhost:53504' 19:47:10 INFO - SUITE-START | Running 2 tests 19:47:10 INFO - TEST-START | dromaeo_css 19:47:10 INFO - operating with platform_type : mac_ 19:47:10 INFO - Initialising browser for dromaeo_css test... 19:47:10 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpgAvBT7/profile http://localhost:53504/getInfo.html) 19:47:12 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 19:47:12 INFO - PROCESS | 1919 | colorDepth:24 19:47:12 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 19:47:12 INFO - PROCESS | 1919 | __metrics 19:47:13 INFO - PROCESS | 1919 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:47:13 INFO - PROCESS | 1919 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:13 INFO - TEST-INFO | 1919: exit 0 19:47:13 INFO - Browser initialized. 19:47:13 INFO - Running cycle 1/1 for dromaeo_css test... 19:47:13 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpgAvBT7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:26 INFO - PROCESS | 1921 | RSS: Main: 222552064 19:47:26 INFO - PROCESS | 1921 | 19:50:29 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53504/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53504/tests/dromaeo/cssquery-ext.html) 19:50:31 INFO - PROCESS | 1921 | RSS: Main: 318394368 19:50:31 INFO - PROCESS | 1921 | 19:53:34 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53504/tests/dromaeo/cssquery-ext.html (next: http://localhost:53504/tests/dromaeo/cssquery-jquery.html) 19:53:35 INFO - PROCESS | 1921 | RSS: Main: 348393472 19:53:35 INFO - PROCESS | 1921 | 19:56:37 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53504/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53504/tests/dromaeo/cssquery-mootools.html) 19:56:38 INFO - PROCESS | 1921 | RSS: Main: 329506816 19:56:38 INFO - PROCESS | 1921 | 19:59:40 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53504/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53504/tests/dromaeo/cssquery-prototype.html) 19:59:40 INFO - PROCESS | 1921 | RSS: Main: 338698240 19:59:40 INFO - PROCESS | 1921 | 20:02:44 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53504/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53504/tests/dromaeo/cssquery-yui.html) 20:02:44 INFO - PROCESS | 1921 | RSS: Main: 309141504 20:02:44 INFO - PROCESS | 1921 | 20:05:47 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53504/tests/dromaeo/cssquery-yui.html (next: http://localhost:53504/tests/dromaeo/cssquery-dojo.html) 20:05:48 INFO - PROCESS | 1921 | RSS: Main: 372461568 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | __start_tp_report 20:05:48 INFO - PROCESS | 1921 | _x_x_mozilla_page_load 20:05:48 INFO - PROCESS | 1921 | _x_x_mozilla_page_load_details 20:05:48 INFO - PROCESS | 1921 | |i|pagename|runs| 20:05:48 INFO - PROCESS | 1921 | |0;dojo.html;2858.7278660995853;3330.816805075721;3342.064222017836;3361.6470270621567;3400.2859399526096;5647.463490968356;5671.631343962645;5681.431856814327;5724.742386592603;5731.369549349579;5621.578381621384;5651.660900345972;5694.898341025321;5765.942340576593;5788.305403351593;5179.2749015137815;5202.947970520303;5226.817061402851;5236.476352364771;5265.9473405266035;5163.380394352665;5185.948140518603;5192.71440070796;5192.766325515342;5306.575473962093;5243.344581927259;5284.841454756363;5289.920651190235;5313.203019547061;5344.839654810362;5263.578913686896;5274.789008439658;5284.630075894689;5286.762095705683;5328.307320048408;5087.008033433482;5092.516210959953;5157.948420515821;5215.035218484592;5215.191645294985;5622.662640241558;5650.915236271459;5658.462446067658;5707.828765137053;5729.140628905656;5145.588352931756;6172.722227499773;6188.845278868064;6258.843528911768;6268.373162683741;5121.334226550562;6303.653299068549;6351.301356850743;6354.237491501003;6372.426481616677;5694.629849059839;5697.202391665171;5725.541956643458;5741.368449470555;5754.4533269339345;5266.578673706094;6293.118963345135;6331.430171284606;6337.081123237105;6355.014972679242;6072.119542666289;6074.058520929263;6074.787382441594;6103.908441373383;6123.142760013601;6138.508919286446;6155.830392225463;6157.261128664589;6168.136460895478;6247.687615619201;6165.8458538536;6207.255129384503;6224.37756224383;6234.781782637677;6245.718942647501;6168.938310616926;6189.288231853305;6243.937560624427;6250.124982502453;6266.24805023391;4840.298156767249;4893.339399181136;4922.606191504671;4927.5811556017425;4954.851354459372;4403.383526306319;4406.096750166208;4413.889652758707;4416.4258646375765;4440.2673558862425;5740.339860915965;5816.1566572846705;5831.970840145772;5851.500161575034;5872.236609240771;6135.049067394561;6245.656488893154;6306.779262725782;6326.557141000086;6334.461570766444;5641.5204707600315;5716.1997320375185;5754.395788442237;5757.942420575824;5758;5326.6537675050995;5370.946290537045;5373.059714549938;5390.622656414013;5409.053415652245;6272.372762723782;6301.747930082929;6307.936920630735;6311.211098612674;6324;4675.438947326343;6102.420270074336;6132.202813634378;6158.753649854135;6259.436650701458;6266.997280435108;6280.183576135073;6291;6297.370262973666;6302.905456418066;6194.566380353332;6203.906941395973;6209.285932117864;6215.502759779117;6216.129741836056;5994.610350327215;6102.694865256631;6124.167343420691;6138.631682099089;6222.28443728977;5988.221531200916;6089.391060893875;6101.145839582551;6131.430567336853;6146.924288249628;5956.612820166675;5991.910121348096;6116.579253789288;6118.527810132385;6145.66198859067;5796.304443466811;5923.703814809329;5964.433378829004;5975.760969561169;5986.07215881539;5945.227120474311;6012.669303188191;6023.879522409615;6079.422454866781;6117.857853872152;5915.852103697442;5918.2898052234;5929.970350148222;5948.2862056553495;5965.761369545169 20:05:48 INFO - PROCESS | 1921 | |1;ext.html;477.210217090715;504.7224026785268;506.8089988526961;508.1108060893439;526.2842534153548;29225.123246302617;29557.704422955765;30397.99999999997;30435.695643043564;38456.42315365265;39369.01577460565;39740.205195896066;39761.60238397623;39804.601953980455;39807;9182.586783594754;9345.11221433966;9351.859722104175;9358.251339892793;9358.906410935906;8336.458130221516;8544.23101920827;9119.224865886408;9236.445813251194;10970.341779493216;11049.447527623586;11217.943910280437;11237.381943993078;11258.211925165242;11271.09831213501;11089;11091.057260132899;11151.107911367071;11169.273997190237;11180.496877640486;8293.543855087968;8488.151184881524;10864.45677716119;11077.667669969915;11152.219344645879;34938;36413.81793091044;36520.269594608224;36560;36668.44997325042;3239.4816829307433;3290.555774970372;3295.950560741591;3609.693176080036;3786.488824008751;27287.015414516216;27733.306667333276;28086.859565702245;29572.852135739184;29755;2968.910932672023;3133.749300056013;3206.4388731972044;3317.154125697956;3326.800391976465;464257;464281.67859160824;465196;466274.34902603854;466283.6743265184;55750.16374754382;56062;56126.43873561212;56136.719316403156;56203.71898140565;55755.721221394444;56065.719671401384;56074;58181.418185818446;58364.832703345695;12772.169808962388;15099.698006040038;15547.689046219239;15598.454054108051;15637.843621563867;12037.097217708706;12118.575849845212;12130.33283169434;12132.96869766062;12140.878591213976;12810.42353094113;13123.409446574928;13404.664883377993;13475.528356507672;14693.632659183606;5671.376148623648;6738.292479289702;6762;6815.761448349284;6821.556598821061;813.4712436916052;968.4915419404869;984.8522721591819;1002.7493126718321;1048.7430579507916;26903.78932948022;28159.296017599725;29258.975935842143;29810.254743631584;30525.38949221003;983.4246965525248;1013.3381254742229;1033.1837848100067;1048.4757621189406;1085.180688580117;14324.498642547462;14712.852871471363;14753.33609987553;15000;15018.69962600742;633886;636410;636807;638295;639393;38909.0272743178;44640.10719785651;45719.54280457219;51333.716657083125;52411.47588524142;1342.9865701342862;1362.8432730235952;1379.648189711617;1384.0450089438255;1385.764420048594;27976.86011569929;28421.289467763472;29057.41885162327;29393.412131757672;29600.851995740744;47067.76466117647;47653.57039288827;47672.76163619298;47703.28445073257;47741.80645483752;564970;566490;569333;569872;570065;24292.878535607208;24581.262562123164;24784.752152478246;25516.234512964642;26176;44028.55971440244;44265.77867110644;44659;44948.10103797971;44991.55008450004;36200.27599448049;37171.44242836306;37203.813980929925;37289.81355093207;37537.2492550142;36668.32224098603;37206.627933720316;37454.06364840901;37813.81093094517;38169;29966.70033299639;36257.91226263216;36493.635063649024;37036.25927481489;37313.253734924605;31392.68607313989;32971.01086967395;33319.83340083284;33372.83313583417;33393.66606333906;24528;24713;24752.876235619427;25175.37061573475;25196.74803251944 20:05:48 INFO - PROCESS | 1921 | |2;jquery.html;323.45174928496203;352.64735264735265;377.6638791475587;381.9789911554865;405.0360142859993;14480.855191448083;14552.490662826804;15697.84302156978;20111.396658100242;20576.279830205945;20011.499712507193;20137.798622013812;20546.48633784156;20986;21060.684089738665;5762.308522977238;5928.88142237155;5931.08068249422;5935.169076329317;5937.495312898387;4768.64235182361;6473.931801252787;6549.901751473732;6576;6591.307912669148;6265.436110750032;6480.805575832709;6520.67396630169;6544.5418820682335;6567.146270984766;5540;6493.642849643291;6535.21577410709;6539.476841852688;6546.5417420780805;5578.581606379537;5619.269494965669;5715.885682286373;5761.251037365158;5768.221290125821;25630.359241018938;25743;25910.352241193934;25988.220353389428;26196.60705089425;2333.369990102663;2428.3807629054477;2756.9724302757118;3064.555639432292;3128.124125244935;13060.804087938688;15110.471133510384;15295.2237870429;15438.922805386013;15989.520314390587;1676.0865328395932;1791.0954967741206;1799.4871461633502;1818.4635532517807;1846.0308338122459;113747.43126284398;118479.4076029623;118848;119367.8063219374;119406.04708600535;10783.514741836636;10917.072048875934;10994.780104398027;11047.005769480786;11127.276727012719;13925.721485570231;13930.303484825921;13934.512292069932;13953.093048951785;13960.301984900714;8372.916270837335;8468.788280293042;8494.15058494158;8519.616617252239;8644.567771611395;8402.957985210034;8435.409521333448;8452.830943381221;8590.355723320776;8628.78428039304;5461.617686761968;6450.258220304631;6563.081168636395;6611.933880661132;6669.233038200572;1548.3342162869849;1686.9746953795702;1726.351334475573;1814.9183286752127;1852.51834523025;872.2934423117168;885.933554983366;908.7682640926521;926.1340646495548;999.9001098791417;20783.58432831335;22180.778192218193;22292;22315.330540083498;22322.665160022614;933.6405483888751;946.8153710026479;962.1581116523042;964.3876138651866;986.5659109991581;11151.665450036511;11430.314181149157;11839.467223974769;11857.940710296394;11882.108841836896;493031;498375;499517;555798;579660;112964;120887.39556302162;141685;147938;148581;933.3746389918771;955.5031383680587;972.5088830140734;990.2919412619867;991.2862738828032;18542.980136092643;19084.427467176007;19266;19292.32476863303;19297.807021930163;42237.78881105575;52301.7384913073;54023.45976540184;54827;57277.713611431675;76062.39002238087;77286.06784830424;80258.59870700842;82659;82915;10628.946855265674;11886.870747278994;11934.224275422417;12521.248725076524;12599;13340.399682014138;13540.526081587097;13834.515791947233;13852.445902163801;14046.297685115907;11476.655700329004;11656.825147622623;11823.408829558659;12093.697657558632;12113.69715757113;10579.206559507913;11019.669409917715;11463.025642820454;11723.824142638037;11975.28148311104;9755.414675119515;11064.944675276573;12059.457324420599;12089.274643521418;12173.634790956285;10011.299209055296;11580.710482237675;12097.274163550215;12260.632181034583;12481.812772808233;11730.648080557597;11879.406029698654;11911.940440297743;11925.642230733092;12024.398780061138 20:05:48 INFO - PROCESS | 1921 | |3;mootools.html;1315.118870356862;1456.7960485532021;1490.0091439192938;1639.5163426789095;1831.0844577711143;7499.100107987042;7919.445638805286;8248.257656810885;8478.19457151571;8499.320054395648;7160.785176444702;8376.748697539068;8487.618057187427;8489.490630562155;8497;2318.9652155217686;2352.729436114843;2354.72920614129;2355.646653002046;2356.988215058931;2340.2511196417154;2372.4543355028354;2384.916527921523;2392.1866565367773;2398.5922393193114;2288.4164538042774;2293.850899691523;2317.1194945920524;2322.4077860145726;2322.7328857181387;2322.431004403915;2335.6730057791838;2349.107339211106;2356.599378105726;2356.670066190735;2336.4509340305017;2360.7521210273017;2361.2325994052003;2366.041753089984;2370.3718514593475;8399.70601028961;8430.747077587683;8512.361572881997;8528.6162122704;8533.402661813676;5080.1617733074;5264.157734762458;5276;5309.787608495694;5317.8404647860625;3442.8794992175403;3505.6319086495805;3560.0743806610208;3569.161247106928;3595.82020898954;951.833429149896;981.2738573455663;1031.3296357367697;1060.931039482431;1102.4542851288663;9355.719328420158;10926.180536459718;10985.121190304757;11045.447727613668;11134.443277836075;3785.167263202091;4312.439382880206;4434.778261086933;4548.363229147922;4559.133764584718;8764.21122099014;8766.824663506693;8773.561321933877;8777.736667899973;8777.780555486164;4829.782659780319;5122.231665250242;5131.897362052813;5132.538071573576;5139.331886854759;4192.4759405074365;4303.74177549348;4391.538888416734;4424.73451592899;4474.865754027384;3051.755859531232;3667.908302292464;3756.154865155373;3781.7920014398924;3831.0230891122587;1149.0807354116673;1156.8149096144577;1159;1166.836642869999;1168.2231316174818;786.0253285925526;858.6779957515931;867.991320086791;880.8986966498807;891.6923661336829;4707.95292047082;5569.610127291051;5814.738336774855;5963.344032156459;6162.352952939967;628.2743431336813;873.7728190670344;898.8876390451194;932.072587775168;962.0043255230803;3171.77797554169;3737.6262373762406;3919.843206271717;3937.330653788863;4025.19496100781;8725.781855453664;9925.305228633926;10418.270721049605;10418.68743937683;10436.217283703752;10382.532786024647;10391.220658450646;10392.168626509861;10405.84391234132;10418.635347762944;7529.962350188214;7920.4059695523065;7932.127465978853;8083.514989100555;8125.06561745395;5625.774969001194;5719.771209151588;5726.770929162787;5966;5972.76768804449;9148.588313526041;9167.808184935915;9295.30285228597;9493.715188544355;9537.189338905993;9465.810683786149;9553.570089346134;9593.28050396209;9619.855702164614;9666.033396660278;7158.642067896689;7262.818429539304;7265;7320.707171713072;7325.597092159983;7885.44801863864;7895.052593688794;7973.9202607973175;7994.120646728971;7995.680172793023;7132.429405647432;7193.784186474414;7200.315969982843;7238.23998480152;7353.632318384166;7084.716611335489;7103.573785572882;7106.751263705745;7142.750003749844;7142.857142857009;6591.967040164768;6672.332766723289;6746.35909588608;6768.593884366954;6772.762953296611;4267.210566045292;4862.416510018679;4885.560299573055;4945.307656928105;4970;4719.764011799465;4871.123197824426;4873.001034787931;5036.748162591783;5053.69677819332 20:05:48 INFO - PROCESS | 1921 | |4;prototype.html;262.6808427760271;283.724786956652;299.58357882543254;302.3152559452839;312.41734165780827;4998.325226094476;5091.465396133408;5241.50205730455;5292.497212764782;5381.219723140152;4101.712880098395;4759.714417134975;4896.666450191579;5235.424103348629;5248.790048398059;3429.8628054877777;3930.44973703681;3985.98707652635;4003.9599604004025;4013.2174226025936;3596.874109406171;3714.5542534895717;3773.6603505755475;3890.389887982735;3969.24584328978;3567.9108022299392;3948.684105271586;3958.782266975315;3962.247173037128;3978.4827972363696;3597.946030809553;3918.5493668228232;3955.4462375267485;3960.6237407446247;3994.400839874013;3002.8198308101582;3311.589063264841;3445.776024558421;3475.7566970312087;3477.2697733475748;4364.367166760833;4834.226523756182;5095.923561146586;5107.233914912756;5133.871653208662;4135.503739551273;4399.140558636879;4448.644108471314;4520.68355215135;4520.728756274634;4778.904421911542;5462.754176062047;5486.506214440679;5495.835124946258;5497.5601951843755;3075.63727538654;3177.269228077555;3643.3988391915304;3759.586445490994;3771.9245615087543;5036.06832735945;5728.169415434781;5778.566607504454;5788.247527821399;5809.564282678773;3240.8541615627355;3837.501124853751;3893.96106038936;3901.669147246554;3902;3162.4623813951684;3835.53973523179;3861.7876016819346;3879.1465877506903;3937.92124157521;3631.219287853124;3899.6880249579967;4304.935425968613;4367.890802729958;4385.780710964503;4467.977660111678;4939.160342741742;5391.3799913009725;5397.703126328011;5559.833205003856;1079.384750692098;1245.7383949370733;1260.338322380739;1265.7531781302557;1266.6326765238161;736.1166600079926;743.9442041846883;775.2634996753108;856.5823562004892;865.9913400865911;4395.011122497476;4431.246688063037;4580.701894635857;4590.173768721662;4679.040796636681;4556.994922234207;4603.286490593963;5393.83818485446;5409.540189083893;5409.56723462122;4079.4900637420324;4726.929096063562;4955.628327875424;4956.91809440036;4998.600111991032;2434.914777982762;2802.7337402946687;2829.8160619559662;2831.3063299491346;2841.005648023175;4743.501932297128;5176.249443830623;5596.4123767003875;5614.63504872182;5659.405762394971;4830.565249127595;5200.8959820803375;5217.191335342952;5547.44525547442;5562.107703993981;5037.823676171316;5182.637215394886;5278.6773819519285;5366.926614677002;5560.832225232665;4565.748883811422;4699.953000469952;4874.367841365764;5372.516473517402;5395.730213489388;3974.1654252607277;4501.527339629422;5333.12003519415;5350.892982140414;5362.069654924147;4645.072294997673;4974.079795237748;5507.504324610804;5601.831945041656;5617;3216.694414030663;3577.0520811984325;3632.4369722693023;3676.540432445944;3694.7413681042067;4123.8969025774595;5239;5468.589855760913;5495.175723641486;5842.474177324061;5625.971870140623;5642.351129620146;5669.858253543694;5677.7161141941915;5680.233168522197;4467.642588592969;5155.355580552431;5312.468753124811;5656.8020119295625;5664.433556644302;5313.521783039545;5394.568434525307;5505.697186654612;5534.584906131976;5548.250986116984;5122.308488354024;5368.892622147613;5523.155574879021;5594.776208951759;5634.605577609528;4463.553644635511;4652.488226295172;5322.574194064388;5513.877157294551;5856.164212440858 20:05:48 INFO - PROCESS | 1921 | |5;yui.html;675.6520391998121;694.8922916947872;715.4133610439442;716.0905649824723;726.099636450801;13980;14276.357563909623;14403.92798036011;14415.189038137567;14415.98176255325;12493.250404975708;12757.617271481871;12809.807852882192;12902.548410805624;13028.478860845578;792.9326007289387;798.3134504326275;798.4530596541388;799.472348250155;800.75977206838;641.2369280556146;662.6256165266633;772.8415674786655;813.7314686153585;820.3109388113983;867.0852250875324;871.8561437362828;873.8383399071192;874.021096372061;875.5272153037353;861.1259571534835;861.3281640320497;862.2584577263548;864.0538610221829;865.2904618213037;498.1852533187483;513.7405610166879;514.4880843560644;639.9680015999228;647.9125318082093;11144.219904606682;11299.322040677585;13343.866561334456;13883.167009979332;13904.026718129735;11648.301101933912;13495;13887.166769993833;14016.649583760385;14025.859741402557;10872.402017889013;11193.776124477547;11302.491387887565;11329.830052549218;11375.658730238023;3509.8420571074107;3684.355237833395;3704.518412606371;3716.1081340478363;3833.750806197588;79409;82062.94842628922;82264.76602850962;86954;87924.80187995288;10380.065794078419;10551.94724026375;10722.03501684852;10766.407847568302;11134.164937629548;20310.593788124155;20350.18599256043;20382.69425958612;20390.490237743878;20654.277100301417;6552.312007239267;6589.505787065989;7442.702291908263;7714.151443341228;7830.491018083806;4099.938500922489;4196.139791342767;4325;4410.580994805488;4427.756473393994;3355.983220083884;3467.479878018267;3468.271662950758;3471.4272145096284;3473.89578312651;628.0924064726518;630.4578062865932;633.439406125573;649.7043845050491;661.751843058853;529.5684017525704;574.3395095639964;642.9198945771057;643.6524276890427;652.8988006858945;8617.181367770052;9109.407888487227;9116.680916167903;9124.680636177702;9527.571259293349;562.7636392715069;565.5080080330139;606.5511521474166;610.6397225636807;677.4309579952765;3773.132179598708;3930.646241838191;3940.9605903941165;4563.771811409416;4602.470715867651;103939;104942;109764.4511777436;110228;111425.77148457148;76316;81645;96032.51983740176;102260;102384.48807755913;89291.55354223317;89629;90906;92346.53826730823;92745.07254927499;8648.870266945874;8706.04233534298;8770.824583508167;8814.250788682777;8814.47113173186;53871;54118.729406352715;55230;55235.44764552303;56939.715301423224;76899;77485.22514775005;77575.44849102873;78413.60793195998;80445.19554804378;11042.282251653616;11240.213185077293;11248.606298779503;11284.379359135326;11534.884651153381;11842.881571184522;12044.819327710267;12048.578299759467;12155.574554890536;12584.685382865502;11845.052395808143;11870.584529541424;11998;12217.755644887231;12354.382280886099;11753.823692644788;11787.11596630239;11817;12094.516219351128;12141.69645758863;10027.849582256125;10932.344059356465;11277.492512837107;11387.772244555228;11449.713757155805;9254.9537252316;9275.72172834816;9470.14768670823;9490.383125096847;9528.99945505712;9155.679551215675;9210.80259566252;9609.231261499202;9890.406575605486;9924.305298629026 20:05:48 INFO - PROCESS | 1921 | __end_tp_report 20:05:48 INFO - PROCESS | 1921 | __start_cc_report 20:05:48 INFO - PROCESS | 1921 | _x_x_mozilla_cycle_collect,1697 20:05:48 INFO - PROCESS | 1921 | __end_cc_report 20:05:48 INFO - PROCESS | 1921 | __startTimestamp1484280348090__endTimestamp 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | ------- Summary: start ------- 20:05:48 INFO - PROCESS | 1921 | Number of tests: 6 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | [#0] dojo.html Cycles:165 Average:5712.09 Median:5923.70 stddev:650.11 (11.0%) stddev-sans-first:612.36 20:05:48 INFO - PROCESS | 1921 | Values: 2858.7 3330.8 3342.1 3361.6 3400.3 5647.5 5671.6 5681.4 5724.7 5731.4 5621.6 5651.7 5694.9 5765.9 5788.3 5179.3 5202.9 5226.8 5236.5 5265.9 5163.4 5185.9 5192.7 5192.8 5306.6 5243.3 5284.8 5289.9 5313.2 5344.8 5263.6 5274.8 5284.6 5286.8 5328.3 5087.0 5092.5 5157.9 5215.0 5215.2 5622.7 5650.9 5658.5 5707.8 5729.1 5145.6 6172.7 6188.8 6258.8 6268.4 5121.3 6303.7 6351.3 6354.2 6372.4 5694.6 5697.2 5725.5 5741.4 5754.5 5266.6 6293.1 6331.4 6337.1 6355.0 6072.1 6074.1 6074.8 6103.9 6123.1 6138.5 6155.8 6157.3 6168.1 6247.7 6165.8 6207.3 6224.4 6234.8 6245.7 6168.9 6189.3 6243.9 6250.1 6266.2 4840.3 4893.3 4922.6 4927.6 4954.9 4403.4 4406.1 4413.9 4416.4 4440.3 5740.3 5816.2 5832.0 5851.5 5872.2 6135.0 6245.7 6306.8 6326.6 6334.5 5641.5 5716.2 5754.4 5757.9 5758.0 5326.7 5370.9 5373.1 5390.6 5409.1 6272.4 6301.7 6307.9 6311.2 6324.0 4675.4 6102.4 6132.2 6158.8 6259.4 6267.0 6280.2 6291.0 6297.4 6302.9 6194.6 6203.9 6209.3 6215.5 6216.1 5994.6 6102.7 6124.2 6138.6 6222.3 5988.2 6089.4 6101.1 6131.4 6146.9 5956.6 5991.9 6116.6 6118.5 6145.7 5796.3 5923.7 5964.4 5975.8 5986.1 5945.2 6012.7 6023.9 6079.4 6117.9 5915.9 5918.3 5930.0 5948.3 5965.8 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | [#1] ext.html Cycles:180 Average:67553.89 Median:36229.09 stddev:150199.10 (414.6%) stddev-sans-first:150536.01 20:05:48 INFO - PROCESS | 1921 | Values: 477.2 504.7 506.8 508.1 526.3 29225.1 29557.7 30398.0 30435.7 38456.4 39369.0 39740.2 39761.6 39804.6 39807.0 9182.6 9345.1 9351.9 9358.3 9358.9 8336.5 8544.2 9119.2 9236.4 10970.3 11049.4 11217.9 11237.4 11258.2 11271.1 11089.0 11091.1 11151.1 11169.3 11180.5 8293.5 8488.2 10864.5 11077.7 11152.2 34938.0 36413.8 36520.3 36560.0 36668.4 3239.5 3290.6 3296.0 3609.7 3786.5 27287.0 27733.3 28086.9 29572.9 29755.0 2968.9 3133.7 3206.4 3317.2 3326.8 464257.0 464281.7 465196.0 466274.3 466283.7 55750.2 56062.0 56126.4 56136.7 56203.7 55755.7 56065.7 56074.0 58181.4 58364.8 12772.2 15099.7 15547.7 15598.5 15637.8 12037.1 12118.6 12130.3 12133.0 12140.9 12810.4 13123.4 13404.7 13475.5 14693.6 5671.4 6738.3 6762.0 6815.8 6821.6 813.5 968.5 984.9 1002.7 1048.7 26903.8 28159.3 29259.0 29810.3 30525.4 983.4 1013.3 1033.2 1048.5 1085.2 14324.5 14712.9 14753.3 15000.0 15018.7 633886.0 636410.0 636807.0 638295.0 639393.0 38909.0 44640.1 45719.5 51333.7 52411.5 1343.0 1362.8 1379.6 1384.0 1385.8 27976.9 28421.3 29057.4 29393.4 29600.9 47067.8 47653.6 47672.8 47703.3 47741.8 564970.0 566490.0 569333.0 569872.0 570065.0 24292.9 24581.3 24784.8 25516.2 26176.0 44028.6 44265.8 44659.0 44948.1 44991.6 36200.3 37171.4 37203.8 37289.8 37537.2 36668.3 37206.6 37454.1 37813.8 38169.0 29966.7 36257.9 36493.6 37036.3 37313.3 31392.7 32971.0 33319.8 33372.8 33393.7 24528.0 24713.0 24752.9 25175.4 25196.7 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | [#2] jquery.html Cycles:180 Average:33694.27 Median:22236.39 stddev:88745.71 (399.1%) stddev-sans-first:88959.29 20:05:48 INFO - PROCESS | 1921 | Values: 323.5 352.6 377.7 382.0 405.0 14480.9 14552.5 15697.8 20111.4 20576.3 20011.5 20137.8 20546.5 20986.0 21060.7 5762.3 5928.9 5931.1 5935.2 5937.5 4768.6 6473.9 6549.9 6576.0 6591.3 6265.4 6480.8 6520.7 6544.5 6567.1 5540.0 6493.6 6535.2 6539.5 6546.5 5578.6 5619.3 5715.9 5761.3 5768.2 25630.4 25743.0 25910.4 25988.2 26196.6 2333.4 2428.4 2757.0 3064.6 3128.1 13060.8 15110.5 15295.2 15438.9 15989.5 1676.1 1791.1 1799.5 1818.5 1846.0 113747.4 118479.4 118848.0 119367.8 119406.0 10783.5 10917.1 10994.8 11047.0 11127.3 13925.7 13930.3 13934.5 13953.1 13960.3 8372.9 8468.8 8494.2 8519.6 8644.6 8403.0 8435.4 8452.8 8590.4 8628.8 5461.6 6450.3 6563.1 6611.9 6669.2 1548.3 1687.0 1726.4 1814.9 1852.5 872.3 885.9 908.8 926.1 999.9 20783.6 22180.8 22292.0 22315.3 22322.7 933.6 946.8 962.2 964.4 986.6 11151.7 11430.3 11839.5 11857.9 11882.1 493031.0 498375.0 499517.0 555798.0 579660.0 112964.0 120887.4 141685.0 147938.0 148581.0 933.4 955.5 972.5 990.3 991.3 18543.0 19084.4 19266.0 19292.3 19297.8 42237.8 52301.7 54023.5 54827.0 57277.7 76062.4 77286.1 80258.6 82659.0 82915.0 10628.9 11886.9 11934.2 12521.2 12599.0 13340.4 13540.5 13834.5 13852.4 14046.3 11476.7 11656.8 11823.4 12093.7 12113.7 10579.2 11019.7 11463.0 11723.8 11975.3 9755.4 11064.9 12059.5 12089.3 12173.6 10011.3 11580.7 12097.3 12260.6 12481.8 11730.6 11879.4 11911.9 11925.6 12024.4 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | [#3] mootools.html Cycles:180 Average:5444.28 Median:5135.93 stddev:2997.91 (58.4%) stddev-sans-first:2990.26 20:05:48 INFO - PROCESS | 1921 | Values: 1315.1 1456.8 1490.0 1639.5 1831.1 7499.1 7919.4 8248.3 8478.2 8499.3 7160.8 8376.7 8487.6 8489.5 8497.0 2319.0 2352.7 2354.7 2355.6 2357.0 2340.3 2372.5 2384.9 2392.2 2398.6 2288.4 2293.9 2317.1 2322.4 2322.7 2322.4 2335.7 2349.1 2356.6 2356.7 2336.5 2360.8 2361.2 2366.0 2370.4 8399.7 8430.7 8512.4 8528.6 8533.4 5080.2 5264.2 5276.0 5309.8 5317.8 3442.9 3505.6 3560.1 3569.2 3595.8 951.8 981.3 1031.3 1060.9 1102.5 9355.7 10926.2 10985.1 11045.4 11134.4 3785.2 4312.4 4434.8 4548.4 4559.1 8764.2 8766.8 8773.6 8777.7 8777.8 4829.8 5122.2 5131.9 5132.5 5139.3 4192.5 4303.7 4391.5 4424.7 4474.9 3051.8 3667.9 3756.2 3781.8 3831.0 1149.1 1156.8 1159.0 1166.8 1168.2 786.0 858.7 868.0 880.9 891.7 4708.0 5569.6 5814.7 5963.3 6162.4 628.3 873.8 898.9 932.1 962.0 3171.8 3737.6 3919.8 3937.3 4025.2 8725.8 9925.3 10418.3 10418.7 10436.2 10382.5 10391.2 10392.2 10405.8 10418.6 7530.0 7920.4 7932.1 8083.5 8125.1 5625.8 5719.8 5726.8 5966.0 5972.8 9148.6 9167.8 9295.3 9493.7 9537.2 9465.8 9553.6 9593.3 9619.9 9666.0 7158.6 7262.8 7265.0 7320.7 7325.6 7885.4 7895.1 7973.9 7994.1 7995.7 7132.4 7193.8 7200.3 7238.2 7353.6 7084.7 7103.6 7106.8 7142.8 7142.9 6592.0 6672.3 6746.4 6768.6 6772.8 4267.2 4862.4 4885.6 4945.3 4970.0 4719.8 4871.1 4873.0 5036.7 5053.7 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | [#4] prototype.html Cycles:180 Average:4322.46 Median:4735.22 stddev:1343.98 (28.4%) stddev-sans-first:1312.75 20:05:48 INFO - PROCESS | 1921 | Values: 262.7 283.7 299.6 302.3 312.4 4998.3 5091.5 5241.5 5292.5 5381.2 4101.7 4759.7 4896.7 5235.4 5248.8 3429.9 3930.4 3986.0 4004.0 4013.2 3596.9 3714.6 3773.7 3890.4 3969.2 3567.9 3948.7 3958.8 3962.2 3978.5 3597.9 3918.5 3955.4 3960.6 3994.4 3002.8 3311.6 3445.8 3475.8 3477.3 4364.4 4834.2 5095.9 5107.2 5133.9 4135.5 4399.1 4448.6 4520.7 4520.7 4778.9 5462.8 5486.5 5495.8 5497.6 3075.6 3177.3 3643.4 3759.6 3771.9 5036.1 5728.2 5778.6 5788.2 5809.6 3240.9 3837.5 3894.0 3901.7 3902.0 3162.5 3835.5 3861.8 3879.1 3937.9 3631.2 3899.7 4304.9 4367.9 4385.8 4468.0 4939.2 5391.4 5397.7 5559.8 1079.4 1245.7 1260.3 1265.8 1266.6 736.1 743.9 775.3 856.6 866.0 4395.0 4431.2 4580.7 4590.2 4679.0 4557.0 4603.3 5393.8 5409.5 5409.6 4079.5 4726.9 4955.6 4956.9 4998.6 2434.9 2802.7 2829.8 2831.3 2841.0 4743.5 5176.2 5596.4 5614.6 5659.4 4830.6 5200.9 5217.2 5547.4 5562.1 5037.8 5182.6 5278.7 5366.9 5560.8 4565.7 4700.0 4874.4 5372.5 5395.7 3974.2 4501.5 5333.1 5350.9 5362.1 4645.1 4974.1 5507.5 5601.8 5617.0 3216.7 3577.1 3632.4 3676.5 3694.7 4123.9 5239.0 5468.6 5495.2 5842.5 5626.0 5642.4 5669.9 5677.7 5680.2 4467.6 5155.4 5312.5 5656.8 5664.4 5313.5 5394.6 5505.7 5534.6 5548.3 5122.3 5368.9 5523.2 5594.8 5634.6 4463.6 4652.5 5322.6 5513.9 5856.2 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - PROCESS | 1921 | [#5] yui.html Cycles:180 Average:20214.72 Median:27200.28 stddev:30112.72 (110.7%) stddev-sans-first:30161.45 20:05:48 INFO - PROCESS | 1921 | Values: 675.7 694.9 715.4 716.1 726.1 13980.0 14276.4 14403.9 14415.2 14416.0 12493.3 12757.6 12809.8 12902.5 13028.5 792.9 798.3 798.5 799.5 800.8 641.2 662.6 772.8 813.7 820.3 867.1 871.9 873.8 874.0 875.5 861.1 861.3 862.3 864.1 865.3 498.2 513.7 514.5 640.0 647.9 11144.2 11299.3 13343.9 13883.2 13904.0 11648.3 13495.0 13887.2 14016.6 14025.9 10872.4 11193.8 11302.5 11329.8 11375.7 3509.8 3684.4 3704.5 3716.1 3833.8 79409.0 82062.9 82264.8 86954.0 87924.8 10380.1 10551.9 10722.0 10766.4 11134.2 20310.6 20350.2 20382.7 20390.5 20654.3 6552.3 6589.5 7442.7 7714.2 7830.5 4099.9 4196.1 4325.0 4410.6 4427.8 3356.0 3467.5 3468.3 3471.4 3473.9 628.1 630.5 633.4 649.7 661.8 529.6 574.3 642.9 643.7 652.9 8617.2 9109.4 9116.7 9124.7 9527.6 562.8 565.5 606.6 610.6 677.4 3773.1 3930.6 3941.0 4563.8 4602.5 103939.0 104942.0 109764.5 110228.0 111425.8 76316.0 81645.0 96032.5 102260.0 102384.5 89291.6 89629.0 90906.0 92346.5 92745.1 8648.9 8706.0 8770.8 8814.3 8814.5 53871.0 54118.7 55230.0 55235.4 56939.7 76899.0 77485.2 77575.4 78413.6 80445.2 11042.3 11240.2 11248.6 11284.4 11534.9 11842.9 12044.8 12048.6 12155.6 12584.7 11845.1 11870.6 11998.0 12217.8 12354.4 11753.8 11787.1 11817.0 12094.5 12141.7 10027.8 10932.3 11277.5 11387.8 11449.7 9255.0 9275.7 9470.1 9490.4 9529.0 9155.7 9210.8 9609.2 9890.4 9924.3 20:05:48 INFO - PROCESS | 1921 | -------- Summary: end -------- 20:05:48 INFO - PROCESS | 1921 | 20:05:48 INFO - TEST-INFO | 1921: exit 0 20:05:48 INFO - TEST-OK | dromaeo_css | took 1118271ms 20:05:48 INFO - TEST-START | kraken 20:05:48 INFO - operating with platform_type : mac_ 20:05:48 INFO - Initialising browser for kraken test... 20:05:48 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpKJH0d3/profile http://localhost:53504/getInfo.html) 20:05:51 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 20:05:51 INFO - PROCESS | 1925 | colorDepth:24 20:05:51 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 20:05:51 INFO - PROCESS | 1925 | __metrics 20:05:51 INFO - PROCESS | 1925 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:05:51 INFO - PROCESS | 1925 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:52 INFO - TEST-INFO | 1925: exit 0 20:05:52 INFO - Browser initialized. 20:05:52 INFO - Running cycle 1/1 for kraken test... 20:05:52 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpKJH0d3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:04 INFO - PROCESS | 1926 | RSS: Main: 222404608 20:06:04 INFO - PROCESS | 1926 | 20:06:07 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53504/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:08 INFO - PROCESS | 1926 | RSS: Main: 272408576 20:06:08 INFO - PROCESS | 1926 | 20:06:10 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53504/tests/kraken/driver.html?testName=audio-dft) 20:06:11 INFO - PROCESS | 1926 | RSS: Main: 283332608 20:06:11 INFO - PROCESS | 1926 | 20:06:14 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53504/tests/kraken/driver.html?testName=audio-fft) 20:06:15 INFO - PROCESS | 1926 | RSS: Main: 379666432 20:06:15 INFO - PROCESS | 1926 | 20:06:17 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53504/tests/kraken/driver.html?testName=audio-oscillator) 20:06:17 INFO - PROCESS | 1926 | RSS: Main: 282832896 20:06:17 INFO - PROCESS | 1926 | 20:06:19 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53504/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:20 INFO - PROCESS | 1926 | RSS: Main: 285073408 20:06:20 INFO - PROCESS | 1926 | 20:06:23 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53504/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:23 INFO - PROCESS | 1926 | RSS: Main: 325681152 20:06:23 INFO - PROCESS | 1926 | 20:06:26 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53504/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:27 INFO - PROCESS | 1926 | RSS: Main: 327557120 20:06:27 INFO - PROCESS | 1926 | 20:06:30 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53504/tests/kraken/driver.html?testName=json-parse-financial) 20:06:30 INFO - PROCESS | 1926 | RSS: Main: 325332992 20:06:30 INFO - PROCESS | 1926 | 20:06:32 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53504/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:06:33 INFO - PROCESS | 1926 | RSS: Main: 299261952 20:06:33 INFO - PROCESS | 1926 | 20:06:35 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:06:35 INFO - PROCESS | 1926 | RSS: Main: 301240320 20:06:35 INFO - PROCESS | 1926 | 20:06:37 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:06:38 INFO - PROCESS | 1926 | RSS: Main: 302514176 20:06:38 INFO - PROCESS | 1926 | 20:06:41 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:06:42 INFO - PROCESS | 1926 | RSS: Main: 312291328 20:06:42 INFO - PROCESS | 1926 | 20:06:44 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:06:45 INFO - PROCESS | 1926 | RSS: Main: 312033280 20:06:45 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:53504/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53504/tests/kraken/driver.html?testName=ai-astar) 20:06:47 INFO - PROCESS | 1926 | RSS: Main: 355643392 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | __start_tp_report 20:06:47 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 20:06:47 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 20:06:47 INFO - PROCESS | 1926 | |i|pagename|runs| 20:06:47 INFO - PROCESS | 1926 | |0;ai-astar;114;115;115;111;113;113;114;113;115;113 20:06:47 INFO - PROCESS | 1926 | |1;audio-beat-detection;148;113;111;150;113;114;113;110;125;119 20:06:47 INFO - PROCESS | 1926 | |2;audio-dft;184;182;185;183;181;182;184;184;184;184 20:06:47 INFO - PROCESS | 1926 | |3;audio-fft;78;60;59;90;62;60;60;59;84;59 20:06:47 INFO - PROCESS | 1926 | |4;audio-oscillator;86;70;93;78;95;99;88;69;70;92 20:06:47 INFO - PROCESS | 1926 | |5;imaging-gaussian-blur;90;87;88;86;87;85;88;86;88;86 20:06:47 INFO - PROCESS | 1926 | |6;imaging-darkroom;92;95;94;94;93;93;95;94;93;94 20:06:47 INFO - PROCESS | 1926 | |7;imaging-desaturate;83;83;78;79;85;86;132;135;81;82 20:06:47 INFO - PROCESS | 1926 | |8;json-parse-financial;55;52;77;84;84;86;78;59;57;59 20:06:47 INFO - PROCESS | 1926 | |9;json-stringify-tinderbox;65;77;68;78;73;72;70;73;72;71 20:06:47 INFO - PROCESS | 1926 | |10;stanford-crypto-aes;85;85;85;83;84;84;82;82;83;84 20:06:47 INFO - PROCESS | 1926 | |11;stanford-crypto-ccm;138;136;142;138;142;142;141;141;174;137 20:06:47 INFO - PROCESS | 1926 | |12;stanford-crypto-pbkdf2;156;165;168;165;166;165;168;165;164;168 20:06:47 INFO - PROCESS | 1926 | |13;stanford-crypto-sha256-iterative;62;82;84;85;68;68;68;67;65;67 20:06:47 INFO - PROCESS | 1926 | __end_tp_report 20:06:47 INFO - PROCESS | 1926 | __start_cc_report 20:06:47 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,1948 20:06:47 INFO - PROCESS | 1926 | __end_cc_report 20:06:47 INFO - PROCESS | 1926 | __startTimestamp1484280407500__endTimestamp 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | ------- Summary: start ------- 20:06:47 INFO - PROCESS | 1926 | Number of tests: 14 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 20:06:47 INFO - PROCESS | 1926 | Values: 114.0 115.0 115.0 111.0 113.0 113.0 114.0 113.0 115.0 113.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:116.50 stddev:15.09 (12.9%) stddev-sans-first:12.62 20:06:47 INFO - PROCESS | 1926 | Values: 148.0 113.0 111.0 150.0 113.0 114.0 113.0 110.0 125.0 119.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.25 (0.7%) stddev-sans-first:1.30 20:06:47 INFO - PROCESS | 1926 | Values: 184.0 182.0 185.0 183.0 181.0 182.0 184.0 184.0 184.0 184.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#3] audio-fft Cycles:10 Average:67.10 Median:61.00 stddev:12.03 (19.7%) stddev-sans-first:12.10 20:06:47 INFO - PROCESS | 1926 | Values: 78.0 60.0 59.0 90.0 62.0 60.0 60.0 59.0 84.0 59.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:90.00 stddev:11.37 (12.6%) stddev-sans-first:12.04 20:06:47 INFO - PROCESS | 1926 | Values: 86.0 70.0 93.0 78.0 95.0 99.0 88.0 69.0 70.0 92.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.50 stddev:1.45 (1.7%) stddev-sans-first:1.09 20:06:47 INFO - PROCESS | 1926 | Values: 90.0 87.0 88.0 86.0 87.0 85.0 88.0 86.0 88.0 86.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.95 (1.0%) stddev-sans-first:0.78 20:06:47 INFO - PROCESS | 1926 | Values: 92.0 95.0 94.0 94.0 93.0 93.0 95.0 94.0 93.0 94.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:82.50 stddev:21.81 (26.4%) stddev-sans-first:22.86 20:06:47 INFO - PROCESS | 1926 | Values: 83.0 83.0 78.0 79.0 85.0 86.0 132.0 135.0 81.0 82.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:77.50 stddev:13.80 (17.8%) stddev-sans-first:13.66 20:06:47 INFO - PROCESS | 1926 | Values: 55.0 52.0 77.0 84.0 84.0 86.0 78.0 59.0 57.0 59.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.50 stddev:3.84 (5.3%) stddev-sans-first:3.16 20:06:47 INFO - PROCESS | 1926 | Values: 65.0 77.0 68.0 78.0 73.0 72.0 70.0 73.0 72.0 71.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.16 (1.4%) stddev-sans-first:1.13 20:06:47 INFO - PROCESS | 1926 | Values: 85.0 85.0 85.0 83.0 84.0 84.0 82.0 82.0 83.0 84.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:141.50 stddev:11.09 (7.8%) stddev-sans-first:11.61 20:06:47 INFO - PROCESS | 1926 | Values: 138.0 136.0 142.0 138.0 142.0 142.0 141.0 141.0 174.0 137.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.50 stddev:3.50 (2.1%) stddev-sans-first:1.58 20:06:47 INFO - PROCESS | 1926 | Values: 156.0 165.0 168.0 165.0 166.0 165.0 168.0 165.0 164.0 168.0 20:06:47 INFO - PROCESS | 1926 | 20:06:47 INFO - PROCESS | 1926 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:68.00 stddev:8.55 (12.6%) stddev-sans-first:8.34 20:06:47 INFO - PROCESS | 1926 | Values: 62.0 82.0 84.0 85.0 68.0 68.0 68.0 67.0 65.0 67.0 20:06:47 INFO - PROCESS | 1926 | -------- Summary: end -------- 20:06:47 INFO - PROCESS | 1926 | 20:06:48 INFO - TEST-INFO | 1926: exit 0 20:06:48 INFO - TEST-OK | kraken | took 59856ms 20:06:48 INFO - SUITE-END | took 1178s 20:06:48 INFO - Completed test suite (00:19:38) 20:06:48 INFO - javascript benchmark 20:06:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2858.7278660995853, 3330.816805075721, 3342.064222017836, 3361.6470270621567, 3400.2859399526096, 5647.463490968356, 5671.631343962645, 5681.431856814327, 5724.742386592603, 5731.369549349579, 5621.578381621384, 5651.660900345972, 5694.898341025321, 5765.942340576593, 5788.305403351593, 5179.2749015137815, 5202.947970520303, 5226.817061402851, 5236.476352364771, 5265.9473405266035, 5163.380394352665, 5185.948140518603, 5192.71440070796, 5192.766325515342, 5306.575473962093, 5243.344581927259, 5284.841454756363, 5289.920651190235, 5313.203019547061, 5344.839654810362, 5263.578913686896, 5274.789008439658, 5284.630075894689, 5286.762095705683, 5328.307320048408, 5087.008033433482, 5092.516210959953, 5157.948420515821, 5215.035218484592, 5215.191645294985, 5622.662640241558, 5650.915236271459, 5658.462446067658, 5707.828765137053, 5729.140628905656, 5145.588352931756, 6172.722227499773, 6188.845278868064, 6258.843528911768, 6268.373162683741, 5121.334226550562, 6303.653299068549, 6351.301356850743, 6354.237491501003, 6372.426481616677, 5694.629849059839, 5697.202391665171, 5725.541956643458, 5741.368449470555, 5754.4533269339345, 5266.578673706094, 6293.118963345135, 6331.430171284606, 6337.081123237105, 6355.014972679242, 6072.119542666289, 6074.058520929263, 6074.787382441594, 6103.908441373383, 6123.142760013601, 6138.508919286446, 6155.830392225463, 6157.261128664589, 6168.136460895478, 6247.687615619201, 6165.8458538536, 6207.255129384503, 6224.37756224383, 6234.781782637677, 6245.718942647501, 6168.938310616926, 6189.288231853305, 6243.937560624427, 6250.124982502453, 6266.24805023391, 4840.298156767249, 4893.339399181136, 4922.606191504671, 4927.5811556017425, 4954.851354459372, 4403.383526306319, 4406.096750166208, 4413.889652758707, 4416.4258646375765, 4440.2673558862425, 5740.339860915965, 5816.1566572846705, 5831.970840145772, 5851.500161575034, 5872.236609240771, 6135.049067394561, 6245.656488893154, 6306.779262725782, 6326.557141000086, 6334.461570766444, 5641.5204707600315, 5716.1997320375185, 5754.395788442237, 5757.942420575824, 5758.0, 5326.6537675050995, 5370.946290537045, 5373.059714549938, 5390.622656414013, 5409.053415652245, 6272.372762723782, 6301.747930082929, 6307.936920630735, 6311.211098612674, 6324.0, 4675.438947326343, 6102.420270074336, 6132.202813634378, 6158.753649854135, 6259.436650701458, 6266.997280435108, 6280.183576135073, 6291.0, 6297.370262973666, 6302.905456418066, 6194.566380353332, 6203.906941395973, 6209.285932117864, 6215.502759779117, 6216.129741836056, 5994.610350327215, 6102.694865256631, 6124.167343420691, 6138.631682099089, 6222.28443728977, 5988.221531200916, 6089.391060893875, 6101.145839582551, 6131.430567336853, 6146.924288249628, 5956.612820166675, 5991.910121348096, 6116.579253789288, 6118.527810132385, 6145.66198859067, 5796.304443466811, 5923.703814809329, 5964.433378829004, 5975.760969561169, 5986.07215881539, 5945.227120474311, 6012.669303188191, 6023.879522409615, 6079.422454866781, 6117.857853872152, 5915.852103697442, 5918.2898052234, 5929.970350148222, 5948.2862056553495, 5965.761369545169], "value": 5670.692696365577, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.210217090715, 504.7224026785268, 506.8089988526961, 508.1108060893439, 526.2842534153548, 29225.123246302617, 29557.704422955765, 30397.99999999997, 30435.695643043564, 38456.42315365265, 39369.01577460565, 39740.205195896066, 39761.60238397623, 39804.601953980455, 39807.0, 9182.586783594754, 9345.11221433966, 9351.859722104175, 9358.251339892793, 9358.906410935906, 8336.458130221516, 8544.23101920827, 9119.224865886408, 9236.445813251194, 10970.341779493216, 11049.447527623586, 11217.943910280437, 11237.381943993078, 11258.211925165242, 11271.09831213501, 11089.0, 11091.057260132899, 11151.107911367071, 11169.273997190237, 11180.496877640486, 8293.543855087968, 8488.151184881524, 10864.45677716119, 11077.667669969915, 11152.219344645879, 34938.0, 36413.81793091044, 36520.269594608224, 36560.0, 36668.44997325042, 3239.4816829307433, 3290.555774970372, 3295.950560741591, 3609.693176080036, 3786.488824008751, 27287.015414516216, 27733.306667333276, 28086.859565702245, 29572.852135739184, 29755.0, 2968.910932672023, 3133.749300056013, 3206.4388731972044, 3317.154125697956, 3326.800391976465, 464257.0, 464281.67859160824, 465196.0, 466274.34902603854, 466283.6743265184, 55750.16374754382, 56062.0, 56126.43873561212, 56136.719316403156, 56203.71898140565, 55755.721221394444, 56065.719671401384, 56074.0, 58181.418185818446, 58364.832703345695, 12772.169808962388, 15099.698006040038, 15547.689046219239, 15598.454054108051, 15637.843621563867, 12037.097217708706, 12118.575849845212, 12130.33283169434, 12132.96869766062, 12140.878591213976, 12810.42353094113, 13123.409446574928, 13404.664883377993, 13475.528356507672, 14693.632659183606, 5671.376148623648, 6738.292479289702, 6762.0, 6815.761448349284, 6821.556598821061, 813.4712436916052, 968.4915419404869, 984.8522721591819, 1002.7493126718321, 1048.7430579507916, 26903.78932948022, 28159.296017599725, 29258.975935842143, 29810.254743631584, 30525.38949221003, 983.4246965525248, 1013.3381254742229, 1033.1837848100067, 1048.4757621189406, 1085.180688580117, 14324.498642547462, 14712.852871471363, 14753.33609987553, 15000.0, 15018.69962600742, 633886.0, 636410.0, 636807.0, 638295.0, 639393.0, 38909.0272743178, 44640.10719785651, 45719.54280457219, 51333.716657083125, 52411.47588524142, 1342.9865701342862, 1362.8432730235952, 1379.648189711617, 1384.0450089438255, 1385.764420048594, 27976.86011569929, 28421.289467763472, 29057.41885162327, 29393.412131757672, 29600.851995740744, 47067.76466117647, 47653.57039288827, 47672.76163619298, 47703.28445073257, 47741.80645483752, 564970.0, 566490.0, 569333.0, 569872.0, 570065.0, 24292.878535607208, 24581.262562123164, 24784.752152478246, 25516.234512964642, 26176.0, 44028.55971440244, 44265.77867110644, 44659.0, 44948.10103797971, 44991.55008450004, 36200.27599448049, 37171.44242836306, 37203.813980929925, 37289.81355093207, 37537.2492550142, 36668.32224098603, 37206.627933720316, 37454.06364840901, 37813.81093094517, 38169.0, 29966.70033299639, 36257.91226263216, 36493.635063649024, 37036.25927481489, 37313.253734924605, 31392.68607313989, 32971.01086967395, 33319.83340083284, 33372.83313583417, 33393.66606333906, 24528.0, 24713.0, 24752.876235619427, 25175.37061573475, 25196.74803251944], "value": 19015.8036137111, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.45174928496203, 352.64735264735265, 377.6638791475587, 381.9789911554865, 405.0360142859993, 14480.855191448083, 14552.490662826804, 15697.84302156978, 20111.396658100242, 20576.279830205945, 20011.499712507193, 20137.798622013812, 20546.48633784156, 20986.0, 21060.684089738665, 5762.308522977238, 5928.88142237155, 5931.08068249422, 5935.169076329317, 5937.495312898387, 4768.64235182361, 6473.931801252787, 6549.901751473732, 6576.0, 6591.307912669148, 6265.436110750032, 6480.805575832709, 6520.67396630169, 6544.5418820682335, 6567.146270984766, 5540.0, 6493.642849643291, 6535.21577410709, 6539.476841852688, 6546.5417420780805, 5578.581606379537, 5619.269494965669, 5715.885682286373, 5761.251037365158, 5768.221290125821, 25630.359241018938, 25743.0, 25910.352241193934, 25988.220353389428, 26196.60705089425, 2333.369990102663, 2428.3807629054477, 2756.9724302757118, 3064.555639432292, 3128.124125244935, 13060.804087938688, 15110.471133510384, 15295.2237870429, 15438.922805386013, 15989.520314390587, 1676.0865328395932, 1791.0954967741206, 1799.4871461633502, 1818.4635532517807, 1846.0308338122459, 113747.43126284398, 118479.4076029623, 118848.0, 119367.8063219374, 119406.04708600535, 10783.514741836636, 10917.072048875934, 10994.780104398027, 11047.005769480786, 11127.276727012719, 13925.721485570231, 13930.303484825921, 13934.512292069932, 13953.093048951785, 13960.301984900714, 8372.916270837335, 8468.788280293042, 8494.15058494158, 8519.616617252239, 8644.567771611395, 8402.957985210034, 8435.409521333448, 8452.830943381221, 8590.355723320776, 8628.78428039304, 5461.617686761968, 6450.258220304631, 6563.081168636395, 6611.933880661132, 6669.233038200572, 1548.3342162869849, 1686.9746953795702, 1726.351334475573, 1814.9183286752127, 1852.51834523025, 872.2934423117168, 885.933554983366, 908.7682640926521, 926.1340646495548, 999.9001098791417, 20783.58432831335, 22180.778192218193, 22292.0, 22315.330540083498, 22322.665160022614, 933.6405483888751, 946.8153710026479, 962.1581116523042, 964.3876138651866, 986.5659109991581, 11151.665450036511, 11430.314181149157, 11839.467223974769, 11857.940710296394, 11882.108841836896, 493031.0, 498375.0, 499517.0, 555798.0, 579660.0, 112964.0, 120887.39556302162, 141685.0, 147938.0, 148581.0, 933.3746389918771, 955.5031383680587, 972.5088830140734, 990.2919412619867, 991.2862738828032, 18542.980136092643, 19084.427467176007, 19266.0, 19292.32476863303, 19297.807021930163, 42237.78881105575, 52301.7384913073, 54023.45976540184, 54827.0, 57277.713611431675, 76062.39002238087, 77286.06784830424, 80258.59870700842, 82659.0, 82915.0, 10628.946855265674, 11886.870747278994, 11934.224275422417, 12521.248725076524, 12599.0, 13340.399682014138, 13540.526081587097, 13834.515791947233, 13852.445902163801, 14046.297685115907, 11476.655700329004, 11656.825147622623, 11823.408829558659, 12093.697657558632, 12113.69715757113, 10579.206559507913, 11019.669409917715, 11463.025642820454, 11723.824142638037, 11975.28148311104, 9755.414675119515, 11064.944675276573, 12059.457324420599, 12089.274643521418, 12173.634790956285, 10011.299209055296, 11580.710482237675, 12097.274163550215, 12260.632181034583, 12481.812772808233, 11730.648080557597, 11879.406029698654, 11911.940440297743, 11925.642230733092, 12024.398780061138], "value": 10069.84688745356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.118870356862, 1456.7960485532021, 1490.0091439192938, 1639.5163426789095, 1831.0844577711143, 7499.100107987042, 7919.445638805286, 8248.257656810885, 8478.19457151571, 8499.320054395648, 7160.785176444702, 8376.748697539068, 8487.618057187427, 8489.490630562155, 8497.0, 2318.9652155217686, 2352.729436114843, 2354.72920614129, 2355.646653002046, 2356.988215058931, 2340.2511196417154, 2372.4543355028354, 2384.916527921523, 2392.1866565367773, 2398.5922393193114, 2288.4164538042774, 2293.850899691523, 2317.1194945920524, 2322.4077860145726, 2322.7328857181387, 2322.431004403915, 2335.6730057791838, 2349.107339211106, 2356.599378105726, 2356.670066190735, 2336.4509340305017, 2360.7521210273017, 2361.2325994052003, 2366.041753089984, 2370.3718514593475, 8399.70601028961, 8430.747077587683, 8512.361572881997, 8528.6162122704, 8533.402661813676, 5080.1617733074, 5264.157734762458, 5276.0, 5309.787608495694, 5317.8404647860625, 3442.8794992175403, 3505.6319086495805, 3560.0743806610208, 3569.161247106928, 3595.82020898954, 951.833429149896, 981.2738573455663, 1031.3296357367697, 1060.931039482431, 1102.4542851288663, 9355.719328420158, 10926.180536459718, 10985.121190304757, 11045.447727613668, 11134.443277836075, 3785.167263202091, 4312.439382880206, 4434.778261086933, 4548.363229147922, 4559.133764584718, 8764.21122099014, 8766.824663506693, 8773.561321933877, 8777.736667899973, 8777.780555486164, 4829.782659780319, 5122.231665250242, 5131.897362052813, 5132.538071573576, 5139.331886854759, 4192.4759405074365, 4303.74177549348, 4391.538888416734, 4424.73451592899, 4474.865754027384, 3051.755859531232, 3667.908302292464, 3756.154865155373, 3781.7920014398924, 3831.0230891122587, 1149.0807354116673, 1156.8149096144577, 1159.0, 1166.836642869999, 1168.2231316174818, 786.0253285925526, 858.6779957515931, 867.991320086791, 880.8986966498807, 891.6923661336829, 4707.95292047082, 5569.610127291051, 5814.738336774855, 5963.344032156459, 6162.352952939967, 628.2743431336813, 873.7728190670344, 898.8876390451194, 932.072587775168, 962.0043255230803, 3171.77797554169, 3737.6262373762406, 3919.843206271717, 3937.330653788863, 4025.19496100781, 8725.781855453664, 9925.305228633926, 10418.270721049605, 10418.68743937683, 10436.217283703752, 10382.532786024647, 10391.220658450646, 10392.168626509861, 10405.84391234132, 10418.635347762944, 7529.962350188214, 7920.4059695523065, 7932.127465978853, 8083.514989100555, 8125.06561745395, 5625.774969001194, 5719.771209151588, 5726.770929162787, 5966.0, 5972.76768804449, 9148.588313526041, 9167.808184935915, 9295.30285228597, 9493.715188544355, 9537.189338905993, 9465.810683786149, 9553.570089346134, 9593.28050396209, 9619.855702164614, 9666.033396660278, 7158.642067896689, 7262.818429539304, 7265.0, 7320.707171713072, 7325.597092159983, 7885.44801863864, 7895.052593688794, 7973.9202607973175, 7994.120646728971, 7995.680172793023, 7132.429405647432, 7193.784186474414, 7200.315969982843, 7238.23998480152, 7353.632318384166, 7084.716611335489, 7103.573785572882, 7106.751263705745, 7142.750003749844, 7142.857142857009, 6591.967040164768, 6672.332766723289, 6746.35909588608, 6768.593884366954, 6772.762953296611, 4267.210566045292, 4862.416510018679, 4885.560299573055, 4945.307656928105, 4970.0, 4719.764011799465, 4871.123197824426, 4873.001034787931, 5036.748162591783, 5053.69677819332], "value": 4394.503631400691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.6808427760271, 283.724786956652, 299.58357882543254, 302.3152559452839, 312.41734165780827, 4998.325226094476, 5091.465396133408, 5241.50205730455, 5292.497212764782, 5381.219723140152, 4101.712880098395, 4759.714417134975, 4896.666450191579, 5235.424103348629, 5248.790048398059, 3429.8628054877777, 3930.44973703681, 3985.98707652635, 4003.9599604004025, 4013.2174226025936, 3596.874109406171, 3714.5542534895717, 3773.6603505755475, 3890.389887982735, 3969.24584328978, 3567.9108022299392, 3948.684105271586, 3958.782266975315, 3962.247173037128, 3978.4827972363696, 3597.946030809553, 3918.5493668228232, 3955.4462375267485, 3960.6237407446247, 3994.400839874013, 3002.8198308101582, 3311.589063264841, 3445.776024558421, 3475.7566970312087, 3477.2697733475748, 4364.367166760833, 4834.226523756182, 5095.923561146586, 5107.233914912756, 5133.871653208662, 4135.503739551273, 4399.140558636879, 4448.644108471314, 4520.68355215135, 4520.728756274634, 4778.904421911542, 5462.754176062047, 5486.506214440679, 5495.835124946258, 5497.5601951843755, 3075.63727538654, 3177.269228077555, 3643.3988391915304, 3759.586445490994, 3771.9245615087543, 5036.06832735945, 5728.169415434781, 5778.566607504454, 5788.247527821399, 5809.564282678773, 3240.8541615627355, 3837.501124853751, 3893.96106038936, 3901.669147246554, 3902.0, 3162.4623813951684, 3835.53973523179, 3861.7876016819346, 3879.1465877506903, 3937.92124157521, 3631.219287853124, 3899.6880249579967, 4304.935425968613, 4367.890802729958, 4385.780710964503, 4467.977660111678, 4939.160342741742, 5391.3799913009725, 5397.703126328011, 5559.833205003856, 1079.384750692098, 1245.7383949370733, 1260.338322380739, 1265.7531781302557, 1266.6326765238161, 736.1166600079926, 743.9442041846883, 775.2634996753108, 856.5823562004892, 865.9913400865911, 4395.011122497476, 4431.246688063037, 4580.701894635857, 4590.173768721662, 4679.040796636681, 4556.994922234207, 4603.286490593963, 5393.83818485446, 5409.540189083893, 5409.56723462122, 4079.4900637420324, 4726.929096063562, 4955.628327875424, 4956.91809440036, 4998.600111991032, 2434.914777982762, 2802.7337402946687, 2829.8160619559662, 2831.3063299491346, 2841.005648023175, 4743.501932297128, 5176.249443830623, 5596.4123767003875, 5614.63504872182, 5659.405762394971, 4830.565249127595, 5200.8959820803375, 5217.191335342952, 5547.44525547442, 5562.107703993981, 5037.823676171316, 5182.637215394886, 5278.6773819519285, 5366.926614677002, 5560.832225232665, 4565.748883811422, 4699.953000469952, 4874.367841365764, 5372.516473517402, 5395.730213489388, 3974.1654252607277, 4501.527339629422, 5333.12003519415, 5350.892982140414, 5362.069654924147, 4645.072294997673, 4974.079795237748, 5507.504324610804, 5601.831945041656, 5617.0, 3216.694414030663, 3577.0520811984325, 3632.4369722693023, 3676.540432445944, 3694.7413681042067, 4123.8969025774595, 5239.0, 5468.589855760913, 5495.175723641486, 5842.474177324061, 5625.971870140623, 5642.351129620146, 5669.858253543694, 5677.7161141941915, 5680.233168522197, 4467.642588592969, 5155.355580552431, 5312.468753124811, 5656.8020119295625, 5664.433556644302, 5313.521783039545, 5394.568434525307, 5505.697186654612, 5534.584906131976, 5548.250986116984, 5122.308488354024, 5368.892622147613, 5523.155574879021, 5594.776208951759, 5634.605577609528, 4463.553644635511, 4652.488226295172, 5322.574194064388, 5513.877157294551, 5856.164212440858], "value": 3891.833585535199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.6520391998121, 694.8922916947872, 715.4133610439442, 716.0905649824723, 726.099636450801, 13980.0, 14276.357563909623, 14403.92798036011, 14415.189038137567, 14415.98176255325, 12493.250404975708, 12757.617271481871, 12809.807852882192, 12902.548410805624, 13028.478860845578, 792.9326007289387, 798.3134504326275, 798.4530596541388, 799.472348250155, 800.75977206838, 641.2369280556146, 662.6256165266633, 772.8415674786655, 813.7314686153585, 820.3109388113983, 867.0852250875324, 871.8561437362828, 873.8383399071192, 874.021096372061, 875.5272153037353, 861.1259571534835, 861.3281640320497, 862.2584577263548, 864.0538610221829, 865.2904618213037, 498.1852533187483, 513.7405610166879, 514.4880843560644, 639.9680015999228, 647.9125318082093, 11144.219904606682, 11299.322040677585, 13343.866561334456, 13883.167009979332, 13904.026718129735, 11648.301101933912, 13495.0, 13887.166769993833, 14016.649583760385, 14025.859741402557, 10872.402017889013, 11193.776124477547, 11302.491387887565, 11329.830052549218, 11375.658730238023, 3509.8420571074107, 3684.355237833395, 3704.518412606371, 3716.1081340478363, 3833.750806197588, 79409.0, 82062.94842628922, 82264.76602850962, 86954.0, 87924.80187995288, 10380.065794078419, 10551.94724026375, 10722.03501684852, 10766.407847568302, 11134.164937629548, 20310.593788124155, 20350.18599256043, 20382.69425958612, 20390.490237743878, 20654.277100301417, 6552.312007239267, 6589.505787065989, 7442.702291908263, 7714.151443341228, 7830.491018083806, 4099.938500922489, 4196.139791342767, 4325.0, 4410.580994805488, 4427.756473393994, 3355.983220083884, 3467.479878018267, 3468.271662950758, 3471.4272145096284, 3473.89578312651, 628.0924064726518, 630.4578062865932, 633.439406125573, 649.7043845050491, 661.751843058853, 529.5684017525704, 574.3395095639964, 642.9198945771057, 643.6524276890427, 652.8988006858945, 8617.181367770052, 9109.407888487227, 9116.680916167903, 9124.680636177702, 9527.571259293349, 562.7636392715069, 565.5080080330139, 606.5511521474166, 610.6397225636807, 677.4309579952765, 3773.132179598708, 3930.646241838191, 3940.9605903941165, 4563.771811409416, 4602.470715867651, 103939.0, 104942.0, 109764.4511777436, 110228.0, 111425.77148457148, 76316.0, 81645.0, 96032.51983740176, 102260.0, 102384.48807755913, 89291.55354223317, 89629.0, 90906.0, 92346.53826730823, 92745.07254927499, 8648.870266945874, 8706.04233534298, 8770.824583508167, 8814.250788682777, 8814.47113173186, 53871.0, 54118.729406352715, 55230.0, 55235.44764552303, 56939.715301423224, 76899.0, 77485.22514775005, 77575.44849102873, 78413.60793195998, 80445.19554804378, 11042.282251653616, 11240.213185077293, 11248.606298779503, 11284.379359135326, 11534.884651153381, 11842.881571184522, 12044.819327710267, 12048.578299759467, 12155.574554890536, 12584.685382865502, 11845.052395808143, 11870.584529541424, 11998.0, 12217.755644887231, 12354.382280886099, 11753.823692644788, 11787.11596630239, 11817.0, 12094.516219351128, 12141.69645758863, 10027.849582256125, 10932.344059356465, 11277.492512837107, 11387.772244555228, 11449.713757155805, 9254.9537252316, 9275.72172834816, 9470.14768670823, 9490.383125096847, 9528.99945505712, 9155.679551215675, 9210.80259566252, 9609.231261499202, 9890.406575605486, 9924.305298629026], "value": 7001.371567307139, "unit": "score"}], "name": "dromaeo_css", "value": 7117.786585472372, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 111.0, 113.0, 113.0, 114.0, 113.0, 115.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 111.0, 150.0, 113.0, 114.0, 113.0, 110.0, 125.0, 119.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 185.0, 183.0, 181.0, 182.0, 184.0, 184.0, 184.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 59.0, 90.0, 62.0, 60.0, 60.0, 59.0, 84.0, 59.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 93.0, 78.0, 95.0, 99.0, 88.0, 69.0, 70.0, 92.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 88.0, 86.0, 87.0, 85.0, 88.0, 86.0, 88.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 94.0, 94.0, 93.0, 93.0, 95.0, 94.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 78.0, 79.0, 85.0, 86.0, 132.0, 135.0, 81.0, 82.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 77.0, 84.0, 84.0, 86.0, 78.0, 59.0, 57.0, 59.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 68.0, 78.0, 73.0, 72.0, 70.0, 73.0, 72.0, 71.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 83.0, 84.0, 84.0, 82.0, 82.0, 83.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 142.0, 138.0, 142.0, 142.0, 141.0, 141.0, 174.0, 137.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 168.0, 165.0, 166.0, 165.0, 168.0, 165.0, 164.0, 168.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 82.0, 84.0, 85.0, 68.0, 68.0, 68.0, 67.0, 65.0, 67.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1447.1999999999998, "alertThreshold": 2.0}]} 20:06:48 INFO - Return code: 0 20:06:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:06:48 INFO - # TBPL SUCCESS # 20:06:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:06:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:06:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:06:48 INFO - 2017-01-12 20:06:48.837 screenresolution[1930:18573] starting screenresolution argv=screenresolution get 20:06:48 INFO - 2017-01-12 20:06:48.840 screenresolution[1930:18573] Display 0: 1600x1200x32@60 20:06:48 INFO - 2017-01-12 20:06:48.846 screenresolution[1931:18576] starting screenresolution argv=screenresolution list 20:06:48 INFO - Available Modes on Display 0 20:06:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:06:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:06:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:06:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:06:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:06:49 INFO - Intel Iris: 20:06:49 INFO - Chipset Model: Intel Iris 20:06:49 INFO - Type: GPU 20:06:49 INFO - Bus: Built-In 20:06:49 INFO - VRAM (Dynamic, Max): 1536 MB 20:06:49 INFO - Vendor: Intel (0x8086) 20:06:49 INFO - Device ID: 0x0a2e 20:06:49 INFO - Revision ID: 0x0009 20:06:49 INFO - Displays: 20:06:49 INFO - Display: 20:06:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:06:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:06:49 INFO - Display Serial Number: 1600x1200 60 20:06:49 INFO - Main Display: Yes 20:06:49 INFO - Mirror: Off 20:06:49 INFO - Online: Yes 20:06:49 INFO - Rotation: Supported 20:06:49 INFO - Return code: 0 20:06:49 INFO - Running post-action listener: _resource_record_post_action 20:06:49 INFO - [mozharness: 2017-01-13 04:06:49.090951Z] Finished run-tests step (success) 20:06:49 INFO - Running post-run listener: _resource_record_post_run 20:06:49 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 1503232; Write bytes: 655243776; Read time: 149; Write time: 1967 20:06:49 INFO - TinderboxPrint: CPU usage
53.5% 20:06:49 INFO - TinderboxPrint: I/O read bytes / time
1,503,232 / 149 20:06:49 INFO - TinderboxPrint: I/O write bytes / time
655,243,776 / 1,967 20:06:49 INFO - TinderboxPrint: CPU idle
2,252.8 (46.5%) 20:06:49 INFO - TinderboxPrint: CPU system
970.5 (20.0%) 20:06:49 INFO - TinderboxPrint: CPU user
1,618.4 (33.4%) 20:06:49 INFO - TinderboxPrint: Swap in / out
350,945,280 / 0 20:06:49 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 345145856; Write bytes: 345671168; Read time: 26928; Write time: 742 20:06:49 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 634880; Write bytes: 302662656; Read time: 10; Write time: 1197 20:06:49 INFO - Running post-run listener: _upload_blobber_files 20:06:49 INFO - Blob upload gear active. 20:06:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:06:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:06:49 INFO - (blobuploader) - INFO - Open directory for files ... 20:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:51 INFO - (blobuploader) - INFO - Done attempting. 20:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:06:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:52 INFO - (blobuploader) - INFO - Done attempting. 20:06:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:06:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:06:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:54 INFO - (blobuploader) - INFO - Done attempting. 20:06:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:06:54 INFO - Return code: 0 20:06:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:06:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:06:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/378e22efe49aeb39632823b9b97b2389028aa55607081233ab336d553f0032187d16a141942b2c189d8a0b4e8c9180ec31b69ab68922d3dee6607843d3cbd565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b72ca961a9a8319184530ee279777505768ad505d43ea4db6853d197fe83d3bf8c25b5db795cb5054e8ab8bb4ce16082ad4fdabac1a53973f068af786d2c9c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5727a67105d539136770359453f304156c94ad0f10a6823f8244300a74374002c95e6ea342fe3f4d48dc3c072ec7ccc2c4801d5438b263a6006b02352e086ac9"} 20:06:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:06:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:06:54 INFO - Contents: 20:06:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/378e22efe49aeb39632823b9b97b2389028aa55607081233ab336d553f0032187d16a141942b2c189d8a0b4e8c9180ec31b69ab68922d3dee6607843d3cbd565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b72ca961a9a8319184530ee279777505768ad505d43ea4db6853d197fe83d3bf8c25b5db795cb5054e8ab8bb4ce16082ad4fdabac1a53973f068af786d2c9c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5727a67105d539136770359453f304156c94ad0f10a6823f8244300a74374002c95e6ea342fe3f4d48dc3c072ec7ccc2c4801d5438b263a6006b02352e086ac9"} 20:06:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:06:54 INFO - Copying logs to upload dir... 20:06:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:06:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.490812 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-12 20:06:54.855579) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-01-12 20:06:54.858163) ========= 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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/378e22efe49aeb39632823b9b97b2389028aa55607081233ab336d553f0032187d16a141942b2c189d8a0b4e8c9180ec31b69ab68922d3dee6607843d3cbd565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b72ca961a9a8319184530ee279777505768ad505d43ea4db6853d197fe83d3bf8c25b5db795cb5054e8ab8bb4ce16082ad4fdabac1a53973f068af786d2c9c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5727a67105d539136770359453f304156c94ad0f10a6823f8244300a74374002c95e6ea342fe3f4d48dc3c072ec7ccc2c4801d5438b263a6006b02352e086ac9"} build_url:https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010891 build_url: 'https://queue.taskcluster.net/v1/task/YckeJOzhTX2W4lHc1UFVCA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/378e22efe49aeb39632823b9b97b2389028aa55607081233ab336d553f0032187d16a141942b2c189d8a0b4e8c9180ec31b69ab68922d3dee6607843d3cbd565", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b72ca961a9a8319184530ee279777505768ad505d43ea4db6853d197fe83d3bf8c25b5db795cb5054e8ab8bb4ce16082ad4fdabac1a53973f068af786d2c9c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5727a67105d539136770359453f304156c94ad0f10a6823f8244300a74374002c95e6ea342fe3f4d48dc3c072ec7ccc2c4801d5438b263a6006b02352e086ac9"}' ========= master_lag: 3.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2017-01-12 20:06:58.145455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 20:06:58.145790) ========= 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.gJxFTwMxnP/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.VrNpYxDDYj/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.005077 ========= master_lag: 0.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 20:06:58.915968) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2017-01-12 20:06:58.921435) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2017-01-12 20:07:00.315040) ========= ========= Total master_lag: 4.39 =========