builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0220 starttime: 1471901822.96 results: success (0) buildid: 20160822121213 builduid: 5eca0f77ad5a426ea7d38940a6843265 revision: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:02.958387) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:02.958894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:02.959210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:02.988367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:02.988887) ========= 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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 --2016-08-22 14:37:02-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.21M=0.001s 2016-08-22 14:37:03 (8.21 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098416 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:03.116020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:03.116399) ========= 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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.020619 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:03.168690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-22 14:37:03.169130) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 279f5c243c49c8e955faf3b667e2fef92cfefbf0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 279f5c243c49c8e955faf3b667e2fef92cfefbf0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UNoy1Cne3g/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.LJHOHmKOYv/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 2016-08-22 14:37:03,241 truncating revision to first 12 chars 2016-08-22 14:37:03,241 Setting DEBUG logging. 2016-08-22 14:37:03,241 attempt 1/10 2016-08-22 14:37:03,241 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/279f5c243c49?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 14:37:04,843 unpacking tar archive at: autoland-279f5c243c49/testing/mozharness/ program finished with exit code 0 elapsedTime=1.858780 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-22 14:37:05.321187) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:05.321849) ========= script_repo_revision: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:05.322539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:05.322976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 14:37:05.345118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-22 14:37:05.345663) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UNoy1Cne3g/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.LJHOHmKOYv/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:37:05 INFO - MultiFileLogger online at 20160822 14:37:05 in /builds/slave/test 14:37:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:37:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:05 INFO - {'append_to_log': False, 14:37:05 INFO - 'base_work_dir': '/builds/slave/test', 14:37:05 INFO - 'blob_upload_branch': 'Autoland', 14:37:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:05 INFO - 'branch': 'Autoland', 14:37:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:05 INFO - 'config_files': ('talos/mac_config.py',), 14:37:05 INFO - 'default_actions': ('clobber', 14:37:05 INFO - 'read-buildbot-config', 14:37:05 INFO - 'download-and-extract', 14:37:05 INFO - 'populate-webroot', 14:37:05 INFO - 'create-virtualenv', 14:37:05 INFO - 'install', 14:37:05 INFO - 'run-tests'), 14:37:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:05 INFO - 'download_minidump_stackwalk': True, 14:37:05 INFO - 'download_symbols': 'ondemand', 14:37:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:05 INFO - 'installer_path': 'installer.exe', 14:37:05 INFO - 'log_level': 'info', 14:37:05 INFO - 'log_name': 'talos', 14:37:05 INFO - 'log_to_console': True, 14:37:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:37:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:37:05 INFO - 'opt_config_files': (), 14:37:05 INFO - 'pip_index': False, 14:37:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:37:05 INFO - 'cmd': ('bash', 14:37:05 INFO - '-c', 14:37:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:37:05 INFO - 'enabled': True, 14:37:05 INFO - 'halt_on_failure': False, 14:37:05 INFO - 'name': 'check_screen_resolution'},), 14:37:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:37:05 INFO - 'cmd': ('bash', 14:37:05 INFO - '-c', 14:37:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:37:05 INFO - 'enabled': True, 14:37:05 INFO - 'halt_on_failure': False, 14:37:05 INFO - 'name': 'check_screen_resolution'},), 14:37:05 INFO - 'run_cmd_checks_enabled': True, 14:37:05 INFO - 'sps_profile': False, 14:37:05 INFO - 'sps_profile_interval': 0, 14:37:05 INFO - 'suite': 'dromaeojs', 14:37:05 INFO - 'system_bits': '32', 14:37:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:05 INFO - 'title': 't-yosemite-r7-0220', 14:37:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:05 INFO - 'use_talos_json': True, 14:37:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:05 INFO - 'work_dir': 'build'} 14:37:05 INFO - [mozharness: 2016-08-22 21:37:05.529415Z] Running clobber step. 14:37:05 INFO - Running pre-action listener: _resource_record_pre_action 14:37:05 INFO - Running main action method: clobber 14:37:05 INFO - rmtree: /builds/slave/test/build 14:37:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:05 INFO - Running post-action listener: _resource_record_post_action 14:37:05 INFO - [mozharness: 2016-08-22 21:37:05.739347Z] Finished clobber step (success) 14:37:05 INFO - [mozharness: 2016-08-22 21:37:05.739509Z] Running read-buildbot-config step. 14:37:05 INFO - Running pre-action listener: _resource_record_pre_action 14:37:05 INFO - Running main action method: read_buildbot_config 14:37:05 INFO - Using buildbot properties: 14:37:05 INFO - { 14:37:05 INFO - "project": "", 14:37:05 INFO - "product": "firefox", 14:37:05 INFO - "script_repo_revision": "production", 14:37:05 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:37:05 INFO - "repository": "", 14:37:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:37:05 INFO - "buildid": "20160822121213", 14:37:05 INFO - "pgo_build": "False", 14:37:05 INFO - "basedir": "/builds/slave/test", 14:37:05 INFO - "buildnumber": 185, 14:37:05 INFO - "slavename": "t-yosemite-r7-0220", 14:37:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:37:05 INFO - "platform": "yosemite_r7", 14:37:05 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:37:05 INFO - "branch": "autoland", 14:37:05 INFO - "repo_path": "integration/autoland", 14:37:05 INFO - "revision": "279f5c243c49c8e955faf3b667e2fef92cfefbf0", 14:37:05 INFO - "stage_platform": "macosx64", 14:37:05 INFO - "builduid": "5eca0f77ad5a426ea7d38940a6843265", 14:37:05 INFO - "slavebuilddir": "test" 14:37:05 INFO - } 14:37:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 14:37:05 INFO - Running post-action listener: _resource_record_post_action 14:37:05 INFO - [mozharness: 2016-08-22 21:37:05.742462Z] Finished read-buildbot-config step (success) 14:37:05 INFO - [mozharness: 2016-08-22 21:37:05.742581Z] Running download-and-extract step. 14:37:05 INFO - Running pre-action listener: _resource_record_pre_action 14:37:05 INFO - Running main action method: download_and_extract 14:37:05 INFO - mkdir: /builds/slave/test/build/tests 14:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:05 INFO - trying https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 14:37:05 INFO - Downloading https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 14:37:06 INFO - Downloaded 1199 bytes. 14:37:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 14:37:06 INFO - Using the following test package requirements: 14:37:06 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:37:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 14:37:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 14:37:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'jsshell-mac.zip'], 14:37:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 14:37:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 14:37:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 14:37:06 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 14:37:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 14:37:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 14:37:06 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 14:37:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:06 INFO - trying https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:37:06 INFO - Downloading https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:37:07 INFO - Downloaded 16353746 bytes. 14:37:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:37:14 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:37: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')]} 14:37:14 INFO - trying https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:37:14 INFO - Downloading https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 14:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:37:15 INFO - Downloaded 16353746 bytes. 14:37:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 14:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:22 INFO - trying https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:37:22 INFO - Downloading https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 14:37:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:37:23 INFO - Downloaded 14413981 bytes. 14:37:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 14:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:23 INFO - trying https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 14:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 14:37:26 INFO - Downloaded 111464877 bytes. 14:37:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:37:26 INFO - mkdir: /builds/slave/test/properties 14:37:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:26 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:26 INFO - Contents: 14:37:26 INFO - build_url:https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 14:37:27 INFO - Running post-action listener: _resource_record_post_action 14:37:27 INFO - Running post-action listener: set_extra_try_arguments 14:37:27 INFO - [mozharness: 2016-08-22 21:37:27.378528Z] Finished download-and-extract step (success) 14:37:27 INFO - [mozharness: 2016-08-22 21:37:27.378692Z] Running populate-webroot step. 14:37:27 INFO - Running pre-action listener: _resource_record_pre_action 14:37:27 INFO - Running main action method: populate_webroot 14:37:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:27 INFO - '--tppagecycles', 14:37:27 INFO - '7'], 14:37:27 INFO - 'tests': ['tsvgm']}}, 14:37:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['damp', 'tps']}, 14:37:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'tests': ['damp', 'tps']}, 14:37:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['dromaeo_dom']}, 14:37:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['basic_compositor_video']}, 14:37:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:37:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['a11yr', 14:37:27 INFO - 'ts_paint', 14:37:27 INFO - 'tpaint', 14:37:27 INFO - 'sessionrestore', 14:37:27 INFO - 'sessionrestore_no_auto_restore', 14:37:27 INFO - 'tabpaint']}, 14:37:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tsvgx', 14:37:27 INFO - 'tsvgr_opacity', 14:37:27 INFO - 'tart', 14:37:27 INFO - 'tscrollx', 14:37:27 INFO - 'cart']}, 14:37:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:27 INFO - 'tsvgr_opacity', 14:37:27 INFO - 'tart', 14:37:27 INFO - 'tscrollx', 14:37:27 INFO - 'cart']}, 14:37:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s'], 14:37:27 INFO - 'tests': ['tp5o']}, 14:37:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'tests': ['tp5o']}, 14:37:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--disable-e10s', 14:37:27 INFO - '--xperf_path', 14:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:27 INFO - 'tests': ['tp5n']}, 14:37:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:37:27 INFO - 'talos_options': ['--xperf_path', 14:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:27 INFO - 'tests': ['tp5n']}}, 14:37:27 INFO - 'talos.zip': {'path': '', 14:37:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:27 INFO - Running post-action listener: _resource_record_post_action 14:37:27 INFO - [mozharness: 2016-08-22 21:37:27.397319Z] Finished populate-webroot step (success) 14:37:27 INFO - [mozharness: 2016-08-22 21:37:27.397427Z] Running create-virtualenv step. 14:37:27 INFO - Running pre-action listener: _resource_record_pre_action 14:37:27 INFO - Running main action method: create_virtualenv 14:37:27 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:37:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:27 INFO - Using real prefix '/tools/python27' 14:37:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:28 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:31 INFO - Installing pip.................done. 14:37:31 INFO - Return code: 0 14:37:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:31 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:31 INFO - 'HOME': '/Users/cltbld', 14:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:31 INFO - 'LOGNAME': 'cltbld', 14:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:31 INFO - 'MOZ_NO_REMOTE': '1', 14:37:31 INFO - 'NO_EM_RESTART': '1', 14:37:31 INFO - 'PAGER': '/bin/cat', 14:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:31 INFO - 'PWD': '/builds/slave/test', 14:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:31 INFO - 'SHELL': '/bin/bash', 14:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:31 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:31 INFO - 'USER': 'cltbld', 14:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:31 INFO - 'XPC_FLAGS': '0x0', 14:37:31 INFO - 'XPC_SERVICE_NAME': '0', 14:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:37:31 INFO - Cleaning up... 14:37:31 INFO - Return code: 0 14:37:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37: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')]} 14:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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')]} 14:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:31 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:31 INFO - 'HOME': '/Users/cltbld', 14:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:31 INFO - 'LOGNAME': 'cltbld', 14:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:31 INFO - 'MOZ_NO_REMOTE': '1', 14:37:31 INFO - 'NO_EM_RESTART': '1', 14:37:31 INFO - 'PAGER': '/bin/cat', 14:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:31 INFO - 'PWD': '/builds/slave/test', 14:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:31 INFO - 'SHELL': '/bin/bash', 14:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:31 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:31 INFO - 'USER': 'cltbld', 14:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:31 INFO - 'XPC_FLAGS': '0x0', 14:37:31 INFO - 'XPC_SERVICE_NAME': '0', 14:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:31 INFO - Downloading/unpacking psutil>=3.1.1 14:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:35 INFO - Installing collected packages: psutil 14:37:35 INFO - Running setup.py install for psutil 14:37:35 INFO - building 'psutil._psutil_osx' extension 14:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:37:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:37:35 INFO - building 'psutil._psutil_posix' extension 14:37:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:37:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:37:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:37:35 INFO - ^ 14:37:35 INFO - 1 warning generated. 14:37:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:37:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:35 INFO - Successfully installed psutil 14:37:35 INFO - Cleaning up... 14:37:35 INFO - Return code: 0 14:37:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:35 INFO - 'HOME': '/Users/cltbld', 14:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:35 INFO - 'LOGNAME': 'cltbld', 14:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:35 INFO - 'MOZ_NO_REMOTE': '1', 14:37:35 INFO - 'NO_EM_RESTART': '1', 14:37:35 INFO - 'PAGER': '/bin/cat', 14:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:35 INFO - 'PWD': '/builds/slave/test', 14:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:35 INFO - 'SHELL': '/bin/bash', 14:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:35 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:35 INFO - 'USER': 'cltbld', 14:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:35 INFO - 'XPC_FLAGS': '0x0', 14:37:35 INFO - 'XPC_SERVICE_NAME': '0', 14:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:38 INFO - Installing collected packages: mozsystemmonitor 14:37:38 INFO - Running setup.py install for mozsystemmonitor 14:37:38 INFO - Successfully installed mozsystemmonitor 14:37:38 INFO - Cleaning up... 14:37:38 INFO - Return code: 0 14:37:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37: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==2.5.1'] in /builds/slave/test/build 14:37: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==2.5.1 14:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:38 INFO - 'HOME': '/Users/cltbld', 14:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:38 INFO - 'LOGNAME': 'cltbld', 14:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:38 INFO - 'MOZ_NO_REMOTE': '1', 14:37:38 INFO - 'NO_EM_RESTART': '1', 14:37:38 INFO - 'PAGER': '/bin/cat', 14:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:38 INFO - 'PWD': '/builds/slave/test', 14:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:38 INFO - 'SHELL': '/bin/bash', 14:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:38 INFO - 'USER': 'cltbld', 14:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:38 INFO - 'XPC_FLAGS': '0x0', 14:37:38 INFO - 'XPC_SERVICE_NAME': '0', 14:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:42 INFO - warning: no files found matching '*.txt' 14:37:42 INFO - no previously-included directories found matching 'build' 14:37:42 INFO - no previously-included directories found matching 'dist' 14:37:42 INFO - no previously-included directories found matching '.git*' 14:37:42 INFO - Installing collected packages: jsonschema, functools32 14:37:42 INFO - Running setup.py install for functools32 14:37:42 INFO - warning: no files found matching '*.txt' 14:37:42 INFO - no previously-included directories found matching 'build' 14:37:42 INFO - no previously-included directories found matching 'dist' 14:37:42 INFO - no previously-included directories found matching '.git*' 14:37:42 INFO - Successfully installed jsonschema functools32 14:37:42 INFO - Cleaning up... 14:37:42 INFO - Return code: 0 14:37:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:42 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:42 INFO - 'HOME': '/Users/cltbld', 14:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:42 INFO - 'LOGNAME': 'cltbld', 14:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:42 INFO - 'MOZ_NO_REMOTE': '1', 14:37:42 INFO - 'NO_EM_RESTART': '1', 14:37:42 INFO - 'PAGER': '/bin/cat', 14:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:42 INFO - 'PWD': '/builds/slave/test', 14:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:42 INFO - 'SHELL': '/bin/bash', 14:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:42 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:42 INFO - 'USER': 'cltbld', 14:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:42 INFO - 'XPC_FLAGS': '0x0', 14:37:42 INFO - 'XPC_SERVICE_NAME': '0', 14:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:37:42 INFO - Cleaning up... 14:37:42 INFO - Return code: 0 14:37:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:42 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:37:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:37:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:42 INFO - 'HOME': '/Users/cltbld', 14:37:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:42 INFO - 'LOGNAME': 'cltbld', 14:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:42 INFO - 'MOZ_NO_REMOTE': '1', 14:37:42 INFO - 'NO_EM_RESTART': '1', 14:37:42 INFO - 'PAGER': '/bin/cat', 14:37:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:42 INFO - 'PWD': '/builds/slave/test', 14:37:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:42 INFO - 'SHELL': '/bin/bash', 14:37:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:42 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:42 INFO - 'USER': 'cltbld', 14:37:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:42 INFO - 'XPC_FLAGS': '0x0', 14:37:42 INFO - 'XPC_SERVICE_NAME': '0', 14:37:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:46 INFO - Downloading docopt-0.6.1.tar.gz 14:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:46 INFO - Running setup.py install for blobuploader 14:37:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:46 INFO - Running setup.py install for requests 14:37:47 INFO - Running setup.py install for docopt 14:37:47 INFO - Successfully installed blobuploader requests docopt 14:37:47 INFO - Cleaning up... 14:37:47 INFO - Return code: 0 14:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:47 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:47 INFO - 'HOME': '/Users/cltbld', 14:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:47 INFO - 'LOGNAME': 'cltbld', 14:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:47 INFO - 'MOZ_NO_REMOTE': '1', 14:37:47 INFO - 'NO_EM_RESTART': '1', 14:37:47 INFO - 'PAGER': '/bin/cat', 14:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:47 INFO - 'PWD': '/builds/slave/test', 14:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:47 INFO - 'SHELL': '/bin/bash', 14:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:47 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:47 INFO - 'USER': 'cltbld', 14:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:47 INFO - 'XPC_FLAGS': '0x0', 14:37:47 INFO - 'XPC_SERVICE_NAME': '0', 14:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-t0d1hS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Inrxi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-pLUtwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-QrIqF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zNA9Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VFUZcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vQoOiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-QFF97v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-hxynaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lBhenI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-YRse0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-J3Up6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-UPVMn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-OxDFGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-FtYn25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-liT33I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:49 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mDrq4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:37:49 INFO - Running setup.py install for manifestparser 14:37:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:37:49 INFO - Running setup.py install for mozcrash 14:37:49 INFO - Running setup.py install for mozdebug 14:37:49 INFO - Running setup.py install for mozdevice 14:37:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Running setup.py install for mozfile 14:37:50 INFO - Running setup.py install for mozhttpd 14:37:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Running setup.py install for mozinfo 14:37:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Running setup.py install for mozInstall 14:37:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:37:50 INFO - Running setup.py install for mozleak 14:37:50 INFO - Running setup.py install for mozlog 14:37:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:37:51 INFO - Running setup.py install for moznetwork 14:37:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:37:51 INFO - Running setup.py install for mozprocess 14:37:51 INFO - Running setup.py install for mozprofile 14:37:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:37:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:37:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:37:51 INFO - Running setup.py install for mozrunner 14:37:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:37:51 INFO - Running setup.py install for mozscreenshot 14:37:51 INFO - Running setup.py install for moztest 14:37:51 INFO - Running setup.py install for mozversion 14:37:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:37:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:37:52 INFO - Cleaning up... 14:37:52 INFO - Return code: 0 14:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:52 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:52 INFO - 'HOME': '/Users/cltbld', 14:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:52 INFO - 'LOGNAME': 'cltbld', 14:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:52 INFO - 'MOZ_NO_REMOTE': '1', 14:37:52 INFO - 'NO_EM_RESTART': '1', 14:37:52 INFO - 'PAGER': '/bin/cat', 14:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:52 INFO - 'PWD': '/builds/slave/test', 14:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:52 INFO - 'SHELL': '/bin/bash', 14:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:52 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:52 INFO - 'USER': 'cltbld', 14:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:52 INFO - 'XPC_FLAGS': '0x0', 14:37:52 INFO - 'XPC_SERVICE_NAME': '0', 14:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-cvC28q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-GISg4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Ked5k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Q6_5OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:52 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)) 14:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-icTOEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-FTbfbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1glrnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-McFlIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-hKXaDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-z5sXn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-aWd8Hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VUOrTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:53 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)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-fMK6nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-tZ08Uw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-axK9tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-YPdXWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:54 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ObVUMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:37:54 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)) 14:37:54 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)) 14:37:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:56 INFO - Downloading blessings-1.6.tar.gz 14:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:37:56 INFO - Installing collected packages: blessings 14:37:56 INFO - Running setup.py install for blessings 14:37:56 INFO - Successfully installed blessings 14:37:56 INFO - Cleaning up... 14:37:56 INFO - Return code: 0 14:37:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:57 INFO - Reading from file tmpfile_stdout 14:37:57 INFO - Current package versions: 14:37:57 INFO - blessings == 1.6 14:37:57 INFO - blobuploader == 1.2.4 14:37:57 INFO - docopt == 0.6.1 14:37:57 INFO - functools32 == 3.2.3-2 14:37:57 INFO - jsonschema == 2.5.1 14:37:57 INFO - manifestparser == 1.1 14:37:57 INFO - mozInstall == 1.12 14:37:57 INFO - mozcrash == 0.17 14:37:57 INFO - mozdebug == 0.1 14:37:57 INFO - mozdevice == 0.48 14:37:57 INFO - mozfile == 1.2 14:37:57 INFO - mozhttpd == 0.7 14:37:57 INFO - mozinfo == 0.9 14:37:57 INFO - mozleak == 0.1 14:37:57 INFO - mozlog == 3.3 14:37:57 INFO - moznetwork == 0.27 14:37:57 INFO - mozprocess == 0.23 14:37:57 INFO - mozprofile == 0.28 14:37:57 INFO - mozrunner == 6.12 14:37:57 INFO - mozscreenshot == 0.1 14:37:57 INFO - mozsystemmonitor == 0.3 14:37:57 INFO - moztest == 0.7 14:37:57 INFO - mozversion == 1.4 14:37:57 INFO - psutil == 3.1.1 14:37:57 INFO - requests == 1.2.3 14:37:57 INFO - wsgiref == 0.1.2 14:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:57 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:57 INFO - 'HOME': '/Users/cltbld', 14:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:57 INFO - 'LOGNAME': 'cltbld', 14:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:57 INFO - 'MOZ_NO_REMOTE': '1', 14:37:57 INFO - 'NO_EM_RESTART': '1', 14:37:57 INFO - 'PAGER': '/bin/cat', 14:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:57 INFO - 'PWD': '/builds/slave/test', 14:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:57 INFO - 'SHELL': '/bin/bash', 14:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:57 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:57 INFO - 'USER': 'cltbld', 14:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:57 INFO - 'XPC_FLAGS': '0x0', 14:37:57 INFO - 'XPC_SERVICE_NAME': '0', 14:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:37:57 INFO - Cleaning up... 14:37:57 INFO - Return code: 0 14:37:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:57 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 0x10d2e0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d375618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcef8c7dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, '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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:37:57 INFO - 'HOME': '/Users/cltbld', 14:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:37:57 INFO - 'LOGNAME': 'cltbld', 14:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:57 INFO - 'MOZ_NO_REMOTE': '1', 14:37:57 INFO - 'NO_EM_RESTART': '1', 14:37:57 INFO - 'PAGER': '/bin/cat', 14:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:57 INFO - 'PWD': '/builds/slave/test', 14:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:37:57 INFO - 'SHELL': '/bin/bash', 14:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:37:57 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:37:57 INFO - 'USER': 'cltbld', 14:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:57 INFO - 'XPC_FLAGS': '0x0', 14:37:57 INFO - 'XPC_SERVICE_NAME': '0', 14:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:37:57 INFO - Cleaning up... 14:37:57 INFO - Return code: 0 14:37:57 INFO - Running post-action listener: _resource_record_post_action 14:37:57 INFO - Running post-action listener: _start_resource_monitoring 14:37:57 INFO - Starting resource monitoring. 14:37:57 INFO - [mozharness: 2016-08-22 21:37:57.799341Z] Finished create-virtualenv step (success) 14:37:57 INFO - [mozharness: 2016-08-22 21:37:57.800296Z] Running install step. 14:37:57 INFO - Running pre-action listener: _resource_record_pre_action 14:37:57 INFO - Running main action method: install 14:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:58 INFO - Reading from file tmpfile_stdout 14:37:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:37:58 INFO - Reading from file tmpfile_stdout 14:37:58 INFO - Output received: 14:37:58 INFO - Usage: mozinstall [options] installer 14:37:58 INFO - Options: 14:37:58 INFO - -h, --help show this help message and exit 14:37:58 INFO - -d DEST, --destination=DEST 14:37:58 INFO - Directory to install application into. [default: 14:37:58 INFO - "/builds/slave/test"] 14:37:58 INFO - --app=APP Application being installed. [default: firefox] 14:37:58 INFO - mkdir: /builds/slave/test/build/application 14:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:38:33 INFO - Reading from file tmpfile_stdout 14:38:33 INFO - Output received: 14:38:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:38:33 INFO - Running post-action listener: _resource_record_post_action 14:38:33 INFO - [mozharness: 2016-08-22 21:38:33.788066Z] Finished install step (success) 14:38:33 INFO - [mozharness: 2016-08-22 21:38:33.788212Z] Running run-tests step. 14:38:33 INFO - Running pre-action listener: _resource_record_pre_action 14:38:33 INFO - Running main action method: run_tests 14:38:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:38:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:38:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:38:33 INFO - 2016-08-22 14:38:33.803 screenresolution[1997:278956] starting screenresolution argv=screenresolution get 14:38:33 INFO - 2016-08-22 14:38:33.805 screenresolution[1997:278956] Display 0: 1600x1200x32@60 14:38:33 INFO - 2016-08-22 14:38:33.812 screenresolution[1998:278958] starting screenresolution argv=screenresolution list 14:38:33 INFO - Available Modes on Display 0 14:38:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:38:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:38:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:38:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:38:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:38:34 INFO - Intel Iris: 14:38:34 INFO - Chipset Model: Intel Iris 14:38:34 INFO - Type: GPU 14:38:34 INFO - Bus: Built-In 14:38:34 INFO - VRAM (Dynamic, Max): 1536 MB 14:38:34 INFO - Vendor: Intel (0x8086) 14:38:34 INFO - Device ID: 0x0a2e 14:38:34 INFO - Revision ID: 0x0009 14:38:34 INFO - Displays: 14:38:34 INFO - Display: 14:38:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:38:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:38:34 INFO - Display Serial Number: 1600x1200 60 14:38:34 INFO - Main Display: Yes 14:38:34 INFO - Mirror: Off 14:38:34 INFO - Online: Yes 14:38:34 INFO - Rotation: Supported 14:38:34 INFO - Return code: 0 14:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:34 INFO - Python 2.7.3 14:38:34 INFO - Return code: 0 14:38:34 INFO - grabbing minidump binary from tooltool 14:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:34 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 0x10d244d30>, '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 0x10cfa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d23cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:38:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:38:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:38:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:34 INFO - Return code: 0 14:38:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:38:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:38:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 14:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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 14:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UNoy1Cne3g/Render', 14:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:34 INFO - 'HOME': '/Users/cltbld', 14:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:34 INFO - 'LOGNAME': 'cltbld', 14:38:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:34 INFO - 'MOZ_NO_REMOTE': '1', 14:38:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:34 INFO - 'NO_EM_RESTART': '1', 14:38:34 INFO - 'PAGER': '/bin/cat', 14:38:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:34 INFO - 'PWD': '/builds/slave/test', 14:38:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:34 INFO - 'SHELL': '/bin/bash', 14:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LJHOHmKOYv/Listeners', 14:38:34 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 14:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:34 INFO - 'USER': 'cltbld', 14:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:34 INFO - 'XPC_FLAGS': '0x0', 14:38:34 INFO - 'XPC_SERVICE_NAME': '0', 14:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 14:38:34 INFO - mozversion application_buildid: 20160822121213 14:38:34 INFO - mozversion application_changeset: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 14:38:34 INFO - mozversion application_display_name: Nightly 14:38:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:34 INFO - mozversion application_name: Firefox 14:38:34 INFO - mozversion application_remotingname: firefox 14:38:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:38:34 INFO - mozversion application_vendor: Mozilla 14:38:34 INFO - mozversion application_version: 51.0a1 14:38:34 INFO - mozversion platform_buildid: 20160822121213 14:38:34 INFO - mozversion platform_changeset: 279f5c243c49c8e955faf3b667e2fef92cfefbf0 14:38:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:38:34 INFO - mozversion platform_version: 51.0a1 14:38:34 INFO - using testdate: 1471901914 14:38:34 INFO - actual date: 1471901914 14:38:34 INFO - starting webserver on 'localhost:49389' 14:38:34 INFO - SUITE-START | Running 2 tests 14:38:34 INFO - TEST-START | dromaeo_css 14:38:34 INFO - operating with platform_type : mac_ 14:38:34 INFO - Initialising browser for dromaeo_css test... 14:38:34 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpo6Wn9F/profile http://localhost:49389/getInfo.html) 14:38:37 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 14:38:37 INFO - PROCESS | 2008 | colorDepth:24 14:38:37 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 14:38:37 INFO - PROCESS | 2008 | __metrics 14:38:37 INFO - PROCESS | 2008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:38:37 INFO - PROCESS | 2008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:38:37 INFO - TEST-INFO | 2008: exit 0 14:38:37 INFO - Browser initialized. 14:38:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:37 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpo6Wn9F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:49 INFO - PROCESS | 2012 | RSS: Main: 228335616 14:38:49 INFO - PROCESS | 2012 | 14:39:40 INFO - PROCESS | 2012 | 1471901980798 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:41:52 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49389/tests/dromaeo/cssquery-ext.html) 14:41:54 INFO - PROCESS | 2012 | RSS: Main: 325767168 14:41:54 INFO - PROCESS | 2012 | 14:44:57 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-ext.html (next: http://localhost:49389/tests/dromaeo/cssquery-jquery.html) 14:44:58 INFO - PROCESS | 2012 | RSS: Main: 376414208 14:44:58 INFO - PROCESS | 2012 | 14:48:00 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49389/tests/dromaeo/cssquery-mootools.html) 14:48:01 INFO - PROCESS | 2012 | RSS: Main: 365723648 14:48:01 INFO - PROCESS | 2012 | 14:51:03 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49389/tests/dromaeo/cssquery-prototype.html) 14:51:04 INFO - PROCESS | 2012 | RSS: Main: 347381760 14:51:04 INFO - PROCESS | 2012 | 14:54:07 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49389/tests/dromaeo/cssquery-yui.html) 14:54:08 INFO - PROCESS | 2012 | RSS: Main: 332083200 14:54:08 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-yui.html (next: http://localhost:49389/tests/dromaeo/cssquery-dojo.html) 14:57:11 INFO - PROCESS | 2012 | RSS: Main: 514572288 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | __start_tp_report 14:57:11 INFO - PROCESS | 2012 | _x_x_mozilla_page_load 14:57:11 INFO - PROCESS | 2012 | _x_x_mozilla_page_load_details 14:57:11 INFO - PROCESS | 2012 | |i|pagename|runs| 14:57:11 INFO - PROCESS | 2012 | |0;dojo.html;3332.733381329493;3356.305065941699;3361.983190084051;3377.121948293443;3387.6612338766126;5682.687452190138;5753.971230143843;5788.884222315552;5912.911306330403;5935;5722.084466485363;5816.185733997233;5880.117982302657;5900.11498275259;5927.110933359998;5181.1710126379785;5226.3989641191365;5250.396204436482;5266.605004624649;5353.812616558421;5390.460953904618;5413.458654134574;5418.268533747933;5430.185472179185;5445.618806683534;5305.602079844008;5310.495502927254;5325.973370133163;5343.545798607103;5362.8123015694455;5129.974350128263;5150.27896094547;5213.4525874782985;5232.319798426218;5251.396089449724;5258.0535503609335;5258.842234732964;5293.285406470116;5302.549283310923;5304.840854774363;5792.913106303409;5843.590948633555;5847.976604094267;5854.092615644582;5914.585978981473;6150.323464418911;6235.438810507076;6237.376262373727;6272.843178920518;6299.992001279773;6153.661548614825;6227.532935029845;6240.719167637467;6245.718942647592;6269.905951410732;5899.852503687443;5966.850828729273;5973.432523910222;5980.22257106582;5992.34084250732;6189.597676151036;6211.378862113843;6220.564560480813;6221.5333849961435;6296.401841825111;6246.781362652286;6285.622862628257;6302.716377763011;6303;6305.747770089237;6235.127082208494;6255.280642726054;6263.248410190807;6270.996640537492;6273.96863015682;6086.452219300196;6217.96891015542;6252.062190671436;6272.560920735505;6318.873622527615;6296.685165741695;6313.842153946096;6322.272938612026;6322.399372059647;6330.145430366933;5060.1903695408555;5070.873228169326;5074.49255074497;5079.009593129378;5079.466656001141;4381.211381951216;4415.2935530315;4455.732656040648;4478.664100192498;4520.864374068783;5736.483716465538;5820.563457740686;5845.976954033027;5848.88302233953;5849.824505264849;6162.969185154136;6165.72254248551;6232.439080482778;6250;6252.343503932113;5618.410066942994;5685;5783.71081445926;5824.650520968756;5830.212921255661;4974.477679843564;5246.291750613695;5498.670079795225;5501.229827824108;5508.9724551376985;6342;6349.68251587428;6362.204724409449;6365.96817015912;6379.585326953733;6120.784812895933;6260.154879091265;6271.43557079865;6275.184226050585;6296.590721603081;6217.036359364306;6259.78090766821;6282.623042617458;6284.654344010941;6308.4322410981395;6188;6222.968885155546;6225.937740622536;6228.968855155877;6235.812925612057;5999.820005399845;6123.601965872204;6276.748930042747;6282.246130464374;6287.53584954669;6070.878582428415;6130.785422510369;6187.690615469299;6246.968765156327;6277.843053923689;6216.440520353009;6223.222097237845;6226.25284965807;6229.906551401642;6254.249490061222;5803.100519419497;6059.72731227087;6075.605085669417;6075.908861367171;6085.421884920926;6085.361037091042;6138.877222455615;6170.50635949132;6245.375462453719;6250.874982500233;6020.638761674313;6100.8779824404155;6111.266648002268;6115.938840611537;6132 14:57:11 INFO - PROCESS | 2012 | |1;ext.html;445.40093574142776;485.54116360039757;517.2396577031765;532.8987492376449;548.019045907825;29305.120846374615;29984.55023174654;31408.842955785247;31461.21346966327;39025.219495610145;39255.80372098143;41815.37276940848;41895.58104418955;41929;41978;9664.468454235015;9823.312368134233;9824.164945979564;9828.017198280186;9878.753031174243;8634.870476942851;8891.244244239248;9649.614015439409;9766.218702503782;9776.266779991494;11707.882921170807;11979.101567382437;12004.459799309008;12201.084918631093;12248.755024899496;10619.097376722988;11788.821117888228;11880.465379057963;11963.820542691867;11972.161948663597;11737.94131029348;11813.763724725542;11817;11819.645410637695;11822.113341499336;39050.80474597637;39184.60815391838;39286;39305;39449.40825887614;3581.767185132984;3652.926941461156;3699.8890033298776;3707.8146092695256;3903.180332130256;30357.696423035708;30643.233919151975;30673.69326306753;31130.37739245225;31944.923579967228;3272.983635081833;3273.394422031908;3275.5414242006136;3278.557394751702;3390.2880395117054;519021;520589;524411.3779431117;655244.8181736344;656112;52192;60677.69661151666;61326.386736132066;61358.0796288056;61430.69284653548;33697.66302336945;34717.47923781145;64057;64373.35626643767;64498.35501645017;16330.591735206477;16520.504384868233;16539.338426463048;16554.917225413796;16568.75146872798;12673.04952128594;12771.361431928552;12779.808302875465;12808.103432759617;12835.422405991752;13657.521986730615;16053.67892642164;16349;16846.663066738598;18637.161327740283;6717.899231511531;6947.756828510978;6989.650517474106;8078.151794061539;8240.587970601446;833.9791505212297;934.7102398256562;965.7392504023874;979.5347210075299;993.2352088891513;28964.71035289662;29596.408071838443;29992.400151996837;30611.38777224443;30750.84624576863;897.5871099294397;1030.2735827540719;1091.4324551233315;1126.5775334249656;1129.9378534180698;15007.699846003019;15621.687566248838;15642.45251416195;15699.764503532457;16105.114218718083;692296;702842;703436;703602;707621;46804.76597617058;51915.480845191065;52981.47018529765;57465.71267143638;58476;1336.652470357714;1361.3057340756088;1385.1550554162154;1389.4164450930634;1393.7560926837764;29981.028447369845;30711.692883070882;31019.53470697896;31209.063728088193;31465.21336966594;46966;47240.7637961808;47425.52574474211;47444;47621.28568071412;418103.4655148343;422907;456783;468520;468775;40202.798986006055;41370.1725965485;41452.37821432621;41649.58350416457;41834.163316732884;45668.314975274734;46159.76920115378;46300.8424789383;46524.76737616426;46877.53122468868;37699.62300377071;37805.43291850569;38175.80912095422;38906.02734931649;39790.2041959165;38413.80793096017;38548.80725596354;38848.2230355397;39733.80133099316;40764.18471630492;37884;38772.6122738769;39192.80403598078;39227.215455691294;39244.822655320386;31760.523592146597;34337.97918039465;34507.65492345044;34641.30717385688;35083.7720679775;25401.872990635668;25432.364190895376;25589.3602659935;25726.8713656438;25866.224013279632 14:57:11 INFO - PROCESS | 2012 | |2;jquery.html;349.8443192779211;365.68002997377295;371.088976562539;372.6571554170164;397.620272639629;14879.404823807048;15348.923255383721;20735.481612959684;21061.368158955254;22183.334499964985;20479.283225087125;21096.68354974673;21705.782942170572;21791.45521361967;21970.231041913536;5850.765969361231;6204.689765511729;6206.131141640174;6221;6225.5019598432245;5790.565707571928;5980.342162362137;6053.848653783669;6061.15143879855;6063.666498342589;5971.5222782177325;5985.461308482236;5989.610675306113;5989.940100599004;6017.308009578889;5790.652560846342;6014.578979471439;6085.786997455068;6096.878062438771;6114.694265286718;5194.792208311701;5213.113770658997;5288;5298.735063246822;5308.336457942757;26908.327291817666;26964.730352696613;27024.1892743218;27299.727002729916;27456.725432745618;2106.852520323578;2357.351728274721;2369.324742448394;2507.6489291499206;2512;14956.62608434787;15635.609109772233;15808.051516909023;16129.354825806953;16324.347026118941;1636.5271255869814;1829.8536117110732;1878.0421984787856;1896.6586014517381;1909.6085302512952;101473.4926325371;112988.87011129866;114846.99999999917;115629;117816;10708.839367409495;10820.67537973862;11005;11285.943570282261;11532.942335288437;10536.735591728888;11831.2901225925;12536;12557.434915428828;13171;8345.749627511184;8477.025142108736;8528.275096616733;8669.21977022071;8715.128487151362;7340.743073992491;8672.69645562415;8676.262517686067;8705.738827835048;8784.91215087841;6279.7488100476385;6374.872502549923;6380.7447702091395;6385.744570217233;6464.25661048976;1807.593291509426;1829.268292682911;1829.3231504343212;1831.7985021647607;1834.7706536682915;868.0971789339017;951.167728237792;970.839811431106;989.5744829723144;1005.6731562242301;17684.057697184235;20320.796792032186;22324.995375208153;22444;22527.662085068736;895.9507227102572;921.870938068671;954.5275088831073;993.3443927008284;1037.7976294622476;9336.673216437528;10742.409167495707;11610.76778464443;11719.765604687858;11758.58844940423;606362;609261;614911;621921;622313;120564.79435205711;120609.39695301467;121721.39139304248;123811.52376952411;126708;989.7278248481725;992.5235886774389;1003.0220534978338;1006.6476733143342;1008.8890222075565;19204.943728095088;19914.00429978466;19919.800801991794;19958.50103747418;19968.800311996692;50231.74884125556;51378.71553211199;52533.68665783386;53582;53926.73036634792;57808.71095644495;72968.54062918818;74634.25365746273;75516.62241688756;76015.85976210472;5363.356397232357;5592.524635405874;7886.408519361185;7986.041674999037;8113;13451.327433628476;13495;13502.392392342172;13815.378307976367;13828.861711382757;11474.311541307548;11482.483288252215;11647.12646551529;11798.52805887755;11929.701757456132;11436;11444.542218311175;11467.426628668367;11493.310401375944;11787.705307367385;11578.594749183738;11653.126015548698;11879.168458207843;11942.462589183333;12051.216670916363;7826.334761545332;8096.190380961857;8142.226488483585;8243.422960392954;8268.545230012407;11036.061934735637;11337.093032557541;11356.712646203796;11714.70713232176;11815.645530634094 14:57:11 INFO - PROCESS | 2012 | |3;mootools.html;1366.583192126401;1408.1128888800054;1498.7377208988423;1646.6953613581488;1850.6668799616064;7742.187070357616;8182.386321025924;8191.180881911806;8206.015278166627;8223.547704876237;8368.958155209215;8494.108118647546;8653.956730216356;8723.607437665305;8732.912670873306;2357.941051473714;2392.83250172488;2396;2399.3761621978324;2403.9639405408934;2320.2459200759736;2366.5858474766933;2374.9287521374386;2376.120835290945;2381.1070848431837;2334.171369163948;2346.7066616672914;2357.3752955466816;2377.619580867062;2378.0844374915696;2318.5826551220775;2342.484653376263;2347.6713260143592;2353.6351865460797;2371.4190023444194;2304.4584522637165;2340.169239919838;2346.5189636124555;2348.330725743155;2350.142198097682;8612.52631105289;8801.591745320718;8825.911740882573;8838.69064582743;8853.557322133867;5105.336306280197;5131.948680513185;5275.28783614211;5281.12861377876;5283.86790330241;3191.329820737648;3589.892303230881;3690.926181476382;3694.7783133012103;3702.4816525686424;1068.6793961811425;1076.95692172313;1101.752105776202;1107.2028139739455;1107.9224454288203;10770.138388928866;10849.566017359297;11579.768404631945;11680.182387232897;11681.415929203591;4416.712913660602;4453.398791163217;4528.41130653013;4589.4722106958125;4589.58693717567;9075.636974521078;9105.499197544199;9142.177204051533;9149.176574108229;9150.679726209552;5211.2443695663915;5216.478352164753;5218.112920803396;5233.5551478124025;5236.083685355047;4394.516603173648;4410.977945110318;4722.291656251589;4873.707577545359;4885.682430641997;3692.6122757110115;3756.417755247941;3784.299904517618;3842.9615703843165;3844.8654297100024;1009.5961615353771;1177.3524561491145;1181.5569161564413;1181.6868529839599;1195.820626905971;645.8191706322237;761.7486229544237;895.7536677413764;904.5838914099456;917.7797328641211;5796.1595568642315;5894.793682221188;5896.321922978912;6107.175531303306;6142.170806941095;897.3673560140086;938.877945867033;954.737447202025;981.7938232971013;1019.0421004255976;3524.8766293179615;3860.652541271299;3906;3974.6621537169663;4050.9594904051173;10588.258821882395;11071.05895998833;11109.83335249972;11112.666620001413;11124.888751112547;10998.835017474745;11030.22788404804;11035.944820275847;11050.226484146033;11056.11551075912;7662.272084151997;7974.16271291506;8271.751847444466;8380.036295826058;8382.538960357238;5922.230110085834;5947.3457919627945;5982.132590774227;6067.453929146398;6141.907871382022;8793.472391656522;9712.5143742814;10236.33463824849;10253.846192306972;10270.178385728974;9842.065003824626;10234.33476824004;10236.692899213036;10350.792984140426;10436.269461137648;6913.827154321182;7144.714211431485;7383.593902335208;7537.8115547111765;7709.845803084019;8234.917650823416;8538.359623028173;8570.700025499078;8575.571221438779;8590.398672092893;7405.411339660859;7526.09686837583;7540.17058123617;7564.167941526538;7677;7271.127464704269;7402.1117465904435;7441.181470038183;7467.92532074694;7604.391648667983;6911.965440172767;7054.506184567236;7068.257832927674;7074.434045276468;7075.009498670087;4837.830675926326;4901.58336541398;4953.157963146202;4980.676256043345;5101.464346243591;4989.979058481321;5026.195808670595;5178.042062218502;5181.145111056633;5310.442403547727 14:57:11 INFO - PROCESS | 2012 | |4;prototype.html;261.3831357995131;295.74418128318996;309.3766061386307;312.3830434891092;315.5345864849346;4066.471358723362;4618.515055919131;5056.494350564942;5329.120695085311;5363.471410647966;4890.8777280568;4971.825986090487;4974.8258810941625;5161.406438259602;5239.371275446952;3624.4563315502755;3918.314294998378;4064.532578753437;4070.4708387909604;4127.401526778615;3322.302316513535;3452.4476083826594;3839.8864329344456;4122.464684219213;4133.5659755725665;3585.390483617778;3664.9633503665023;3822.2928758179687;4052.4326594276827;4098.549159592442;3535.982320088409;3838.673712734421;4035.9192816143805;4039.010442441606;4053.898652533681;3523.3222750709388;3534.6642069003406;3539.3098345822573;3553.218291975787;3563.5901871284873;3889.8444062237477;4261.4673165854265;4970.378702662168;5183.50756678115;5188.469401526559;3949.822257998397;4199.648197009685;4636.4899861015265;4653.045720797273;4698.412698412699;5477.370102438231;5500.724963751836;5537.750801213955;5544.033941841096;5567.47109024642;3900.3369427197445;3928.823202955874;3947.4276229946786;3955.46601208836;3964.5044369453817;5151.793928242866;5302.602304827154;5795.797147099831;5822.621529600562;5863.182413451844;3943.0930885896405;3974.344233201547;3993.5806740292433;4001.6998725095737;4031.4680421440253;4045.453863728359;4048.8582899598373;4056.4320995060716;4067.511898572131;4068.349064149722;3708.962910370916;4314.654827613784;4466.307722303049;4679.4618618858585;4712.2224832902875;5172.793088276427;5238.454655876526;5555.944440555623;5584.91622625661;5597.916031259534;1336.3385124363501;1347.7465956660203;1387.67389663429;1397.7280674586282;1403.2352367959284;749.4978364495801;790.6639678136769;870.5331516394895;892.5983307511646;933.1788026536605;4485.439320084989;5092.516210959953;5107.821226257138;5117.616178786531;5146.639735218499;4745.383100196952;5658.066419040894;5689.345725241567;5718.228039214653;5726.312842458931;4042.0501182222156;4766.165920963817;4905.337779399735;5066.48005598319;5071.503906347636;2518.848869067862;3050.710182532656;3065.75836786102;3086.1667349815425;3098.411301852641;5037.7733002014265;5959.28488581373;6007.068904319837;6086.2696476422225;6086.543509236825;4625.838095666635;5712.257406537124;5910.645361278337;6011.849703757441;6101.84745381369;5385.057614917374;5584.329880414376;6030.939690603125;6066.363031881677;6118.143459915705;5566.220729097849;5640.548756099584;5779.653220806765;5823.330317013429;5833.941660583339;4844.135008021866;5104.438511763628;5768.7404066817935;5776.335721392094;5784.855378615568;5064.797408103635;6011.827693599706;6017.638941663514;6023;6032.461722260796;3502.7249521697295;3520.2783429397423;3883.5339759229073;3906.980465097656;3954.9209015818947;4451.132029254394;5642.852503410072;5875.500582450369;5929.199558059607;5953.761849526144;5266.631335806457;5433.945660543344;5521.834344969658;5787.668836167621;5810.1575271586225;4924.778384972613;5342.866428339323;5489.258950041693;5691.630044047124;5714.885702285847;5120.471398966348;5214.270002199619;5587.385387607279;5605.32736071674;5612.522935550524;5065.493450654905;5491.121420572689;5494.36270590111;5542.445755424425;5547.588233236611;5544.251526044094;5555.527780138734;5602.579806514609;5615.326160860723;5630.324361076697 14:57:11 INFO - PROCESS | 2012 | |5;yui.html;677.8440958579527;710.690849480476;715.3275920634604;724.7934338713468;775.0196002057398;15665.373385064599;16793.328266869343;16815.91592042041;16844.831551684478;16847;14983.700325993474;15150;15171.317290721916;15182.089074655501;15238.847611523881;670.8624731929967;692.0484334040694;693.5353313280115;829.1335554345708;840.6805413942693;689;691.9827853055999;693.8508220732541;815.0708192660372;846.5640195299426;895.0020726889536;904.7195369435497;910.3581974707815;910.4082346474778;911.2800887299026;776.8523980443698;778.7352300217954;907.0611916666219;907.2968449451662;910.5310764956052;518.6499113098681;635.399547427681;671.2482020137477;673.7406098652054;675.5507587454387;12433.37833108341;15258.618534536725;15278.694426111526;15279.402501574648;15317.540473785804;11285.548578056867;14224.359903804354;14630.735033342406;14635.63410914725;14667.63330916725;12708.983281337563;13018.863210493442;13022.348882555834;13497.392617332243;13727.519536816264;4037.3705381337472;4569.520200378945;4633.6061434778085;4680.204365257914;4856.635752318591;89597.55201223952;114409;117721.05068442464;118849;123108;9834.967328430555;11391.259568128045;11423.828642570368;11452.312861228353;11812.881871181178;23177;23312.3006309811;23312.834358282358;23327.650085248733;23330.066797327916;7618.771436856903;8095.311898488577;8100.473469224482;8271.586420678943;8426.536540490331;4361.825526978885;4495.25828238337;4506.3465797459185;4641.86074417768;4649.093426781813;3498.4052711039185;3647.544056992876;3648.9635103649157;3651.580068292127;3658.3963645998642;605.933347331802;664.2958464028146;674.3964152083857;685.2873012067494;701.7263267325746;612.6324205476678;617.604732970899;620.6896551724138;627.5387590121258;633.7686744338375;9172.503293938227;9259.861102083474;9302.348835581444;9424.717258482257;9433.66982155635;520.5445235419008;592.7984485275027;625.7152995387088;632.6172665537375;633.7655067625009;4275.422817919603;4526.343680166423;4530.841420550265;4548.954510454853;4549.658775591844;87501.12498875057;100934.49532752289;135459;139853;168488;117916.23125653122;123966;126150;127496;129949;72424.63787681134;109796;110064;113466;115612.42193788977;9034.942343391524;9656.468894210604;9860.570217318593;9945.950270248602;10097.848532271875;52570.73714631402;55984;60539.69730151321;65381;68616.999999998;84895;85319;86440.70338944795;88601;90142.54928725315;11903.774988888541;13441.46234150623;13653.931730341284;13675.452981880613;14059.789103163665;15292.847071529142;15336.539903802905;15365.462208822637;15378.69242615119;15749.133797640781;13856.376463058985;14212.715745684822;14403;14405.42378304856;14703.19132447683;12340.691482713004;13635.727285454434;14137.939654525746;14400.42398304056;14441.422343106578;13640.386182621607;13810.37853296584;13932.2337271447;14114.294285285489;14244.184596973166;10453.320534165256;11234.943825280821;11242.875712428691;11285.7742845141;11656.650300491;9018.639254430012;11116.943890330405;11377.374244416305;11437.199396042197;11672.182947193614 14:57:11 INFO - PROCESS | 2012 | __end_tp_report 14:57:11 INFO - PROCESS | 2012 | __start_cc_report 14:57:11 INFO - PROCESS | 2012 | _x_x_mozilla_cycle_collect,1479 14:57:11 INFO - PROCESS | 2012 | __end_cc_report 14:57:11 INFO - PROCESS | 2012 | __startTimestamp1471903031783__endTimestamp 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | ------- Summary: start ------- 14:57:11 INFO - PROCESS | 2012 | Number of tests: 6 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | [#0] dojo.html Cycles:165 Average:5810.94 Median:6085.36 stddev:635.87 (10.4%) stddev-sans-first:607.37 14:57:11 INFO - PROCESS | 2012 | Values: 3332.7 3356.3 3362.0 3377.1 3387.7 5682.7 5754.0 5788.9 5912.9 5935.0 5722.1 5816.2 5880.1 5900.1 5927.1 5181.2 5226.4 5250.4 5266.6 5353.8 5390.5 5413.5 5418.3 5430.2 5445.6 5305.6 5310.5 5326.0 5343.5 5362.8 5130.0 5150.3 5213.5 5232.3 5251.4 5258.1 5258.8 5293.3 5302.5 5304.8 5792.9 5843.6 5848.0 5854.1 5914.6 6150.3 6235.4 6237.4 6272.8 6300.0 6153.7 6227.5 6240.7 6245.7 6269.9 5899.9 5966.9 5973.4 5980.2 5992.3 6189.6 6211.4 6220.6 6221.5 6296.4 6246.8 6285.6 6302.7 6303.0 6305.7 6235.1 6255.3 6263.2 6271.0 6274.0 6086.5 6218.0 6252.1 6272.6 6318.9 6296.7 6313.8 6322.3 6322.4 6330.1 5060.2 5070.9 5074.5 5079.0 5079.5 4381.2 4415.3 4455.7 4478.7 4520.9 5736.5 5820.6 5846.0 5848.9 5849.8 6163.0 6165.7 6232.4 6250.0 6252.3 5618.4 5685.0 5783.7 5824.7 5830.2 4974.5 5246.3 5498.7 5501.2 5509.0 6342.0 6349.7 6362.2 6366.0 6379.6 6120.8 6260.2 6271.4 6275.2 6296.6 6217.0 6259.8 6282.6 6284.7 6308.4 6188.0 6223.0 6225.9 6229.0 6235.8 5999.8 6123.6 6276.7 6282.2 6287.5 6070.9 6130.8 6187.7 6247.0 6277.8 6216.4 6223.2 6226.3 6229.9 6254.2 5803.1 6059.7 6075.6 6075.9 6085.4 6085.4 6138.9 6170.5 6245.4 6250.9 6020.6 6100.9 6111.3 6115.9 6132.0 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | [#1] ext.html Cycles:180 Average:70534.56 Median:38810.42 stddev:156747.53 (403.9%) stddev-sans-first:157098.92 14:57:11 INFO - PROCESS | 2012 | Values: 445.4 485.5 517.2 532.9 548.0 29305.1 29984.6 31408.8 31461.2 39025.2 39255.8 41815.4 41895.6 41929.0 41978.0 9664.5 9823.3 9824.2 9828.0 9878.8 8634.9 8891.2 9649.6 9766.2 9776.3 11707.9 11979.1 12004.5 12201.1 12248.8 10619.1 11788.8 11880.5 11963.8 11972.2 11737.9 11813.8 11817.0 11819.6 11822.1 39050.8 39184.6 39286.0 39305.0 39449.4 3581.8 3652.9 3699.9 3707.8 3903.2 30357.7 30643.2 30673.7 31130.4 31944.9 3273.0 3273.4 3275.5 3278.6 3390.3 519021.0 520589.0 524411.4 655244.8 656112.0 52192.0 60677.7 61326.4 61358.1 61430.7 33697.7 34717.5 64057.0 64373.4 64498.4 16330.6 16520.5 16539.3 16554.9 16568.8 12673.0 12771.4 12779.8 12808.1 12835.4 13657.5 16053.7 16349.0 16846.7 18637.2 6717.9 6947.8 6989.7 8078.2 8240.6 834.0 934.7 965.7 979.5 993.2 28964.7 29596.4 29992.4 30611.4 30750.8 897.6 1030.3 1091.4 1126.6 1129.9 15007.7 15621.7 15642.5 15699.8 16105.1 692296.0 702842.0 703436.0 703602.0 707621.0 46804.8 51915.5 52981.5 57465.7 58476.0 1336.7 1361.3 1385.2 1389.4 1393.8 29981.0 30711.7 31019.5 31209.1 31465.2 46966.0 47240.8 47425.5 47444.0 47621.3 418103.5 422907.0 456783.0 468520.0 468775.0 40202.8 41370.2 41452.4 41649.6 41834.2 45668.3 46159.8 46300.8 46524.8 46877.5 37699.6 37805.4 38175.8 38906.0 39790.2 38413.8 38548.8 38848.2 39733.8 40764.2 37884.0 38772.6 39192.8 39227.2 39244.8 31760.5 34338.0 34507.7 34641.3 35083.8 25401.9 25432.4 25589.4 25726.9 25866.2 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | [#2] jquery.html Cycles:180 Average:35261.41 Median:2363.34 stddev:102120.77 (4321.0%) stddev-sans-first:102373.60 14:57:11 INFO - PROCESS | 2012 | Values: 349.8 365.7 371.1 372.7 397.6 14879.4 15348.9 20735.5 21061.4 22183.3 20479.3 21096.7 21705.8 21791.5 21970.2 5850.8 6204.7 6206.1 6221.0 6225.5 5790.6 5980.3 6053.8 6061.2 6063.7 5971.5 5985.5 5989.6 5989.9 6017.3 5790.7 6014.6 6085.8 6096.9 6114.7 5194.8 5213.1 5288.0 5298.7 5308.3 26908.3 26964.7 27024.2 27299.7 27456.7 2106.9 2357.4 2369.3 2507.6 2512.0 14956.6 15635.6 15808.1 16129.4 16324.3 1636.5 1829.9 1878.0 1896.7 1909.6 101473.5 112988.9 114847.0 115629.0 117816.0 10708.8 10820.7 11005.0 11285.9 11532.9 10536.7 11831.3 12536.0 12557.4 13171.0 8345.7 8477.0 8528.3 8669.2 8715.1 7340.7 8672.7 8676.3 8705.7 8784.9 6279.7 6374.9 6380.7 6385.7 6464.3 1807.6 1829.3 1829.3 1831.8 1834.8 868.1 951.2 970.8 989.6 1005.7 17684.1 20320.8 22325.0 22444.0 22527.7 896.0 921.9 954.5 993.3 1037.8 9336.7 10742.4 11610.8 11719.8 11758.6 606362.0 609261.0 614911.0 621921.0 622313.0 120564.8 120609.4 121721.4 123811.5 126708.0 989.7 992.5 1003.0 1006.6 1008.9 19204.9 19914.0 19919.8 19958.5 19968.8 50231.7 51378.7 52533.7 53582.0 53926.7 57808.7 72968.5 74634.3 75516.6 76015.9 5363.4 5592.5 7886.4 7986.0 8113.0 13451.3 13495.0 13502.4 13815.4 13828.9 11474.3 11482.5 11647.1 11798.5 11929.7 11436.0 11444.5 11467.4 11493.3 11787.7 11578.6 11653.1 11879.2 11942.5 12051.2 7826.3 8096.2 8142.2 8243.4 8268.5 11036.1 11337.1 11356.7 11714.7 11815.6 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | [#3] mootools.html Cycles:180 Average:5675.23 Median:4966.92 stddev:3186.95 (64.2%) stddev-sans-first:3179.44 14:57:11 INFO - PROCESS | 2012 | Values: 1366.6 1408.1 1498.7 1646.7 1850.7 7742.2 8182.4 8191.2 8206.0 8223.5 8369.0 8494.1 8654.0 8723.6 8732.9 2357.9 2392.8 2396.0 2399.4 2404.0 2320.2 2366.6 2374.9 2376.1 2381.1 2334.2 2346.7 2357.4 2377.6 2378.1 2318.6 2342.5 2347.7 2353.6 2371.4 2304.5 2340.2 2346.5 2348.3 2350.1 8612.5 8801.6 8825.9 8838.7 8853.6 5105.3 5131.9 5275.3 5281.1 5283.9 3191.3 3589.9 3690.9 3694.8 3702.5 1068.7 1077.0 1101.8 1107.2 1107.9 10770.1 10849.6 11579.8 11680.2 11681.4 4416.7 4453.4 4528.4 4589.5 4589.6 9075.6 9105.5 9142.2 9149.2 9150.7 5211.2 5216.5 5218.1 5233.6 5236.1 4394.5 4411.0 4722.3 4873.7 4885.7 3692.6 3756.4 3784.3 3843.0 3844.9 1009.6 1177.4 1181.6 1181.7 1195.8 645.8 761.7 895.8 904.6 917.8 5796.2 5894.8 5896.3 6107.2 6142.2 897.4 938.9 954.7 981.8 1019.0 3524.9 3860.7 3906.0 3974.7 4051.0 10588.3 11071.1 11109.8 11112.7 11124.9 10998.8 11030.2 11035.9 11050.2 11056.1 7662.3 7974.2 8271.8 8380.0 8382.5 5922.2 5947.3 5982.1 6067.5 6141.9 8793.5 9712.5 10236.3 10253.8 10270.2 9842.1 10234.3 10236.7 10350.8 10436.3 6913.8 7144.7 7383.6 7537.8 7709.8 8234.9 8538.4 8570.7 8575.6 8590.4 7405.4 7526.1 7540.2 7564.2 7677.0 7271.1 7402.1 7441.2 7467.9 7604.4 6912.0 7054.5 7068.3 7074.4 7075.0 4837.8 4901.6 4953.2 4980.7 5101.5 4990.0 5026.2 5178.0 5181.1 5310.4 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | [#4] prototype.html Cycles:180 Average:4524.08 Median:5065.99 stddev:1398.65 (27.6%) stddev-sans-first:1365.49 14:57:11 INFO - PROCESS | 2012 | Values: 261.4 295.7 309.4 312.4 315.5 4066.5 4618.5 5056.5 5329.1 5363.5 4890.9 4971.8 4974.8 5161.4 5239.4 3624.5 3918.3 4064.5 4070.5 4127.4 3322.3 3452.4 3839.9 4122.5 4133.6 3585.4 3665.0 3822.3 4052.4 4098.5 3536.0 3838.7 4035.9 4039.0 4053.9 3523.3 3534.7 3539.3 3553.2 3563.6 3889.8 4261.5 4970.4 5183.5 5188.5 3949.8 4199.6 4636.5 4653.0 4698.4 5477.4 5500.7 5537.8 5544.0 5567.5 3900.3 3928.8 3947.4 3955.5 3964.5 5151.8 5302.6 5795.8 5822.6 5863.2 3943.1 3974.3 3993.6 4001.7 4031.5 4045.5 4048.9 4056.4 4067.5 4068.3 3709.0 4314.7 4466.3 4679.5 4712.2 5172.8 5238.5 5555.9 5584.9 5597.9 1336.3 1347.7 1387.7 1397.7 1403.2 749.5 790.7 870.5 892.6 933.2 4485.4 5092.5 5107.8 5117.6 5146.6 4745.4 5658.1 5689.3 5718.2 5726.3 4042.1 4766.2 4905.3 5066.5 5071.5 2518.8 3050.7 3065.8 3086.2 3098.4 5037.8 5959.3 6007.1 6086.3 6086.5 4625.8 5712.3 5910.6 6011.8 6101.8 5385.1 5584.3 6030.9 6066.4 6118.1 5566.2 5640.5 5779.7 5823.3 5833.9 4844.1 5104.4 5768.7 5776.3 5784.9 5064.8 6011.8 6017.6 6023.0 6032.5 3502.7 3520.3 3883.5 3907.0 3954.9 4451.1 5642.9 5875.5 5929.2 5953.8 5266.6 5433.9 5521.8 5787.7 5810.2 4924.8 5342.9 5489.3 5691.6 5714.9 5120.5 5214.3 5587.4 5605.3 5612.5 5065.5 5491.1 5494.4 5542.4 5547.6 5544.3 5555.5 5602.6 5615.3 5630.3 14:57:11 INFO - PROCESS | 2012 | 14:57:11 INFO - PROCESS | 2012 | [#5] yui.html Cycles:180 Average:24111.71 Median:3847.88 stddev:37439.36 (973.0%) stddev-sans-first:37503.04 14:57:11 INFO - PROCESS | 2012 | Values: 677.8 710.7 715.3 724.8 775.0 15665.4 16793.3 16815.9 16844.8 16847.0 14983.7 15150.0 15171.3 15182.1 15238.8 670.9 692.0 693.5 829.1 840.7 689.0 692.0 693.9 815.1 846.6 895.0 904.7 910.4 910.4 911.3 776.9 778.7 907.1 907.3 910.5 518.6 635.4 671.2 673.7 675.6 12433.4 15258.6 15278.7 15279.4 15317.5 11285.5 14224.4 14630.7 14635.6 14667.6 12709.0 13018.9 13022.3 13497.4 13727.5 4037.4 4569.5 4633.6 4680.2 4856.6 89597.6 114409.0 117721.1 118849.0 123108.0 9835.0 11391.3 11423.8 11452.3 11812.9 23177.0 23312.3 23312.8 23327.7 23330.1 7618.8 8095.3 8100.5 8271.6 8426.5 4361.8 4495.3 4506.3 4641.9 4649.1 3498.4 3647.5 3649.0 3651.6 3658.4 605.9 664.3 674.4 685.3 701.7 612.6 617.6 620.7 627.5 633.8 9172.5 9259.9 9302.3 9424.7 9433.7 520.5 592.8 625.7 632.6 633.8 4275.4 4526.3 4530.8 4549.0 4549.7 87501.1 100934.5 135459.0 139853.0 168488.0 117916.2 123966.0 126150.0 127496.0 129949.0 72424.6 109796.0 110064.0 113466.0 115612.4 9034.9 9656.5 9860.6 9946.0 10097.8 52570.7 55984.0 60539.7 65381.0 68617.0 84895.0 85319.0 86440.7 88601.0 90142.5 11903.8 13441.5 13653.9 13675.5 14059.8 15292.8 15336.5 15365.5 15378.7 15749.1 13856.4 14212.7 14403.0 14405.4 14703.2 12340.7 13635.7 14137.9 14400.4 14441.4 13640.4 13810.4 13932.2 14114.3 14244.2 10453.3 11234.9 11242.9 11285.8 11656.7 9018.6 11116.9 11377.4 11437.2 11672.2 14:57:11 INFO - PROCESS | 2012 | -------- Summary: end -------- 14:57:11 INFO - PROCESS | 2012 | 14:57:12 INFO - TEST-INFO | 2012: exit 0 14:57:12 INFO - TEST-OK | dromaeo_css | took 1118106ms 14:57:12 INFO - TEST-START | kraken 14:57:12 INFO - operating with platform_type : mac_ 14:57:12 INFO - Initialising browser for kraken test... 14:57:12 INFO - TEST-INFO | started process 2017 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpgKaCak/profile http://localhost:49389/getInfo.html) 14:57:14 INFO - PROCESS | 2017 | __metrics Screen width/height:1600/1200 14:57:14 INFO - PROCESS | 2017 | colorDepth:24 14:57:14 INFO - PROCESS | 2017 | Browser inner width/height: 1024/689 14:57:14 INFO - PROCESS | 2017 | __metrics 14:57:15 INFO - PROCESS | 2017 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:57:15 INFO - PROCESS | 2017 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:57:15 INFO - TEST-INFO | 2017: exit 0 14:57:15 INFO - Browser initialized. 14:57:15 INFO - Running cycle 1/1 for kraken test... 14:57:15 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpgKaCak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:27 INFO - PROCESS | 2018 | RSS: Main: 228470784 14:57:27 INFO - PROCESS | 2018 | 14:57:30 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection) 14:57:31 INFO - PROCESS | 2018 | RSS: Main: 293687296 14:57:31 INFO - PROCESS | 2018 | 14:57:33 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-dft) 14:57:34 INFO - PROCESS | 2018 | RSS: Main: 295690240 14:57:34 INFO - PROCESS | 2018 | 14:57:37 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-fft) 14:57:38 INFO - PROCESS | 2018 | RSS: Main: 381665280 14:57:38 INFO - PROCESS | 2018 | 14:57:40 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator) 14:57:41 INFO - PROCESS | 2018 | RSS: Main: 282488832 14:57:41 INFO - PROCESS | 2018 | 14:57:43 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:43 INFO - PROCESS | 2018 | RSS: Main: 286650368 14:57:43 INFO - PROCESS | 2018 | 14:57:46 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:47 INFO - PROCESS | 2018 | RSS: Main: 324706304 14:57:47 INFO - PROCESS | 2018 | 14:57:50 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:51 INFO - PROCESS | 2018 | RSS: Main: 324853760 14:57:51 INFO - PROCESS | 2018 | 14:57:53 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial) 14:57:54 INFO - PROCESS | 2018 | RSS: Main: 324214784 14:57:54 INFO - PROCESS | 2018 | 14:57:55 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:56 INFO - PROCESS | 2018 | RSS: Main: 301953024 14:57:56 INFO - PROCESS | 2018 | 14:57:58 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:59 INFO - PROCESS | 2018 | RSS: Main: 302469120 14:57:59 INFO - PROCESS | 2018 | 14:58:01 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:58:02 INFO - PROCESS | 2018 | RSS: Main: 304214016 14:58:02 INFO - PROCESS | 2018 | 14:58:04 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:58:05 INFO - PROCESS | 2018 | RSS: Main: 313917440 14:58:05 INFO - PROCESS | 2018 | 14:58:08 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:58:09 INFO - PROCESS | 2018 | RSS: Main: 316334080 14:58:09 INFO - PROCESS | 2018 | 14:58:10 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49389/tests/kraken/driver.html?testName=ai-astar) 14:58:11 INFO - PROCESS | 2018 | RSS: Main: 359985152 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | __start_tp_report 14:58:11 INFO - PROCESS | 2018 | _x_x_mozilla_page_load 14:58:11 INFO - PROCESS | 2018 | _x_x_mozilla_page_load_details 14:58:11 INFO - PROCESS | 2018 | |i|pagename|runs| 14:58:11 INFO - PROCESS | 2018 | |0;ai-astar;97;113;106;113;112;115;116;113;114;114 14:58:11 INFO - PROCESS | 2018 | |1;audio-beat-detection;149;110;129;167;106;133;130;109;158;113 14:58:11 INFO - PROCESS | 2018 | |2;audio-dft;187;185;184;184;185;185;183;181;185;183 14:58:11 INFO - PROCESS | 2018 | |3;audio-fft;77;75;76;151;58;57;58;86;79;55 14:58:11 INFO - PROCESS | 2018 | |4;audio-oscillator;83;91;130;82;63;58;131;97;95;168 14:58:11 INFO - PROCESS | 2018 | |5;imaging-gaussian-blur;90;89;89;87;90;86;90;87;89;87 14:58:11 INFO - PROCESS | 2018 | |6;imaging-darkroom;95;106;144;111;96;95;95;96;95;96 14:58:11 INFO - PROCESS | 2018 | |7;imaging-desaturate;82;84;83;84;84;86;86;84;86;84 14:58:11 INFO - PROCESS | 2018 | |8;json-parse-financial;55;54;53;56;54;55;55;55;54;54 14:58:11 INFO - PROCESS | 2018 | |9;json-stringify-tinderbox;68;67;76;81;73;72;70;72;71;71 14:58:11 INFO - PROCESS | 2018 | |10;stanford-crypto-aes;89;84;85;85;89;85;85;85;91;89 14:58:11 INFO - PROCESS | 2018 | |11;stanford-crypto-ccm;124;129;147;128;137;155;139;136;214;135 14:58:11 INFO - PROCESS | 2018 | |12;stanford-crypto-pbkdf2;170;169;176;164;168;172;169;167;167;167 14:58:11 INFO - PROCESS | 2018 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;66;66;66;67;65 14:58:11 INFO - PROCESS | 2018 | __end_tp_report 14:58:11 INFO - PROCESS | 2018 | __start_cc_report 14:58:11 INFO - PROCESS | 2018 | _x_x_mozilla_cycle_collect,2142 14:58:11 INFO - PROCESS | 2018 | __end_cc_report 14:58:11 INFO - PROCESS | 2018 | __startTimestamp1471903091085__endTimestamp 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | ------- Summary: start ------- 14:58:11 INFO - PROCESS | 2018 | Number of tests: 14 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#0] ai-astar Cycles:10 Average:111.30 Median:114.00 stddev:5.70 (5.0%) stddev-sans-first:2.85 14:58:11 INFO - PROCESS | 2018 | Values: 97.0 113.0 106.0 113.0 112.0 115.0 116.0 113.0 114.0 114.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:131.50 stddev:21.68 (16.5%) stddev-sans-first:21.92 14:58:11 INFO - PROCESS | 2018 | Values: 149.0 110.0 129.0 167.0 106.0 133.0 130.0 109.0 158.0 113.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.00 stddev:1.62 (0.9%) stddev-sans-first:1.36 14:58:11 INFO - PROCESS | 2018 | Values: 187.0 185.0 184.0 184.0 185.0 185.0 183.0 181.0 185.0 183.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#3] audio-fft Cycles:10 Average:77.20 Median:75.50 stddev:28.23 (37.4%) stddev-sans-first:29.94 14:58:11 INFO - PROCESS | 2018 | Values: 77.0 75.0 76.0 151.0 58.0 57.0 58.0 86.0 79.0 55.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:82.50 stddev:33.90 (41.1%) stddev-sans-first:35.41 14:58:11 INFO - PROCESS | 2018 | Values: 83.0 91.0 130.0 82.0 63.0 58.0 131.0 97.0 95.0 168.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.00 stddev:1.51 (1.7%) stddev-sans-first:1.48 14:58:11 INFO - PROCESS | 2018 | Values: 90.0 89.0 89.0 87.0 90.0 86.0 90.0 87.0 89.0 87.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#6] imaging-darkroom Cycles:10 Average:102.90 Median:95.00 stddev:15.48 (16.3%) stddev-sans-first:16.15 14:58:11 INFO - PROCESS | 2018 | Values: 95.0 106.0 144.0 111.0 96.0 95.0 95.0 96.0 95.0 96.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:1.34 (1.6%) stddev-sans-first:1.13 14:58:11 INFO - PROCESS | 2018 | Values: 82.0 84.0 83.0 84.0 84.0 86.0 86.0 84.0 86.0 84.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 14:58:11 INFO - PROCESS | 2018 | Values: 55.0 54.0 53.0 56.0 54.0 55.0 55.0 55.0 54.0 54.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:4.01 (5.6%) stddev-sans-first:3.97 14:58:11 INFO - PROCESS | 2018 | Values: 68.0 67.0 76.0 81.0 73.0 72.0 70.0 72.0 71.0 71.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:2.50 (2.9%) stddev-sans-first:2.51 14:58:11 INFO - PROCESS | 2018 | Values: 89.0 84.0 85.0 85.0 89.0 85.0 85.0 85.0 91.0 89.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:138.00 stddev:26.09 (18.9%) stddev-sans-first:26.61 14:58:11 INFO - PROCESS | 2018 | Values: 124.0 129.0 147.0 128.0 137.0 155.0 139.0 136.0 214.0 135.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.90 Median:169.00 stddev:3.28 (1.9%) stddev-sans-first:3.46 14:58:11 INFO - PROCESS | 2018 | Values: 170.0 169.0 176.0 164.0 168.0 172.0 169.0 167.0 167.0 167.0 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - PROCESS | 2018 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 14:58:11 INFO - PROCESS | 2018 | Values: 67.0 68.0 68.0 68.0 67.0 66.0 66.0 66.0 67.0 65.0 14:58:11 INFO - PROCESS | 2018 | -------- Summary: end -------- 14:58:11 INFO - PROCESS | 2018 | 14:58:11 INFO - TEST-INFO | 2018: exit 0 14:58:11 INFO - TEST-OK | kraken | took 59419ms 14:58:11 INFO - SUITE-END | took 1177s 14:58:12 INFO - Completed test suite (00:19:37) 14:58:12 INFO - javascript benchmark 14:58:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.733381329493, 3356.305065941699, 3361.983190084051, 3377.121948293443, 3387.6612338766126, 5682.687452190138, 5753.971230143843, 5788.884222315552, 5912.911306330403, 5935.0, 5722.084466485363, 5816.185733997233, 5880.117982302657, 5900.11498275259, 5927.110933359998, 5181.1710126379785, 5226.3989641191365, 5250.396204436482, 5266.605004624649, 5353.812616558421, 5390.460953904618, 5413.458654134574, 5418.268533747933, 5430.185472179185, 5445.618806683534, 5305.602079844008, 5310.495502927254, 5325.973370133163, 5343.545798607103, 5362.8123015694455, 5129.974350128263, 5150.27896094547, 5213.4525874782985, 5232.319798426218, 5251.396089449724, 5258.0535503609335, 5258.842234732964, 5293.285406470116, 5302.549283310923, 5304.840854774363, 5792.913106303409, 5843.590948633555, 5847.976604094267, 5854.092615644582, 5914.585978981473, 6150.323464418911, 6235.438810507076, 6237.376262373727, 6272.843178920518, 6299.992001279773, 6153.661548614825, 6227.532935029845, 6240.719167637467, 6245.718942647592, 6269.905951410732, 5899.852503687443, 5966.850828729273, 5973.432523910222, 5980.22257106582, 5992.34084250732, 6189.597676151036, 6211.378862113843, 6220.564560480813, 6221.5333849961435, 6296.401841825111, 6246.781362652286, 6285.622862628257, 6302.716377763011, 6303.0, 6305.747770089237, 6235.127082208494, 6255.280642726054, 6263.248410190807, 6270.996640537492, 6273.96863015682, 6086.452219300196, 6217.96891015542, 6252.062190671436, 6272.560920735505, 6318.873622527615, 6296.685165741695, 6313.842153946096, 6322.272938612026, 6322.399372059647, 6330.145430366933, 5060.1903695408555, 5070.873228169326, 5074.49255074497, 5079.009593129378, 5079.466656001141, 4381.211381951216, 4415.2935530315, 4455.732656040648, 4478.664100192498, 4520.864374068783, 5736.483716465538, 5820.563457740686, 5845.976954033027, 5848.88302233953, 5849.824505264849, 6162.969185154136, 6165.72254248551, 6232.439080482778, 6250.0, 6252.343503932113, 5618.410066942994, 5685.0, 5783.71081445926, 5824.650520968756, 5830.212921255661, 4974.477679843564, 5246.291750613695, 5498.670079795225, 5501.229827824108, 5508.9724551376985, 6342.0, 6349.68251587428, 6362.204724409449, 6365.96817015912, 6379.585326953733, 6120.784812895933, 6260.154879091265, 6271.43557079865, 6275.184226050585, 6296.590721603081, 6217.036359364306, 6259.78090766821, 6282.623042617458, 6284.654344010941, 6308.4322410981395, 6188.0, 6222.968885155546, 6225.937740622536, 6228.968855155877, 6235.812925612057, 5999.820005399845, 6123.601965872204, 6276.748930042747, 6282.246130464374, 6287.53584954669, 6070.878582428415, 6130.785422510369, 6187.690615469299, 6246.968765156327, 6277.843053923689, 6216.440520353009, 6223.222097237845, 6226.25284965807, 6229.906551401642, 6254.249490061222, 5803.100519419497, 6059.72731227087, 6075.605085669417, 6075.908861367171, 6085.421884920926, 6085.361037091042, 6138.877222455615, 6170.50635949132, 6245.375462453719, 6250.874982500233, 6020.638761674313, 6100.8779824404155, 6111.266648002268, 6115.938840611537, 6132.0], "value": 5769.448932958323, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.40093574142776, 485.54116360039757, 517.2396577031765, 532.8987492376449, 548.019045907825, 29305.120846374615, 29984.55023174654, 31408.842955785247, 31461.21346966327, 39025.219495610145, 39255.80372098143, 41815.37276940848, 41895.58104418955, 41929.0, 41978.0, 9664.468454235015, 9823.312368134233, 9824.164945979564, 9828.017198280186, 9878.753031174243, 8634.870476942851, 8891.244244239248, 9649.614015439409, 9766.218702503782, 9776.266779991494, 11707.882921170807, 11979.101567382437, 12004.459799309008, 12201.084918631093, 12248.755024899496, 10619.097376722988, 11788.821117888228, 11880.465379057963, 11963.820542691867, 11972.161948663597, 11737.94131029348, 11813.763724725542, 11817.0, 11819.645410637695, 11822.113341499336, 39050.80474597637, 39184.60815391838, 39286.0, 39305.0, 39449.40825887614, 3581.767185132984, 3652.926941461156, 3699.8890033298776, 3707.8146092695256, 3903.180332130256, 30357.696423035708, 30643.233919151975, 30673.69326306753, 31130.37739245225, 31944.923579967228, 3272.983635081833, 3273.394422031908, 3275.5414242006136, 3278.557394751702, 3390.2880395117054, 519021.0, 520589.0, 524411.3779431117, 655244.8181736344, 656112.0, 52192.0, 60677.69661151666, 61326.386736132066, 61358.0796288056, 61430.69284653548, 33697.66302336945, 34717.47923781145, 64057.0, 64373.35626643767, 64498.35501645017, 16330.591735206477, 16520.504384868233, 16539.338426463048, 16554.917225413796, 16568.75146872798, 12673.04952128594, 12771.361431928552, 12779.808302875465, 12808.103432759617, 12835.422405991752, 13657.521986730615, 16053.67892642164, 16349.0, 16846.663066738598, 18637.161327740283, 6717.899231511531, 6947.756828510978, 6989.650517474106, 8078.151794061539, 8240.587970601446, 833.9791505212297, 934.7102398256562, 965.7392504023874, 979.5347210075299, 993.2352088891513, 28964.71035289662, 29596.408071838443, 29992.400151996837, 30611.38777224443, 30750.84624576863, 897.5871099294397, 1030.2735827540719, 1091.4324551233315, 1126.5775334249656, 1129.9378534180698, 15007.699846003019, 15621.687566248838, 15642.45251416195, 15699.764503532457, 16105.114218718083, 692296.0, 702842.0, 703436.0, 703602.0, 707621.0, 46804.76597617058, 51915.480845191065, 52981.47018529765, 57465.71267143638, 58476.0, 1336.652470357714, 1361.3057340756088, 1385.1550554162154, 1389.4164450930634, 1393.7560926837764, 29981.028447369845, 30711.692883070882, 31019.53470697896, 31209.063728088193, 31465.21336966594, 46966.0, 47240.7637961808, 47425.52574474211, 47444.0, 47621.28568071412, 418103.4655148343, 422907.0, 456783.0, 468520.0, 468775.0, 40202.798986006055, 41370.1725965485, 41452.37821432621, 41649.58350416457, 41834.163316732884, 45668.314975274734, 46159.76920115378, 46300.8424789383, 46524.76737616426, 46877.53122468868, 37699.62300377071, 37805.43291850569, 38175.80912095422, 38906.02734931649, 39790.2041959165, 38413.80793096017, 38548.80725596354, 38848.2230355397, 39733.80133099316, 40764.18471630492, 37884.0, 38772.6122738769, 39192.80403598078, 39227.215455691294, 39244.822655320386, 31760.523592146597, 34337.97918039465, 34507.65492345044, 34641.30717385688, 35083.7720679775, 25401.872990635668, 25432.364190895376, 25589.3602659935, 25726.8713656438, 25866.224013279632], "value": 20244.099665454636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.8443192779211, 365.68002997377295, 371.088976562539, 372.6571554170164, 397.620272639629, 14879.404823807048, 15348.923255383721, 20735.481612959684, 21061.368158955254, 22183.334499964985, 20479.283225087125, 21096.68354974673, 21705.782942170572, 21791.45521361967, 21970.231041913536, 5850.765969361231, 6204.689765511729, 6206.131141640174, 6221.0, 6225.5019598432245, 5790.565707571928, 5980.342162362137, 6053.848653783669, 6061.15143879855, 6063.666498342589, 5971.5222782177325, 5985.461308482236, 5989.610675306113, 5989.940100599004, 6017.308009578889, 5790.652560846342, 6014.578979471439, 6085.786997455068, 6096.878062438771, 6114.694265286718, 5194.792208311701, 5213.113770658997, 5288.0, 5298.735063246822, 5308.336457942757, 26908.327291817666, 26964.730352696613, 27024.1892743218, 27299.727002729916, 27456.725432745618, 2106.852520323578, 2357.351728274721, 2369.324742448394, 2507.6489291499206, 2512.0, 14956.62608434787, 15635.609109772233, 15808.051516909023, 16129.354825806953, 16324.347026118941, 1636.5271255869814, 1829.8536117110732, 1878.0421984787856, 1896.6586014517381, 1909.6085302512952, 101473.4926325371, 112988.87011129866, 114846.99999999917, 115629.0, 117816.0, 10708.839367409495, 10820.67537973862, 11005.0, 11285.943570282261, 11532.942335288437, 10536.735591728888, 11831.2901225925, 12536.0, 12557.434915428828, 13171.0, 8345.749627511184, 8477.025142108736, 8528.275096616733, 8669.21977022071, 8715.128487151362, 7340.743073992491, 8672.69645562415, 8676.262517686067, 8705.738827835048, 8784.91215087841, 6279.7488100476385, 6374.872502549923, 6380.7447702091395, 6385.744570217233, 6464.25661048976, 1807.593291509426, 1829.268292682911, 1829.3231504343212, 1831.7985021647607, 1834.7706536682915, 868.0971789339017, 951.167728237792, 970.839811431106, 989.5744829723144, 1005.6731562242301, 17684.057697184235, 20320.796792032186, 22324.995375208153, 22444.0, 22527.662085068736, 895.9507227102572, 921.870938068671, 954.5275088831073, 993.3443927008284, 1037.7976294622476, 9336.673216437528, 10742.409167495707, 11610.76778464443, 11719.765604687858, 11758.58844940423, 606362.0, 609261.0, 614911.0, 621921.0, 622313.0, 120564.79435205711, 120609.39695301467, 121721.39139304248, 123811.52376952411, 126708.0, 989.7278248481725, 992.5235886774389, 1003.0220534978338, 1006.6476733143342, 1008.8890222075565, 19204.943728095088, 19914.00429978466, 19919.800801991794, 19958.50103747418, 19968.800311996692, 50231.74884125556, 51378.71553211199, 52533.68665783386, 53582.0, 53926.73036634792, 57808.71095644495, 72968.54062918818, 74634.25365746273, 75516.62241688756, 76015.85976210472, 5363.356397232357, 5592.524635405874, 7886.408519361185, 7986.041674999037, 8113.0, 13451.327433628476, 13495.0, 13502.392392342172, 13815.378307976367, 13828.861711382757, 11474.311541307548, 11482.483288252215, 11647.12646551529, 11798.52805887755, 11929.701757456132, 11436.0, 11444.542218311175, 11467.426628668367, 11493.310401375944, 11787.705307367385, 11578.594749183738, 11653.126015548698, 11879.168458207843, 11942.462589183333, 12051.216670916363, 7826.334761545332, 8096.190380961857, 8142.226488483585, 8243.422960392954, 8268.545230012407, 11036.061934735637, 11337.093032557541, 11356.712646203796, 11714.70713232176, 11815.645530634094], "value": 9758.909922516392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.583192126401, 1408.1128888800054, 1498.7377208988423, 1646.6953613581488, 1850.6668799616064, 7742.187070357616, 8182.386321025924, 8191.180881911806, 8206.015278166627, 8223.547704876237, 8368.958155209215, 8494.108118647546, 8653.956730216356, 8723.607437665305, 8732.912670873306, 2357.941051473714, 2392.83250172488, 2396.0, 2399.3761621978324, 2403.9639405408934, 2320.2459200759736, 2366.5858474766933, 2374.9287521374386, 2376.120835290945, 2381.1070848431837, 2334.171369163948, 2346.7066616672914, 2357.3752955466816, 2377.619580867062, 2378.0844374915696, 2318.5826551220775, 2342.484653376263, 2347.6713260143592, 2353.6351865460797, 2371.4190023444194, 2304.4584522637165, 2340.169239919838, 2346.5189636124555, 2348.330725743155, 2350.142198097682, 8612.52631105289, 8801.591745320718, 8825.911740882573, 8838.69064582743, 8853.557322133867, 5105.336306280197, 5131.948680513185, 5275.28783614211, 5281.12861377876, 5283.86790330241, 3191.329820737648, 3589.892303230881, 3690.926181476382, 3694.7783133012103, 3702.4816525686424, 1068.6793961811425, 1076.95692172313, 1101.752105776202, 1107.2028139739455, 1107.9224454288203, 10770.138388928866, 10849.566017359297, 11579.768404631945, 11680.182387232897, 11681.415929203591, 4416.712913660602, 4453.398791163217, 4528.41130653013, 4589.4722106958125, 4589.58693717567, 9075.636974521078, 9105.499197544199, 9142.177204051533, 9149.176574108229, 9150.679726209552, 5211.2443695663915, 5216.478352164753, 5218.112920803396, 5233.5551478124025, 5236.083685355047, 4394.516603173648, 4410.977945110318, 4722.291656251589, 4873.707577545359, 4885.682430641997, 3692.6122757110115, 3756.417755247941, 3784.299904517618, 3842.9615703843165, 3844.8654297100024, 1009.5961615353771, 1177.3524561491145, 1181.5569161564413, 1181.6868529839599, 1195.820626905971, 645.8191706322237, 761.7486229544237, 895.7536677413764, 904.5838914099456, 917.7797328641211, 5796.1595568642315, 5894.793682221188, 5896.321922978912, 6107.175531303306, 6142.170806941095, 897.3673560140086, 938.877945867033, 954.737447202025, 981.7938232971013, 1019.0421004255976, 3524.8766293179615, 3860.652541271299, 3906.0, 3974.6621537169663, 4050.9594904051173, 10588.258821882395, 11071.05895998833, 11109.83335249972, 11112.666620001413, 11124.888751112547, 10998.835017474745, 11030.22788404804, 11035.944820275847, 11050.226484146033, 11056.11551075912, 7662.272084151997, 7974.16271291506, 8271.751847444466, 8380.036295826058, 8382.538960357238, 5922.230110085834, 5947.3457919627945, 5982.132590774227, 6067.453929146398, 6141.907871382022, 8793.472391656522, 9712.5143742814, 10236.33463824849, 10253.846192306972, 10270.178385728974, 9842.065003824626, 10234.33476824004, 10236.692899213036, 10350.792984140426, 10436.269461137648, 6913.827154321182, 7144.714211431485, 7383.593902335208, 7537.8115547111765, 7709.845803084019, 8234.917650823416, 8538.359623028173, 8570.700025499078, 8575.571221438779, 8590.398672092893, 7405.411339660859, 7526.09686837583, 7540.17058123617, 7564.167941526538, 7677.0, 7271.127464704269, 7402.1117465904435, 7441.181470038183, 7467.92532074694, 7604.391648667983, 6911.965440172767, 7054.506184567236, 7068.257832927674, 7074.434045276468, 7075.009498670087, 4837.830675926326, 4901.58336541398, 4953.157963146202, 4980.676256043345, 5101.464346243591, 4989.979058481321, 5026.195808670595, 5178.042062218502, 5181.145111056633, 5310.442403547727], "value": 4547.58941246795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.3831357995131, 295.74418128318996, 309.3766061386307, 312.3830434891092, 315.5345864849346, 4066.471358723362, 4618.515055919131, 5056.494350564942, 5329.120695085311, 5363.471410647966, 4890.8777280568, 4971.825986090487, 4974.8258810941625, 5161.406438259602, 5239.371275446952, 3624.4563315502755, 3918.314294998378, 4064.532578753437, 4070.4708387909604, 4127.401526778615, 3322.302316513535, 3452.4476083826594, 3839.8864329344456, 4122.464684219213, 4133.5659755725665, 3585.390483617778, 3664.9633503665023, 3822.2928758179687, 4052.4326594276827, 4098.549159592442, 3535.982320088409, 3838.673712734421, 4035.9192816143805, 4039.010442441606, 4053.898652533681, 3523.3222750709388, 3534.6642069003406, 3539.3098345822573, 3553.218291975787, 3563.5901871284873, 3889.8444062237477, 4261.4673165854265, 4970.378702662168, 5183.50756678115, 5188.469401526559, 3949.822257998397, 4199.648197009685, 4636.4899861015265, 4653.045720797273, 4698.412698412699, 5477.370102438231, 5500.724963751836, 5537.750801213955, 5544.033941841096, 5567.47109024642, 3900.3369427197445, 3928.823202955874, 3947.4276229946786, 3955.46601208836, 3964.5044369453817, 5151.793928242866, 5302.602304827154, 5795.797147099831, 5822.621529600562, 5863.182413451844, 3943.0930885896405, 3974.344233201547, 3993.5806740292433, 4001.6998725095737, 4031.4680421440253, 4045.453863728359, 4048.8582899598373, 4056.4320995060716, 4067.511898572131, 4068.349064149722, 3708.962910370916, 4314.654827613784, 4466.307722303049, 4679.4618618858585, 4712.2224832902875, 5172.793088276427, 5238.454655876526, 5555.944440555623, 5584.91622625661, 5597.916031259534, 1336.3385124363501, 1347.7465956660203, 1387.67389663429, 1397.7280674586282, 1403.2352367959284, 749.4978364495801, 790.6639678136769, 870.5331516394895, 892.5983307511646, 933.1788026536605, 4485.439320084989, 5092.516210959953, 5107.821226257138, 5117.616178786531, 5146.639735218499, 4745.383100196952, 5658.066419040894, 5689.345725241567, 5718.228039214653, 5726.312842458931, 4042.0501182222156, 4766.165920963817, 4905.337779399735, 5066.48005598319, 5071.503906347636, 2518.848869067862, 3050.710182532656, 3065.75836786102, 3086.1667349815425, 3098.411301852641, 5037.7733002014265, 5959.28488581373, 6007.068904319837, 6086.2696476422225, 6086.543509236825, 4625.838095666635, 5712.257406537124, 5910.645361278337, 6011.849703757441, 6101.84745381369, 5385.057614917374, 5584.329880414376, 6030.939690603125, 6066.363031881677, 6118.143459915705, 5566.220729097849, 5640.548756099584, 5779.653220806765, 5823.330317013429, 5833.941660583339, 4844.135008021866, 5104.438511763628, 5768.7404066817935, 5776.335721392094, 5784.855378615568, 5064.797408103635, 6011.827693599706, 6017.638941663514, 6023.0, 6032.461722260796, 3502.7249521697295, 3520.2783429397423, 3883.5339759229073, 3906.980465097656, 3954.9209015818947, 4451.132029254394, 5642.852503410072, 5875.500582450369, 5929.199558059607, 5953.761849526144, 5266.631335806457, 5433.945660543344, 5521.834344969658, 5787.668836167621, 5810.1575271586225, 4924.778384972613, 5342.866428339323, 5489.258950041693, 5691.630044047124, 5714.885702285847, 5120.471398966348, 5214.270002199619, 5587.385387607279, 5605.32736071674, 5612.522935550524, 5065.493450654905, 5491.121420572689, 5494.36270590111, 5542.445755424425, 5547.588233236611, 5544.251526044094, 5555.527780138734, 5602.579806514609, 5615.326160860723, 5630.324361076697], "value": 4078.212864125263, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.8440958579527, 710.690849480476, 715.3275920634604, 724.7934338713468, 775.0196002057398, 15665.373385064599, 16793.328266869343, 16815.91592042041, 16844.831551684478, 16847.0, 14983.700325993474, 15150.0, 15171.317290721916, 15182.089074655501, 15238.847611523881, 670.8624731929967, 692.0484334040694, 693.5353313280115, 829.1335554345708, 840.6805413942693, 689.0, 691.9827853055999, 693.8508220732541, 815.0708192660372, 846.5640195299426, 895.0020726889536, 904.7195369435497, 910.3581974707815, 910.4082346474778, 911.2800887299026, 776.8523980443698, 778.7352300217954, 907.0611916666219, 907.2968449451662, 910.5310764956052, 518.6499113098681, 635.399547427681, 671.2482020137477, 673.7406098652054, 675.5507587454387, 12433.37833108341, 15258.618534536725, 15278.694426111526, 15279.402501574648, 15317.540473785804, 11285.548578056867, 14224.359903804354, 14630.735033342406, 14635.63410914725, 14667.63330916725, 12708.983281337563, 13018.863210493442, 13022.348882555834, 13497.392617332243, 13727.519536816264, 4037.3705381337472, 4569.520200378945, 4633.6061434778085, 4680.204365257914, 4856.635752318591, 89597.55201223952, 114409.0, 117721.05068442464, 118849.0, 123108.0, 9834.967328430555, 11391.259568128045, 11423.828642570368, 11452.312861228353, 11812.881871181178, 23177.0, 23312.3006309811, 23312.834358282358, 23327.650085248733, 23330.066797327916, 7618.771436856903, 8095.311898488577, 8100.473469224482, 8271.586420678943, 8426.536540490331, 4361.825526978885, 4495.25828238337, 4506.3465797459185, 4641.86074417768, 4649.093426781813, 3498.4052711039185, 3647.544056992876, 3648.9635103649157, 3651.580068292127, 3658.3963645998642, 605.933347331802, 664.2958464028146, 674.3964152083857, 685.2873012067494, 701.7263267325746, 612.6324205476678, 617.604732970899, 620.6896551724138, 627.5387590121258, 633.7686744338375, 9172.503293938227, 9259.861102083474, 9302.348835581444, 9424.717258482257, 9433.66982155635, 520.5445235419008, 592.7984485275027, 625.7152995387088, 632.6172665537375, 633.7655067625009, 4275.422817919603, 4526.343680166423, 4530.841420550265, 4548.954510454853, 4549.658775591844, 87501.12498875057, 100934.49532752289, 135459.0, 139853.0, 168488.0, 117916.23125653122, 123966.0, 126150.0, 127496.0, 129949.0, 72424.63787681134, 109796.0, 110064.0, 113466.0, 115612.42193788977, 9034.942343391524, 9656.468894210604, 9860.570217318593, 9945.950270248602, 10097.848532271875, 52570.73714631402, 55984.0, 60539.69730151321, 65381.0, 68616.999999998, 84895.0, 85319.0, 86440.70338944795, 88601.0, 90142.54928725315, 11903.774988888541, 13441.46234150623, 13653.931730341284, 13675.452981880613, 14059.789103163665, 15292.847071529142, 15336.539903802905, 15365.462208822637, 15378.69242615119, 15749.133797640781, 13856.376463058985, 14212.715745684822, 14403.0, 14405.42378304856, 14703.19132447683, 12340.691482713004, 13635.727285454434, 14137.939654525746, 14400.42398304056, 14441.422343106578, 13640.386182621607, 13810.37853296584, 13932.2337271447, 14114.294285285489, 14244.184596973166, 10453.320534165256, 11234.943825280821, 11242.875712428691, 11285.7742845141, 11656.650300491, 9018.639254430012, 11116.943890330405, 11377.374244416305, 11437.199396042197, 11672.182947193614], "value": 7825.902226869994, "unit": "score"}], "name": "dromaeo_css", "value": 7409.3102420265095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 113.0, 106.0, 113.0, 112.0, 115.0, 116.0, 113.0, 114.0, 114.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 129.0, 167.0, 106.0, 133.0, 130.0, 109.0, 158.0, 113.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 184.0, 185.0, 185.0, 183.0, 181.0, 185.0, 183.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 151.0, 58.0, 57.0, 58.0, 86.0, 79.0, 55.0], "value": 77.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 91.0, 130.0, 82.0, 63.0, 58.0, 131.0, 97.0, 95.0, 168.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 87.0, 90.0, 86.0, 90.0, 87.0, 89.0, 87.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 106.0, 144.0, 111.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 102.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 83.0, 84.0, 84.0, 86.0, 86.0, 84.0, 86.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 56.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 76.0, 81.0, 73.0, 72.0, 70.0, 72.0, 71.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 85.0, 85.0, 89.0, 85.0, 85.0, 85.0, 91.0, 89.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 147.0, 128.0, 137.0, 155.0, 139.0, 136.0, 214.0, 135.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 176.0, 164.0, 168.0, 172.0, 169.0, 167.0, 167.0, 167.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 66.0, 66.0, 66.0, 67.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1471.9, "alertThreshold": 2.0}]} 14:58:12 INFO - Return code: 0 14:58:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:58:12 INFO - # TBPL SUCCESS # 14:58:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:58:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:58:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:58:12 INFO - 2016-08-22 14:58:12.414 screenresolution[2022:281086] starting screenresolution argv=screenresolution get 14:58:12 INFO - 2016-08-22 14:58:12.416 screenresolution[2022:281086] Display 0: 1600x1200x32@60 14:58:12 INFO - 2016-08-22 14:58:12.422 screenresolution[2023:281089] starting screenresolution argv=screenresolution list 14:58:12 INFO - Available Modes on Display 0 14:58:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:58:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:58:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:58:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:58:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:58:12 INFO - Intel Iris: 14:58:12 INFO - Chipset Model: Intel Iris 14:58:12 INFO - Type: GPU 14:58:12 INFO - Bus: Built-In 14:58:12 INFO - VRAM (Dynamic, Max): 1536 MB 14:58:12 INFO - Vendor: Intel (0x8086) 14:58:12 INFO - Device ID: 0x0a2e 14:58:12 INFO - Revision ID: 0x0009 14:58:12 INFO - Displays: 14:58:12 INFO - Display: 14:58:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:58:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:58:12 INFO - Display Serial Number: 1600x1200 60 14:58:12 INFO - Main Display: Yes 14:58:12 INFO - Mirror: Off 14:58:12 INFO - Online: Yes 14:58:12 INFO - Rotation: Supported 14:58:12 INFO - Return code: 0 14:58:12 INFO - Running post-action listener: _resource_record_post_action 14:58:12 INFO - [mozharness: 2016-08-22 21:58:12.654700Z] Finished run-tests step (success) 14:58:12 INFO - Running post-run listener: _resource_record_post_run 14:58:12 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 8060416; Write bytes: 708232704; Read time: 55; Write time: 2056 14:58:12 INFO - TinderboxPrint: CPU usage
53.7% 14:58:12 INFO - TinderboxPrint: I/O read bytes / time
8,060,416 / 55 14:58:12 INFO - TinderboxPrint: I/O write bytes / time
708,232,704 / 2,056 14:58:12 INFO - TinderboxPrint: CPU idle
2,250.6 (46.3%) 14:58:12 INFO - TinderboxPrint: CPU system
980.1 (20.2%) 14:58:12 INFO - TinderboxPrint: CPU user
1,627.0 (33.5%) 14:58:12 INFO - TinderboxPrint: Swap in / out
423,460,864 / 0 14:58:12 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 384678400; Write bytes: 379701248; Read time: 30939; Write time: 830 14:58:12 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 8060416; Write bytes: 298892800; Read time: 55; Write time: 1153 14:58:13 INFO - Running post-run listener: _upload_blobber_files 14:58:13 INFO - Blob upload gear active. 14:58:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:58:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:58:13 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:58:13 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:58:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:14 INFO - (blobuploader) - INFO - Done attempting. 14:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:58:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:15 INFO - (blobuploader) - INFO - Done attempting. 14:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:18 INFO - (blobuploader) - INFO - Done attempting. 14:58:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:58:18 INFO - Return code: 0 14:58:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:58:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:58:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3be0e229bbd7b9067f4f1aeebf8fc8fa860df3ecad2f8d03d4979510906eae476f81841eed8e409394212e7919c24a97f60559b4a3ac8de52c957df654c4017", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297645252e07b37346942b71d04a22e4688eae3d886e48e95486fef7ed53a8a13e0ef64b2216ad80aeaf381cc32200a658ddcabe2818f01829e4e4d29646b319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b02a475dc37d04b03b5060cf842383d3016f19fd7cb31905e9d0ede61460279ffa580c95e24eac1c05cbf61ac9d011863def78cc1dc079fd5a385e55a93883b"} 14:58:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:58:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:58:18 INFO - Contents: 14:58:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3be0e229bbd7b9067f4f1aeebf8fc8fa860df3ecad2f8d03d4979510906eae476f81841eed8e409394212e7919c24a97f60559b4a3ac8de52c957df654c4017", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297645252e07b37346942b71d04a22e4688eae3d886e48e95486fef7ed53a8a13e0ef64b2216ad80aeaf381cc32200a658ddcabe2818f01829e4e4d29646b319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b02a475dc37d04b03b5060cf842383d3016f19fd7cb31905e9d0ede61460279ffa580c95e24eac1c05cbf61ac9d011863def78cc1dc079fd5a385e55a93883b"} 14:58:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:58:18 INFO - Copying logs to upload dir... 14:58:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:58:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.998477 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-22 14:58:18.447369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 14:58:18.452830) ========= 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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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/Autoland/sha512/f3be0e229bbd7b9067f4f1aeebf8fc8fa860df3ecad2f8d03d4979510906eae476f81841eed8e409394212e7919c24a97f60559b4a3ac8de52c957df654c4017", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297645252e07b37346942b71d04a22e4688eae3d886e48e95486fef7ed53a8a13e0ef64b2216ad80aeaf381cc32200a658ddcabe2818f01829e4e4d29646b319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b02a475dc37d04b03b5060cf842383d3016f19fd7cb31905e9d0ede61460279ffa580c95e24eac1c05cbf61ac9d011863def78cc1dc079fd5a385e55a93883b"} build_url:https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/cR13mZibSp2n1pwim6RzyQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3be0e229bbd7b9067f4f1aeebf8fc8fa860df3ecad2f8d03d4979510906eae476f81841eed8e409394212e7919c24a97f60559b4a3ac8de52c957df654c4017", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/297645252e07b37346942b71d04a22e4688eae3d886e48e95486fef7ed53a8a13e0ef64b2216ad80aeaf381cc32200a658ddcabe2818f01829e4e4d29646b319", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5b02a475dc37d04b03b5060cf842383d3016f19fd7cb31905e9d0ede61460279ffa580c95e24eac1c05cbf61ac9d011863def78cc1dc079fd5a385e55a93883b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 14:58:18.486615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:58:18.486958) ========= 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.UNoy1Cne3g/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.LJHOHmKOYv/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005204 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 14:58:18.535318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 14:58:18.535639) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 14:58:18.535988) ========= ========= Total master_lag: 0.52 =========