builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1484884540.95 results: success (0) buildid: 20170119182725 builduid: 513590851d6345218ee082bfa6f74644 revision: 1a5d6439f0e6c36cb2a4537eaee3670910388420 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:40.949082) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:40.949592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:40.949878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:40.975259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:40.975639) ========= 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.ppEbmkPuTu/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.6qkATzBUg2/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-19 19:55:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.83M=0.001s 2017-01-19 19:55:41 (9.83 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127396 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:41.126791) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:41.127114) ========= 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.ppEbmkPuTu/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.6qkATzBUg2/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.020185 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:41.176500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-19 19:55:41.176882) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 1a5d6439f0e6c36cb2a4537eaee3670910388420 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 1a5d6439f0e6c36cb2a4537eaee3670910388420 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ppEbmkPuTu/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.6qkATzBUg2/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-19 19:55:41,240 truncating revision to first 12 chars 2017-01-19 19:55:41,240 Setting DEBUG logging. 2017-01-19 19:55:41,240 attempt 1/10 2017-01-19 19:55:41,240 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/1a5d6439f0e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-19 19:55:42,998 unpacking tar archive at: graphics-1a5d6439f0e6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.016975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-19 19:55:43.218172) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:43.218527) ========= script_repo_revision: 1a5d6439f0e6c36cb2a4537eaee3670910388420 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:43.218966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:43.219243) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-19 19:55:43.239315) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-19 19:55:43.239734) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ppEbmkPuTu/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.6qkATzBUg2/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:55:43 INFO - MultiFileLogger online at 20170119 19:55:43 in /builds/slave/test 19:55:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:55:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:55:43 INFO - {'append_to_log': False, 19:55:43 INFO - 'base_work_dir': '/builds/slave/test', 19:55:43 INFO - 'blob_upload_branch': 'Graphics', 19:55:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:55:43 INFO - 'branch': 'Graphics', 19:55:43 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:43 INFO - 'config_files': ('talos/mac_config.py',), 19:55:43 INFO - 'default_actions': ('clobber', 19:55:43 INFO - 'read-buildbot-config', 19:55:43 INFO - 'download-and-extract', 19:55:43 INFO - 'populate-webroot', 19:55:43 INFO - 'create-virtualenv', 19:55:43 INFO - 'install', 19:55:43 INFO - 'run-tests'), 19:55:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:43 INFO - 'download_minidump_stackwalk': True, 19:55:43 INFO - 'download_symbols': 'ondemand', 19:55:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:43 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:43 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:43 INFO - 'installer_path': 'installer.exe', 19:55:43 INFO - 'log_level': 'info', 19:55:43 INFO - 'log_name': 'talos', 19:55:43 INFO - 'log_to_console': True, 19:55:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:55:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:55:43 INFO - 'opt_config_files': (), 19:55:43 INFO - 'pip_index': False, 19:55:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:55:43 INFO - 'cmd': ('bash', 19:55:43 INFO - '-c', 19:55:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:55:43 INFO - 'enabled': True, 19:55:43 INFO - 'halt_on_failure': False, 19:55:43 INFO - 'name': 'check_screen_resolution'},), 19:55:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:55:43 INFO - 'cmd': ('bash', 19:55:43 INFO - '-c', 19:55:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:55:43 INFO - 'enabled': True, 19:55:43 INFO - 'halt_on_failure': False, 19:55:43 INFO - 'name': 'check_screen_resolution'},), 19:55:43 INFO - 'run_cmd_checks_enabled': True, 19:55:43 INFO - 'sps_profile': False, 19:55:43 INFO - 'sps_profile_interval': 0, 19:55:43 INFO - 'suite': 'dromaeojs', 19:55:43 INFO - 'system_bits': '32', 19:55:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:43 INFO - 'title': 't-yosemite-r7-0312', 19:55:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:43 INFO - 'use_talos_json': True, 19:55:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:55:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:43 INFO - 'work_dir': 'build'} 19:55:43 INFO - [mozharness: 2017-01-20 03:55:43.427100Z] Running clobber step. 19:55:43 INFO - Running pre-action listener: _resource_record_pre_action 19:55:43 INFO - Running main action method: clobber 19:55:43 INFO - rmtree: /builds/slave/test/build 19:55:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:55:44 INFO - Running post-action listener: _resource_record_post_action 19:55:44 INFO - [mozharness: 2017-01-20 03:55:44.108968Z] Finished clobber step (success) 19:55:44 INFO - [mozharness: 2017-01-20 03:55:44.109105Z] Running read-buildbot-config step. 19:55:44 INFO - Running pre-action listener: _resource_record_pre_action 19:55:44 INFO - Running main action method: read_buildbot_config 19:55:44 INFO - Using buildbot properties: 19:55:44 INFO - { 19:55:44 INFO - "project": "", 19:55:44 INFO - "product": "firefox", 19:55:44 INFO - "script_repo_revision": "default", 19:55:44 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 19:55:44 INFO - "repository": "", 19:55:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 19:55:44 INFO - "buildid": "20170119182725", 19:55:44 INFO - "pgo_build": "False", 19:55:44 INFO - "basedir": "/builds/slave/test", 19:55:44 INFO - "buildnumber": 4, 19:55:44 INFO - "slavename": "t-yosemite-r7-0312", 19:55:44 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:55:44 INFO - "platform": "yosemite_r7", 19:55:44 INFO - "scheduler": "tests-graphics-macosx64-talos", 19:55:44 INFO - "branch": "graphics", 19:55:44 INFO - "repo_path": "projects/graphics", 19:55:44 INFO - "revision": "1a5d6439f0e6c36cb2a4537eaee3670910388420", 19:55:44 INFO - "stage_platform": "macosx64", 19:55:44 INFO - "builduid": "513590851d6345218ee082bfa6f74644", 19:55:44 INFO - "slavebuilddir": "test" 19:55:44 INFO - } 19:55:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 19:55:44 INFO - Running post-action listener: _resource_record_post_action 19:55:44 INFO - [mozharness: 2017-01-20 03:55:44.113989Z] Finished read-buildbot-config step (success) 19:55:44 INFO - [mozharness: 2017-01-20 03:55:44.114281Z] Running download-and-extract step. 19:55:44 INFO - Running pre-action listener: _resource_record_pre_action 19:55:44 INFO - Running main action method: download_and_extract 19:55:44 INFO - mkdir: /builds/slave/test/build/tests 19:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:55:44 INFO - trying https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 19:55:44 INFO - Downloading https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 19:55:45 INFO - Downloaded 1199 bytes. 19:55:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 19:55:45 INFO - Using the following test package requirements: 19:55:45 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:55:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 19:55:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 19:55:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'jsshell-mac.zip'], 19:55:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 19:55:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 19:55:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 19:55:45 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 19:55:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 19:55:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 19:55:45 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 19:55:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:55:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:55:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:55:45 INFO - Fetch https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:55:46 INFO - Expected file size: 16340635 19:55:46 INFO - Obtained file size: 16340635 19:55:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:55:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 19:55:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:55:52 INFO - Fetch https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 19:55:53 INFO - Expected file size: 16340635 19:55:53 INFO - Obtained file size: 16340635 19:56:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 19:56:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:56:00 INFO - Fetch https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 19:56:01 INFO - Expected file size: 14403463 19:56:01 INFO - Obtained file size: 14403463 19:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:01 INFO - trying https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:56:01 INFO - Downloading https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 19:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 19:56:03 INFO - Downloaded 69933561 bytes. 19:56:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:56:03 INFO - mkdir: /builds/slave/test/properties 19:56:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:56:03 INFO - Writing to file /builds/slave/test/properties/build_url 19:56:03 INFO - Contents: 19:56:03 INFO - build_url:https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 19:56:04 INFO - Running post-action listener: _resource_record_post_action 19:56:04 INFO - Running post-action listener: set_extra_try_arguments 19:56:04 INFO - [mozharness: 2017-01-20 03:56:04.364067Z] Finished download-and-extract step (success) 19:56:04 INFO - [mozharness: 2017-01-20 03:56:04.364204Z] Running populate-webroot step. 19:56:04 INFO - Running pre-action listener: _resource_record_pre_action 19:56:04 INFO - Running main action method: populate_webroot 19:56:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:56:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:56:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:56:04 INFO - '--tppagecycles', 19:56:04 INFO - '7'], 19:56:04 INFO - 'tests': ['tsvgm']}}, 19:56:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:56:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:56:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:56:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:56:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['damp', 'tps']}, 19:56:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'tests': ['damp', 'tps']}, 19:56:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['dromaeo_dom']}, 19:56:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:56:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['basic_compositor_video']}, 19:56:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:56:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['a11yr', 19:56:04 INFO - 'ts_paint', 19:56:04 INFO - 'tpaint', 19:56:04 INFO - 'sessionrestore', 19:56:04 INFO - 'sessionrestore_no_auto_restore', 19:56:04 INFO - 'tabpaint']}, 19:56:04 INFO - 'other-e10s': {'tests': ['a11yr', 19:56:04 INFO - 'ts_paint', 19:56:04 INFO - 'tpaint', 19:56:04 INFO - 'sessionrestore', 19:56:04 INFO - 'sessionrestore_no_auto_restore', 19:56:04 INFO - 'tabpaint']}, 19:56:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:56:04 INFO - 'ts_paint', 19:56:04 INFO - 'tpaint', 19:56:04 INFO - 'sessionrestore', 19:56:04 INFO - 'sessionrestore_no_auto_restore', 19:56:04 INFO - 'tabpaint']}, 19:56:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:56:04 INFO - 'ts_paint', 19:56:04 INFO - 'tpaint', 19:56:04 INFO - 'sessionrestore', 19:56:04 INFO - 'sessionrestore_no_auto_restore', 19:56:04 INFO - 'tabpaint']}, 19:56:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['a11yr', 19:56:04 INFO - 'ts_paint', 19:56:04 INFO - 'tpaint', 19:56:04 INFO - 'sessionrestore', 19:56:04 INFO - 'sessionrestore_no_auto_restore', 19:56:04 INFO - 'tabpaint']}, 19:56:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['a11yr', 19:56:04 INFO - 'ts_paint', 19:56:04 INFO - 'tpaint', 19:56:04 INFO - 'sessionrestore', 19:56:04 INFO - 'sessionrestore_no_auto_restore', 19:56:04 INFO - 'tabpaint']}, 19:56:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['tsvgx', 19:56:04 INFO - 'tsvgr_opacity', 19:56:04 INFO - 'tart', 19:56:04 INFO - 'tscrollx', 19:56:04 INFO - 'cart', 19:56:04 INFO - 'tsvg_static']}, 19:56:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:56:04 INFO - 'tsvgr_opacity', 19:56:04 INFO - 'tart', 19:56:04 INFO - 'tscrollx', 19:56:04 INFO - 'cart', 19:56:04 INFO - 'tsvg_static']}, 19:56:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'talos_options': ['--disable-e10s'], 19:56:04 INFO - 'tests': ['tp5o']}, 19:56:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:56:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'talos_options': ['--disable-e10s', 19:56:04 INFO - '--xperf_path', 19:56:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:04 INFO - 'tests': ['tp5n']}, 19:56:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:56:04 INFO - 'talos_options': ['--xperf_path', 19:56:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:04 INFO - 'tests': ['tp5n']}}, 19:56:04 INFO - 'talos.zip': {'path': '', 19:56:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:56:04 INFO - Running post-action listener: _resource_record_post_action 19:56:04 INFO - [mozharness: 2017-01-20 03:56:04.382224Z] Finished populate-webroot step (success) 19:56:04 INFO - [mozharness: 2017-01-20 03:56:04.382361Z] Running create-virtualenv step. 19:56:04 INFO - Running pre-action listener: _resource_record_pre_action 19:56:04 INFO - Running main action method: create_virtualenv 19:56:04 INFO - Creating virtualenv /builds/slave/test/build/venv 19:56:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:56:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:56:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:56:04 INFO - Using real prefix '/tools/python27' 19:56:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:56:05 INFO - Installing distribute.............................................................................................................................................................................................done. 19:56:08 INFO - Installing pip.................done. 19:56:08 INFO - Return code: 0 19:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:56:08 INFO - Reading from file tmpfile_stdout 19:56:08 INFO - Output received: 19:56:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:56:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:08 INFO - 'HOME': '/Users/cltbld', 19:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:08 INFO - 'LOGNAME': 'cltbld', 19:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:08 INFO - 'MOZ_NO_REMOTE': '1', 19:56:08 INFO - 'NO_EM_RESTART': '1', 19:56:08 INFO - 'PAGER': '/bin/cat', 19:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:08 INFO - 'PWD': '/builds/slave/test', 19:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:08 INFO - 'SHELL': '/bin/bash', 19:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:08 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:08 INFO - 'USER': 'cltbld', 19:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:08 INFO - 'XPC_FLAGS': '0x0', 19:56:08 INFO - 'XPC_SERVICE_NAME': '0', 19:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:56:08 INFO - Cleaning up... 19:56:08 INFO - Return code: 0 19:56:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:56:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:08 INFO - 'HOME': '/Users/cltbld', 19:56:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:08 INFO - 'LOGNAME': 'cltbld', 19:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:08 INFO - 'MOZ_NO_REMOTE': '1', 19:56:08 INFO - 'NO_EM_RESTART': '1', 19:56:08 INFO - 'PAGER': '/bin/cat', 19:56:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:08 INFO - 'PWD': '/builds/slave/test', 19:56:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:08 INFO - 'SHELL': '/bin/bash', 19:56:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:08 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:08 INFO - 'USER': 'cltbld', 19:56:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:08 INFO - 'XPC_FLAGS': '0x0', 19:56:08 INFO - 'XPC_SERVICE_NAME': '0', 19:56:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:08 INFO - Downloading/unpacking psutil>=3.1.1 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:56:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:12 INFO - Installing collected packages: psutil 19:56:12 INFO - Running setup.py install for psutil 19:56:12 INFO - building 'psutil._psutil_osx' extension 19:56:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:56:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:56:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:56:12 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:56:13 INFO - building 'psutil._psutil_posix' extension 19:56:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:56:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:56:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:56:13 INFO - ^ 19:56:13 INFO - 1 warning generated. 19:56:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:56:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:13 INFO - Successfully installed psutil 19:56:13 INFO - Cleaning up... 19:56:13 INFO - Return code: 0 19:56:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:13 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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:13 INFO - 'HOME': '/Users/cltbld', 19:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:13 INFO - 'LOGNAME': 'cltbld', 19:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:13 INFO - 'MOZ_NO_REMOTE': '1', 19:56:13 INFO - 'NO_EM_RESTART': '1', 19:56:13 INFO - 'PAGER': '/bin/cat', 19:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:13 INFO - 'PWD': '/builds/slave/test', 19:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:13 INFO - 'SHELL': '/bin/bash', 19:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:13 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:13 INFO - 'USER': 'cltbld', 19:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:13 INFO - 'XPC_FLAGS': '0x0', 19:56:13 INFO - 'XPC_SERVICE_NAME': '0', 19:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:56:16 INFO - Installing collected packages: mozsystemmonitor 19:56:16 INFO - Running setup.py install for mozsystemmonitor 19:56:16 INFO - Successfully installed mozsystemmonitor 19:56:16 INFO - Cleaning up... 19:56:16 INFO - Return code: 0 19:56:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:16 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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:16 INFO - 'HOME': '/Users/cltbld', 19:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:16 INFO - 'LOGNAME': 'cltbld', 19:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:16 INFO - 'MOZ_NO_REMOTE': '1', 19:56:16 INFO - 'NO_EM_RESTART': '1', 19:56:16 INFO - 'PAGER': '/bin/cat', 19:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:16 INFO - 'PWD': '/builds/slave/test', 19:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:16 INFO - 'SHELL': '/bin/bash', 19:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:16 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:16 INFO - 'USER': 'cltbld', 19:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:16 INFO - 'XPC_FLAGS': '0x0', 19:56:16 INFO - 'XPC_SERVICE_NAME': '0', 19:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:16 INFO - Downloading/unpacking jsonschema==2.5.1 19:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:19 INFO - warning: no files found matching '*.txt' 19:56:19 INFO - no previously-included directories found matching 'build' 19:56:19 INFO - no previously-included directories found matching 'dist' 19:56:19 INFO - no previously-included directories found matching '.git*' 19:56:20 INFO - Installing collected packages: jsonschema, functools32 19:56:20 INFO - Running setup.py install for functools32 19:56:20 INFO - warning: no files found matching '*.txt' 19:56:20 INFO - no previously-included directories found matching 'build' 19:56:20 INFO - no previously-included directories found matching 'dist' 19:56:20 INFO - no previously-included directories found matching '.git*' 19:56:20 INFO - Successfully installed jsonschema functools32 19:56:20 INFO - Cleaning up... 19:56:20 INFO - Return code: 0 19:56:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:20 INFO - 'HOME': '/Users/cltbld', 19:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:20 INFO - 'LOGNAME': 'cltbld', 19:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:20 INFO - 'MOZ_NO_REMOTE': '1', 19:56:20 INFO - 'NO_EM_RESTART': '1', 19:56:20 INFO - 'PAGER': '/bin/cat', 19:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:20 INFO - 'PWD': '/builds/slave/test', 19:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:20 INFO - 'SHELL': '/bin/bash', 19:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:20 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:20 INFO - 'USER': 'cltbld', 19:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:20 INFO - 'XPC_FLAGS': '0x0', 19:56:20 INFO - 'XPC_SERVICE_NAME': '0', 19:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:56:20 INFO - Cleaning up... 19:56:20 INFO - Return code: 0 19:56:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:20 INFO - 'HOME': '/Users/cltbld', 19:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:20 INFO - 'LOGNAME': 'cltbld', 19:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:20 INFO - 'MOZ_NO_REMOTE': '1', 19:56:20 INFO - 'NO_EM_RESTART': '1', 19:56:20 INFO - 'PAGER': '/bin/cat', 19:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:20 INFO - 'PWD': '/builds/slave/test', 19:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:20 INFO - 'SHELL': '/bin/bash', 19:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:20 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:20 INFO - 'USER': 'cltbld', 19:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:20 INFO - 'XPC_FLAGS': '0x0', 19:56:20 INFO - 'XPC_SERVICE_NAME': '0', 19:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:20 INFO - Downloading/unpacking blobuploader==1.2.4 19:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:56:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:56:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:56:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:24 INFO - Downloading docopt-0.6.1.tar.gz 19:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:24 INFO - Running setup.py install for blobuploader 19:56:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:56:24 INFO - Running setup.py install for requests 19:56:25 INFO - Running setup.py install for docopt 19:56:25 INFO - Successfully installed blobuploader requests docopt 19:56:25 INFO - Cleaning up... 19:56:25 INFO - Return code: 0 19:56:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:25 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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:56:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:25 INFO - 'HOME': '/Users/cltbld', 19:56:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:25 INFO - 'LOGNAME': 'cltbld', 19:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:25 INFO - 'MOZ_NO_REMOTE': '1', 19:56:25 INFO - 'NO_EM_RESTART': '1', 19:56:25 INFO - 'PAGER': '/bin/cat', 19:56:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:25 INFO - 'PWD': '/builds/slave/test', 19:56:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:25 INFO - 'SHELL': '/bin/bash', 19:56:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:25 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:25 INFO - 'USER': 'cltbld', 19:56:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:25 INFO - 'XPC_FLAGS': '0x0', 19:56:25 INFO - 'XPC_SERVICE_NAME': '0', 19:56:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-REk8na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-98j0jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PpWtYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-t3Z6_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-QXKFPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-bXCmpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PAJToF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-3Kv3F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Doz9ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-g4TBKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-rAUkrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9y0Fzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EN0pKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-_tE_YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-B1eikH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UAiLqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gCoZDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:27 INFO - Running setup.py install for manifestparser 19:56:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:56:27 INFO - Running setup.py install for mozcrash 19:56:27 INFO - Running setup.py install for mozdebug 19:56:28 INFO - Running setup.py install for mozdevice 19:56:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Running setup.py install for mozfile 19:56:28 INFO - Running setup.py install for mozhttpd 19:56:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Running setup.py install for mozinfo 19:56:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Running setup.py install for mozInstall 19:56:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:56:28 INFO - Running setup.py install for mozleak 19:56:28 INFO - Running setup.py install for mozlog 19:56:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:56:29 INFO - Running setup.py install for moznetwork 19:56:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:56:29 INFO - Running setup.py install for mozprocess 19:56:29 INFO - Running setup.py install for mozprofile 19:56:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:56:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:56:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:56:29 INFO - Running setup.py install for mozrunner 19:56:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:56:29 INFO - Running setup.py install for mozscreenshot 19:56:29 INFO - Running setup.py install for moztest 19:56:30 INFO - Running setup.py install for mozversion 19:56:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:56:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:30 INFO - Cleaning up... 19:56:30 INFO - Return code: 0 19:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:30 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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:30 INFO - 'HOME': '/Users/cltbld', 19:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:30 INFO - 'LOGNAME': 'cltbld', 19:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:30 INFO - 'MOZ_NO_REMOTE': '1', 19:56:30 INFO - 'NO_EM_RESTART': '1', 19:56:30 INFO - 'PAGER': '/bin/cat', 19:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:30 INFO - 'PWD': '/builds/slave/test', 19:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:30 INFO - 'SHELL': '/bin/bash', 19:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:30 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:30 INFO - 'USER': 'cltbld', 19:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:30 INFO - 'XPC_FLAGS': '0x0', 19:56:30 INFO - 'XPC_SERVICE_NAME': '0', 19:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:30 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-x2pyda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:30 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XeCKdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:30 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tNzhJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:30 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-yeQMD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:30 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CQlein-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-m1Ljho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9SEEMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-w3Z2Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-8MJrXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-YeVx6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-72k8dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ungdfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1B52G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:31 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VV9cdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:32 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-G_cpyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:32 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XyLRqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:32 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zMQ_H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:56:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:32 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:34 INFO - Downloading blessings-1.6.tar.gz 19:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:35 INFO - Installing collected packages: blessings 19:56:35 INFO - Running setup.py install for blessings 19:56:35 INFO - Successfully installed blessings 19:56:35 INFO - Cleaning up... 19:56:35 INFO - Return code: 0 19:56:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:35 INFO - Reading from file tmpfile_stdout 19:56:35 INFO - Current package versions: 19:56:35 INFO - blessings == 1.6 19:56:35 INFO - blobuploader == 1.2.4 19:56:35 INFO - docopt == 0.6.1 19:56:35 INFO - functools32 == 3.2.3-2 19:56:35 INFO - jsonschema == 2.5.1 19:56:35 INFO - manifestparser == 1.1 19:56:35 INFO - mozInstall == 1.12 19:56:35 INFO - mozcrash == 1.0 19:56:35 INFO - mozdebug == 0.1 19:56:35 INFO - mozdevice == 0.49 19:56:35 INFO - mozfile == 1.2 19:56:35 INFO - mozhttpd == 0.7 19:56:35 INFO - mozinfo == 0.9 19:56:35 INFO - mozleak == 0.1 19:56:35 INFO - mozlog == 3.4 19:56:35 INFO - moznetwork == 0.27 19:56:35 INFO - mozprocess == 0.24 19:56:35 INFO - mozprofile == 0.28 19:56:35 INFO - mozrunner == 6.13 19:56:35 INFO - mozscreenshot == 0.1 19:56:35 INFO - mozsystemmonitor == 0.3 19:56:35 INFO - moztest == 0.8 19:56:35 INFO - mozversion == 1.4 19:56:35 INFO - psutil == 3.1.1 19:56:35 INFO - requests == 1.2.3 19:56:35 INFO - wsgiref == 0.1.2 19:56:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56: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')]} 19:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:35 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 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:56:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:35 INFO - 'HOME': '/Users/cltbld', 19:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:35 INFO - 'LOGNAME': 'cltbld', 19:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:35 INFO - 'MOZ_NO_REMOTE': '1', 19:56:35 INFO - 'NO_EM_RESTART': '1', 19:56:35 INFO - 'PAGER': '/bin/cat', 19:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:35 INFO - 'PWD': '/builds/slave/test', 19:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:35 INFO - 'SHELL': '/bin/bash', 19:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:35 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:35 INFO - 'USER': 'cltbld', 19:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:35 INFO - 'XPC_FLAGS': '0x0', 19:56:35 INFO - 'XPC_SERVICE_NAME': '0', 19:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:56:35 INFO - Cleaning up... 19:56:35 INFO - Return code: 0 19:56:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56: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')]} 19:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109df6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109df9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe18bd7b020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, '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.ppEbmkPuTu/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.6qkATzBUg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:56: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', 'jsonschema'] in /builds/slave/test/build 19:56: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 jsonschema 19:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:35 INFO - 'HOME': '/Users/cltbld', 19:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:35 INFO - 'LOGNAME': 'cltbld', 19:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:35 INFO - 'MOZ_NO_REMOTE': '1', 19:56:35 INFO - 'NO_EM_RESTART': '1', 19:56:35 INFO - 'PAGER': '/bin/cat', 19:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:35 INFO - 'PWD': '/builds/slave/test', 19:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:35 INFO - 'SHELL': '/bin/bash', 19:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:35 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:35 INFO - 'USER': 'cltbld', 19:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:35 INFO - 'XPC_FLAGS': '0x0', 19:56:35 INFO - 'XPC_SERVICE_NAME': '0', 19:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:56:36 INFO - Cleaning up... 19:56:36 INFO - Return code: 0 19:56:36 INFO - Running post-action listener: _resource_record_post_action 19:56:36 INFO - Running post-action listener: _start_resource_monitoring 19:56:36 INFO - Starting resource monitoring. 19:56:36 INFO - [mozharness: 2017-01-20 03:56:36.162995Z] Finished create-virtualenv step (success) 19:56:36 INFO - [mozharness: 2017-01-20 03:56:36.164080Z] Running install step. 19:56:36 INFO - Running pre-action listener: _resource_record_pre_action 19:56:36 INFO - Running main action method: install 19:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:36 INFO - Reading from file tmpfile_stdout 19:56:36 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:36 INFO - Reading from file tmpfile_stdout 19:56:36 INFO - Output received: 19:56:36 INFO - Usage: mozinstall [options] installer 19:56:36 INFO - Options: 19:56:36 INFO - -h, --help show this help message and exit 19:56:36 INFO - -d DEST, --destination=DEST 19:56:36 INFO - Directory to install application into. [default: 19:56:36 INFO - "/builds/slave/test"] 19:56:36 INFO - --app=APP Application being installed. [default: firefox] 19:56:36 INFO - mkdir: /builds/slave/test/build/application 19:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:56:58 INFO - Reading from file tmpfile_stdout 19:56:58 INFO - Output received: 19:56:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:56:58 INFO - Running post-action listener: _resource_record_post_action 19:56:58 INFO - [mozharness: 2017-01-20 03:56:58.705769Z] Finished install step (success) 19:56:58 INFO - [mozharness: 2017-01-20 03:56:58.705918Z] Running run-tests step. 19:56:58 INFO - Running pre-action listener: _resource_record_pre_action 19:56:58 INFO - Running main action method: run_tests 19:56:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:56:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:56:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:56:58 INFO - 2017-01-19 19:56:58.721 screenresolution[6424:117194] starting screenresolution argv=screenresolution get 19:56:58 INFO - 2017-01-19 19:56:58.723 screenresolution[6424:117194] Display 0: 1600x1200x32@60 19:56:58 INFO - 2017-01-19 19:56:58.730 screenresolution[6425:117196] starting screenresolution argv=screenresolution list 19:56:58 INFO - Available Modes on Display 0 19:56:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:56:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:56:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:56:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:56:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:56:58 INFO - Intel Iris: 19:56:58 INFO - Chipset Model: Intel Iris 19:56:58 INFO - Type: GPU 19:56:58 INFO - Bus: Built-In 19:56:58 INFO - VRAM (Dynamic, Max): 1536 MB 19:56:58 INFO - Vendor: Intel (0x8086) 19:56:58 INFO - Device ID: 0x0a2e 19:56:58 INFO - Revision ID: 0x0009 19:56:58 INFO - Displays: 19:56:58 INFO - Display: 19:56:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:56:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:56:58 INFO - Display Serial Number: 1600x1200 60 19:56:58 INFO - Main Display: Yes 19:56:58 INFO - Mirror: Off 19:56:58 INFO - Online: Yes 19:56:58 INFO - Rotation: Supported 19:56:58 INFO - Return code: 0 19:56:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:56:58 INFO - Python 2.7.3 19:56:58 INFO - Return code: 0 19:56:58 INFO - grabbing minidump binary from tooltool 19:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:56:58 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 0x109bd4d30>, '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 0x109afbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109bc9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:56:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:56:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:56:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:56:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:59 INFO - Return code: 0 19:56:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:56:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:56:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:56:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:56:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ppEbmkPuTu/Render', 19:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:59 INFO - 'HOME': '/Users/cltbld', 19:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:59 INFO - 'LOGNAME': 'cltbld', 19:56:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:56:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:59 INFO - 'MOZ_NO_REMOTE': '1', 19:56:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:56:59 INFO - 'NO_EM_RESTART': '1', 19:56:59 INFO - 'PAGER': '/bin/cat', 19:56:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:59 INFO - 'PWD': '/builds/slave/test', 19:56:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:59 INFO - 'SHELL': '/bin/bash', 19:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6qkATzBUg2/Listeners', 19:56:59 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 19:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:59 INFO - 'USER': 'cltbld', 19:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:59 INFO - 'XPC_FLAGS': '0x0', 19:56:59 INFO - 'XPC_SERVICE_NAME': '0', 19:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:56:59 INFO - mozversion application_buildid: 20170119182725 19:56:59 INFO - mozversion application_changeset: 1a5d6439f0e6c36cb2a4537eaee3670910388420 19:56:59 INFO - mozversion application_display_name: Nightly 19:56:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:59 INFO - mozversion application_name: Firefox 19:56:59 INFO - mozversion application_remotingname: firefox 19:56:59 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:56:59 INFO - mozversion application_vendor: Mozilla 19:56:59 INFO - mozversion application_version: 53.0a1 19:56:59 INFO - mozversion platform_buildid: 20170119182725 19:56:59 INFO - mozversion platform_changeset: 1a5d6439f0e6c36cb2a4537eaee3670910388420 19:56:59 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:56:59 INFO - mozversion platform_version: 53.0a1 19:56:59 INFO - using testdate: 1484884619 19:56:59 INFO - actual date: 1484884619 19:56:59 INFO - starting webserver on 'localhost:57580' 19:56:59 INFO - SUITE-START | Running 2 tests 19:56:59 INFO - TEST-START | dromaeo_css 19:56:59 INFO - operating with platform_type : mac_ 19:56:59 INFO - Initialising browser for dromaeo_css test... 19:56:59 INFO - TEST-INFO | started process 6435 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpVfRtzk/profile http://localhost:57580/getInfo.html) 19:57:01 INFO - PROCESS | 6435 | __metrics Screen width/height:1600/1200 19:57:01 INFO - PROCESS | 6435 | colorDepth:24 19:57:01 INFO - PROCESS | 6435 | Browser inner width/height: 1024/689 19:57:01 INFO - PROCESS | 6435 | __metrics 19:57:01 INFO - PROCESS | 6435 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:57:01 INFO - PROCESS | 6435 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:02 INFO - TEST-INFO | 6435: exit 0 19:57:02 INFO - Browser initialized. 19:57:02 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:02 INFO - TEST-INFO | started process 6438 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpVfRtzk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:14 INFO - PROCESS | 6438 | RSS: Main: 235110400 19:57:14 INFO - PROCESS | 6438 | 20:00:17 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57580/tests/dromaeo/cssquery-ext.html) 20:00:20 INFO - PROCESS | 6438 | RSS: Main: 428040192 20:00:20 INFO - PROCESS | 6438 | 20:02:04 INFO - PROCESS | 6438 | ************************* 20:02:04 INFO - PROCESS | 6438 | A coding exception was thrown and uncaught in a Task. 20:02:04 INFO - PROCESS | 6438 | 20:02:04 ERROR - PROCESS | 6438 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:02:04 INFO - PROCESS | 6438 | Full stack: 20:02:04 INFO - PROCESS | 6438 | ************************* 20:03:23 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-ext.html (next: http://localhost:57580/tests/dromaeo/cssquery-jquery.html) 20:03:23 INFO - PROCESS | 6438 | RSS: Main: 366039040 20:03:23 INFO - PROCESS | 6438 | 20:06:26 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57580/tests/dromaeo/cssquery-mootools.html) 20:06:27 INFO - PROCESS | 6438 | RSS: Main: 337645568 20:06:27 INFO - PROCESS | 6438 | 20:09:29 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57580/tests/dromaeo/cssquery-prototype.html) 20:09:29 INFO - PROCESS | 6438 | RSS: Main: 337416192 20:09:29 INFO - PROCESS | 6438 | 20:12:33 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57580/tests/dromaeo/cssquery-yui.html) 20:12:34 INFO - PROCESS | 6438 | RSS: Main: 330719232 20:12:34 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | Cycle 1(1): loaded http://localhost:57580/tests/dromaeo/cssquery-yui.html (next: http://localhost:57580/tests/dromaeo/cssquery-dojo.html) 20:15:37 INFO - PROCESS | 6438 | RSS: Main: 456454144 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | __start_tp_report 20:15:37 INFO - PROCESS | 6438 | _x_x_mozilla_page_load 20:15:37 INFO - PROCESS | 6438 | _x_x_mozilla_page_load_details 20:15:37 INFO - PROCESS | 6438 | |i|pagename|runs| 20:15:37 INFO - PROCESS | 6438 | |0;dojo.html;3276.246463313438;3309.702126808587;3314.419976504111;3320.933581328375;3368.595768507779;4930.704157750538;5641.323041235058;5718.170865224545;5792.855178620536;5820.854478638036;5085.466026067256;5695.971520142393;5734.684592347419;5812.534997200224;5816.360200377966;5231.450697676746;5247.816326428557;5248.763805628737;5272.683638981654;5385.165299378583;5169.638125331228;5288.312519372476;5303.390110137326;5303.734813259341;5351.839444816662;5290.074237008508;5295.0998330283755;5303.390110137345;5306.3632364116165;5315.415304316522;5128.794848206067;5138.409082955471;5146.330976972969;5193.169092945111;5193.221016847503;5114.974425127851;5170.095233334189;5189.974050129763;5210.452902445264;5215.478452154792;5644.435556444364;5647.237622920935;5650.971745141248;5680.886382272372;5700.714964251771;6107.340534417173;6172.382761723837;6198.783042593533;6201.503879689659;6213.254409470847;6273.8745225095245;6287.811365659038;6331.39851714091;6353.809385718436;6367.204099487564;5901.498372638288;5902.6458412495385;5909.674967876765;5911.172435858984;5953.553483488756;6264.091706702503;6264.5301602380005;6342.873142537216;6345.841353966188;6358.7456501740335;6102.368068311607;6132.355508992545;6136.17161683176;6193.504519638418;6197.946349120661;6250.124982502453;6269.529785266123;6276.560640755103;6288.465480434123;6298;6115.327313995457;6130.245269656939;6151.72317245725;6161;6213.906791398133;6184.5980011299125;6212.627242365473;6235.657038862815;6244.219472565929;6295.748170073146;4504.2793153095345;4979.904421027368;5007.148784706608;5017.397912250481;5032.0690672225755;4509.6843220974215;4518.954810451919;4525.253333200051;4551.795169217393;4559.224931761542;4876.7076724667995;5651.039323314964;5654.575906806924;5676.829695109153;5718.056520674126;6249.156363890907;6271.937280627227;6282.654454005074;6293.937060629427;6366.045093236052;5724.112762521732;5775.33583637887;5785.652860828363;5787.913181302284;5817.912731308949;5505.724713764296;5513.145462453326;5520.199571062173;5525.143602741581;5526.253955716007;6243.344448832807;6254.249490061222;6275.874482510416;6330.715117819617;6375.266844312778;6299.527535434769;6300.0234963580715;6309.810705678653;6333.20834895638;6339.397757213057;6267.279262884645;6296.464800492009;6312.58968167086;6320.652364119834;6321.1782468278825;6116.1836049259855;6121.755129794758;6153.476954458921;6225.003999360262;6250.4374606285655;6178.783742568989;6293.3391993841815;6300.59046161998;6301.212348456443;6327.746890124344;5988.700564971647;6112.388761123852;6150.907736384047;6173.32093469727;6179.598326108789;6020.217371741645;6054;6123.510119190365;6156;6163.167972323679;5881.676507791942;5886.941130588811;5889.116632505158;5946.702664866652;5995.61028533144;5933.792317268875;6073.058675905242;6093.817185484442;6114.021756519113;6128.754849805958;5859.414058594107;5876.206712093813;5879.412058794086;5890.646561206341;5895.67573783446 20:15:37 INFO - PROCESS | 6438 | |1;ext.html;431.0903992575665;438.85737135430975;455.15114311808475;469.4155776058805;498.71573203274147;33895.32209355811;40015.1996960061;41980.580194198126;42028.94927626811;43669.34495982563;42087.78956105215;42481.787591062;42502.14995700084;42573.36139957896;42611.78694106525;8458.915410845904;8607.18231767981;9437.150656440901;9661.17879980199;9666.516674166298;11422;11756.823647645293;11797.7640447191;11955.64133076009;11958.7608247835;11723.824142637824;11729.061675066017;11790.349351090854;11798.58704945327;11822;8609.096044915257;8815.20663140314;8816.030236673962;9686.951565242163;11670.708232294219;8649.048604653482;11249;11520.596779112691;11570.074394048455;11645.592404265895;31090.689093109006;40458.595414045776;41882.581174188475;41954.58045419537;42015.57984420147;4069.1861627674584;4087.509498860126;4090.2637525245445;4116.444280022189;4185;24280.39299017521;30631.309625339512;30815.845920770476;31429.214269643442;31677.683223167704;3204.3591281743743;3217.260030193045;3223.4197844388;3225.225945773021;3323.7507186961075;456321.7183914126;472327;476360;477893;482415;50285.24572131421;60858.17425477243;60944.695276524224;60953.69523152356;61028.38971610227;56079.439205608236;62333.376666232754;64206.6789666058;64395.03407448892;64467;15574.844251557566;15923.12422816733;16030.358785648443;16065.036097834167;16075.517734467985;11127.109831213484;11402.429878506042;11418.771624567627;12318.568850090203;12349.259044457362;15936;16215.756763648555;16219.594510137105;16228.83771162297;16424.67150657004;5774.971125144348;6052.213212282463;6300.243970723543;6309.085182648582;6368.681565921685;697.8604279144191;876.0757400942067;877.1973644115562;882.161946151159;892.6295587331315;26150.6077408839;27246.72753272442;28869.133925982253;30172;30237.54232947653;892.8035832116924;1055.8574592430077;1105.2318638546294;1105.5633024955098;1118.4072441605963;12931.612051638465;13048.739025219442;15058.698826023638;15607.843921560867;15674.764878526832;221697;221831.89084054477;221958;222033.77966220453;222391;60470;60825.695871521246;60885.78228435406;60896.69551652214;61009.389906101256;1398.1261711430357;1448.7537118689847;1461.8465061168638;1462.6782107936237;1463.5975106845704;29434.969776057736;29467.85266073656;29749.851250743606;30305.24236894095;30497.390052199276;50504;50565.494345056075;54395;54702.452975469736;54847.177292339846;558082;563048;563915;563980;564234;21956.78043219547;22549.887250563643;24028.87985560131;24033.879830601436;24516.387090322885;41006.9748256296;41868.1626367477;42754.144917100864;42824.35763463613;42972.140557189305;35054;35057.8247108773;35180.648193517736;35896.820515897256;36304.818475908505;34959.65040349666;34992.65007349894;35675.64324356827;35929.46105808362;36073;34119.4882076774;34601.653983459844;35023.47464787979;35059.474107887894;35365.469517956735;30017.949371771883;30845.845770771004;30916.381672365977;30988;31198;18820.623587528447;23294.417639559146;23499.29502114939;23716;23801.880990594935 20:15:37 INFO - PROCESS | 6438 | |2;jquery.html;365.3879751416377;372.52317034196227;379.7265968502677;393.73226206179794;415.9292920203565;15392.384304627816;15428.768568471467;17875.821241787577;20713.482162945933;21258.255961041366;21065.57868842626;21822.018009189585;21906.342809715734;22031.449213769665;22666.433339166528;6574.441172500343;6617.272100068989;6797.932020679779;6805.251422343538;6897.896531552031;4669.159551280785;6673.366030227121;6790.6944187511435;6796;6814.727410903558;4891.14404979129;4901.485344038878;7861.371090312789;7934.7222847200355;7958.124606293303;7596.430267729887;7776.961115194445;7858.921410785876;7912.762617121495;7931.682732690714;7231.891521627127;7670.616469176519;7671.117821450549;7676.731314403969;7693;27885.58171627427;28557.143285701462;29130.708692913013;29343.853280733674;29741.959031433795;2939.1623387334507;3009.6689364169924;3067.1105379439937;3082.892098776532;3123.5314702794535;14562.927185364111;16194.83805161945;16709.331626734915;16954.915225423792;17863.642727145383;1589.4278059898427;1947.9610407791906;1975.170428420067;1979.7228388025544;1989.7015447682818;122065;131931;147057.79430805228;154983;157088.99999999886;21084.683729744065;22493.775062249497;22613.547729045655;22674.43313917165;22677.092916283495;39690.20619587592;39808.60191398049;39968.60031399707;39970.40044399336;40090.599094008685;10516.737081572868;10744.516496757664;11006.779864402668;11014.39420831862;11201.047910927662;7444.702211911571;8795.560221988875;8842.690505832265;8865.468071915706;9060.954695226614;10309.123724483354;10721.195910306602;10865.728356791144;10962;10966.342019478856;3206.823624700617;3237.3525294941105;3447.293589673128;4015.2371049501085;4034.172994536113;709.5458906299972;794.6781553470854;818.1572979830784;818.9467684600481;836;20935.639183453026;21595.892020539795;21624.78375216259;21682.460912977214;21721.131154753948;776.0183368039435;844.273924424994;866.6316815353575;986.9309148359546;1079.3200283821143;10323.690289291333;10825.621103261348;10965.287256328313;11233.943830280796;11418.371989540488;582186;594577.0271148616;596885;718620;722528;154184;158319;161903;163753;166630;1028.5937054863286;1050.5220124843179;1091.9454027298602;1094.4527736131934;1097.1716354152722;19443.902780486005;20088.79297971231;20151;20225.178711283334;20264.898675506527;47474;53601.731991339795;54990.725046374515;56174.7191264041;57863.710681446326;76895;83824.58087709523;86816.69774953507;87584.5620771892;89821.26340524356;7269.382102521345;8190.7952301192945;8295.58522073906;8860.3797734158;8894.777630559287;11367.261128026652;11646.475908584303;13179;13611.319434028457;13696;11382.601608943647;11521.539138434704;11824.645260642195;11829.76340473203;11869.643910682693;11218.887811121784;11419.543218271176;11547.595834145764;11724.41377931083;11948.761024779282;9521.476318802532;9628.18160456341;10870.565177392815;10952.835707464554;11400.771984560428;7406.666799976056;7469.850602988018;7709.267619576131;7820.296173344426;7899.921000789918;9804.460754658277;10600.416977066336;11288.379139147426;11426.94286528562;11486 20:15:37 INFO - PROCESS | 6438 | |3;mootools.html;1459.9708005839884;1461.9853801461995;1468.750312446884;1480.896337256392;1487.2415068315158;7359.926400735991;7875.17310682378;8292.295154911824;8306.79233019174;8307.87538186927;6797.6941037653305;7516.4738468307105;7751.263629955145;8115.1073381927945;8289.129641387643;2251.2570851619007;2303.2744685424123;2306.5271619318;2311.28350211435;2317.142657216832;2291.7708229177115;2314.884255787204;2326.0579465316573;2328.2200462844967;2333.3583264602285;2028.4421784009369;2117.7988091131397;2118.608057509358;2205.889705514726;2286.0969916882823;1894.9861823924202;2297.885105744706;2298.896549655253;2299.8160147188187;2301.298104078264;2225.4770129019666;2309.3533810533077;2311.722593288799;2315.5716192504274;2315.7336906255828;8228.341732661373;8295.668173273121;8331.83336333276;8343;8355.916440835575;4981.12830254704;5136.512031357052;5142.408623008365;5143.151380022329;5150.381954165524;3285.720713739335;3344.298245614045;3425.417678994552;3427.0404286799735;3481.1123163593375;1136.6615389942142;1141.720278531765;1163.9301641901513;1195.1394995603152;1222.4987755020488;10605.151587872951;10732.463376831127;10744.409057501834;10751.301165424222;10762.946185269024;3939.6848252140335;4345;4510.2783554631105;4534.206513860061;4615.653825963066;9313.115254050854;9358.672446464478;9373.953130234442;9393.060693930553;9405.623775049058;5136.5890728741615;5149.944261426399;5151.484851514819;5153.6907785532985;5160.767765450564;4629.8842528936375;4634.165850147006;4699.929501057487;4724.291356296583;4743.288506724019;3688.6126956669164;3728.664420202195;3760.511133552621;3793.943090853639;3806.4861243732294;1235.2835355493792;1238.8327575777334;1238.8823061809114;1250.8936740376987;1251.6557946564585;780.4673833410619;861.1990848510819;882.5366682491615;894.4454438248328;930.3255140023564;5528.668279903219;5558.638688485235;5633.436656334334;5744.597878148573;5818.330891947396;951.8286708392556;970.7184916374173;976.6630512473185;987.9110880020833;1017.7913527726798;3367.579052618423;3759.0978165240695;3770.5852356240794;3801.7718936863876;3868.419737039467;9665.661701840543;9692.9030709692;9973.10242078202;9980.500974951223;9990.800183996425;9763.560639771227;9909.256805739598;9928.453935033642;9949.452780097019;10022.248331375176;7698.653560589787;7838.568878711611;7839.412044096715;7843.137254901956;7844.4901081429525;4397.73613583186;5435.716998860567;5534.1975413564005;5560.332760068818;5613.410591887956;8997.28021758271;9056.592453339485;9191;9208.907910921072;9330.486823224517;9101.817963640822;9355.766105847408;9360.251179905727;9472.52637368115;9477.336586439158;5876.883392155477;6449.677516124269;6732.562383445061;6736.528443008942;6744.359285867835;7594.202608726005;7696.884546731915;7769.72805951789;7781.338586220235;7787.29914307715;5505.642133261325;6561.934380656323;6973.96513017452;7070.4343652508705;7106.289371062852;5824.679642619697;6700.262971073081;6815.2162501311;6924.272951340238;6928.099347084847;6316.3367846377305;6432.903506447314;6437.420632142942;6442.581232219891;6455.774047908489;4866.732329721758;4929.211326187793;4957.355543779286;4983.925241121314;5148.253503242084;4746.098241334135;4853.466118727008;4924.162892308388;5055.620828437808;5160.561352285098 20:15:37 INFO - PROCESS | 6438 | |4;prototype.html;324.49378968808645;347.7600455685577;349.7513875464592;357.8622230441279;368.67004031391923;4121.402396652484;4720.291956206571;5278.630495865291;5318.78724851006;5414.810481633139;4349.217140914634;4413.668974826885;4910.459849416561;5206.609504287175;5265.236540701596;3572.5355703758473;3859.247446747885;4028.2346354192755;4032.0927791247027;4055.35114381699;3553.4314509678456;4091.2226676931286;4106.8562600309;4108.28105081611;4109.157622687342;3568.411212149992;3752.5795861669208;4074.103697186614;4085.1625416789634;4086.9373962769746;3376.983115084409;3936.0872954014108;3990.78281124257;4102.405151253081;4108.50697916249;3200.895690986606;3511.5083888255663;3597.694195993344;3616.511770910946;3632.8365223565;5031.6729412588065;5107.693538387709;5113.488651134894;5121.257417674454;5139.357580302462;4306.784660766981;4548.272276435754;4705.212019432628;4708.552687494683;4713.394253396154;4666.859994200146;4988.551030407244;5497.443688684781;5538.501534861882;5576.6375185613215;3993.3211354069877;3994.520657521087;4007.5391329997133;4023.7786921719294;4025.6175663311938;5109.9489005109845;5380.681732975446;5417.322834645669;5740.626859254176;5860.736266868002;3334.7832390895;3737.7757334560015;4048.3522636378625;4060.4924384451942;4077.7553346799286;4119.237940980928;4137.2552940470405;4138.689598280141;4142.316517774533;4142.316517774533;4099.405586189986;4525.547445255514;4681.542190350094;4716.6698331116495;4729.763511824395;5381.596380271495;5536.335639723259;5593.664380137205;5599.440055994368;5606.719664016783;1322.3784821134052;1324.2650329067267;1336.565616174747;1340.8390993080893;1342.8187194728782;810.9391795615353;868.6351732272461;875.3959767760225;926.2358554192817;929.9814003719888;4178.291053007197;4440.7335559866515;4672.74299913508;4882.218844984785;4930.580900623487;4617.7691115444095;4716.95283047172;5077.873053173626;5338.97330513345;5430.8099216527235;4404.50413569621;4786.200072957359;4881.975590122027;4914.950850491521;4941.171766446438;2337.8012868906335;2386.5942789725786;2673.770065769768;2823.5905793660213;2836.446892855873;5307.4427185145005;5564.774090363887;5612.321337608233;5619.775208991595;5628.634138780966;4560.908781824345;5206.114960456732;5244.947550524446;5545.61180717354;5556.333240011225;4431.40176076232;4606.443423899767;5221.608379371486;5585.301837270423;5606.85982850432;4648.628109751144;4649.674522783373;4986.650934434555;5039.84880453587;5387.838364849061;4961.90838015636;5110.308984977585;5282.392524859537;5312.150055991023;5369.006733754111;4664.836730714409;5049.141645920129;5166.689998599945;5562.97085039269;5701.429857014431;3795.3927371620407;3818.19817838246;3830.4254361845947;4012.6388625023887;4054.7769872657286;5028.974855125847;5039.966806804523;5536.972315138399;5685.180742162468;5703.315602127771;4626.86119416418;5029.59763218949;5437.157240627709;5504.311961004874;5517.944820551743;4605.953940460687;5472.452754724496;5498.213080748693;5524.950259450691;5526.447355264441;4099.9180016400105;5361.383440904346;5367.530935769433;5385.707430216641;5390.919136213039;4813.582356526905;5246.921296180484;5479.178123281539;5515.751791169488;5521.861953451196;4661.021185551072;4854.83008094715;5303.178007408857;5405.9459405407015;5413.648112872651 20:15:37 INFO - PROCESS | 6438 | |5;yui.html;715.3311653603878;736.0210919477096;770.5607803551977;799.0890384961143;810.9538695083342;15224.543263702093;15601.063936163824;15688.137152456611;15705.21473926302;15725.921370393133;14344.784828227559;14506.274686265697;14515.983881128324;14516.983811133225;14534.854651453483;670.2727540618434;685.6640246279337;839.6179738219096;852.0457088061364;867.0808942520916;852.075498084579;857.3826844671827;859.5959898847532;862.4782006885806;863.5984267315697;896.2202883491371;917.8531434970406;920.410937000317;922.4188761080543;924.7040946896996;908.9091090890857;909.5134103254727;911.129870973219;911.7720569857536;912.3886995712921;523.9187925871458;543.4402565357688;544.1429748146685;545.5826292885945;677.3395938959525;11181.385023823686;12495.062870284673;14613.70772584553;14710.33803478846;15037.473688420852;14371.71256574873;14380.137191768423;14520.854791452055;14524.201168935704;14650.487232946902;11856.992155666692;11936.58221962227;12081.214721043192;12119.337457593241;12195.08536859739;3645.671889529955;3802.9429558556644;3803.2393521295853;3815.9236815263816;3885.5725870154542;95095.04904951001;100861.49569252107;101161;101601;101739.99999999926;9065;10777.62278320255;11184.328940263611;11272.54909803615;11506.88493115075;22415.887920560293;22658.320250392186;22729.204477843195;22813.31560053201;22835.543289134122;6714.764983225564;7608.163102058769;7631.7328893489575;7633.2366763323225;7646.694132234648;4197.433346498245;4232.830686772556;4284.59625729375;4331.350297455344;4475.194464996332;3567.126054116758;3682.502862113634;3684.5394325709285;3685.1708365617524;3687.207250441168;641.4099028893429;649.8862699027651;657.5167252069725;673.5453568841012;679.3647939176885;659.2879689934858;677.1975209376905;688.7451642892062;701.8771714949863;724.344468256229;9699.51502424876;10370.22223333253;10430.37417754937;10454.68635940923;10566.577336906437;606.3936063936064;672.5191488086042;688.944884409246;693.9930600693929;708.6358759388157;4956.231784073474;5017.874553136201;5019.573336266385;5026.396832380138;5032.396112466454;94530.5273473642;102682;105360.47319763352;106044;109299.45350273357;96015.51992239994;98371;98967;99291.50354248182;103871;78694.21305786983;80202.79695804567;80708;80996.19003809887;81308.18691813006;9647.469389183661;9706.126448619658;9750.902490975282;9764.609415623296;9778.462184579916;46377.072458551316;50783;53232.73383633057;54957;55402.72298638481;64233.71532569229;69130;73164;73835.63082184769;77334;11514.88485115138;11981.880181198076;12047.156699030984;12147.210431321935;12251.019918406328;12726.109172357847;12806.103572749818;12918.547850825553;13133.474661013835;13151.300612520592;9695.70912872615;10390.908954559662;11841.52633894669;12111.939440302742;12534.498620055096;11792.823107653563;12019.879801201876;12418.565350212699;12463.688407789878;12500.687482812638;11912.52349905994;11927.582534611247;11933.164678472423;12091.57679481214;12114.75770484603;9257.21313688344;9921.355111917703;10285.691429256834;10628.149748019985;10906.34561926287;9916.851247231152;9921.206303495559;9942.9119884825;9944.877815808246;9963.053509916546 20:15:37 INFO - PROCESS | 6438 | __end_tp_report 20:15:37 INFO - PROCESS | 6438 | __start_cc_report 20:15:37 INFO - PROCESS | 6438 | _x_x_mozilla_cycle_collect,2349 20:15:37 INFO - PROCESS | 6438 | __end_cc_report 20:15:37 INFO - PROCESS | 6438 | __startTimestamp1484885737584__endTimestamp 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | ------- Summary: start ------- 20:15:37 INFO - PROCESS | 6438 | Number of tests: 6 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | [#0] dojo.html Cycles:165 Average:5756.19 Median:5933.79 stddev:647.24 (10.9%) stddev-sans-first:619.29 20:15:37 INFO - PROCESS | 6438 | Values: 3276.2 3309.7 3314.4 3320.9 3368.6 4930.7 5641.3 5718.2 5792.9 5820.9 5085.5 5696.0 5734.7 5812.5 5816.4 5231.5 5247.8 5248.8 5272.7 5385.2 5169.6 5288.3 5303.4 5303.7 5351.8 5290.1 5295.1 5303.4 5306.4 5315.4 5128.8 5138.4 5146.3 5193.2 5193.2 5115.0 5170.1 5190.0 5210.5 5215.5 5644.4 5647.2 5651.0 5680.9 5700.7 6107.3 6172.4 6198.8 6201.5 6213.3 6273.9 6287.8 6331.4 6353.8 6367.2 5901.5 5902.6 5909.7 5911.2 5953.6 6264.1 6264.5 6342.9 6345.8 6358.7 6102.4 6132.4 6136.2 6193.5 6197.9 6250.1 6269.5 6276.6 6288.5 6298.0 6115.3 6130.2 6151.7 6161.0 6213.9 6184.6 6212.6 6235.7 6244.2 6295.7 4504.3 4979.9 5007.1 5017.4 5032.1 4509.7 4519.0 4525.3 4551.8 4559.2 4876.7 5651.0 5654.6 5676.8 5718.1 6249.2 6271.9 6282.7 6293.9 6366.0 5724.1 5775.3 5785.7 5787.9 5817.9 5505.7 5513.1 5520.2 5525.1 5526.3 6243.3 6254.2 6275.9 6330.7 6375.3 6299.5 6300.0 6309.8 6333.2 6339.4 6267.3 6296.5 6312.6 6320.7 6321.2 6116.2 6121.8 6153.5 6225.0 6250.4 6178.8 6293.3 6300.6 6301.2 6327.7 5988.7 6112.4 6150.9 6173.3 6179.6 6020.2 6054.0 6123.5 6156.0 6163.2 5881.7 5886.9 5889.1 5946.7 5995.6 5933.8 6073.1 6093.8 6114.0 6128.8 5859.4 5876.2 5879.4 5890.6 5895.7 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | [#1] ext.html Cycles:180 Average:57134.93 Median:35038.74 stddev:118505.30 (338.2%) stddev-sans-first:118761.26 20:15:37 INFO - PROCESS | 6438 | Values: 431.1 438.9 455.2 469.4 498.7 33895.3 40015.2 41980.6 42028.9 43669.3 42087.8 42481.8 42502.1 42573.4 42611.8 8458.9 8607.2 9437.2 9661.2 9666.5 11422.0 11756.8 11797.8 11955.6 11958.8 11723.8 11729.1 11790.3 11798.6 11822.0 8609.1 8815.2 8816.0 9687.0 11670.7 8649.0 11249.0 11520.6 11570.1 11645.6 31090.7 40458.6 41882.6 41954.6 42015.6 4069.2 4087.5 4090.3 4116.4 4185.0 24280.4 30631.3 30815.8 31429.2 31677.7 3204.4 3217.3 3223.4 3225.2 3323.8 456321.7 472327.0 476360.0 477893.0 482415.0 50285.2 60858.2 60944.7 60953.7 61028.4 56079.4 62333.4 64206.7 64395.0 64467.0 15574.8 15923.1 16030.4 16065.0 16075.5 11127.1 11402.4 11418.8 12318.6 12349.3 15936.0 16215.8 16219.6 16228.8 16424.7 5775.0 6052.2 6300.2 6309.1 6368.7 697.9 876.1 877.2 882.2 892.6 26150.6 27246.7 28869.1 30172.0 30237.5 892.8 1055.9 1105.2 1105.6 1118.4 12931.6 13048.7 15058.7 15607.8 15674.8 221697.0 221831.9 221958.0 222033.8 222391.0 60470.0 60825.7 60885.8 60896.7 61009.4 1398.1 1448.8 1461.8 1462.7 1463.6 29435.0 29467.9 29749.9 30305.2 30497.4 50504.0 50565.5 54395.0 54702.5 54847.2 558082.0 563048.0 563915.0 563980.0 564234.0 21956.8 22549.9 24028.9 24033.9 24516.4 41007.0 41868.2 42754.1 42824.4 42972.1 35054.0 35057.8 35180.6 35896.8 36304.8 34959.7 34992.7 35675.6 35929.5 36073.0 34119.5 34601.7 35023.5 35059.5 35365.5 30017.9 30845.8 30916.4 30988.0 31198.0 18820.6 23294.4 23499.3 23716.0 23801.9 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | [#2] jquery.html Cycles:180 Average:39893.37 Median:29237.28 stddev:108719.30 (371.9%) stddev-sans-first:108983.78 20:15:37 INFO - PROCESS | 6438 | Values: 365.4 372.5 379.7 393.7 415.9 15392.4 15428.8 17875.8 20713.5 21258.3 21065.6 21822.0 21906.3 22031.4 22666.4 6574.4 6617.3 6797.9 6805.3 6897.9 4669.2 6673.4 6790.7 6796.0 6814.7 4891.1 4901.5 7861.4 7934.7 7958.1 7596.4 7777.0 7858.9 7912.8 7931.7 7231.9 7670.6 7671.1 7676.7 7693.0 27885.6 28557.1 29130.7 29343.9 29742.0 2939.2 3009.7 3067.1 3082.9 3123.5 14562.9 16194.8 16709.3 16954.9 17863.6 1589.4 1948.0 1975.2 1979.7 1989.7 122065.0 131931.0 147057.8 154983.0 157089.0 21084.7 22493.8 22613.5 22674.4 22677.1 39690.2 39808.6 39968.6 39970.4 40090.6 10516.7 10744.5 11006.8 11014.4 11201.0 7444.7 8795.6 8842.7 8865.5 9061.0 10309.1 10721.2 10865.7 10962.0 10966.3 3206.8 3237.4 3447.3 4015.2 4034.2 709.5 794.7 818.2 818.9 836.0 20935.6 21595.9 21624.8 21682.5 21721.1 776.0 844.3 866.6 986.9 1079.3 10323.7 10825.6 10965.3 11233.9 11418.4 582186.0 594577.0 596885.0 718620.0 722528.0 154184.0 158319.0 161903.0 163753.0 166630.0 1028.6 1050.5 1091.9 1094.5 1097.2 19443.9 20088.8 20151.0 20225.2 20264.9 47474.0 53601.7 54990.7 56174.7 57863.7 76895.0 83824.6 86816.7 87584.6 89821.3 7269.4 8190.8 8295.6 8860.4 8894.8 11367.3 11646.5 13179.0 13611.3 13696.0 11382.6 11521.5 11824.6 11829.8 11869.6 11218.9 11419.5 11547.6 11724.4 11948.8 9521.5 9628.2 10870.6 10952.8 11400.8 7406.7 7469.9 7709.3 7820.3 7899.9 9804.5 10600.4 11288.4 11426.9 11486.0 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | [#3] mootools.html Cycles:180 Average:5340.59 Median:5157.13 stddev:2916.31 (56.5%) stddev-sans-first:2909.91 20:15:37 INFO - PROCESS | 6438 | Values: 1460.0 1462.0 1468.8 1480.9 1487.2 7359.9 7875.2 8292.3 8306.8 8307.9 6797.7 7516.5 7751.3 8115.1 8289.1 2251.3 2303.3 2306.5 2311.3 2317.1 2291.8 2314.9 2326.1 2328.2 2333.4 2028.4 2117.8 2118.6 2205.9 2286.1 1895.0 2297.9 2298.9 2299.8 2301.3 2225.5 2309.4 2311.7 2315.6 2315.7 8228.3 8295.7 8331.8 8343.0 8355.9 4981.1 5136.5 5142.4 5143.2 5150.4 3285.7 3344.3 3425.4 3427.0 3481.1 1136.7 1141.7 1163.9 1195.1 1222.5 10605.2 10732.5 10744.4 10751.3 10762.9 3939.7 4345.0 4510.3 4534.2 4615.7 9313.1 9358.7 9374.0 9393.1 9405.6 5136.6 5149.9 5151.5 5153.7 5160.8 4629.9 4634.2 4699.9 4724.3 4743.3 3688.6 3728.7 3760.5 3793.9 3806.5 1235.3 1238.8 1238.9 1250.9 1251.7 780.5 861.2 882.5 894.4 930.3 5528.7 5558.6 5633.4 5744.6 5818.3 951.8 970.7 976.7 987.9 1017.8 3367.6 3759.1 3770.6 3801.8 3868.4 9665.7 9692.9 9973.1 9980.5 9990.8 9763.6 9909.3 9928.5 9949.5 10022.2 7698.7 7838.6 7839.4 7843.1 7844.5 4397.7 5435.7 5534.2 5560.3 5613.4 8997.3 9056.6 9191.0 9208.9 9330.5 9101.8 9355.8 9360.3 9472.5 9477.3 5876.9 6449.7 6732.6 6736.5 6744.4 7594.2 7696.9 7769.7 7781.3 7787.3 5505.6 6561.9 6974.0 7070.4 7106.3 5824.7 6700.3 6815.2 6924.3 6928.1 6316.3 6432.9 6437.4 6442.6 6455.8 4866.7 4929.2 4957.4 4983.9 5148.3 4746.1 4853.5 4924.2 5055.6 5160.6 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | [#4] prototype.html Cycles:180 Average:4384.71 Median:4757.98 stddev:1293.85 (27.2%) stddev-sans-first:1261.08 20:15:37 INFO - PROCESS | 6438 | Values: 324.5 347.8 349.8 357.9 368.7 4121.4 4720.3 5278.6 5318.8 5414.8 4349.2 4413.7 4910.5 5206.6 5265.2 3572.5 3859.2 4028.2 4032.1 4055.4 3553.4 4091.2 4106.9 4108.3 4109.2 3568.4 3752.6 4074.1 4085.2 4086.9 3377.0 3936.1 3990.8 4102.4 4108.5 3200.9 3511.5 3597.7 3616.5 3632.8 5031.7 5107.7 5113.5 5121.3 5139.4 4306.8 4548.3 4705.2 4708.6 4713.4 4666.9 4988.6 5497.4 5538.5 5576.6 3993.3 3994.5 4007.5 4023.8 4025.6 5109.9 5380.7 5417.3 5740.6 5860.7 3334.8 3737.8 4048.4 4060.5 4077.8 4119.2 4137.3 4138.7 4142.3 4142.3 4099.4 4525.5 4681.5 4716.7 4729.8 5381.6 5536.3 5593.7 5599.4 5606.7 1322.4 1324.3 1336.6 1340.8 1342.8 810.9 868.6 875.4 926.2 930.0 4178.3 4440.7 4672.7 4882.2 4930.6 4617.8 4717.0 5077.9 5339.0 5430.8 4404.5 4786.2 4882.0 4915.0 4941.2 2337.8 2386.6 2673.8 2823.6 2836.4 5307.4 5564.8 5612.3 5619.8 5628.6 4560.9 5206.1 5244.9 5545.6 5556.3 4431.4 4606.4 5221.6 5585.3 5606.9 4648.6 4649.7 4986.7 5039.8 5387.8 4961.9 5110.3 5282.4 5312.2 5369.0 4664.8 5049.1 5166.7 5563.0 5701.4 3795.4 3818.2 3830.4 4012.6 4054.8 5029.0 5040.0 5537.0 5685.2 5703.3 4626.9 5029.6 5437.2 5504.3 5517.9 4606.0 5472.5 5498.2 5525.0 5526.4 4099.9 5361.4 5367.5 5385.7 5390.9 4813.6 5246.9 5479.2 5515.8 5521.9 4661.0 4854.8 5303.2 5405.9 5413.6 20:15:37 INFO - PROCESS | 6438 | 20:15:37 INFO - PROCESS | 6438 | [#5] yui.html Cycles:180 Average:20622.42 Median:4987.05 stddev:30160.07 (604.8%) stddev-sans-first:30207.64 20:15:37 INFO - PROCESS | 6438 | Values: 715.3 736.0 770.6 799.1 811.0 15224.5 15601.1 15688.1 15705.2 15725.9 14344.8 14506.3 14516.0 14517.0 14534.9 670.3 685.7 839.6 852.0 867.1 852.1 857.4 859.6 862.5 863.6 896.2 917.9 920.4 922.4 924.7 908.9 909.5 911.1 911.8 912.4 523.9 543.4 544.1 545.6 677.3 11181.4 12495.1 14613.7 14710.3 15037.5 14371.7 14380.1 14520.9 14524.2 14650.5 11857.0 11936.6 12081.2 12119.3 12195.1 3645.7 3802.9 3803.2 3815.9 3885.6 95095.0 100861.5 101161.0 101601.0 101740.0 9065.0 10777.6 11184.3 11272.5 11506.9 22415.9 22658.3 22729.2 22813.3 22835.5 6714.8 7608.2 7631.7 7633.2 7646.7 4197.4 4232.8 4284.6 4331.4 4475.2 3567.1 3682.5 3684.5 3685.2 3687.2 641.4 649.9 657.5 673.5 679.4 659.3 677.2 688.7 701.9 724.3 9699.5 10370.2 10430.4 10454.7 10566.6 606.4 672.5 688.9 694.0 708.6 4956.2 5017.9 5019.6 5026.4 5032.4 94530.5 102682.0 105360.5 106044.0 109299.5 96015.5 98371.0 98967.0 99291.5 103871.0 78694.2 80202.8 80708.0 80996.2 81308.2 9647.5 9706.1 9750.9 9764.6 9778.5 46377.1 50783.0 53232.7 54957.0 55402.7 64233.7 69130.0 73164.0 73835.6 77334.0 11514.9 11981.9 12047.2 12147.2 12251.0 12726.1 12806.1 12918.5 13133.5 13151.3 9695.7 10390.9 11841.5 12111.9 12534.5 11792.8 12019.9 12418.6 12463.7 12500.7 11912.5 11927.6 11933.2 12091.6 12114.8 9257.2 9921.4 10285.7 10628.1 10906.3 9916.9 9921.2 9942.9 9944.9 9963.1 20:15:37 INFO - PROCESS | 6438 | -------- Summary: end -------- 20:15:37 INFO - PROCESS | 6438 | 20:15:38 INFO - TEST-INFO | 6438: exit 0 20:15:38 INFO - TEST-OK | dromaeo_css | took 1118932ms 20:15:38 INFO - TEST-START | kraken 20:15:38 INFO - operating with platform_type : mac_ 20:15:38 INFO - Initialising browser for kraken test... 20:15:38 INFO - TEST-INFO | started process 6441 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpkfWNuN/profile http://localhost:57580/getInfo.html) 20:15:40 INFO - PROCESS | 6441 | __metrics Screen width/height:1600/1200 20:15:40 INFO - PROCESS | 6441 | colorDepth:24 20:15:40 INFO - PROCESS | 6441 | Browser inner width/height: 1024/689 20:15:40 INFO - PROCESS | 6441 | __metrics 20:15:40 INFO - PROCESS | 6441 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:15:40 INFO - PROCESS | 6441 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:41 INFO - TEST-INFO | 6441: exit 0 20:15:41 INFO - Browser initialized. 20:15:41 INFO - Running cycle 1/1 for kraken test... 20:15:41 INFO - TEST-INFO | started process 6442 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpkfWNuN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:53 INFO - PROCESS | 6442 | RSS: Main: 235397120 20:15:53 INFO - PROCESS | 6442 | 20:15:56 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:57 INFO - PROCESS | 6442 | RSS: Main: 287739904 20:15:57 INFO - PROCESS | 6442 | 20:15:59 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-dft) 20:16:00 INFO - PROCESS | 6442 | RSS: Main: 288153600 20:16:00 INFO - PROCESS | 6442 | 20:16:03 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-fft) 20:16:04 INFO - PROCESS | 6442 | RSS: Main: 379662336 20:16:04 INFO - PROCESS | 6442 | 20:16:06 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57580/tests/kraken/driver.html?testName=audio-oscillator) 20:16:07 INFO - PROCESS | 6442 | RSS: Main: 282611712 20:16:07 INFO - PROCESS | 6442 | 20:16:09 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:09 INFO - PROCESS | 6442 | RSS: Main: 286064640 20:16:09 INFO - PROCESS | 6442 | 20:16:12 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57580/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:13 INFO - PROCESS | 6442 | RSS: Main: 327217152 20:16:13 INFO - PROCESS | 6442 | 20:16:16 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57580/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:16 INFO - PROCESS | 6442 | RSS: Main: 327929856 20:16:16 INFO - PROCESS | 6442 | 20:16:19 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57580/tests/kraken/driver.html?testName=json-parse-financial) 20:16:20 INFO - PROCESS | 6442 | RSS: Main: 326238208 20:16:20 INFO - PROCESS | 6442 | 20:16:21 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:22 INFO - PROCESS | 6442 | RSS: Main: 302129152 20:16:22 INFO - PROCESS | 6442 | 20:16:24 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:24 INFO - PROCESS | 6442 | RSS: Main: 306221056 20:16:24 INFO - PROCESS | 6442 | 20:16:27 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:27 INFO - PROCESS | 6442 | RSS: Main: 309456896 20:16:27 INFO - PROCESS | 6442 | 20:16:30 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:31 INFO - PROCESS | 6442 | RSS: Main: 324153344 20:16:31 INFO - PROCESS | 6442 | 20:16:34 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:35 INFO - PROCESS | 6442 | RSS: Main: 318656512 20:16:35 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | Cycle 1(1): loaded http://localhost:57580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57580/tests/kraken/driver.html?testName=ai-astar) 20:16:37 INFO - PROCESS | 6442 | RSS: Main: 362704896 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | __start_tp_report 20:16:37 INFO - PROCESS | 6442 | _x_x_mozilla_page_load 20:16:37 INFO - PROCESS | 6442 | _x_x_mozilla_page_load_details 20:16:37 INFO - PROCESS | 6442 | |i|pagename|runs| 20:16:37 INFO - PROCESS | 6442 | |0;ai-astar;123;169;140;114;114;115;114;112;114;113 20:16:37 INFO - PROCESS | 6442 | |1;audio-beat-detection;147;108;108;148;110;111;110;110;129;112 20:16:37 INFO - PROCESS | 6442 | |2;audio-dft;184;188;185;187;184;180;184;185;183;187 20:16:37 INFO - PROCESS | 6442 | |3;audio-fft;80;59;58;88;60;60;58;58;73;58 20:16:37 INFO - PROCESS | 6442 | |4;audio-oscillator;92;70;85;71;67;69;82;67;68;83 20:16:37 INFO - PROCESS | 6442 | |5;imaging-gaussian-blur;88;99;88;86;126;85;90;87;89;84 20:16:37 INFO - PROCESS | 6442 | |6;imaging-darkroom;94;94;94;103;93;94;94;95;94;94 20:16:37 INFO - PROCESS | 6442 | |7;imaging-desaturate;104;133;85;87;88;84;85;86;87;84 20:16:37 INFO - PROCESS | 6442 | |8;json-parse-financial;55;53;54;54;56;55;55;55;56;54 20:16:37 INFO - PROCESS | 6442 | |9;json-stringify-tinderbox;69;66;76;78;76;71;72;72;72;73 20:16:37 INFO - PROCESS | 6442 | |10;stanford-crypto-aes;85;91;88;93;107;106;88;86;90;87 20:16:37 INFO - PROCESS | 6442 | |11;stanford-crypto-ccm;141;152;154;139;141;139;142;139;195;146 20:16:37 INFO - PROCESS | 6442 | |12;stanford-crypto-pbkdf2;182;177;242;224;175;176;172;173;182;173 20:16:37 INFO - PROCESS | 6442 | |13;stanford-crypto-sha256-iterative;67;67;67;69;68;68;63;72;82;84 20:16:37 INFO - PROCESS | 6442 | __end_tp_report 20:16:37 INFO - PROCESS | 6442 | __start_cc_report 20:16:37 INFO - PROCESS | 6442 | _x_x_mozilla_cycle_collect,1976 20:16:37 INFO - PROCESS | 6442 | __end_cc_report 20:16:37 INFO - PROCESS | 6442 | __startTimestamp1484885797268__endTimestamp 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | ------- Summary: start ------- 20:16:37 INFO - PROCESS | 6442 | Number of tests: 14 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#0] ai-astar Cycles:10 Average:122.80 Median:114.50 stddev:18.30 (16.0%) stddev-sans-first:19.41 20:16:37 INFO - PROCESS | 6442 | Values: 123.0 169.0 140.0 114.0 114.0 115.0 114.0 112.0 114.0 113.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:111.50 stddev:16.06 (14.4%) stddev-sans-first:13.55 20:16:37 INFO - PROCESS | 6442 | Values: 147.0 108.0 108.0 148.0 110.0 111.0 110.0 110.0 129.0 112.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:2.31 (1.2%) stddev-sans-first:2.44 20:16:37 INFO - PROCESS | 6442 | Values: 184.0 188.0 185.0 187.0 184.0 180.0 184.0 185.0 183.0 187.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#3] audio-fft Cycles:10 Average:65.20 Median:60.00 stddev:11.05 (18.4%) stddev-sans-first:10.35 20:16:37 INFO - PROCESS | 6442 | Values: 80.0 59.0 58.0 88.0 60.0 60.0 58.0 58.0 73.0 58.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.50 stddev:9.16 (12.0%) stddev-sans-first:7.49 20:16:37 INFO - PROCESS | 6442 | Values: 92.0 70.0 85.0 71.0 67.0 69.0 82.0 67.0 68.0 83.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:88.00 stddev:12.58 (14.3%) stddev-sans-first:13.25 20:16:37 INFO - PROCESS | 6442 | Values: 88.0 99.0 88.0 86.0 126.0 85.0 90.0 87.0 89.0 84.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.00 stddev:2.88 (3.1%) stddev-sans-first:3.04 20:16:37 INFO - PROCESS | 6442 | Values: 94.0 94.0 94.0 103.0 93.0 94.0 94.0 95.0 94.0 94.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:85.50 stddev:15.46 (18.1%) stddev-sans-first:15.81 20:16:37 INFO - PROCESS | 6442 | Values: 104.0 133.0 85.0 87.0 88.0 84.0 85.0 86.0 87.0 84.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 20:16:37 INFO - PROCESS | 6442 | Values: 55.0 53.0 54.0 54.0 56.0 55.0 55.0 55.0 56.0 54.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:3.54 (4.9%) stddev-sans-first:3.52 20:16:37 INFO - PROCESS | 6442 | Values: 69.0 66.0 76.0 78.0 76.0 71.0 72.0 72.0 72.0 73.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:88.00 stddev:7.95 (9.0%) stddev-sans-first:8.01 20:16:37 INFO - PROCESS | 6442 | Values: 85.0 91.0 88.0 93.0 107.0 106.0 88.0 86.0 90.0 87.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:144.00 stddev:17.11 (11.9%) stddev-sans-first:17.92 20:16:37 INFO - PROCESS | 6442 | Values: 141.0 152.0 154.0 139.0 141.0 139.0 142.0 139.0 195.0 146.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.60 Median:179.50 stddev:24.55 (13.7%) stddev-sans-first:25.95 20:16:37 INFO - PROCESS | 6442 | Values: 182.0 177.0 242.0 224.0 175.0 176.0 172.0 173.0 182.0 173.0 20:16:37 INFO - PROCESS | 6442 | 20:16:37 INFO - PROCESS | 6442 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:68.50 stddev:6.86 (10.0%) stddev-sans-first:7.15 20:16:37 INFO - PROCESS | 6442 | Values: 67.0 67.0 67.0 69.0 68.0 68.0 63.0 72.0 82.0 84.0 20:16:37 INFO - PROCESS | 6442 | -------- Summary: end -------- 20:16:37 INFO - PROCESS | 6442 | 20:16:38 INFO - TEST-INFO | 6442: exit 0 20:16:38 INFO - TEST-OK | kraken | took 59967ms 20:16:38 INFO - SUITE-END | took 1178s 20:16:38 INFO - Completed test suite (00:19:39) 20:16:38 INFO - javascript benchmark 20:16:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.246463313438, 3309.702126808587, 3314.419976504111, 3320.933581328375, 3368.595768507779, 4930.704157750538, 5641.323041235058, 5718.170865224545, 5792.855178620536, 5820.854478638036, 5085.466026067256, 5695.971520142393, 5734.684592347419, 5812.534997200224, 5816.360200377966, 5231.450697676746, 5247.816326428557, 5248.763805628737, 5272.683638981654, 5385.165299378583, 5169.638125331228, 5288.312519372476, 5303.390110137326, 5303.734813259341, 5351.839444816662, 5290.074237008508, 5295.0998330283755, 5303.390110137345, 5306.3632364116165, 5315.415304316522, 5128.794848206067, 5138.409082955471, 5146.330976972969, 5193.169092945111, 5193.221016847503, 5114.974425127851, 5170.095233334189, 5189.974050129763, 5210.452902445264, 5215.478452154792, 5644.435556444364, 5647.237622920935, 5650.971745141248, 5680.886382272372, 5700.714964251771, 6107.340534417173, 6172.382761723837, 6198.783042593533, 6201.503879689659, 6213.254409470847, 6273.8745225095245, 6287.811365659038, 6331.39851714091, 6353.809385718436, 6367.204099487564, 5901.498372638288, 5902.6458412495385, 5909.674967876765, 5911.172435858984, 5953.553483488756, 6264.091706702503, 6264.5301602380005, 6342.873142537216, 6345.841353966188, 6358.7456501740335, 6102.368068311607, 6132.355508992545, 6136.17161683176, 6193.504519638418, 6197.946349120661, 6250.124982502453, 6269.529785266123, 6276.560640755103, 6288.465480434123, 6298.0, 6115.327313995457, 6130.245269656939, 6151.72317245725, 6161.0, 6213.906791398133, 6184.5980011299125, 6212.627242365473, 6235.657038862815, 6244.219472565929, 6295.748170073146, 4504.2793153095345, 4979.904421027368, 5007.148784706608, 5017.397912250481, 5032.0690672225755, 4509.6843220974215, 4518.954810451919, 4525.253333200051, 4551.795169217393, 4559.224931761542, 4876.7076724667995, 5651.039323314964, 5654.575906806924, 5676.829695109153, 5718.056520674126, 6249.156363890907, 6271.937280627227, 6282.654454005074, 6293.937060629427, 6366.045093236052, 5724.112762521732, 5775.33583637887, 5785.652860828363, 5787.913181302284, 5817.912731308949, 5505.724713764296, 5513.145462453326, 5520.199571062173, 5525.143602741581, 5526.253955716007, 6243.344448832807, 6254.249490061222, 6275.874482510416, 6330.715117819617, 6375.266844312778, 6299.527535434769, 6300.0234963580715, 6309.810705678653, 6333.20834895638, 6339.397757213057, 6267.279262884645, 6296.464800492009, 6312.58968167086, 6320.652364119834, 6321.1782468278825, 6116.1836049259855, 6121.755129794758, 6153.476954458921, 6225.003999360262, 6250.4374606285655, 6178.783742568989, 6293.3391993841815, 6300.59046161998, 6301.212348456443, 6327.746890124344, 5988.700564971647, 6112.388761123852, 6150.907736384047, 6173.32093469727, 6179.598326108789, 6020.217371741645, 6054.0, 6123.510119190365, 6156.0, 6163.167972323679, 5881.676507791942, 5886.941130588811, 5889.116632505158, 5946.702664866652, 5995.61028533144, 5933.792317268875, 6073.058675905242, 6093.817185484442, 6114.021756519113, 6128.754849805958, 5859.414058594107, 5876.206712093813, 5879.412058794086, 5890.646561206341, 5895.67573783446], "value": 5714.01347582984, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.0903992575665, 438.85737135430975, 455.15114311808475, 469.4155776058805, 498.71573203274147, 33895.32209355811, 40015.1996960061, 41980.580194198126, 42028.94927626811, 43669.34495982563, 42087.78956105215, 42481.787591062, 42502.14995700084, 42573.36139957896, 42611.78694106525, 8458.915410845904, 8607.18231767981, 9437.150656440901, 9661.17879980199, 9666.516674166298, 11422.0, 11756.823647645293, 11797.7640447191, 11955.64133076009, 11958.7608247835, 11723.824142637824, 11729.061675066017, 11790.349351090854, 11798.58704945327, 11822.0, 8609.096044915257, 8815.20663140314, 8816.030236673962, 9686.951565242163, 11670.708232294219, 8649.048604653482, 11249.0, 11520.596779112691, 11570.074394048455, 11645.592404265895, 31090.689093109006, 40458.595414045776, 41882.581174188475, 41954.58045419537, 42015.57984420147, 4069.1861627674584, 4087.509498860126, 4090.2637525245445, 4116.444280022189, 4185.0, 24280.39299017521, 30631.309625339512, 30815.845920770476, 31429.214269643442, 31677.683223167704, 3204.3591281743743, 3217.260030193045, 3223.4197844388, 3225.225945773021, 3323.7507186961075, 456321.7183914126, 472327.0, 476360.0, 477893.0, 482415.0, 50285.24572131421, 60858.17425477243, 60944.695276524224, 60953.69523152356, 61028.38971610227, 56079.439205608236, 62333.376666232754, 64206.6789666058, 64395.03407448892, 64467.0, 15574.844251557566, 15923.12422816733, 16030.358785648443, 16065.036097834167, 16075.517734467985, 11127.109831213484, 11402.429878506042, 11418.771624567627, 12318.568850090203, 12349.259044457362, 15936.0, 16215.756763648555, 16219.594510137105, 16228.83771162297, 16424.67150657004, 5774.971125144348, 6052.213212282463, 6300.243970723543, 6309.085182648582, 6368.681565921685, 697.8604279144191, 876.0757400942067, 877.1973644115562, 882.161946151159, 892.6295587331315, 26150.6077408839, 27246.72753272442, 28869.133925982253, 30172.0, 30237.54232947653, 892.8035832116924, 1055.8574592430077, 1105.2318638546294, 1105.5633024955098, 1118.4072441605963, 12931.612051638465, 13048.739025219442, 15058.698826023638, 15607.843921560867, 15674.764878526832, 221697.0, 221831.89084054477, 221958.0, 222033.77966220453, 222391.0, 60470.0, 60825.695871521246, 60885.78228435406, 60896.69551652214, 61009.389906101256, 1398.1261711430357, 1448.7537118689847, 1461.8465061168638, 1462.6782107936237, 1463.5975106845704, 29434.969776057736, 29467.85266073656, 29749.851250743606, 30305.24236894095, 30497.390052199276, 50504.0, 50565.494345056075, 54395.0, 54702.452975469736, 54847.177292339846, 558082.0, 563048.0, 563915.0, 563980.0, 564234.0, 21956.78043219547, 22549.887250563643, 24028.87985560131, 24033.879830601436, 24516.387090322885, 41006.9748256296, 41868.1626367477, 42754.144917100864, 42824.35763463613, 42972.140557189305, 35054.0, 35057.8247108773, 35180.648193517736, 35896.820515897256, 36304.818475908505, 34959.65040349666, 34992.65007349894, 35675.64324356827, 35929.46105808362, 36073.0, 34119.4882076774, 34601.653983459844, 35023.47464787979, 35059.474107887894, 35365.469517956735, 30017.949371771883, 30845.845770771004, 30916.381672365977, 30988.0, 31198.0, 18820.623587528447, 23294.417639559146, 23499.29502114939, 23716.0, 23801.880990594935], "value": 18970.372897466175, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.3879751416377, 372.52317034196227, 379.7265968502677, 393.73226206179794, 415.9292920203565, 15392.384304627816, 15428.768568471467, 17875.821241787577, 20713.482162945933, 21258.255961041366, 21065.57868842626, 21822.018009189585, 21906.342809715734, 22031.449213769665, 22666.433339166528, 6574.441172500343, 6617.272100068989, 6797.932020679779, 6805.251422343538, 6897.896531552031, 4669.159551280785, 6673.366030227121, 6790.6944187511435, 6796.0, 6814.727410903558, 4891.14404979129, 4901.485344038878, 7861.371090312789, 7934.7222847200355, 7958.124606293303, 7596.430267729887, 7776.961115194445, 7858.921410785876, 7912.762617121495, 7931.682732690714, 7231.891521627127, 7670.616469176519, 7671.117821450549, 7676.731314403969, 7693.0, 27885.58171627427, 28557.143285701462, 29130.708692913013, 29343.853280733674, 29741.959031433795, 2939.1623387334507, 3009.6689364169924, 3067.1105379439937, 3082.892098776532, 3123.5314702794535, 14562.927185364111, 16194.83805161945, 16709.331626734915, 16954.915225423792, 17863.642727145383, 1589.4278059898427, 1947.9610407791906, 1975.170428420067, 1979.7228388025544, 1989.7015447682818, 122065.0, 131931.0, 147057.79430805228, 154983.0, 157088.99999999886, 21084.683729744065, 22493.775062249497, 22613.547729045655, 22674.43313917165, 22677.092916283495, 39690.20619587592, 39808.60191398049, 39968.60031399707, 39970.40044399336, 40090.599094008685, 10516.737081572868, 10744.516496757664, 11006.779864402668, 11014.39420831862, 11201.047910927662, 7444.702211911571, 8795.560221988875, 8842.690505832265, 8865.468071915706, 9060.954695226614, 10309.123724483354, 10721.195910306602, 10865.728356791144, 10962.0, 10966.342019478856, 3206.823624700617, 3237.3525294941105, 3447.293589673128, 4015.2371049501085, 4034.172994536113, 709.5458906299972, 794.6781553470854, 818.1572979830784, 818.9467684600481, 836.0, 20935.639183453026, 21595.892020539795, 21624.78375216259, 21682.460912977214, 21721.131154753948, 776.0183368039435, 844.273924424994, 866.6316815353575, 986.9309148359546, 1079.3200283821143, 10323.690289291333, 10825.621103261348, 10965.287256328313, 11233.943830280796, 11418.371989540488, 582186.0, 594577.0271148616, 596885.0, 718620.0, 722528.0, 154184.0, 158319.0, 161903.0, 163753.0, 166630.0, 1028.5937054863286, 1050.5220124843179, 1091.9454027298602, 1094.4527736131934, 1097.1716354152722, 19443.902780486005, 20088.79297971231, 20151.0, 20225.178711283334, 20264.898675506527, 47474.0, 53601.731991339795, 54990.725046374515, 56174.7191264041, 57863.710681446326, 76895.0, 83824.58087709523, 86816.69774953507, 87584.5620771892, 89821.26340524356, 7269.382102521345, 8190.7952301192945, 8295.58522073906, 8860.3797734158, 8894.777630559287, 11367.261128026652, 11646.475908584303, 13179.0, 13611.319434028457, 13696.0, 11382.601608943647, 11521.539138434704, 11824.645260642195, 11829.76340473203, 11869.643910682693, 11218.887811121784, 11419.543218271176, 11547.595834145764, 11724.41377931083, 11948.761024779282, 9521.476318802532, 9628.18160456341, 10870.565177392815, 10952.835707464554, 11400.771984560428, 7406.666799976056, 7469.850602988018, 7709.267619576131, 7820.296173344426, 7899.921000789918, 9804.460754658277, 10600.416977066336, 11288.379139147426, 11426.94286528562, 11486.0], "value": 11262.00528563313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.9708005839884, 1461.9853801461995, 1468.750312446884, 1480.896337256392, 1487.2415068315158, 7359.926400735991, 7875.17310682378, 8292.295154911824, 8306.79233019174, 8307.87538186927, 6797.6941037653305, 7516.4738468307105, 7751.263629955145, 8115.1073381927945, 8289.129641387643, 2251.2570851619007, 2303.2744685424123, 2306.5271619318, 2311.28350211435, 2317.142657216832, 2291.7708229177115, 2314.884255787204, 2326.0579465316573, 2328.2200462844967, 2333.3583264602285, 2028.4421784009369, 2117.7988091131397, 2118.608057509358, 2205.889705514726, 2286.0969916882823, 1894.9861823924202, 2297.885105744706, 2298.896549655253, 2299.8160147188187, 2301.298104078264, 2225.4770129019666, 2309.3533810533077, 2311.722593288799, 2315.5716192504274, 2315.7336906255828, 8228.341732661373, 8295.668173273121, 8331.83336333276, 8343.0, 8355.916440835575, 4981.12830254704, 5136.512031357052, 5142.408623008365, 5143.151380022329, 5150.381954165524, 3285.720713739335, 3344.298245614045, 3425.417678994552, 3427.0404286799735, 3481.1123163593375, 1136.6615389942142, 1141.720278531765, 1163.9301641901513, 1195.1394995603152, 1222.4987755020488, 10605.151587872951, 10732.463376831127, 10744.409057501834, 10751.301165424222, 10762.946185269024, 3939.6848252140335, 4345.0, 4510.2783554631105, 4534.206513860061, 4615.653825963066, 9313.115254050854, 9358.672446464478, 9373.953130234442, 9393.060693930553, 9405.623775049058, 5136.5890728741615, 5149.944261426399, 5151.484851514819, 5153.6907785532985, 5160.767765450564, 4629.8842528936375, 4634.165850147006, 4699.929501057487, 4724.291356296583, 4743.288506724019, 3688.6126956669164, 3728.664420202195, 3760.511133552621, 3793.943090853639, 3806.4861243732294, 1235.2835355493792, 1238.8327575777334, 1238.8823061809114, 1250.8936740376987, 1251.6557946564585, 780.4673833410619, 861.1990848510819, 882.5366682491615, 894.4454438248328, 930.3255140023564, 5528.668279903219, 5558.638688485235, 5633.436656334334, 5744.597878148573, 5818.330891947396, 951.8286708392556, 970.7184916374173, 976.6630512473185, 987.9110880020833, 1017.7913527726798, 3367.579052618423, 3759.0978165240695, 3770.5852356240794, 3801.7718936863876, 3868.419737039467, 9665.661701840543, 9692.9030709692, 9973.10242078202, 9980.500974951223, 9990.800183996425, 9763.560639771227, 9909.256805739598, 9928.453935033642, 9949.452780097019, 10022.248331375176, 7698.653560589787, 7838.568878711611, 7839.412044096715, 7843.137254901956, 7844.4901081429525, 4397.73613583186, 5435.716998860567, 5534.1975413564005, 5560.332760068818, 5613.410591887956, 8997.28021758271, 9056.592453339485, 9191.0, 9208.907910921072, 9330.486823224517, 9101.817963640822, 9355.766105847408, 9360.251179905727, 9472.52637368115, 9477.336586439158, 5876.883392155477, 6449.677516124269, 6732.562383445061, 6736.528443008942, 6744.359285867835, 7594.202608726005, 7696.884546731915, 7769.72805951789, 7781.338586220235, 7787.29914307715, 5505.642133261325, 6561.934380656323, 6973.96513017452, 7070.4343652508705, 7106.289371062852, 5824.679642619697, 6700.262971073081, 6815.2162501311, 6924.272951340238, 6928.099347084847, 6316.3367846377305, 6432.903506447314, 6437.420632142942, 6442.581232219891, 6455.774047908489, 4866.732329721758, 4929.211326187793, 4957.355543779286, 4983.925241121314, 5148.253503242084, 4746.098241334135, 4853.466118727008, 4924.162892308388, 5055.620828437808, 5160.561352285098], "value": 4350.798810352632, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.49378968808645, 347.7600455685577, 349.7513875464592, 357.8622230441279, 368.67004031391923, 4121.402396652484, 4720.291956206571, 5278.630495865291, 5318.78724851006, 5414.810481633139, 4349.217140914634, 4413.668974826885, 4910.459849416561, 5206.609504287175, 5265.236540701596, 3572.5355703758473, 3859.247446747885, 4028.2346354192755, 4032.0927791247027, 4055.35114381699, 3553.4314509678456, 4091.2226676931286, 4106.8562600309, 4108.28105081611, 4109.157622687342, 3568.411212149992, 3752.5795861669208, 4074.103697186614, 4085.1625416789634, 4086.9373962769746, 3376.983115084409, 3936.0872954014108, 3990.78281124257, 4102.405151253081, 4108.50697916249, 3200.895690986606, 3511.5083888255663, 3597.694195993344, 3616.511770910946, 3632.8365223565, 5031.6729412588065, 5107.693538387709, 5113.488651134894, 5121.257417674454, 5139.357580302462, 4306.784660766981, 4548.272276435754, 4705.212019432628, 4708.552687494683, 4713.394253396154, 4666.859994200146, 4988.551030407244, 5497.443688684781, 5538.501534861882, 5576.6375185613215, 3993.3211354069877, 3994.520657521087, 4007.5391329997133, 4023.7786921719294, 4025.6175663311938, 5109.9489005109845, 5380.681732975446, 5417.322834645669, 5740.626859254176, 5860.736266868002, 3334.7832390895, 3737.7757334560015, 4048.3522636378625, 4060.4924384451942, 4077.7553346799286, 4119.237940980928, 4137.2552940470405, 4138.689598280141, 4142.316517774533, 4142.316517774533, 4099.405586189986, 4525.547445255514, 4681.542190350094, 4716.6698331116495, 4729.763511824395, 5381.596380271495, 5536.335639723259, 5593.664380137205, 5599.440055994368, 5606.719664016783, 1322.3784821134052, 1324.2650329067267, 1336.565616174747, 1340.8390993080893, 1342.8187194728782, 810.9391795615353, 868.6351732272461, 875.3959767760225, 926.2358554192817, 929.9814003719888, 4178.291053007197, 4440.7335559866515, 4672.74299913508, 4882.218844984785, 4930.580900623487, 4617.7691115444095, 4716.95283047172, 5077.873053173626, 5338.97330513345, 5430.8099216527235, 4404.50413569621, 4786.200072957359, 4881.975590122027, 4914.950850491521, 4941.171766446438, 2337.8012868906335, 2386.5942789725786, 2673.770065769768, 2823.5905793660213, 2836.446892855873, 5307.4427185145005, 5564.774090363887, 5612.321337608233, 5619.775208991595, 5628.634138780966, 4560.908781824345, 5206.114960456732, 5244.947550524446, 5545.61180717354, 5556.333240011225, 4431.40176076232, 4606.443423899767, 5221.608379371486, 5585.301837270423, 5606.85982850432, 4648.628109751144, 4649.674522783373, 4986.650934434555, 5039.84880453587, 5387.838364849061, 4961.90838015636, 5110.308984977585, 5282.392524859537, 5312.150055991023, 5369.006733754111, 4664.836730714409, 5049.141645920129, 5166.689998599945, 5562.97085039269, 5701.429857014431, 3795.3927371620407, 3818.19817838246, 3830.4254361845947, 4012.6388625023887, 4054.7769872657286, 5028.974855125847, 5039.966806804523, 5536.972315138399, 5685.180742162468, 5703.315602127771, 4626.86119416418, 5029.59763218949, 5437.157240627709, 5504.311961004874, 5517.944820551743, 4605.953940460687, 5472.452754724496, 5498.213080748693, 5524.950259450691, 5526.447355264441, 4099.9180016400105, 5361.383440904346, 5367.530935769433, 5385.707430216641, 5390.919136213039, 4813.582356526905, 5246.921296180484, 5479.178123281539, 5515.751791169488, 5521.861953451196, 4661.021185551072, 4854.83008094715, 5303.178007408857, 5405.9459405407015, 5413.648112872651], "value": 3989.031647663565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.3311653603878, 736.0210919477096, 770.5607803551977, 799.0890384961143, 810.9538695083342, 15224.543263702093, 15601.063936163824, 15688.137152456611, 15705.21473926302, 15725.921370393133, 14344.784828227559, 14506.274686265697, 14515.983881128324, 14516.983811133225, 14534.854651453483, 670.2727540618434, 685.6640246279337, 839.6179738219096, 852.0457088061364, 867.0808942520916, 852.075498084579, 857.3826844671827, 859.5959898847532, 862.4782006885806, 863.5984267315697, 896.2202883491371, 917.8531434970406, 920.410937000317, 922.4188761080543, 924.7040946896996, 908.9091090890857, 909.5134103254727, 911.129870973219, 911.7720569857536, 912.3886995712921, 523.9187925871458, 543.4402565357688, 544.1429748146685, 545.5826292885945, 677.3395938959525, 11181.385023823686, 12495.062870284673, 14613.70772584553, 14710.33803478846, 15037.473688420852, 14371.71256574873, 14380.137191768423, 14520.854791452055, 14524.201168935704, 14650.487232946902, 11856.992155666692, 11936.58221962227, 12081.214721043192, 12119.337457593241, 12195.08536859739, 3645.671889529955, 3802.9429558556644, 3803.2393521295853, 3815.9236815263816, 3885.5725870154542, 95095.04904951001, 100861.49569252107, 101161.0, 101601.0, 101739.99999999926, 9065.0, 10777.62278320255, 11184.328940263611, 11272.54909803615, 11506.88493115075, 22415.887920560293, 22658.320250392186, 22729.204477843195, 22813.31560053201, 22835.543289134122, 6714.764983225564, 7608.163102058769, 7631.7328893489575, 7633.2366763323225, 7646.694132234648, 4197.433346498245, 4232.830686772556, 4284.59625729375, 4331.350297455344, 4475.194464996332, 3567.126054116758, 3682.502862113634, 3684.5394325709285, 3685.1708365617524, 3687.207250441168, 641.4099028893429, 649.8862699027651, 657.5167252069725, 673.5453568841012, 679.3647939176885, 659.2879689934858, 677.1975209376905, 688.7451642892062, 701.8771714949863, 724.344468256229, 9699.51502424876, 10370.22223333253, 10430.37417754937, 10454.68635940923, 10566.577336906437, 606.3936063936064, 672.5191488086042, 688.944884409246, 693.9930600693929, 708.6358759388157, 4956.231784073474, 5017.874553136201, 5019.573336266385, 5026.396832380138, 5032.396112466454, 94530.5273473642, 102682.0, 105360.47319763352, 106044.0, 109299.45350273357, 96015.51992239994, 98371.0, 98967.0, 99291.50354248182, 103871.0, 78694.21305786983, 80202.79695804567, 80708.0, 80996.19003809887, 81308.18691813006, 9647.469389183661, 9706.126448619658, 9750.902490975282, 9764.609415623296, 9778.462184579916, 46377.072458551316, 50783.0, 53232.73383633057, 54957.0, 55402.72298638481, 64233.71532569229, 69130.0, 73164.0, 73835.63082184769, 77334.0, 11514.88485115138, 11981.880181198076, 12047.156699030984, 12147.210431321935, 12251.019918406328, 12726.109172357847, 12806.103572749818, 12918.547850825553, 13133.474661013835, 13151.300612520592, 9695.70912872615, 10390.908954559662, 11841.52633894669, 12111.939440302742, 12534.498620055096, 11792.823107653563, 12019.879801201876, 12418.565350212699, 12463.688407789878, 12500.687482812638, 11912.52349905994, 11927.582534611247, 11933.164678472423, 12091.57679481214, 12114.75770484603, 9257.21313688344, 9921.355111917703, 10285.691429256834, 10628.149748019985, 10906.34561926287, 9916.851247231152, 9921.206303495559, 9942.9119884825, 9944.877815808246, 9963.053509916546], "value": 7380.81275490884, "unit": "score"}], "name": "dromaeo_css", "value": 7340.132796495089, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 169.0, 140.0, 114.0, 114.0, 115.0, 114.0, 112.0, 114.0, 113.0], "value": 122.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 108.0, 108.0, 148.0, 110.0, 111.0, 110.0, 110.0, 129.0, 112.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 185.0, 187.0, 184.0, 180.0, 184.0, 185.0, 183.0, 187.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 60.0, 60.0, 58.0, 58.0, 73.0, 58.0], "value": 65.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 85.0, 71.0, 67.0, 69.0, 82.0, 67.0, 68.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 99.0, 88.0, 86.0, 126.0, 85.0, 90.0, 87.0, 89.0, 84.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 103.0, 93.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 133.0, 85.0, 87.0, 88.0, 84.0, 85.0, 86.0, 87.0, 84.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 56.0, 55.0, 55.0, 55.0, 56.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 76.0, 78.0, 76.0, 71.0, 72.0, 72.0, 72.0, 73.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 88.0, 93.0, 107.0, 106.0, 88.0, 86.0, 90.0, 87.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 152.0, 154.0, 139.0, 141.0, 139.0, 142.0, 139.0, 195.0, 146.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 177.0, 242.0, 224.0, 175.0, 176.0, 172.0, 173.0, 182.0, 173.0], "value": 187.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 69.0, 68.0, 68.0, 63.0, 72.0, 82.0, 84.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1473.1999999999998, "alertThreshold": 2.0}]} 20:16:38 INFO - Return code: 0 20:16:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:16:38 ERROR - # TBPL SUCCESS # 20:16:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:16:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:16:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:16:38 INFO - 2017-01-19 20:16:38.515 screenresolution[6446:119600] starting screenresolution argv=screenresolution get 20:16:38 INFO - 2017-01-19 20:16:38.518 screenresolution[6446:119600] Display 0: 1600x1200x32@60 20:16:38 INFO - 2017-01-19 20:16:38.524 screenresolution[6447:119603] starting screenresolution argv=screenresolution list 20:16:38 INFO - Available Modes on Display 0 20:16:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:16:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:16:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:16:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:16:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:16:38 INFO - Intel Iris: 20:16:38 INFO - Chipset Model: Intel Iris 20:16:38 INFO - Type: GPU 20:16:38 INFO - Bus: Built-In 20:16:38 INFO - VRAM (Dynamic, Max): 1536 MB 20:16:38 INFO - Vendor: Intel (0x8086) 20:16:38 INFO - Device ID: 0x0a2e 20:16:38 INFO - Revision ID: 0x0009 20:16:38 INFO - Displays: 20:16:38 INFO - Display: 20:16:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:16:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:16:38 INFO - Display Serial Number: 1600x1200 60 20:16:38 INFO - Main Display: Yes 20:16:38 INFO - Mirror: Off 20:16:38 INFO - Online: Yes 20:16:38 INFO - Rotation: Supported 20:16:38 INFO - Return code: 0 20:16:38 INFO - Running post-action listener: _resource_record_post_action 20:16:38 INFO - [mozharness: 2017-01-20 04:16:38.774617Z] Finished run-tests step (success) 20:16:38 INFO - Running post-run listener: _resource_record_post_run 20:16:38 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1362944; Write bytes: 551613440; Read time: 22; Write time: 1646 20:16:38 INFO - TinderboxPrint: CPU usage
53.8% 20:16:38 INFO - TinderboxPrint: I/O read bytes / time
1,362,944 / 22 20:16:38 INFO - TinderboxPrint: I/O write bytes / time
551,613,440 / 1,646 20:16:38 INFO - TinderboxPrint: CPU idle
2,222.7 (46.2%) 20:16:38 INFO - TinderboxPrint: CPU system
969.9 (20.2%) 20:16:38 INFO - TinderboxPrint: CPU user
1,617.0 (33.6%) 20:16:38 INFO - TinderboxPrint: Swap in / out
253,849,600 / 0 20:16:38 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 240974336; Write bytes: 234571264; Read time: 17631; Write time: 481 20:16:38 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1362944; Write bytes: 297496064; Read time: 22; Write time: 1114 20:16:39 INFO - Running post-run listener: _upload_blobber_files 20:16:39 INFO - Blob upload gear active. 20:16:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:16:39 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:16:39 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:16:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:41 INFO - (blobuploader) - INFO - Done attempting. 20:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:42 INFO - (blobuploader) - INFO - Done attempting. 20:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:43 INFO - (blobuploader) - INFO - Done attempting. 20:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:16:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:46 INFO - (blobuploader) - INFO - Done attempting. 20:16:46 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:46 INFO - Return code: 0 20:16:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:16:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1268dbd335bc05c4573e799d78d3108375d4dc333898b5c120222caafd96c688a019fbf64e82d730b847f825d8195e4cc665d4f0a39365a764444b5cbcfa574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c0ce1409cd8ef55e52dc446c3b8d4dfeaa1dfc02fd48247c6d404bee9a837aad1d2a731d5239fcc043d4d193474ca321341fa7510cbe19c771e6b3552957ff44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d635afed187f8ec25f69c595690e2eb63bdc1b7dd8fb2c8d6a868fdf5c21bdac4b435090b4427457da099a25f2d663f67ebd9314a79bab3e6a0e3af8e3f2e6f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3dd4c7013f50709485a692397a963c79f2ef2081f06591fe4f14034056227d6a4fa422424592ebdc55ddc6967c37150427b8346a6d387d61dd78b85318b05cbb"} 20:16:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:16:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:16:46 INFO - Contents: 20:16:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1268dbd335bc05c4573e799d78d3108375d4dc333898b5c120222caafd96c688a019fbf64e82d730b847f825d8195e4cc665d4f0a39365a764444b5cbcfa574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c0ce1409cd8ef55e52dc446c3b8d4dfeaa1dfc02fd48247c6d404bee9a837aad1d2a731d5239fcc043d4d193474ca321341fa7510cbe19c771e6b3552957ff44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d635afed187f8ec25f69c595690e2eb63bdc1b7dd8fb2c8d6a868fdf5c21bdac4b435090b4427457da099a25f2d663f67ebd9314a79bab3e6a0e3af8e3f2e6f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3dd4c7013f50709485a692397a963c79f2ef2081f06591fe4f14034056227d6a4fa422424592ebdc55ddc6967c37150427b8346a6d387d61dd78b85318b05cbb"} 20:16:46 INFO - Running post-run listener: copy_logs_to_upload_dir 20:16:46 INFO - Copying logs to upload dir... 20:16:46 INFO - mkdir: /builds/slave/test/build/upload/logs 20:16:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.875152 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-19 20:16:46.132632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 20:16:46.136090) ========= 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.ppEbmkPuTu/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.6qkATzBUg2/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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/Graphics/sha512/b1268dbd335bc05c4573e799d78d3108375d4dc333898b5c120222caafd96c688a019fbf64e82d730b847f825d8195e4cc665d4f0a39365a764444b5cbcfa574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c0ce1409cd8ef55e52dc446c3b8d4dfeaa1dfc02fd48247c6d404bee9a837aad1d2a731d5239fcc043d4d193474ca321341fa7510cbe19c771e6b3552957ff44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d635afed187f8ec25f69c595690e2eb63bdc1b7dd8fb2c8d6a868fdf5c21bdac4b435090b4427457da099a25f2d663f67ebd9314a79bab3e6a0e3af8e3f2e6f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3dd4c7013f50709485a692397a963c79f2ef2081f06591fe4f14034056227d6a4fa422424592ebdc55ddc6967c37150427b8346a6d387d61dd78b85318b05cbb"} build_url:https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/c7zSO8gXQ76cHhykf3WV3w/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/b1268dbd335bc05c4573e799d78d3108375d4dc333898b5c120222caafd96c688a019fbf64e82d730b847f825d8195e4cc665d4f0a39365a764444b5cbcfa574", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/c0ce1409cd8ef55e52dc446c3b8d4dfeaa1dfc02fd48247c6d404bee9a837aad1d2a731d5239fcc043d4d193474ca321341fa7510cbe19c771e6b3552957ff44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d635afed187f8ec25f69c595690e2eb63bdc1b7dd8fb2c8d6a868fdf5c21bdac4b435090b4427457da099a25f2d663f67ebd9314a79bab3e6a0e3af8e3f2e6f2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3dd4c7013f50709485a692397a963c79f2ef2081f06591fe4f14034056227d6a4fa422424592ebdc55ddc6967c37150427b8346a6d387d61dd78b85318b05cbb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-19 20:16:46.170742) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 20:16:46.171054) ========= 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.ppEbmkPuTu/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.6qkATzBUg2/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005556 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-19 20:16:46.219431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 20:16:46.219746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-19 20:16:46.220057) ========= ========= Total master_lag: 0.16 =========