builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0336 starttime: 1479755358.46 results: success (0) buildid: 20161121080011 builduid: b83800a7b1314f2a879fb28c2998a985 revision: de6d43636e4252fc43371dce0808231e7ff3bea6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.458921) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.459356) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.459630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.485247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.485562) ========= 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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-21 11:09:18-- 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% 17.9M=0.001s 2016-11-21 11:09:18 (17.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085958 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.598465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.598809) ========= 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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.023816 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:18.647004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 11:09:18.650389) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev de6d43636e4252fc43371dce0808231e7ff3bea6 --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 de6d43636e4252fc43371dce0808231e7ff3bea6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kt7Jau2QVP/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.VGP9HrpAbW/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-21 11:09:18,744 truncating revision to first 12 chars 2016-11-21 11:09:18,744 Setting DEBUG logging. 2016-11-21 11:09:18,744 attempt 1/10 2016-11-21 11:09:18,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/de6d43636e42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 11:09:19,777 unpacking tar archive at: graphics-de6d43636e42/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 11:09:19.985194) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:19.988539) ========= script_repo_revision: de6d43636e4252fc43371dce0808231e7ff3bea6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:19.988933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:19.989194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 11:09:20.008616) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-21 11:09:20.008925) ========= /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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:20 INFO - MultiFileLogger online at 20161121 11:09:20 in /builds/slave/test 11:09:20 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 11:09:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:09:20 INFO - {'append_to_log': False, 11:09:20 INFO - 'base_work_dir': '/builds/slave/test', 11:09:20 INFO - 'blob_upload_branch': 'Graphics', 11:09:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:09:20 INFO - 'branch': 'Graphics', 11:09:20 INFO - 'buildbot_json_path': 'buildprops.json', 11:09:20 INFO - 'config_files': ('talos/mac_config.py',), 11:09:20 INFO - 'default_actions': ('clobber', 11:09:20 INFO - 'read-buildbot-config', 11:09:20 INFO - 'download-and-extract', 11:09:20 INFO - 'populate-webroot', 11:09:20 INFO - 'create-virtualenv', 11:09:20 INFO - 'install', 11:09:20 INFO - 'run-tests'), 11:09:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:09:20 INFO - 'download_minidump_stackwalk': True, 11:09:20 INFO - 'download_symbols': 'ondemand', 11:09:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:09:20 INFO - 'tooltool.py': '/tools/tooltool.py', 11:09:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:09:20 INFO - '/tools/misc-python/virtualenv.py')}, 11:09:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:09:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:09:20 INFO - 'installer_path': 'installer.exe', 11:09:20 INFO - 'log_level': 'info', 11:09:20 INFO - 'log_name': 'talos', 11:09:20 INFO - 'log_to_console': True, 11:09:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:09:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:09:20 INFO - 'opt_config_files': (), 11:09:20 INFO - 'pip_index': False, 11:09:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:09:20 INFO - 'cmd': ('bash', 11:09:20 INFO - '-c', 11:09:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:09:20 INFO - 'enabled': True, 11:09:20 INFO - 'halt_on_failure': False, 11:09:20 INFO - 'name': 'check_screen_resolution'},), 11:09:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:09:20 INFO - 'cmd': ('bash', 11:09:20 INFO - '-c', 11:09:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:09:20 INFO - 'enabled': True, 11:09:20 INFO - 'halt_on_failure': False, 11:09:20 INFO - 'name': 'check_screen_resolution'},), 11:09:20 INFO - 'run_cmd_checks_enabled': True, 11:09:20 INFO - 'sps_profile': False, 11:09:20 INFO - 'sps_profile_interval': 0, 11:09:20 INFO - 'suite': 'dromaeojs', 11:09:20 INFO - 'system_bits': '32', 11:09:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:09:20 INFO - 'title': 't-yosemite-r7-0336', 11:09:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:09:20 INFO - 'use_talos_json': True, 11:09:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:09:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:09:20 INFO - 'work_dir': 'build'} 11:09:20 INFO - [mozharness: 2016-11-21 19:09:20.210541Z] Running clobber step. 11:09:20 INFO - Running pre-action listener: _resource_record_pre_action 11:09:20 INFO - Running main action method: clobber 11:09:20 INFO - rmtree: /builds/slave/test/build 11:09:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:09:22 INFO - Running post-action listener: _resource_record_post_action 11:09:22 INFO - [mozharness: 2016-11-21 19:09:22.655737Z] Finished clobber step (success) 11:09:22 INFO - [mozharness: 2016-11-21 19:09:22.655973Z] Running read-buildbot-config step. 11:09:22 INFO - Running pre-action listener: _resource_record_pre_action 11:09:22 INFO - Running main action method: read_buildbot_config 11:09:22 INFO - Using buildbot properties: 11:09:22 INFO - { 11:09:22 INFO - "project": "", 11:09:22 INFO - "product": "firefox", 11:09:22 INFO - "script_repo_revision": "default", 11:09:22 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 11:09:22 INFO - "repository": "", 11:09:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 11:09:22 INFO - "buildid": "20161121080011", 11:09:22 INFO - "pgo_build": "False", 11:09:22 INFO - "basedir": "/builds/slave/test", 11:09:22 INFO - "buildnumber": 1, 11:09:22 INFO - "slavename": "t-yosemite-r7-0336", 11:09:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:09:22 INFO - "platform": "yosemite_r7", 11:09:22 INFO - "scheduler": "tests-graphics-macosx64-talos", 11:09:22 INFO - "branch": "graphics", 11:09:22 INFO - "repo_path": "projects/graphics", 11:09:22 INFO - "revision": "de6d43636e4252fc43371dce0808231e7ff3bea6", 11:09:22 INFO - "stage_platform": "macosx64", 11:09:22 INFO - "builduid": "b83800a7b1314f2a879fb28c2998a985", 11:09:22 INFO - "slavebuilddir": "test" 11:09:22 INFO - } 11:09:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 11:09:22 INFO - Running post-action listener: _resource_record_post_action 11:09:22 INFO - [mozharness: 2016-11-21 19:09:22.661707Z] Finished read-buildbot-config step (success) 11:09:22 INFO - [mozharness: 2016-11-21 19:09:22.661937Z] Running download-and-extract step. 11:09:22 INFO - Running pre-action listener: _resource_record_pre_action 11:09:22 INFO - Running main action method: download_and_extract 11:09:22 INFO - mkdir: /builds/slave/test/build/tests 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:22 INFO - trying https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 11:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/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 11:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/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 11:09:24 INFO - Downloaded 1199 bytes. 11:09:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:09:24 INFO - Using the following test package requirements: 11:09:24 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:09:24 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 11:09:24 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 11:09:24 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'jsshell-mac.zip'], 11:09:24 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 11:09:24 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:09:24 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 11:09:24 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 11:09:24 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 11:09:24 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:09:24 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 11:09:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:09:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:09:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:09:24 INFO - Fetch https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:09:24 INFO - Http code: 200 11:09:24 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 11:09:24 INFO - x-amz-cf-id: S-FDoFBCcWndr8nEWBsYqurKFBX8aLBfO-g9UNu22JTUB09NHiMCAQ== 11:09:24 INFO - x-amz-version-id: GOY9JGiH0gjuCsplL3n0iCUxeUHcMn3R 11:09:24 INFO - Expected file size: 16282114 11:09:24 INFO - Obtained file size: 16282114 11:09:31 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 11:09:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:09:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:09:31 INFO - Fetch https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:09:32 INFO - Http code: 200 11:09:32 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 11:09:32 INFO - x-amz-cf-id: _fzcJpGtCNWQHh9LeyxniUmhip48II7X_tQxnlHOTiiqITMBjPvtoQ== 11:09:32 INFO - x-amz-version-id: GOY9JGiH0gjuCsplL3n0iCUxeUHcMn3R 11:09:32 INFO - Expected file size: 16282114 11:09:32 INFO - Obtained file size: 16282114 11:09:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 11:09:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:09:38 INFO - Fetch https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 11:09:39 INFO - Http code: 200 11:09:39 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 11:09:39 INFO - x-amz-cf-id: _6NMXI0PmKn2jKY2nDlQ0mDovyzXhl-SJ6py--ewEXxef2pvLwbX2Q== 11:09:39 INFO - x-amz-version-id: dDrgeTeooNG5p8IesDJ_hTQlArkb.mM. 11:09:39 INFO - Expected file size: 14409392 11:09:39 INFO - Obtained file size: 14409392 11:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:40 INFO - trying https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:09:40 INFO - Downloading https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 11:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/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 11:09:42 INFO - Downloaded 107571685 bytes. 11:09:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:09:42 INFO - mkdir: /builds/slave/test/properties 11:09:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:42 INFO - Contents: 11:09:42 INFO - build_url:https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:09:43 INFO - Running post-action listener: _resource_record_post_action 11:09:43 INFO - Running post-action listener: set_extra_try_arguments 11:09:43 INFO - [mozharness: 2016-11-21 19:09:43.455952Z] Finished download-and-extract step (success) 11:09:43 INFO - [mozharness: 2016-11-21 19:09:43.456102Z] Running populate-webroot step. 11:09:43 INFO - Running pre-action listener: _resource_record_pre_action 11:09:43 INFO - Running main action method: populate_webroot 11:09:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:43 INFO - '--tppagecycles', 11:09:43 INFO - '7'], 11:09:43 INFO - 'tests': ['tsvgm']}}, 11:09:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['damp', 'tps']}, 11:09:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'tests': ['damp', 'tps']}, 11:09:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['dromaeo_dom']}, 11:09:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['basic_compositor_video']}, 11:09:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:09:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['a11yr', 11:09:43 INFO - 'ts_paint', 11:09:43 INFO - 'tpaint', 11:09:43 INFO - 'sessionrestore', 11:09:43 INFO - 'sessionrestore_no_auto_restore', 11:09:43 INFO - 'tabpaint']}, 11:09:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['tsvgx', 11:09:43 INFO - 'tsvgr_opacity', 11:09:43 INFO - 'tart', 11:09:43 INFO - 'tscrollx', 11:09:43 INFO - 'cart']}, 11:09:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:43 INFO - 'tsvgr_opacity', 11:09:43 INFO - 'tart', 11:09:43 INFO - 'tscrollx', 11:09:43 INFO - 'cart']}, 11:09:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'talos_options': ['--disable-e10s'], 11:09:43 INFO - 'tests': ['tp5o']}, 11:09:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:09:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'talos_options': ['--disable-e10s', 11:09:43 INFO - '--xperf_path', 11:09:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:43 INFO - 'tests': ['tp5n']}, 11:09:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:09:43 INFO - 'talos_options': ['--xperf_path', 11:09:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:43 INFO - 'tests': ['tp5n']}}, 11:09:43 INFO - 'talos.zip': {'path': '', 11:09:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:43 INFO - Running post-action listener: _resource_record_post_action 11:09:43 INFO - [mozharness: 2016-11-21 19:09:43.474016Z] Finished populate-webroot step (success) 11:09:43 INFO - [mozharness: 2016-11-21 19:09:43.474132Z] Running create-virtualenv step. 11:09:43 INFO - Running pre-action listener: _resource_record_pre_action 11:09:43 INFO - Running main action method: create_virtualenv 11:09:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:43 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 11:09:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:43 INFO - Using real prefix '/tools/python27' 11:09:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:47 INFO - Installing pip.................done. 11:09:47 INFO - Return code: 0 11:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:09:47 INFO - Reading from file tmpfile_stdout 11:09:47 INFO - Output received: 11:09:47 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) 11:09:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:47 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 11:09:47 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 11:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:47 INFO - 'HOME': '/Users/cltbld', 11:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:47 INFO - 'LOGNAME': 'cltbld', 11:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:47 INFO - 'MOZ_NO_REMOTE': '1', 11:09:47 INFO - 'NO_EM_RESTART': '1', 11:09:47 INFO - 'PAGER': '/bin/cat', 11:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:47 INFO - 'PWD': '/builds/slave/test', 11:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:47 INFO - 'SHELL': '/bin/bash', 11:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:09:47 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:47 INFO - 'USER': 'cltbld', 11:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:47 INFO - 'XPC_FLAGS': '0x0', 11:09:47 INFO - 'XPC_SERVICE_NAME': '0', 11:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 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 11:09:47 INFO - Cleaning up... 11:09:47 INFO - Return code: 0 11:09:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:47 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:47 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 11:09:47 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 11:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:47 INFO - 'HOME': '/Users/cltbld', 11:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:47 INFO - 'LOGNAME': 'cltbld', 11:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:47 INFO - 'MOZ_NO_REMOTE': '1', 11:09:47 INFO - 'NO_EM_RESTART': '1', 11:09:47 INFO - 'PAGER': '/bin/cat', 11:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:47 INFO - 'PWD': '/builds/slave/test', 11:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:47 INFO - 'SHELL': '/bin/bash', 11:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:09:47 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:47 INFO - 'USER': 'cltbld', 11:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:47 INFO - 'XPC_FLAGS': '0x0', 11:09:47 INFO - 'XPC_SERVICE_NAME': '0', 11:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:47 INFO - Downloading/unpacking psutil>=3.1.1 11:09:47 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 11:09:47 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 11:09:47 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 11:09:47 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 11:09:47 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 11:09:47 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 11:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:51 INFO - Installing collected packages: psutil 11:09:51 INFO - Running setup.py install for psutil 11:09:51 INFO - building 'psutil._psutil_osx' extension 11:09:51 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 11:09:51 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 11:09:52 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 11:09:52 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 11:09:52 INFO - building 'psutil._psutil_posix' extension 11:09:52 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 11:09:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:09:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:09:52 INFO - ^ 11:09:52 INFO - 1 warning generated. 11:09:52 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 11:09:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:52 INFO - Successfully installed psutil 11:09:52 INFO - Cleaning up... 11:09:52 INFO - Return code: 0 11:09:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:52 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:52 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 11:09:52 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 11:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:52 INFO - 'HOME': '/Users/cltbld', 11:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:52 INFO - 'LOGNAME': 'cltbld', 11:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:52 INFO - 'MOZ_NO_REMOTE': '1', 11:09:52 INFO - 'NO_EM_RESTART': '1', 11:09:52 INFO - 'PAGER': '/bin/cat', 11:09:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:52 INFO - 'PWD': '/builds/slave/test', 11:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:52 INFO - 'SHELL': '/bin/bash', 11:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:09:52 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:52 INFO - 'USER': 'cltbld', 11:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:52 INFO - 'XPC_FLAGS': '0x0', 11:09:52 INFO - 'XPC_SERVICE_NAME': '0', 11:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:52 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 11:09:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:55 INFO - Installing collected packages: mozsystemmonitor 11:09:55 INFO - Running setup.py install for mozsystemmonitor 11:09:55 INFO - Successfully installed mozsystemmonitor 11:09:55 INFO - Cleaning up... 11:09:55 INFO - Return code: 0 11:09:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09:55 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')]} 11:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:55 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')]} 11:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:55 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:55 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 11:09:55 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 11:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:55 INFO - 'HOME': '/Users/cltbld', 11:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:55 INFO - 'LOGNAME': 'cltbld', 11:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:55 INFO - 'MOZ_NO_REMOTE': '1', 11:09:55 INFO - 'NO_EM_RESTART': '1', 11:09:55 INFO - 'PAGER': '/bin/cat', 11:09:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:55 INFO - 'PWD': '/builds/slave/test', 11:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:55 INFO - 'SHELL': '/bin/bash', 11:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:09:55 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:55 INFO - 'USER': 'cltbld', 11:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:55 INFO - 'XPC_FLAGS': '0x0', 11:09:55 INFO - 'XPC_SERVICE_NAME': '0', 11:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:55 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:55 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 11:09:55 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 11:09:55 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 11:09:55 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 11:09:55 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 11:09:55 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 11:09:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09:58 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 11:09:58 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 11:09:58 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 11:09:58 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 11:09:58 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 11:09:58 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 11:09:58 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:58 INFO - warning: no files found matching '*.txt' 11:09:58 INFO - no previously-included directories found matching 'build' 11:09:58 INFO - no previously-included directories found matching 'dist' 11:09:58 INFO - no previously-included directories found matching '.git*' 11:09:58 INFO - Installing collected packages: jsonschema, functools32 11:09:58 INFO - Running setup.py install for functools32 11:09:59 INFO - warning: no files found matching '*.txt' 11:09:59 INFO - no previously-included directories found matching 'build' 11:09:59 INFO - no previously-included directories found matching 'dist' 11:09:59 INFO - no previously-included directories found matching '.git*' 11:09:59 INFO - Successfully installed jsonschema functools32 11:09:59 INFO - Cleaning up... 11:09:59 INFO - Return code: 0 11:09:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:09:59 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')]} 11:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:59 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')]} 11:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:59 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:59 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 11:09:59 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 11:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:59 INFO - 'HOME': '/Users/cltbld', 11:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:59 INFO - 'LOGNAME': 'cltbld', 11:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:59 INFO - 'MOZ_NO_REMOTE': '1', 11:09:59 INFO - 'NO_EM_RESTART': '1', 11:09:59 INFO - 'PAGER': '/bin/cat', 11:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:59 INFO - 'PWD': '/builds/slave/test', 11:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:59 INFO - 'SHELL': '/bin/bash', 11:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:09:59 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:59 INFO - 'USER': 'cltbld', 11:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:59 INFO - 'XPC_FLAGS': '0x0', 11:09:59 INFO - 'XPC_SERVICE_NAME': '0', 11:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:09:59 INFO - Cleaning up... 11:09:59 INFO - Return code: 0 11:09:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:59 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')]} 11:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:59 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')]} 11:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:59 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:09:59 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 11:09:59 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 11:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:59 INFO - 'HOME': '/Users/cltbld', 11:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:59 INFO - 'LOGNAME': 'cltbld', 11:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:59 INFO - 'MOZ_NO_REMOTE': '1', 11:09:59 INFO - 'NO_EM_RESTART': '1', 11:09:59 INFO - 'PAGER': '/bin/cat', 11:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:59 INFO - 'PWD': '/builds/slave/test', 11:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:59 INFO - 'SHELL': '/bin/bash', 11:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:09:59 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:59 INFO - 'USER': 'cltbld', 11:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:59 INFO - 'XPC_FLAGS': '0x0', 11:09:59 INFO - 'XPC_SERVICE_NAME': '0', 11:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:59 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:59 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 11:09:59 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 11:09:59 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 11:09:59 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 11:09:59 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 11:09:59 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 11:10:02 INFO - Downloading blobuploader-1.2.4.tar.gz 11:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:10:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 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 11:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:10:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 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 11:10:03 INFO - Downloading docopt-0.6.1.tar.gz 11:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:10:03 INFO - Installing collected packages: blobuploader, requests, docopt 11:10:03 INFO - Running setup.py install for blobuploader 11:10:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:10:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:10:03 INFO - Running setup.py install for requests 11:10:04 INFO - Running setup.py install for docopt 11:10:04 INFO - Successfully installed blobuploader requests docopt 11:10:04 INFO - Cleaning up... 11:10:04 INFO - Return code: 0 11:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:04 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:10:04 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 11:10:04 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 11:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:04 INFO - 'HOME': '/Users/cltbld', 11:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:04 INFO - 'LOGNAME': 'cltbld', 11:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:04 INFO - 'MOZ_NO_REMOTE': '1', 11:10:04 INFO - 'NO_EM_RESTART': '1', 11:10:04 INFO - 'PAGER': '/bin/cat', 11:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:04 INFO - 'PWD': '/builds/slave/test', 11:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:04 INFO - 'SHELL': '/bin/bash', 11:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:10:04 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:04 INFO - 'USER': 'cltbld', 11:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:04 INFO - 'XPC_FLAGS': '0x0', 11:10:04 INFO - 'XPC_SERVICE_NAME': '0', 11:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:10:04 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-_jE0hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:10:04 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-he_XLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:10:04 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-b28syh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-v0cnlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-CDEspU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-RNCAvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-U5I68Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-KCeCED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-dhXpFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-l7ndbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-sxD4Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:10:05 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-8HxkKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:10:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:10:06 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-mToTt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:10:06 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-E4wIX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:06 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-jedP4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:10:06 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-BlDoyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:10:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:10:06 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-_Pas4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:10:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:10:06 INFO - Running setup.py install for manifestparser 11:10:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:10:06 INFO - Running setup.py install for mozcrash 11:10:06 INFO - Running setup.py install for mozdebug 11:10:06 INFO - Running setup.py install for mozdevice 11:10:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozfile 11:10:07 INFO - Running setup.py install for mozhttpd 11:10:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozinfo 11:10:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozInstall 11:10:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:10:07 INFO - Running setup.py install for mozleak 11:10:07 INFO - Running setup.py install for mozlog 11:10:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Running setup.py install for moznetwork 11:10:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Running setup.py install for mozprocess 11:10:08 INFO - Running setup.py install for mozprofile 11:10:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Running setup.py install for mozrunner 11:10:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:10:08 INFO - Running setup.py install for mozscreenshot 11:10:08 INFO - Running setup.py install for moztest 11:10:08 INFO - Running setup.py install for mozversion 11:10:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:10:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:10:09 INFO - Cleaning up... 11:10:09 INFO - Return code: 0 11:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:09 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:10:09 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 11:10:09 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 11:10:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:10:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:09 INFO - 'HOME': '/Users/cltbld', 11:10:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:09 INFO - 'LOGNAME': 'cltbld', 11:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:09 INFO - 'MOZ_NO_REMOTE': '1', 11:10:09 INFO - 'NO_EM_RESTART': '1', 11:10:09 INFO - 'PAGER': '/bin/cat', 11:10:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:09 INFO - 'PWD': '/builds/slave/test', 11:10:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:09 INFO - 'SHELL': '/bin/bash', 11:10:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:10:09 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:10:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:09 INFO - 'USER': 'cltbld', 11:10:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:09 INFO - 'XPC_FLAGS': '0x0', 11:10:09 INFO - 'XPC_SERVICE_NAME': '0', 11:10:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:10:09 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-9F7tEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:10:09 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)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:10:09 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-q7nLO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:10:09 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)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:10:09 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-nqYF84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:10:09 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)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:10:09 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-mqHEr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:10:09 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)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:10:09 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-xeiqzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:10:09 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)) 11:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:10:09 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-HA2Xnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-GU_RL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-4xK1pE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-UHy2G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-od5BTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-mDuAeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-w0lnAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-XB1ncz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-zvzRJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:10:10 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)) 11:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:10 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-0378zn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:10:11 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)) 11:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:10:11 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-Ec95rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:10:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:10:11 INFO - Running setup.py (path:/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/pip-orDB3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:10:11 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)) 11:10:11 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)) 11:10:11 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)) 11:10:11 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)) 11:10:11 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)) 11:10:11 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)) 11:10:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:10:14 INFO - Downloading blessings-1.6.tar.gz 11:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:10:14 INFO - Installing collected packages: blessings 11:10:14 INFO - Running setup.py install for blessings 11:10:14 INFO - Successfully installed blessings 11:10:14 INFO - Cleaning up... 11:10:14 INFO - Return code: 0 11:10:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:14 INFO - Reading from file tmpfile_stdout 11:10:14 INFO - Current package versions: 11:10:14 INFO - blessings == 1.6 11:10:14 INFO - blobuploader == 1.2.4 11:10:14 INFO - docopt == 0.6.1 11:10:14 INFO - functools32 == 3.2.3-2 11:10:14 INFO - jsonschema == 2.5.1 11:10:14 INFO - manifestparser == 1.1 11:10:14 INFO - mozInstall == 1.12 11:10:14 INFO - mozcrash == 1.0 11:10:14 INFO - mozdebug == 0.1 11:10:14 INFO - mozdevice == 0.49 11:10:14 INFO - mozfile == 1.2 11:10:14 INFO - mozhttpd == 0.7 11:10:14 INFO - mozinfo == 0.9 11:10:14 INFO - mozleak == 0.1 11:10:14 INFO - mozlog == 3.4 11:10:14 INFO - moznetwork == 0.27 11:10:14 INFO - mozprocess == 0.23 11:10:14 INFO - mozprofile == 0.28 11:10:14 INFO - mozrunner == 6.13 11:10:14 INFO - mozscreenshot == 0.1 11:10:14 INFO - mozsystemmonitor == 0.3 11:10:14 INFO - moztest == 0.7 11:10:14 INFO - mozversion == 1.4 11:10:14 INFO - psutil == 3.1.1 11:10:14 INFO - requests == 1.2.3 11:10:14 INFO - wsgiref == 0.1.2 11:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:15 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:10:15 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 11:10:15 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 11:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:15 INFO - 'HOME': '/Users/cltbld', 11:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:15 INFO - 'LOGNAME': 'cltbld', 11:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:15 INFO - 'MOZ_NO_REMOTE': '1', 11:10:15 INFO - 'NO_EM_RESTART': '1', 11:10:15 INFO - 'PAGER': '/bin/cat', 11:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:15 INFO - 'PWD': '/builds/slave/test', 11:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:15 INFO - 'SHELL': '/bin/bash', 11:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:10:15 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:15 INFO - 'USER': 'cltbld', 11:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:15 INFO - 'XPC_FLAGS': '0x0', 11:10:15 INFO - 'XPC_SERVICE_NAME': '0', 11:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 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)) 11:10:15 INFO - Cleaning up... 11:10:15 INFO - Return code: 0 11:10:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:10:15 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 0x1017703f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016e6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe069c5ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, '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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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 11:10:15 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 11:10:15 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 11:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:15 INFO - 'HOME': '/Users/cltbld', 11:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:15 INFO - 'LOGNAME': 'cltbld', 11:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:15 INFO - 'MOZ_NO_REMOTE': '1', 11:10:15 INFO - 'NO_EM_RESTART': '1', 11:10:15 INFO - 'PAGER': '/bin/cat', 11:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:15 INFO - 'PWD': '/builds/slave/test', 11:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:15 INFO - 'SHELL': '/bin/bash', 11:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:10:15 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:15 INFO - 'USER': 'cltbld', 11:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:15 INFO - 'XPC_FLAGS': '0x0', 11:10:15 INFO - 'XPC_SERVICE_NAME': '0', 11:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:10:15 INFO - Cleaning up... 11:10:15 INFO - Return code: 0 11:10:15 INFO - Running post-action listener: _resource_record_post_action 11:10:15 INFO - Running post-action listener: _start_resource_monitoring 11:10:15 INFO - Starting resource monitoring. 11:10:15 INFO - [mozharness: 2016-11-21 19:10:15.745661Z] Finished create-virtualenv step (success) 11:10:15 INFO - [mozharness: 2016-11-21 19:10:15.746623Z] Running install step. 11:10:15 INFO - Running pre-action listener: _resource_record_pre_action 11:10:15 INFO - Running main action method: install 11:10:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:10:16 INFO - Reading from file tmpfile_stdout 11:10:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:10:16 INFO - Reading from file tmpfile_stdout 11:10:16 INFO - Output received: 11:10:16 INFO - Usage: mozinstall [options] installer 11:10:16 INFO - Options: 11:10:16 INFO - -h, --help show this help message and exit 11:10:16 INFO - -d DEST, --destination=DEST 11:10:16 INFO - Directory to install application into. [default: 11:10:16 INFO - "/builds/slave/test"] 11:10:16 INFO - --app=APP Application being installed. [default: firefox] 11:10:16 INFO - mkdir: /builds/slave/test/build/application 11:10:16 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'] 11:10:16 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 11:10:48 INFO - Reading from file tmpfile_stdout 11:10:48 INFO - Output received: 11:10:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:10:48 INFO - Running post-action listener: _resource_record_post_action 11:10:48 INFO - [mozharness: 2016-11-21 19:10:48.586593Z] Finished install step (success) 11:10:48 INFO - [mozharness: 2016-11-21 19:10:48.586730Z] Running run-tests step. 11:10:48 INFO - Running pre-action listener: _resource_record_pre_action 11:10:48 INFO - Running main action method: run_tests 11:10:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:48 INFO - 2016-11-21 11:10:48.601 screenresolution[1627:7870] starting screenresolution argv=screenresolution get 11:10:48 INFO - 2016-11-21 11:10:48.603 screenresolution[1627:7870] Display 0: 1600x1200x32@60 11:10:48 INFO - 2016-11-21 11:10:48.609 screenresolution[1628:7872] starting screenresolution argv=screenresolution list 11:10:48 INFO - Available Modes on Display 0 11:10:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:48 INFO - Intel Iris: 11:10:48 INFO - Chipset Model: Intel Iris 11:10:48 INFO - Type: GPU 11:10:48 INFO - Bus: Built-In 11:10:48 INFO - VRAM (Dynamic, Max): 1536 MB 11:10:48 INFO - Vendor: Intel (0x8086) 11:10:48 INFO - Device ID: 0x0a2e 11:10:48 INFO - Revision ID: 0x0009 11:10:48 INFO - Displays: 11:10:48 INFO - Display: 11:10:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:48 INFO - Display Serial Number: 1600x1200 60 11:10:48 INFO - Main Display: Yes 11:10:48 INFO - Mirror: Off 11:10:48 INFO - Online: Yes 11:10:48 INFO - Rotation: Supported 11:10:48 INFO - Return code: 0 11:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:48 INFO - Python 2.7.3 11:10:48 INFO - Return code: 0 11:10:48 INFO - grabbing minidump binary from tooltool 11:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:10:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101586d30>, '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 0x1013eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10157eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:10:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:10:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:10:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:48 INFO - Return code: 0 11:10:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:10:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:10:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:48 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/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--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 11:10:48 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/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0336 --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 11:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kt7Jau2QVP/Render', 11:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:48 INFO - 'HOME': '/Users/cltbld', 11:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:48 INFO - 'LOGNAME': 'cltbld', 11:10:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:48 INFO - 'MOZ_NO_REMOTE': '1', 11:10:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:48 INFO - 'NO_EM_RESTART': '1', 11:10:48 INFO - 'PAGER': '/bin/cat', 11:10:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:48 INFO - 'PWD': '/builds/slave/test', 11:10:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:48 INFO - 'SHELL': '/bin/bash', 11:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VGP9HrpAbW/Listeners', 11:10:48 INFO - 'TMPDIR': '/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/', 11:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:48 INFO - 'USER': 'cltbld', 11:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:48 INFO - 'XPC_FLAGS': '0x0', 11:10:48 INFO - 'XPC_SERVICE_NAME': '0', 11:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:10:48 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/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0336', '--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 11:10:49 INFO - mozversion application_buildid: 20161121080011 11:10:49 INFO - mozversion application_changeset: de6d43636e4252fc43371dce0808231e7ff3bea6 11:10:49 INFO - mozversion application_display_name: Nightly 11:10:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:49 INFO - mozversion application_name: Firefox 11:10:49 INFO - mozversion application_remotingname: firefox 11:10:49 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 11:10:49 INFO - mozversion application_vendor: Mozilla 11:10:49 INFO - mozversion application_version: 53.0a1 11:10:49 INFO - mozversion platform_buildid: 20161121080011 11:10:49 INFO - mozversion platform_changeset: de6d43636e4252fc43371dce0808231e7ff3bea6 11:10:49 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 11:10:49 INFO - mozversion platform_version: 53.0a1 11:10:49 INFO - using testdate: 1479755449 11:10:49 INFO - actual date: 1479755449 11:10:49 INFO - starting webserver on 'localhost:49236' 11:10:49 INFO - SUITE-START | Running 2 tests 11:10:49 INFO - TEST-START | dromaeo_css 11:10:49 INFO - operating with platform_type : mac_ 11:10:49 INFO - Initialising browser for dromaeo_css test... 11:10:49 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmppnaxA4/profile http://localhost:49236/getInfo.html) 11:10:52 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 11:10:52 INFO - PROCESS | 1638 | colorDepth:24 11:10:52 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 11:10:52 INFO - PROCESS | 1638 | __metrics 11:10:52 INFO - PROCESS | 1638 | 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" 11:10:52 INFO - PROCESS | 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:10:52 INFO - TEST-INFO | 1638: exit 0 11:10:52 INFO - Browser initialized. 11:10:52 INFO - Running cycle 1/1 for dromaeo_css test... 11:10:52 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmppnaxA4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:05 INFO - PROCESS | 1640 | RSS: Main: 243875840 11:11:05 INFO - PROCESS | 1640 | 11:11:56 INFO - PROCESS | 1640 | 1479755516805 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:14:09 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 11:14:10 INFO - PROCESS | 1640 | RSS: Main: 376639488 11:14:10 INFO - PROCESS | 1640 | 11:17:13 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 11:17:14 INFO - PROCESS | 1640 | RSS: Main: 369373184 11:17:14 INFO - PROCESS | 1640 | 11:20:16 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 11:20:17 INFO - PROCESS | 1640 | RSS: Main: 337993728 11:20:17 INFO - PROCESS | 1640 | 11:23:19 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 11:23:20 INFO - PROCESS | 1640 | RSS: Main: 331337728 11:23:20 INFO - PROCESS | 1640 | 11:26:23 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 11:26:24 INFO - PROCESS | 1640 | RSS: Main: 327151616 11:26:24 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 11:29:27 INFO - PROCESS | 1640 | RSS: Main: 386686976 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | __start_tp_report 11:29:27 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 11:29:27 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 11:29:27 INFO - PROCESS | 1640 | |i|pagename|runs| 11:29:27 INFO - PROCESS | 1640 | |0;dojo.html;3256.625488068872;3290.9177270568234;3309.3050459403526;3340.8663653453864;3368.427367347551;5508;5576.749046292916;5614.550835933126;5696.6866822324755;5704.458076482732;5584.21820945067;5621.859453513664;5705.572082093839;5715.199872017911;5743.741531631076;5048;5085.211792172219;5123.666961647499;5182.740862956856;5186.740662966856;5207.765650545715;5215.947840521603;5220.060389129955;5223.686578805265;5297.470252974691;5104.668196567249;5194.948050519484;5207.192885102815;5217.713025783581;5290.444503327153;5160.380754309469;5194.246834209019;5194.3766747990485;5197.714125723083;5202.479752024805;5037.647364684473;5159.432462429129;5159.613029022801;5168.224766285088;5184.7407629618365;5581.972090139523;5606.327240731098;5612.35457922336;5632.2678051853;5636.74634641438;6035.3059398169335;6105.67942450621;6131.356207598183;6131.877362452726;6137.478314343286;6132.782355430526;6180.783672571439;6191.0713392990965;6195.915714749901;6208.50331973441;5653;5693.3168019837885;5696.971515142398;5711.6858572778065;5735.0823868181305;6162.661053642003;6224;6271.749130034747;6289.559730818799;6296.433321001132;6110.597336992702;6127.505970454377;6130.8377647633215;6137.880059131387;6139.8601398601395;6238.1266622672865;6247.656378899113;6247.875042499125;6252.718627661766;6262;6014;6057.121717350959;6083.6045657032155;6186.072089186658;6186.845328866724;6102.640737559664;6133.242854861876;6177.598456100339;6231.096491008779;6248.9062664060075;4930.359053323117;4937.1606826839525;4942.9011419771405;4947.307376967227;4956.058348913767;4343.69594128408;4362.956370436255;4380.67144964129;4382.737035777864;4403.53762854902;5588.441155884379;5622.718864056781;5659.490645841894;5671.801486948019;5712.65724056558;5158.484151584811;6234.3453937336835;6256.499480041586;6261.060840873814;6265.216847894013;5706.832707847102;5715.857103572361;5724.513416359656;5762.250907382014;5771.30744310677;5212.348456442945;5306.257124002643;5307.0182016326335;5371.62398632092;5373.758180881791;6230.096635987666;6248.500119990481;6274;6312.5581209314905;6313.179286692701;4739.620830333634;6255.843603909939;6256.0303153011355;6275.811725648238;6285.277193122849;6208.875822483616;6252.187215661935;6277.497800176066;6285.308616052322;6291.02489114188;5011.323471331323;6044.486218671462;6081.300650425258;6113.537117903944;6144.832481828438;4886.29148773433;6078.422549857756;6206.534509911684;6234;6252.874942501034;5631;5996.790112346047;6068.514518838394;6068.696565171812;6072.453479186717;5856.677882716492;5891.086881533369;5915.438033386821;5921.1414344918885;5946.910796337972;5814.331351894586;5827.562932779973;5828.038373668467;5835.153902684172;5841.94158058414;5896.233489646319;5910.261217347832;5914.67469289176;5921.111833225051;5921.733521991435;5725.997950358587;5738.741756621045;5790.10253410722;5797.072468405035;5849.239598852122 11:29:27 INFO - PROCESS | 1640 | |1;ext.html;487.9922959089482;505.35819509223296;518.0959226150368;523.6910222968451;549.2834890965732;29604.85197574012;37809.43285850711;39083.41374879379;39120.80439597805;39168.41247381292;40156.39765403514;40410.39384409236;40449;40563.78308650738;40577.985550361256;9093.272538196945;9279.907200927972;9286.535673216345;9296.163345298923;9301;9231.446113233194;9335.719928402124;9346.672866449675;9354.672586459475;9374.953125234364;8680.175383338572;8736.645819897925;9319.394239374453;9381.765455863624;9389.812203755955;9282;9289.071092890725;9351.672691455766;9373.578188981512;9377.812443751087;9195.770105747342;9256.907430925672;9273.768155796091;9276.860847087299;9298.581563829644;38403.03992400212;38736.8378948632;38746.41880371797;38755.44978200868;38802.61197388046;3300.2409445827593;3315.419801534746;3367.6295607483157;3380.8140552269615;3387.9830600847085;28377.858110709316;28918.71081289181;29426;30039.249018774488;30159.849200754074;3149.984250078735;3162.57305263791;3201.2317043909525;3290;3308.6195087564997;409372.9531352354;414759;417247;417507.999999997;418849;62763.74472510524;63513;63665.72345595043;63687.726245474834;63723.044154337724;34804.65195348065;35677.8216108923;35752.82123589365;36565.26869462596;65771.34228657748;16053.357865685242;16251.431199907947;16309.755353669705;16313.510594682179;16361.509154725378;12302.75394492123;12418.316992565495;12433.689157771129;12446.937765311297;12450.25298482094;19492.155717615864;19702.507437314183;19704.90147549253;19729.210831566863;19744.70382944257;7370.963145184347;8056.791481277855;8261.339092872557;8305.252527272454;8345.749627511184;875.8379699755566;927.0544045074122;954.4750387286964;1019.704285757137;1092.0881064311388;23791.167309144097;28262.85868570644;28625.427491450053;29246;29879.850600747293;894.6600291889171;969.8399764038995;1031.8142734307746;1094.2832444748703;1106.6956586938657;15444.845551544566;15669.373225071098;16033.438829640907;16039.599010024609;16049.358025678843;680219;684723;686821;687786;690793;55404.72297638486;55926;56064.878702425725;56086.43913560894;56261;1000.3943670408889;1226.7730469863104;1229.342301868514;1277.3613193403298;1314.6450458376376;27795.861020694767;29059.12822615325;29225.70774292315;29823.254418639706;29913.85043074858;33163.83418082991;47684.5231547694;47733;47771.28343074787;47822;559465;562045;564104;565030;567206;25495.49009019772;25860.224193274233;26467.205983820517;26500.204993850217;26854.731452685224;44190.558094418644;44275.778621106685;44480;44666.55333446624;44725;36226.818865906556;36363.7272695465;36532.32390707425;37096.07259818526;37113.443298351085;36155.27689446249;36481.45277820888;37129.81435092807;37161.814190928875;37467.2506549862;36214.63785362113;36397.45403818892;36442.27115457623;36448;36800;28693;31387.686123138476;32986.34027319488;33040.66959330472;33076.338473230884;24147.51704965926;24387.930819336503;24540.87729561341;24877.626835597843;24985.500289994463 11:29:27 INFO - PROCESS | 1640 | |2;jquery.html;350.57930483419904;371.98884033479004;372.19419955795706;383.7294707231402;403.6609248231485;14592.78110828337;14976.625584360383;15403.460878869242;19906.601867962632;20433.386998390033;14676.706465870677;19159.521011974706;19490.610187796236;19748.407547773553;20021.1991520339;5608.663480191181;5905.586608937376;5907.113932910055;5911.4384133507465;5913.811889600854;5464.590155738316;5703.372629010805;5750.942490575083;5751.4536119068625;5771.105478650816;5716.085426331788;5720;5721.313442386899;5721.799737009205;5728.9974254505505;5473.124300111983;5736.741846616912;5766.279215098113;5774.989376859033;5784.768609255625;4717.174494463489;5054.11552978231;5059.569936555397;5063.898722025576;5065.924011139836;12217.266963982189;12856.678583035406;12864.485420583165;12869.4208760606;12892.742145157139;2046.6111438826576;2113.3765539165984;2152.956940861174;2308.826837987158;2829.4058247767994;7812.843743125162;9969.538077403246;10149.39103653783;10153.441560714158;10211.234157438223;1766.9028203448804;1778.2531336838429;1819.154093346587;1840.5122642499748;1858.609691964689;95330.52334738281;113498.43250783693;115203.42398288038;116608;118743;9086;9598.66404675833;9631.422114673142;9727.854082188773;11022;12203.20679155852;12260.957818585342;12274.754504909852;12282.263064216175;12287;7620.542767433972;7735.110462296795;7735.303822655988;7820.960895195488;7837.804054898673;7009.61447120403;7937.444378893422;7965.800854978672;7995.280424761683;8109.107998120202;3132.8903488377796;3709.221063576679;3823.973294154103;3865.2462769759627;3898.96101038986;1666.2446440363353;1802.765640466757;1914.1719657726837;1915.7796853361763;1921.8174273444001;841.9284360829275;917.3670167584345;923.6767131504055;965.280865755017;983.5082458770614;19956;20581.970901454868;20597.382078537667;20685.345172386173;20748.896255518626;775.7866586688706;892.9866052009226;925.379995403068;941.8869735631768;949.3117489819825;10299.227557933185;10694.251402401913;10785.298955567863;10803.621873234399;10864.348139111678;586330;591207;599353;601376;619328;111242.88757112325;128108.35945820212;132333;134966;137502;826.7519744076753;991.8313886639289;998.8601595776597;1007.8387458006683;1007.8387458006683;17434.21546030457;17635.647287054442;18434.723479147557;18557.97931113748;18606;52037.7398113007;53034.20448693196;53691.46308537021;53940.730296348265;55009.1748623779;78632;78671;78883.42233155419;79406.60296698479;79432.60283698545;7642.388608911163;7735.419843511647;7865.685372585262;7915.525068495908;7958.801029974297;10213.285070045025;12199.939000305296;12229.266244025386;12329.198602090835;12566.308853013172;10239;10399.376037437778;10640.627578034731;10879.673609791718;11078.5568577256;10555.94722026385;10597.9470102649;10926.945365273441;11005.449727513753;11025.889741102486;10772.676819695422;11084.00243978046;11208.27146235492;11234.213605047567;11282.887171128184;7762.68949242024;7898.723544675909;7973;8002.639881205476;8199.754007379788;7962.601869906365;10378.495118207667;10534.473276335999;10850.945745271223;10999 11:29:27 INFO - PROCESS | 1640 | |3;mootools.html;1308.914920530166;1344.529414704853;1455.2432734977808;1595.5372941846865;1811.3841293960052;7186.137663480383;7551.093868735753;7808.531488110717;8043.235892590209;8066.556339401331;7920.564368959705;7996;7997.40019498537;7998.640061197246;8007.19928007199;2249.842511024233;2287.588234117858;2288.702468679069;2289.519200967799;2290.1297506947335;2229.6321107017325;2267.671187677786;2283.5090455552054;2287.4052746286;2291.4385975435957;2224.510607666311;2262.6040442922504;2291.4958709083976;2293.7935585797277;2296.2651951375565;1851.7870444898806;2011.6278488479531;2273.602119629075;2273.9317820465412;2278.7493375728654;2127.276725913197;2284.1776960294283;2287.0508738873345;2289.072925465173;2291.747907730148;6092.72582733778;7930.405219608552;7987.640556174928;7994.600269986536;7994.64024118916;4913.680610760325;5105.932097500481;5111.616628752859;5112.565431938289;5119.539241468248;3356.9160770980675;3455.844486998066;3456.4642480415578;3520.419130843408;3524.6299138590334;1042.4839704346398;1074.3231763988715;1691.2558474271282;1725.7497662838944;1815.6550255451423;10395.584176633001;10492;10511.10655594283;10533.157347412265;10561.260711750181;4438.755868427203;4598.172328980816;4614.077184563101;4614.330922016289;4637.930431043537;8341.958290208631;8388.58057097155;8390.32877369809;8401.411901166859;8409.159084091665;4982.451930287665;4985.177445721415;4987.775550100254;4990.975045124751;5003.499650034967;4008.0981779100052;4135.937960930589;4681.531846815359;4689.343491911135;4693.779617299459;3436.4845273209216;3501.3347463981763;3522.823858807101;3560.1099725068734;3582.6238244984424;994.6866736977829;1116.832475128737;1117.9776404471866;1127.1264769803468;1127.2954403497813;788.9250521200477;847.1782371100023;884.5184316270222;901.2789768185426;914.6844338703137;3998.6401223889407;5144.43411224765;5409.377921538995;5467.391521595728;5538.030844602178;416.14897534541933;427.67345639719827;430.7846076961519;435.7537991035055;439.27958148636264;3549.8580056797955;3640.908977275589;3718.981405092957;3737.9626203738158;3796.981015094907;9429.811403772022;9721.513924303756;9824.4105353679;9841.409515429097;9864.260180486492;9418.529073546433;9625.470599116976;9804.46075465842;9816.263780216512;9818.361806482555;7474.439417043744;7643.159252482223;7662.501937374052;7669.233076692398;7671.041119860018;5350.357957045179;5367.087595108919;5406.297181366397;5415.106507426231;5480;9003.63985440575;9038.683646072619;9075.591598377956;9129.406588571721;9227.76930576741;9107.635694572407;9158.038405967278;9178.724638260863;9292.442453452815;9293.210077143518;6129.172561704113;6347.873042539216;6352.872942541031;6537.215534135934;6598.703058362481;6252.499800015897;7640;7687.0391201099865;7753.573553454614;7771.494852834548;6783.253842077269;6834.897476537955;6952.895706564304;6970.477214209056;6974.755883544051;6692.832679182865;6702;6745.9662701686175;6780.762673306411;6879.2432832389395;6423.678816059271;6453.9354606453335;6455.128557644658;6535.934640653722;6542.83642908912;4576.58810707038;4665.440147182359;4670.276107203389;4673.182193116259;4822.9758851205515;4267.551907049715;4602.815887364468;4732.503087175797;4788.640851936049;4871.293662419001 11:29:27 INFO - PROCESS | 1640 | |4;prototype.html;300.2448841164471;309.55733301379036;311.1288392500998;316.7940838455004;320.1675643327348;4700.929486057707;5152.33019707438;5171.327727395434;5184.974075129624;5186.925229908039;5100.668456550322;5181.689098654083;5184.688918664873;5189.844304670856;5246.449122842095;3725.590185079632;3783.5081439412975;3887.1836914248042;3906.4921560197276;3958.2677204717074;3416.9076985328193;3573.178169021127;3983.4622325986056;4016.7188296819236;4028.5958365181373;3367.9960423548073;3630.153744750761;3733.909010953861;3905.258000979819;3938.369860822269;3588.4258518637153;3682.926341473182;3934.1148241645687;3962.900927476822;3981.705945567673;3030.7423868971164;3352.6814952579466;3469;3471.930561388783;3491.2493813830147;4986.127427700138;5045.571126454256;5048.9495105048845;5054.548543956178;5055.9241611375855;4367.934480982788;4544.7052535354105;4549.954500455019;4555.567221113989;4568.931466028012;4295.864019265922;4715.863950472932;5350.973245133789;5361.08861493547;5397;3202.647708752035;3697.3899306614376;3826.6747326477284;3842.769433833979;3850.26844899471;5422.43064478232;5748.419184724235;5751.741171647286;5766.365699773021;5785.971070144665;3241.8379081045855;3261.5433839262523;3854.6530812227033;3866.5553461352306;3885.184111336651;3278.5573947517255;3937.8621748238675;3941.831992404166;3948.8025598720524;3958.247932892741;4307.052448461333;4537.568930951555;4547.886302842456;4548.840790572381;4572.6799124061;4591.632669386508;4756;5070.974645126751;5510.834674959678;5588.608797384225;1180.3508070561156;1220.6277085488834;1239.510393394622;1243.384524660299;1243.993780031094;731.4294850016995;737.0638514249802;759.8594260061906;805.8952336196257;826.8553003224412;4942;5003.7998480061115;5054.115529782273;5101.540861322499;5184.844454666366;4512.751798651106;5293.391260005072;5552.69460179694;5570.610057296031;5580.525655319262;4006.5359803720503;4919.281446603102;5107.61692873036;5126.539261154667;5144.485551444825;2263.705718256649;2694.3025893686854;2754.6969833318317;2777.6250206222307;2780.0547813743424;4772.76136193189;5380.78476860929;5476.945230547643;5546.1143211308345;5546.278983732089;5032.194848824171;5190.688558686491;5370.603643052835;5395.7841686332895;5552.083906155439;4905.607551395879;4925.57158424053;5074.923876141861;5561.277033985637;5582.888342233133;4717.636186527517;5208.401033881;5224.268602395744;5263.499967503081;5264.947350526446;4299.527052024212;4516.503184649751;5044.192929131322;5275.834499300389;5305.681659100466;4617.907641847077;5420.593455490933;5434;5477.835664930059;5548.447714051582;3061.800982936102;3403.243372867985;3525.7531972762686;3543.7497189284472;3551.804650744234;4398.846040388571;4495.53894984125;4730.787114579921;4985.277134815504;5363.892722145457;4723.386609243862;5061.051495174458;5096.821611243588;5104.3619547556555;5117.820876269313;4311.655067594647;4705.811767529261;4825.9034819304115;5095.414027386898;5111.361079865017;4186.576563968265;4690.577847993697;4944.381952255968;4968.27959945813;5297.735113244399;4873.756312184306;5181.663191892515;5341.065313570032;5455.945440545703;5460.426655201147;4696.365990591226;5255.921161182662;5391.784328626811;5398.325209348832;5401.675899446046 11:29:27 INFO - PROCESS | 1640 | |5;yui.html;593.4629160609649;704.1901812915144;744.8845428958514;776.3362325211942;791.7347688524344;13637.795433068499;13941.233232172226;14322.355494002768;14973.625659358522;14986.850131498682;11390.943045284783;12483.377160969061;13349.199048057124;13359.33203339834;13560.796588051187;718.3068339052826;851.3784936995996;853.9530325832108;855.7903313688124;856.3834039491556;667.8430568816324;686.0806519264185;809.4940662086196;834.1200033964195;837.6774941647479;905.6196397513028;909.6907051602453;911.9452832830018;913.8903331600218;920.2178148573726;896.3277541843618;897.6678628907281;897.7531178925815;898.1108702384657;898.865170224465;513.1661050792462;529.5578192209471;639.5363361562876;665.2150462454302;673.6631684157921;12947;13416.396262168226;13431.261280629562;13432.395542200624;13439.798403023962;12236.938815305866;12422.56521021769;12566.05754568411;12593.622191334274;12682.80975785364;11346.149038822039;11519.712007199803;11545.480453379618;11632.185746997713;12154.027677785756;4205.76868272248;4261.6590672746415;4282.47052640973;4307.396964424983;4342.066455712005;92432.53783731106;93321.53339233261;94502;94587;96679.51660241724;8379.413441059189;10056.983301070926;10274;10416.843747343795;10513.421761803022;18789.718154227696;18910.52723681919;19194.520136996685;19222.423327300203;19236.519087022658;7257.947597598319;7261.854762904818;7269.236730143259;7334.3032411920785;7519.172890981988;4114.218298523271;4145;4182.581741825793;4206.747595144301;4218.198542276958;3085.4446199683825;3146.9527957080663;3183.570218020584;3191.2979144588153;3194.2014496375905;586.5219845825638;591.7189335065896;602.9969850150809;605.5458406195354;611.3947192279611;498.08601216766914;521.6009752539311;546.9890602187934;584.0829897061573;600.9789657362059;7212.60330681807;7347.375473084848;8493.787655308543;8640.913590864011;8672.826543469222;523.3144580599427;587.1838144978483;607.0499668019535;644.8489446338264;648.5849056603778;3630.8003059831963;3972.3445631471063;3981.980090099589;4384.3497128525005;4497.955020449754;91561.62657560142;106459.935400645;112127;114292;120749;100308.49845750724;100425.99574004166;101815;102295.48852255692;102844.48577757063;60441.395586043574;69058;80229.79655305292;81188.59405703052;83666.5816670925;7086.799050830523;8006.719764808204;8057.5165490070785;8201.13888041771;8253.752387428387;54443.72778136084;54673.90652186854;54967.45032549623;56063;57105.85788284128;79036.60481697785;79105;80109.59671209873;80167.97900262468;81521.59239203767;10395.58417663285;10641.840372394576;10661.573537058432;10881.30035787836;10976.725581860517;11689.357085360047;11813.468393922467;11899;11968.880311196777;11971.20648399061;11370.54517819311;11424.371659558472;11450.82823757661;11487.48306326234;11769.35268560203;11233.38216398106;11481.885181148082;11639.359835209145;11672.88327116718;12061.819072714092;9257.25941924631;10767.138628909825;10989.450527473755;11010.944945275221;11424.028957538701;8863.601137948679;9357.298202634693;9697.466639334903;9827.606895724377;10123.341982771097;9169.128932751379;9409.48247846375;9510.524473776422;9545.809083818145;9547.809043819223 11:29:27 INFO - PROCESS | 1640 | __end_tp_report 11:29:27 INFO - PROCESS | 1640 | __start_cc_report 11:29:27 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1476 11:29:27 INFO - PROCESS | 1640 | __end_cc_report 11:29:27 INFO - PROCESS | 1640 | __startTimestamp1479756567779__endTimestamp 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | ------- Summary: start ------- 11:29:27 INFO - PROCESS | 1640 | Number of tests: 6 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5659.90 Median:5790.10 stddev:636.63 (11.0%) stddev-sans-first:610.03 11:29:27 INFO - PROCESS | 1640 | Values: 3256.6 3290.9 3309.3 3340.9 3368.4 5508.0 5576.7 5614.6 5696.7 5704.5 5584.2 5621.9 5705.6 5715.2 5743.7 5048.0 5085.2 5123.7 5182.7 5186.7 5207.8 5215.9 5220.1 5223.7 5297.5 5104.7 5194.9 5207.2 5217.7 5290.4 5160.4 5194.2 5194.4 5197.7 5202.5 5037.6 5159.4 5159.6 5168.2 5184.7 5582.0 5606.3 5612.4 5632.3 5636.7 6035.3 6105.7 6131.4 6131.9 6137.5 6132.8 6180.8 6191.1 6195.9 6208.5 5653.0 5693.3 5697.0 5711.7 5735.1 6162.7 6224.0 6271.7 6289.6 6296.4 6110.6 6127.5 6130.8 6137.9 6139.9 6238.1 6247.7 6247.9 6252.7 6262.0 6014.0 6057.1 6083.6 6186.1 6186.8 6102.6 6133.2 6177.6 6231.1 6248.9 4930.4 4937.2 4942.9 4947.3 4956.1 4343.7 4363.0 4380.7 4382.7 4403.5 5588.4 5622.7 5659.5 5671.8 5712.7 5158.5 6234.3 6256.5 6261.1 6265.2 5706.8 5715.9 5724.5 5762.3 5771.3 5212.3 5306.3 5307.0 5371.6 5373.8 6230.1 6248.5 6274.0 6312.6 6313.2 4739.6 6255.8 6256.0 6275.8 6285.3 6208.9 6252.2 6277.5 6285.3 6291.0 5011.3 6044.5 6081.3 6113.5 6144.8 4886.3 6078.4 6206.5 6234.0 6252.9 5631.0 5996.8 6068.5 6068.7 6072.5 5856.7 5891.1 5915.4 5921.1 5946.9 5814.3 5827.6 5828.0 5835.2 5841.9 5896.2 5910.3 5914.7 5921.1 5921.7 5726.0 5738.7 5790.1 5797.1 5849.2 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:67769.52 Median:37638.34 stddev:151682.52 (403.0%) stddev-sans-first:152023.91 11:29:27 INFO - PROCESS | 1640 | Values: 488.0 505.4 518.1 523.7 549.3 29604.9 37809.4 39083.4 39120.8 39168.4 40156.4 40410.4 40449.0 40563.8 40578.0 9093.3 9279.9 9286.5 9296.2 9301.0 9231.4 9335.7 9346.7 9354.7 9375.0 8680.2 8736.6 9319.4 9381.8 9389.8 9282.0 9289.1 9351.7 9373.6 9377.8 9195.8 9256.9 9273.8 9276.9 9298.6 38403.0 38736.8 38746.4 38755.4 38802.6 3300.2 3315.4 3367.6 3380.8 3388.0 28377.9 28918.7 29426.0 30039.2 30159.8 3150.0 3162.6 3201.2 3290.0 3308.6 409373.0 414759.0 417247.0 417508.0 418849.0 62763.7 63513.0 63665.7 63687.7 63723.0 34804.7 35677.8 35752.8 36565.3 65771.3 16053.4 16251.4 16309.8 16313.5 16361.5 12302.8 12418.3 12433.7 12446.9 12450.3 19492.2 19702.5 19704.9 19729.2 19744.7 7371.0 8056.8 8261.3 8305.3 8345.7 875.8 927.1 954.5 1019.7 1092.1 23791.2 28262.9 28625.4 29246.0 29879.9 894.7 969.8 1031.8 1094.3 1106.7 15444.8 15669.4 16033.4 16039.6 16049.4 680219.0 684723.0 686821.0 687786.0 690793.0 55404.7 55926.0 56064.9 56086.4 56261.0 1000.4 1226.8 1229.3 1277.4 1314.6 27795.9 29059.1 29225.7 29823.3 29913.9 33163.8 47684.5 47733.0 47771.3 47822.0 559465.0 562045.0 564104.0 565030.0 567206.0 25495.5 25860.2 26467.2 26500.2 26854.7 44190.6 44275.8 44480.0 44666.6 44725.0 36226.8 36363.7 36532.3 37096.1 37113.4 36155.3 36481.5 37129.8 37161.8 37467.3 36214.6 36397.5 36442.3 36448.0 36800.0 28693.0 31387.7 32986.3 33040.7 33076.3 24147.5 24387.9 24540.9 24877.6 24985.5 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:34139.12 Median:2029.90 stddev:100142.83 (4933.4%) stddev-sans-first:100391.61 11:29:27 INFO - PROCESS | 1640 | Values: 350.6 372.0 372.2 383.7 403.7 14592.8 14976.6 15403.5 19906.6 20433.4 14676.7 19159.5 19490.6 19748.4 20021.2 5608.7 5905.6 5907.1 5911.4 5913.8 5464.6 5703.4 5750.9 5751.5 5771.1 5716.1 5720.0 5721.3 5721.8 5729.0 5473.1 5736.7 5766.3 5775.0 5784.8 4717.2 5054.1 5059.6 5063.9 5065.9 12217.3 12856.7 12864.5 12869.4 12892.7 2046.6 2113.4 2153.0 2308.8 2829.4 7812.8 9969.5 10149.4 10153.4 10211.2 1766.9 1778.3 1819.2 1840.5 1858.6 95330.5 113498.4 115203.4 116608.0 118743.0 9086.0 9598.7 9631.4 9727.9 11022.0 12203.2 12261.0 12274.8 12282.3 12287.0 7620.5 7735.1 7735.3 7821.0 7837.8 7009.6 7937.4 7965.8 7995.3 8109.1 3132.9 3709.2 3824.0 3865.2 3899.0 1666.2 1802.8 1914.2 1915.8 1921.8 841.9 917.4 923.7 965.3 983.5 19956.0 20582.0 20597.4 20685.3 20748.9 775.8 893.0 925.4 941.9 949.3 10299.2 10694.3 10785.3 10803.6 10864.3 586330.0 591207.0 599353.0 601376.0 619328.0 111242.9 128108.4 132333.0 134966.0 137502.0 826.8 991.8 998.9 1007.8 1007.8 17434.2 17635.6 18434.7 18558.0 18606.0 52037.7 53034.2 53691.5 53940.7 55009.2 78632.0 78671.0 78883.4 79406.6 79432.6 7642.4 7735.4 7865.7 7915.5 7958.8 10213.3 12199.9 12229.3 12329.2 12566.3 10239.0 10399.4 10640.6 10879.7 11078.6 10555.9 10597.9 10926.9 11005.4 11025.9 10772.7 11084.0 11208.3 11234.2 11282.9 7762.7 7898.7 7973.0 8002.6 8199.8 7962.6 10378.5 10534.5 10850.9 10999.0 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5214.24 Median:5054.72 stddev:2849.04 (56.4%) stddev-sans-first:2841.91 11:29:27 INFO - PROCESS | 1640 | Values: 1308.9 1344.5 1455.2 1595.5 1811.4 7186.1 7551.1 7808.5 8043.2 8066.6 7920.6 7996.0 7997.4 7998.6 8007.2 2249.8 2287.6 2288.7 2289.5 2290.1 2229.6 2267.7 2283.5 2287.4 2291.4 2224.5 2262.6 2291.5 2293.8 2296.3 1851.8 2011.6 2273.6 2273.9 2278.7 2127.3 2284.2 2287.1 2289.1 2291.7 6092.7 7930.4 7987.6 7994.6 7994.6 4913.7 5105.9 5111.6 5112.6 5119.5 3356.9 3455.8 3456.5 3520.4 3524.6 1042.5 1074.3 1691.3 1725.7 1815.7 10395.6 10492.0 10511.1 10533.2 10561.3 4438.8 4598.2 4614.1 4614.3 4637.9 8342.0 8388.6 8390.3 8401.4 8409.2 4982.5 4985.2 4987.8 4991.0 5003.5 4008.1 4135.9 4681.5 4689.3 4693.8 3436.5 3501.3 3522.8 3560.1 3582.6 994.7 1116.8 1118.0 1127.1 1127.3 788.9 847.2 884.5 901.3 914.7 3998.6 5144.4 5409.4 5467.4 5538.0 416.1 427.7 430.8 435.8 439.3 3549.9 3640.9 3719.0 3738.0 3797.0 9429.8 9721.5 9824.4 9841.4 9864.3 9418.5 9625.5 9804.5 9816.3 9818.4 7474.4 7643.2 7662.5 7669.2 7671.0 5350.4 5367.1 5406.3 5415.1 5480.0 9003.6 9038.7 9075.6 9129.4 9227.8 9107.6 9158.0 9178.7 9292.4 9293.2 6129.2 6347.9 6352.9 6537.2 6598.7 6252.5 7640.0 7687.0 7753.6 7771.5 6783.3 6834.9 6952.9 6970.5 6974.8 6692.8 6702.0 6746.0 6780.8 6879.2 6423.7 6453.9 6455.1 6535.9 6542.8 4576.6 4665.4 4670.3 4673.2 4823.0 4267.6 4602.8 4732.5 4788.6 4871.3 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4292.96 Median:4799.33 stddev:1312.07 (27.3%) stddev-sans-first:1281.07 11:29:27 INFO - PROCESS | 1640 | Values: 300.2 309.6 311.1 316.8 320.2 4700.9 5152.3 5171.3 5185.0 5186.9 5100.7 5181.7 5184.7 5189.8 5246.4 3725.6 3783.5 3887.2 3906.5 3958.3 3416.9 3573.2 3983.5 4016.7 4028.6 3368.0 3630.2 3733.9 3905.3 3938.4 3588.4 3682.9 3934.1 3962.9 3981.7 3030.7 3352.7 3469.0 3471.9 3491.2 4986.1 5045.6 5048.9 5054.5 5055.9 4367.9 4544.7 4550.0 4555.6 4568.9 4295.9 4715.9 5351.0 5361.1 5397.0 3202.6 3697.4 3826.7 3842.8 3850.3 5422.4 5748.4 5751.7 5766.4 5786.0 3241.8 3261.5 3854.7 3866.6 3885.2 3278.6 3937.9 3941.8 3948.8 3958.2 4307.1 4537.6 4547.9 4548.8 4572.7 4591.6 4756.0 5071.0 5510.8 5588.6 1180.4 1220.6 1239.5 1243.4 1244.0 731.4 737.1 759.9 805.9 826.9 4942.0 5003.8 5054.1 5101.5 5184.8 4512.8 5293.4 5552.7 5570.6 5580.5 4006.5 4919.3 5107.6 5126.5 5144.5 2263.7 2694.3 2754.7 2777.6 2780.1 4772.8 5380.8 5476.9 5546.1 5546.3 5032.2 5190.7 5370.6 5395.8 5552.1 4905.6 4925.6 5074.9 5561.3 5582.9 4717.6 5208.4 5224.3 5263.5 5264.9 4299.5 4516.5 5044.2 5275.8 5305.7 4617.9 5420.6 5434.0 5477.8 5548.4 3061.8 3403.2 3525.8 3543.7 3551.8 4398.8 4495.5 4730.8 4985.3 5363.9 4723.4 5061.1 5096.8 5104.4 5117.8 4311.7 4705.8 4825.9 5095.4 5111.4 4186.6 4690.6 4944.4 4968.3 5297.7 4873.8 5181.7 5341.1 5455.9 5460.4 4696.4 5255.9 5391.8 5398.3 5401.7 11:29:27 INFO - PROCESS | 1640 | 11:29:27 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20272.80 Median:522.46 stddev:30788.19 (5893.0%) stddev-sans-first:30839.10 11:29:27 INFO - PROCESS | 1640 | Values: 593.5 704.2 744.9 776.3 791.7 13637.8 13941.2 14322.4 14973.6 14986.9 11390.9 12483.4 13349.2 13359.3 13560.8 718.3 851.4 854.0 855.8 856.4 667.8 686.1 809.5 834.1 837.7 905.6 909.7 911.9 913.9 920.2 896.3 897.7 897.8 898.1 898.9 513.2 529.6 639.5 665.2 673.7 12947.0 13416.4 13431.3 13432.4 13439.8 12236.9 12422.6 12566.1 12593.6 12682.8 11346.1 11519.7 11545.5 11632.2 12154.0 4205.8 4261.7 4282.5 4307.4 4342.1 92432.5 93321.5 94502.0 94587.0 96679.5 8379.4 10057.0 10274.0 10416.8 10513.4 18789.7 18910.5 19194.5 19222.4 19236.5 7257.9 7261.9 7269.2 7334.3 7519.2 4114.2 4145.0 4182.6 4206.7 4218.2 3085.4 3147.0 3183.6 3191.3 3194.2 586.5 591.7 603.0 605.5 611.4 498.1 521.6 547.0 584.1 601.0 7212.6 7347.4 8493.8 8640.9 8672.8 523.3 587.2 607.0 644.8 648.6 3630.8 3972.3 3982.0 4384.3 4498.0 91561.6 106459.9 112127.0 114292.0 120749.0 100308.5 100426.0 101815.0 102295.5 102844.5 60441.4 69058.0 80229.8 81188.6 83666.6 7086.8 8006.7 8057.5 8201.1 8253.8 54443.7 54673.9 54967.5 56063.0 57105.9 79036.6 79105.0 80109.6 80168.0 81521.6 10395.6 10641.8 10661.6 10881.3 10976.7 11689.4 11813.5 11899.0 11968.9 11971.2 11370.5 11424.4 11450.8 11487.5 11769.4 11233.4 11481.9 11639.4 11672.9 12061.8 9257.3 10767.1 10989.5 11010.9 11424.0 8863.6 9357.3 9697.5 9827.6 10123.3 9169.1 9409.5 9510.5 9545.8 9547.8 11:29:27 INFO - PROCESS | 1640 | -------- Summary: end -------- 11:29:27 INFO - PROCESS | 1640 | 11:29:28 INFO - TEST-INFO | 1640: exit 0 11:29:28 INFO - TEST-OK | dromaeo_css | took 1119272ms 11:29:28 INFO - TEST-START | kraken 11:29:28 INFO - operating with platform_type : mac_ 11:29:28 INFO - Initialising browser for kraken test... 11:29:28 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpXO4wx_/profile http://localhost:49236/getInfo.html) 11:29:31 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 11:29:31 INFO - PROCESS | 1646 | colorDepth:24 11:29:31 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 11:29:31 INFO - PROCESS | 1646 | __metrics 11:29:31 INFO - PROCESS | 1646 | 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" 11:29:31 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:29:31 INFO - TEST-INFO | 1646: exit 0 11:29:31 INFO - Browser initialized. 11:29:31 INFO - Running cycle 1/1 for kraken test... 11:29:31 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/T/tmpXO4wx_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:29:44 INFO - PROCESS | 1647 | RSS: Main: 236441600 11:29:44 INFO - PROCESS | 1647 | 11:29:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:47 INFO - PROCESS | 1647 | RSS: Main: 294158336 11:29:47 INFO - PROCESS | 1647 | 11:29:50 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 11:29:51 INFO - PROCESS | 1647 | RSS: Main: 297914368 11:29:51 INFO - PROCESS | 1647 | 11:29:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 11:29:55 INFO - PROCESS | 1647 | RSS: Main: 384606208 11:29:55 INFO - PROCESS | 1647 | 11:29:57 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 11:29:58 INFO - PROCESS | 1647 | RSS: Main: 291028992 11:29:58 INFO - PROCESS | 1647 | 11:30:00 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:30:00 INFO - PROCESS | 1647 | RSS: Main: 293056512 11:30:00 INFO - PROCESS | 1647 | 11:30:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 11:30:04 INFO - PROCESS | 1647 | RSS: Main: 335990784 11:30:04 INFO - PROCESS | 1647 | 11:30:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 11:30:07 INFO - PROCESS | 1647 | RSS: Main: 337711104 11:30:07 INFO - PROCESS | 1647 | 11:30:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 11:30:11 INFO - PROCESS | 1647 | RSS: Main: 335294464 11:30:11 INFO - PROCESS | 1647 | 11:30:12 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:30:13 INFO - PROCESS | 1647 | RSS: Main: 308842496 11:30:13 INFO - PROCESS | 1647 | 11:30:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:30:15 INFO - PROCESS | 1647 | RSS: Main: 311418880 11:30:15 INFO - PROCESS | 1647 | 11:30:17 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:30:18 INFO - PROCESS | 1647 | RSS: Main: 313430016 11:30:18 INFO - PROCESS | 1647 | 11:30:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:30:22 INFO - PROCESS | 1647 | RSS: Main: 330436608 11:30:22 INFO - PROCESS | 1647 | 11:30:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:30:25 INFO - PROCESS | 1647 | RSS: Main: 324067328 11:30:25 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 11:30:27 INFO - PROCESS | 1647 | RSS: Main: 368050176 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | __start_tp_report 11:30:27 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 11:30:27 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 11:30:27 INFO - PROCESS | 1647 | |i|pagename|runs| 11:30:27 INFO - PROCESS | 1647 | |0;ai-astar;104;115;115;115;114;113;114;115;116;114 11:30:27 INFO - PROCESS | 1647 | |1;audio-beat-detection;150;112;125;182;118;113;115;113;143;113 11:30:27 INFO - PROCESS | 1647 | |2;audio-dft;184;182;187;185;185;184;184;179;184;179 11:30:27 INFO - PROCESS | 1647 | |3;audio-fft;81;75;50;99;88;84;82;82;82;57 11:30:27 INFO - PROCESS | 1647 | |4;audio-oscillator;91;71;95;72;68;69;89;68;69;93 11:30:27 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;88;86;88;86;87;85;89;86;88;85 11:30:27 INFO - PROCESS | 1647 | |6;imaging-darkroom;95;95;94;94;103;94;95;94;94;95 11:30:27 INFO - PROCESS | 1647 | |7;imaging-desaturate;85;87;86;87;85;87;86;88;84;84 11:30:27 INFO - PROCESS | 1647 | |8;json-parse-financial;55;53;53;54;53;57;54;55;54;54 11:30:27 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;66;75;64;74;71;68;68;71;69;69 11:30:27 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;88;88;86;88;87;88;87;86;88;91 11:30:27 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;151;148;151;150;146;148;150;159;193;162 11:30:27 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;175;177;170;174;173;174;174;173;172;172 11:30:27 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;68;65;68;67;68;68;66;66;67;67 11:30:27 INFO - PROCESS | 1647 | __end_tp_report 11:30:27 INFO - PROCESS | 1647 | __start_cc_report 11:30:27 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2000 11:30:27 INFO - PROCESS | 1647 | __end_cc_report 11:30:27 INFO - PROCESS | 1647 | __startTimestamp1479756627920__endTimestamp 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | ------- Summary: start ------- 11:30:27 INFO - PROCESS | 1647 | Number of tests: 14 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.44 (3.0%) stddev-sans-first:0.88 11:30:27 INFO - PROCESS | 1647 | Values: 104.0 115.0 115.0 115.0 114.0 113.0 114.0 115.0 116.0 114.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:121.50 stddev:23.17 (19.1%) stddev-sans-first:23.22 11:30:27 INFO - PROCESS | 1647 | Values: 150.0 112.0 125.0 182.0 118.0 113.0 115.0 113.0 143.0 113.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.58 (1.4%) stddev-sans-first:2.73 11:30:27 INFO - PROCESS | 1647 | Values: 184.0 182.0 187.0 185.0 185.0 184.0 184.0 179.0 184.0 179.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:78.00 Median:82.00 stddev:14.41 (17.6%) stddev-sans-first:15.24 11:30:27 INFO - PROCESS | 1647 | Values: 81.0 75.0 50.0 99.0 88.0 84.0 82.0 82.0 82.0 57.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:80.50 stddev:11.78 (14.6%) stddev-sans-first:11.59 11:30:27 INFO - PROCESS | 1647 | Values: 91.0 71.0 95.0 72.0 68.0 69.0 89.0 68.0 69.0 93.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.50 stddev:1.40 (1.6%) stddev-sans-first:1.41 11:30:27 INFO - PROCESS | 1647 | Values: 88.0 86.0 88.0 86.0 87.0 85.0 89.0 86.0 88.0 85.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:94.50 stddev:2.75 (2.9%) stddev-sans-first:2.92 11:30:27 INFO - PROCESS | 1647 | Values: 95.0 95.0 94.0 94.0 103.0 94.0 95.0 94.0 94.0 95.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.50 stddev:1.37 (1.6%) stddev-sans-first:1.41 11:30:27 INFO - PROCESS | 1647 | Values: 85.0 87.0 86.0 87.0 85.0 87.0 86.0 88.0 84.0 84.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.27 11:30:27 INFO - PROCESS | 1647 | Values: 55.0 53.0 53.0 54.0 53.0 57.0 54.0 55.0 54.0 54.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:3.37 (4.8%) stddev-sans-first:3.33 11:30:27 INFO - PROCESS | 1647 | Values: 66.0 75.0 64.0 74.0 71.0 68.0 68.0 71.0 69.0 69.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.00 stddev:1.42 (1.6%) stddev-sans-first:1.50 11:30:27 INFO - PROCESS | 1647 | Values: 88.0 88.0 86.0 88.0 87.0 88.0 87.0 86.0 88.0 91.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:151.00 stddev:14.00 (9.3%) stddev-sans-first:14.74 11:30:27 INFO - PROCESS | 1647 | Values: 151.0 148.0 151.0 150.0 146.0 148.0 150.0 159.0 193.0 162.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:1.90 (1.1%) stddev-sans-first:1.92 11:30:27 INFO - PROCESS | 1647 | Values: 175.0 177.0 170.0 174.0 173.0 174.0 174.0 173.0 172.0 172.0 11:30:27 INFO - PROCESS | 1647 | 11:30:27 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 11:30:27 INFO - PROCESS | 1647 | Values: 68.0 65.0 68.0 67.0 68.0 68.0 66.0 66.0 67.0 67.0 11:30:27 INFO - PROCESS | 1647 | -------- Summary: end -------- 11:30:27 INFO - PROCESS | 1647 | 11:30:28 INFO - TEST-INFO | 1647: exit 0 11:30:29 INFO - TEST-OK | kraken | took 60554ms 11:30:29 INFO - SUITE-END | took 1179s 11:30:29 INFO - Completed test suite (00:19:39) 11:30:29 INFO - javascript benchmark 11:30:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.625488068872, 3290.9177270568234, 3309.3050459403526, 3340.8663653453864, 3368.427367347551, 5508.0, 5576.749046292916, 5614.550835933126, 5696.6866822324755, 5704.458076482732, 5584.21820945067, 5621.859453513664, 5705.572082093839, 5715.199872017911, 5743.741531631076, 5048.0, 5085.211792172219, 5123.666961647499, 5182.740862956856, 5186.740662966856, 5207.765650545715, 5215.947840521603, 5220.060389129955, 5223.686578805265, 5297.470252974691, 5104.668196567249, 5194.948050519484, 5207.192885102815, 5217.713025783581, 5290.444503327153, 5160.380754309469, 5194.246834209019, 5194.3766747990485, 5197.714125723083, 5202.479752024805, 5037.647364684473, 5159.432462429129, 5159.613029022801, 5168.224766285088, 5184.7407629618365, 5581.972090139523, 5606.327240731098, 5612.35457922336, 5632.2678051853, 5636.74634641438, 6035.3059398169335, 6105.67942450621, 6131.356207598183, 6131.877362452726, 6137.478314343286, 6132.782355430526, 6180.783672571439, 6191.0713392990965, 6195.915714749901, 6208.50331973441, 5653.0, 5693.3168019837885, 5696.971515142398, 5711.6858572778065, 5735.0823868181305, 6162.661053642003, 6224.0, 6271.749130034747, 6289.559730818799, 6296.433321001132, 6110.597336992702, 6127.505970454377, 6130.8377647633215, 6137.880059131387, 6139.8601398601395, 6238.1266622672865, 6247.656378899113, 6247.875042499125, 6252.718627661766, 6262.0, 6014.0, 6057.121717350959, 6083.6045657032155, 6186.072089186658, 6186.845328866724, 6102.640737559664, 6133.242854861876, 6177.598456100339, 6231.096491008779, 6248.9062664060075, 4930.359053323117, 4937.1606826839525, 4942.9011419771405, 4947.307376967227, 4956.058348913767, 4343.69594128408, 4362.956370436255, 4380.67144964129, 4382.737035777864, 4403.53762854902, 5588.441155884379, 5622.718864056781, 5659.490645841894, 5671.801486948019, 5712.65724056558, 5158.484151584811, 6234.3453937336835, 6256.499480041586, 6261.060840873814, 6265.216847894013, 5706.832707847102, 5715.857103572361, 5724.513416359656, 5762.250907382014, 5771.30744310677, 5212.348456442945, 5306.257124002643, 5307.0182016326335, 5371.62398632092, 5373.758180881791, 6230.096635987666, 6248.500119990481, 6274.0, 6312.5581209314905, 6313.179286692701, 4739.620830333634, 6255.843603909939, 6256.0303153011355, 6275.811725648238, 6285.277193122849, 6208.875822483616, 6252.187215661935, 6277.497800176066, 6285.308616052322, 6291.02489114188, 5011.323471331323, 6044.486218671462, 6081.300650425258, 6113.537117903944, 6144.832481828438, 4886.29148773433, 6078.422549857756, 6206.534509911684, 6234.0, 6252.874942501034, 5631.0, 5996.790112346047, 6068.514518838394, 6068.696565171812, 6072.453479186717, 5856.677882716492, 5891.086881533369, 5915.438033386821, 5921.1414344918885, 5946.910796337972, 5814.331351894586, 5827.562932779973, 5828.038373668467, 5835.153902684172, 5841.94158058414, 5896.233489646319, 5910.261217347832, 5914.67469289176, 5921.111833225051, 5921.733521991435, 5725.997950358587, 5738.741756621045, 5790.10253410722, 5797.072468405035, 5849.239598852122], "value": 5620.765348256899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.9922959089482, 505.35819509223296, 518.0959226150368, 523.6910222968451, 549.2834890965732, 29604.85197574012, 37809.43285850711, 39083.41374879379, 39120.80439597805, 39168.41247381292, 40156.39765403514, 40410.39384409236, 40449.0, 40563.78308650738, 40577.985550361256, 9093.272538196945, 9279.907200927972, 9286.535673216345, 9296.163345298923, 9301.0, 9231.446113233194, 9335.719928402124, 9346.672866449675, 9354.672586459475, 9374.953125234364, 8680.175383338572, 8736.645819897925, 9319.394239374453, 9381.765455863624, 9389.812203755955, 9282.0, 9289.071092890725, 9351.672691455766, 9373.578188981512, 9377.812443751087, 9195.770105747342, 9256.907430925672, 9273.768155796091, 9276.860847087299, 9298.581563829644, 38403.03992400212, 38736.8378948632, 38746.41880371797, 38755.44978200868, 38802.61197388046, 3300.2409445827593, 3315.419801534746, 3367.6295607483157, 3380.8140552269615, 3387.9830600847085, 28377.858110709316, 28918.71081289181, 29426.0, 30039.249018774488, 30159.849200754074, 3149.984250078735, 3162.57305263791, 3201.2317043909525, 3290.0, 3308.6195087564997, 409372.9531352354, 414759.0, 417247.0, 417507.999999997, 418849.0, 62763.74472510524, 63513.0, 63665.72345595043, 63687.726245474834, 63723.044154337724, 34804.65195348065, 35677.8216108923, 35752.82123589365, 36565.26869462596, 65771.34228657748, 16053.357865685242, 16251.431199907947, 16309.755353669705, 16313.510594682179, 16361.509154725378, 12302.75394492123, 12418.316992565495, 12433.689157771129, 12446.937765311297, 12450.25298482094, 19492.155717615864, 19702.507437314183, 19704.90147549253, 19729.210831566863, 19744.70382944257, 7370.963145184347, 8056.791481277855, 8261.339092872557, 8305.252527272454, 8345.749627511184, 875.8379699755566, 927.0544045074122, 954.4750387286964, 1019.704285757137, 1092.0881064311388, 23791.167309144097, 28262.85868570644, 28625.427491450053, 29246.0, 29879.850600747293, 894.6600291889171, 969.8399764038995, 1031.8142734307746, 1094.2832444748703, 1106.6956586938657, 15444.845551544566, 15669.373225071098, 16033.438829640907, 16039.599010024609, 16049.358025678843, 680219.0, 684723.0, 686821.0, 687786.0, 690793.0, 55404.72297638486, 55926.0, 56064.878702425725, 56086.43913560894, 56261.0, 1000.3943670408889, 1226.7730469863104, 1229.342301868514, 1277.3613193403298, 1314.6450458376376, 27795.861020694767, 29059.12822615325, 29225.70774292315, 29823.254418639706, 29913.85043074858, 33163.83418082991, 47684.5231547694, 47733.0, 47771.28343074787, 47822.0, 559465.0, 562045.0, 564104.0, 565030.0, 567206.0, 25495.49009019772, 25860.224193274233, 26467.205983820517, 26500.204993850217, 26854.731452685224, 44190.558094418644, 44275.778621106685, 44480.0, 44666.55333446624, 44725.0, 36226.818865906556, 36363.7272695465, 36532.32390707425, 37096.07259818526, 37113.443298351085, 36155.27689446249, 36481.45277820888, 37129.81435092807, 37161.814190928875, 37467.2506549862, 36214.63785362113, 36397.45403818892, 36442.27115457623, 36448.0, 36800.0, 28693.0, 31387.686123138476, 32986.34027319488, 33040.66959330472, 33076.338473230884, 24147.51704965926, 24387.930819336503, 24540.87729561341, 24877.626835597843, 24985.500289994463], "value": 19187.7630657784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.57930483419904, 371.98884033479004, 372.19419955795706, 383.7294707231402, 403.6609248231485, 14592.78110828337, 14976.625584360383, 15403.460878869242, 19906.601867962632, 20433.386998390033, 14676.706465870677, 19159.521011974706, 19490.610187796236, 19748.407547773553, 20021.1991520339, 5608.663480191181, 5905.586608937376, 5907.113932910055, 5911.4384133507465, 5913.811889600854, 5464.590155738316, 5703.372629010805, 5750.942490575083, 5751.4536119068625, 5771.105478650816, 5716.085426331788, 5720.0, 5721.313442386899, 5721.799737009205, 5728.9974254505505, 5473.124300111983, 5736.741846616912, 5766.279215098113, 5774.989376859033, 5784.768609255625, 4717.174494463489, 5054.11552978231, 5059.569936555397, 5063.898722025576, 5065.924011139836, 12217.266963982189, 12856.678583035406, 12864.485420583165, 12869.4208760606, 12892.742145157139, 2046.6111438826576, 2113.3765539165984, 2152.956940861174, 2308.826837987158, 2829.4058247767994, 7812.843743125162, 9969.538077403246, 10149.39103653783, 10153.441560714158, 10211.234157438223, 1766.9028203448804, 1778.2531336838429, 1819.154093346587, 1840.5122642499748, 1858.609691964689, 95330.52334738281, 113498.43250783693, 115203.42398288038, 116608.0, 118743.0, 9086.0, 9598.66404675833, 9631.422114673142, 9727.854082188773, 11022.0, 12203.20679155852, 12260.957818585342, 12274.754504909852, 12282.263064216175, 12287.0, 7620.542767433972, 7735.110462296795, 7735.303822655988, 7820.960895195488, 7837.804054898673, 7009.61447120403, 7937.444378893422, 7965.800854978672, 7995.280424761683, 8109.107998120202, 3132.8903488377796, 3709.221063576679, 3823.973294154103, 3865.2462769759627, 3898.96101038986, 1666.2446440363353, 1802.765640466757, 1914.1719657726837, 1915.7796853361763, 1921.8174273444001, 841.9284360829275, 917.3670167584345, 923.6767131504055, 965.280865755017, 983.5082458770614, 19956.0, 20581.970901454868, 20597.382078537667, 20685.345172386173, 20748.896255518626, 775.7866586688706, 892.9866052009226, 925.379995403068, 941.8869735631768, 949.3117489819825, 10299.227557933185, 10694.251402401913, 10785.298955567863, 10803.621873234399, 10864.348139111678, 586330.0, 591207.0, 599353.0, 601376.0, 619328.0, 111242.88757112325, 128108.35945820212, 132333.0, 134966.0, 137502.0, 826.7519744076753, 991.8313886639289, 998.8601595776597, 1007.8387458006683, 1007.8387458006683, 17434.21546030457, 17635.647287054442, 18434.723479147557, 18557.97931113748, 18606.0, 52037.7398113007, 53034.20448693196, 53691.46308537021, 53940.730296348265, 55009.1748623779, 78632.0, 78671.0, 78883.42233155419, 79406.60296698479, 79432.60283698545, 7642.388608911163, 7735.419843511647, 7865.685372585262, 7915.525068495908, 7958.801029974297, 10213.285070045025, 12199.939000305296, 12229.266244025386, 12329.198602090835, 12566.308853013172, 10239.0, 10399.376037437778, 10640.627578034731, 10879.673609791718, 11078.5568577256, 10555.94722026385, 10597.9470102649, 10926.945365273441, 11005.449727513753, 11025.889741102486, 10772.676819695422, 11084.00243978046, 11208.27146235492, 11234.213605047567, 11282.887171128184, 7762.68949242024, 7898.723544675909, 7973.0, 8002.639881205476, 8199.754007379788, 7962.601869906365, 10378.495118207667, 10534.473276335999, 10850.945745271223, 10999.0], "value": 8951.899190423526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.914920530166, 1344.529414704853, 1455.2432734977808, 1595.5372941846865, 1811.3841293960052, 7186.137663480383, 7551.093868735753, 7808.531488110717, 8043.235892590209, 8066.556339401331, 7920.564368959705, 7996.0, 7997.40019498537, 7998.640061197246, 8007.19928007199, 2249.842511024233, 2287.588234117858, 2288.702468679069, 2289.519200967799, 2290.1297506947335, 2229.6321107017325, 2267.671187677786, 2283.5090455552054, 2287.4052746286, 2291.4385975435957, 2224.510607666311, 2262.6040442922504, 2291.4958709083976, 2293.7935585797277, 2296.2651951375565, 1851.7870444898806, 2011.6278488479531, 2273.602119629075, 2273.9317820465412, 2278.7493375728654, 2127.276725913197, 2284.1776960294283, 2287.0508738873345, 2289.072925465173, 2291.747907730148, 6092.72582733778, 7930.405219608552, 7987.640556174928, 7994.600269986536, 7994.64024118916, 4913.680610760325, 5105.932097500481, 5111.616628752859, 5112.565431938289, 5119.539241468248, 3356.9160770980675, 3455.844486998066, 3456.4642480415578, 3520.419130843408, 3524.6299138590334, 1042.4839704346398, 1074.3231763988715, 1691.2558474271282, 1725.7497662838944, 1815.6550255451423, 10395.584176633001, 10492.0, 10511.10655594283, 10533.157347412265, 10561.260711750181, 4438.755868427203, 4598.172328980816, 4614.077184563101, 4614.330922016289, 4637.930431043537, 8341.958290208631, 8388.58057097155, 8390.32877369809, 8401.411901166859, 8409.159084091665, 4982.451930287665, 4985.177445721415, 4987.775550100254, 4990.975045124751, 5003.499650034967, 4008.0981779100052, 4135.937960930589, 4681.531846815359, 4689.343491911135, 4693.779617299459, 3436.4845273209216, 3501.3347463981763, 3522.823858807101, 3560.1099725068734, 3582.6238244984424, 994.6866736977829, 1116.832475128737, 1117.9776404471866, 1127.1264769803468, 1127.2954403497813, 788.9250521200477, 847.1782371100023, 884.5184316270222, 901.2789768185426, 914.6844338703137, 3998.6401223889407, 5144.43411224765, 5409.377921538995, 5467.391521595728, 5538.030844602178, 416.14897534541933, 427.67345639719827, 430.7846076961519, 435.7537991035055, 439.27958148636264, 3549.8580056797955, 3640.908977275589, 3718.981405092957, 3737.9626203738158, 3796.981015094907, 9429.811403772022, 9721.513924303756, 9824.4105353679, 9841.409515429097, 9864.260180486492, 9418.529073546433, 9625.470599116976, 9804.46075465842, 9816.263780216512, 9818.361806482555, 7474.439417043744, 7643.159252482223, 7662.501937374052, 7669.233076692398, 7671.041119860018, 5350.357957045179, 5367.087595108919, 5406.297181366397, 5415.106507426231, 5480.0, 9003.63985440575, 9038.683646072619, 9075.591598377956, 9129.406588571721, 9227.76930576741, 9107.635694572407, 9158.038405967278, 9178.724638260863, 9292.442453452815, 9293.210077143518, 6129.172561704113, 6347.873042539216, 6352.872942541031, 6537.215534135934, 6598.703058362481, 6252.499800015897, 7640.0, 7687.0391201099865, 7753.573553454614, 7771.494852834548, 6783.253842077269, 6834.897476537955, 6952.895706564304, 6970.477214209056, 6974.755883544051, 6692.832679182865, 6702.0, 6745.9662701686175, 6780.762673306411, 6879.2432832389395, 6423.678816059271, 6453.9354606453335, 6455.128557644658, 6535.934640653722, 6542.83642908912, 4576.58810707038, 4665.440147182359, 4670.276107203389, 4673.182193116259, 4822.9758851205515, 4267.551907049715, 4602.815887364468, 4732.503087175797, 4788.640851936049, 4871.293662419001], "value": 4192.5714305984375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2448841164471, 309.55733301379036, 311.1288392500998, 316.7940838455004, 320.1675643327348, 4700.929486057707, 5152.33019707438, 5171.327727395434, 5184.974075129624, 5186.925229908039, 5100.668456550322, 5181.689098654083, 5184.688918664873, 5189.844304670856, 5246.449122842095, 3725.590185079632, 3783.5081439412975, 3887.1836914248042, 3906.4921560197276, 3958.2677204717074, 3416.9076985328193, 3573.178169021127, 3983.4622325986056, 4016.7188296819236, 4028.5958365181373, 3367.9960423548073, 3630.153744750761, 3733.909010953861, 3905.258000979819, 3938.369860822269, 3588.4258518637153, 3682.926341473182, 3934.1148241645687, 3962.900927476822, 3981.705945567673, 3030.7423868971164, 3352.6814952579466, 3469.0, 3471.930561388783, 3491.2493813830147, 4986.127427700138, 5045.571126454256, 5048.9495105048845, 5054.548543956178, 5055.9241611375855, 4367.934480982788, 4544.7052535354105, 4549.954500455019, 4555.567221113989, 4568.931466028012, 4295.864019265922, 4715.863950472932, 5350.973245133789, 5361.08861493547, 5397.0, 3202.647708752035, 3697.3899306614376, 3826.6747326477284, 3842.769433833979, 3850.26844899471, 5422.43064478232, 5748.419184724235, 5751.741171647286, 5766.365699773021, 5785.971070144665, 3241.8379081045855, 3261.5433839262523, 3854.6530812227033, 3866.5553461352306, 3885.184111336651, 3278.5573947517255, 3937.8621748238675, 3941.831992404166, 3948.8025598720524, 3958.247932892741, 4307.052448461333, 4537.568930951555, 4547.886302842456, 4548.840790572381, 4572.6799124061, 4591.632669386508, 4756.0, 5070.974645126751, 5510.834674959678, 5588.608797384225, 1180.3508070561156, 1220.6277085488834, 1239.510393394622, 1243.384524660299, 1243.993780031094, 731.4294850016995, 737.0638514249802, 759.8594260061906, 805.8952336196257, 826.8553003224412, 4942.0, 5003.7998480061115, 5054.115529782273, 5101.540861322499, 5184.844454666366, 4512.751798651106, 5293.391260005072, 5552.69460179694, 5570.610057296031, 5580.525655319262, 4006.5359803720503, 4919.281446603102, 5107.61692873036, 5126.539261154667, 5144.485551444825, 2263.705718256649, 2694.3025893686854, 2754.6969833318317, 2777.6250206222307, 2780.0547813743424, 4772.76136193189, 5380.78476860929, 5476.945230547643, 5546.1143211308345, 5546.278983732089, 5032.194848824171, 5190.688558686491, 5370.603643052835, 5395.7841686332895, 5552.083906155439, 4905.607551395879, 4925.57158424053, 5074.923876141861, 5561.277033985637, 5582.888342233133, 4717.636186527517, 5208.401033881, 5224.268602395744, 5263.499967503081, 5264.947350526446, 4299.527052024212, 4516.503184649751, 5044.192929131322, 5275.834499300389, 5305.681659100466, 4617.907641847077, 5420.593455490933, 5434.0, 5477.835664930059, 5548.447714051582, 3061.800982936102, 3403.243372867985, 3525.7531972762686, 3543.7497189284472, 3551.804650744234, 4398.846040388571, 4495.53894984125, 4730.787114579921, 4985.277134815504, 5363.892722145457, 4723.386609243862, 5061.051495174458, 5096.821611243588, 5104.3619547556555, 5117.820876269313, 4311.655067594647, 4705.811767529261, 4825.9034819304115, 5095.414027386898, 5111.361079865017, 4186.576563968265, 4690.577847993697, 4944.381952255968, 4968.27959945813, 5297.735113244399, 4873.756312184306, 5181.663191892515, 5341.065313570032, 5455.945440545703, 5460.426655201147, 4696.365990591226, 5255.921161182662, 5391.784328626811, 5398.325209348832, 5401.675899446046], "value": 3873.388594354671, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4629160609649, 704.1901812915144, 744.8845428958514, 776.3362325211942, 791.7347688524344, 13637.795433068499, 13941.233232172226, 14322.355494002768, 14973.625659358522, 14986.850131498682, 11390.943045284783, 12483.377160969061, 13349.199048057124, 13359.33203339834, 13560.796588051187, 718.3068339052826, 851.3784936995996, 853.9530325832108, 855.7903313688124, 856.3834039491556, 667.8430568816324, 686.0806519264185, 809.4940662086196, 834.1200033964195, 837.6774941647479, 905.6196397513028, 909.6907051602453, 911.9452832830018, 913.8903331600218, 920.2178148573726, 896.3277541843618, 897.6678628907281, 897.7531178925815, 898.1108702384657, 898.865170224465, 513.1661050792462, 529.5578192209471, 639.5363361562876, 665.2150462454302, 673.6631684157921, 12947.0, 13416.396262168226, 13431.261280629562, 13432.395542200624, 13439.798403023962, 12236.938815305866, 12422.56521021769, 12566.05754568411, 12593.622191334274, 12682.80975785364, 11346.149038822039, 11519.712007199803, 11545.480453379618, 11632.185746997713, 12154.027677785756, 4205.76868272248, 4261.6590672746415, 4282.47052640973, 4307.396964424983, 4342.066455712005, 92432.53783731106, 93321.53339233261, 94502.0, 94587.0, 96679.51660241724, 8379.413441059189, 10056.983301070926, 10274.0, 10416.843747343795, 10513.421761803022, 18789.718154227696, 18910.52723681919, 19194.520136996685, 19222.423327300203, 19236.519087022658, 7257.947597598319, 7261.854762904818, 7269.236730143259, 7334.3032411920785, 7519.172890981988, 4114.218298523271, 4145.0, 4182.581741825793, 4206.747595144301, 4218.198542276958, 3085.4446199683825, 3146.9527957080663, 3183.570218020584, 3191.2979144588153, 3194.2014496375905, 586.5219845825638, 591.7189335065896, 602.9969850150809, 605.5458406195354, 611.3947192279611, 498.08601216766914, 521.6009752539311, 546.9890602187934, 584.0829897061573, 600.9789657362059, 7212.60330681807, 7347.375473084848, 8493.787655308543, 8640.913590864011, 8672.826543469222, 523.3144580599427, 587.1838144978483, 607.0499668019535, 644.8489446338264, 648.5849056603778, 3630.8003059831963, 3972.3445631471063, 3981.980090099589, 4384.3497128525005, 4497.955020449754, 91561.62657560142, 106459.935400645, 112127.0, 114292.0, 120749.0, 100308.49845750724, 100425.99574004166, 101815.0, 102295.48852255692, 102844.48577757063, 60441.395586043574, 69058.0, 80229.79655305292, 81188.59405703052, 83666.5816670925, 7086.799050830523, 8006.719764808204, 8057.5165490070785, 8201.13888041771, 8253.752387428387, 54443.72778136084, 54673.90652186854, 54967.45032549623, 56063.0, 57105.85788284128, 79036.60481697785, 79105.0, 80109.59671209873, 80167.97900262468, 81521.59239203767, 10395.58417663285, 10641.840372394576, 10661.573537058432, 10881.30035787836, 10976.725581860517, 11689.357085360047, 11813.468393922467, 11899.0, 11968.880311196777, 11971.20648399061, 11370.54517819311, 11424.371659558472, 11450.82823757661, 11487.48306326234, 11769.35268560203, 11233.38216398106, 11481.885181148082, 11639.359835209145, 11672.88327116718, 12061.819072714092, 9257.25941924631, 10767.138628909825, 10989.450527473755, 11010.944945275221, 11424.028957538701, 8863.601137948679, 9357.298202634693, 9697.466639334903, 9827.606895724377, 10123.341982771097, 9169.128932751379, 9409.48247846375, 9510.524473776422, 9545.809083818145, 9547.809043819223], "value": 6935.512759229342, "unit": "score"}], "name": "dromaeo_css", "value": 6908.850218638257, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 115.0, 114.0, 113.0, 114.0, 115.0, 116.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 112.0, 125.0, 182.0, 118.0, 113.0, 115.0, 113.0, 143.0, 113.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 187.0, 185.0, 185.0, 184.0, 184.0, 179.0, 184.0, 179.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 50.0, 99.0, 88.0, 84.0, 82.0, 82.0, 82.0, 57.0], "value": 78.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 95.0, 72.0, 68.0, 69.0, 89.0, 68.0, 69.0, 93.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 87.0, 85.0, 89.0, 86.0, 88.0, 85.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 103.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 87.0, 85.0, 87.0, 86.0, 88.0, 84.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 53.0, 57.0, 54.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 64.0, 74.0, 71.0, 68.0, 68.0, 71.0, 69.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 88.0, 87.0, 88.0, 87.0, 86.0, 88.0, 91.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 151.0, 150.0, 146.0, 148.0, 150.0, 159.0, 193.0, 162.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 170.0, 174.0, 173.0, 174.0, 174.0, 173.0, 172.0, 172.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 67.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1457.3, "alertThreshold": 2.0}]} 11:30:29 INFO - Return code: 0 11:30:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:30:29 INFO - # TBPL SUCCESS # 11:30:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:30:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:30:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:30:29 INFO - 2016-11-21 11:30:29.255 screenresolution[1652:10077] starting screenresolution argv=screenresolution get 11:30:29 INFO - 2016-11-21 11:30:29.258 screenresolution[1652:10077] Display 0: 1600x1200x32@60 11:30:29 INFO - 2016-11-21 11:30:29.263 screenresolution[1653:10080] starting screenresolution argv=screenresolution list 11:30:29 INFO - Available Modes on Display 0 11:30:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:30:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:30:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:30:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:30:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:30:29 INFO - Intel Iris: 11:30:29 INFO - Chipset Model: Intel Iris 11:30:29 INFO - Type: GPU 11:30:29 INFO - Bus: Built-In 11:30:29 INFO - VRAM (Dynamic, Max): 1536 MB 11:30:29 INFO - Vendor: Intel (0x8086) 11:30:29 INFO - Device ID: 0x0a2e 11:30:29 INFO - Revision ID: 0x0009 11:30:29 INFO - Displays: 11:30:29 INFO - Display: 11:30:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:30:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:30:29 INFO - Display Serial Number: 1600x1200 60 11:30:29 INFO - Main Display: Yes 11:30:29 INFO - Mirror: Off 11:30:29 INFO - Online: Yes 11:30:29 INFO - Rotation: Supported 11:30:29 INFO - Return code: 0 11:30:29 INFO - Running post-action listener: _resource_record_post_action 11:30:29 INFO - [mozharness: 2016-11-21 19:30:29.515947Z] Finished run-tests step (success) 11:30:29 INFO - Running post-run listener: _resource_record_post_run 11:30:29 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 37475328; Write bytes: 693167616; Read time: 241; Write time: 1939 11:30:29 INFO - TinderboxPrint: CPU usage
53.8% 11:30:29 INFO - TinderboxPrint: I/O read bytes / time
37,475,328 / 241 11:30:29 INFO - TinderboxPrint: I/O write bytes / time
693,167,616 / 1,939 11:30:29 INFO - TinderboxPrint: CPU idle
2,242.0 (46.2%) 11:30:29 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 11:30:29 INFO - TinderboxPrint: CPU user
1,639.7 (33.8%) 11:30:29 INFO - TinderboxPrint: Swap in / out
420,327,424 / 0 11:30:29 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 372060672; Write bytes: 366696448; Read time: 27838; Write time: 744 11:30:29 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31218688; Write bytes: 307891712; Read time: 184; Write time: 1145 11:30:30 INFO - Running post-run listener: _upload_blobber_files 11:30:30 INFO - Blob upload gear active. 11:30:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:30:30 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 11:30:30 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'] 11:30:30 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 11:30:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:30:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:30:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:30:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:31 INFO - (blobuploader) - INFO - Done attempting. 11:30:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:30:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:32 INFO - (blobuploader) - INFO - Done attempting. 11:30:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:30:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:30:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:30:35 INFO - (blobuploader) - INFO - Done attempting. 11:30:35 INFO - (blobuploader) - INFO - Iteration through files over. 11:30:35 INFO - Return code: 0 11:30:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:30:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:30:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/78094dedf9d45f190912e84dc240c0a7e53df4d57ff69580c71eab363ed5ebf5c8c051533b15b9af5017b59a9be63d6d2a22a3499ad72b59c33a13b5456424a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/53805b8ef092ebee13334c8c8746b74a8cbc46666e228b9ddba47575a537ae648250f2a014fd4388932b679a6eca1a9e5267f84be9ce571df3ac991bf05dba92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1391156c1fae51174fa4ad877e72106563ca8fc40cc8efcf3bd9044ab4daab38c9644a3faff5520194e02cd54f5c40f1746cfcb0b0c536b265d947c0975a6b74"} 11:30:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:30:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:30:35 INFO - Contents: 11:30:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/78094dedf9d45f190912e84dc240c0a7e53df4d57ff69580c71eab363ed5ebf5c8c051533b15b9af5017b59a9be63d6d2a22a3499ad72b59c33a13b5456424a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/53805b8ef092ebee13334c8c8746b74a8cbc46666e228b9ddba47575a537ae648250f2a014fd4388932b679a6eca1a9e5267f84be9ce571df3ac991bf05dba92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1391156c1fae51174fa4ad877e72106563ca8fc40cc8efcf3bd9044ab4daab38c9644a3faff5520194e02cd54f5c40f1746cfcb0b0c536b265d947c0975a6b74"} 11:30:35 INFO - Running post-run listener: copy_logs_to_upload_dir 11:30:35 INFO - Copying logs to upload dir... 11:30:35 INFO - mkdir: /builds/slave/test/build/upload/logs 11:30:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.062319 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-21 11:30:35.124713) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 11:30:35.132592) ========= 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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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/78094dedf9d45f190912e84dc240c0a7e53df4d57ff69580c71eab363ed5ebf5c8c051533b15b9af5017b59a9be63d6d2a22a3499ad72b59c33a13b5456424a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/53805b8ef092ebee13334c8c8746b74a8cbc46666e228b9ddba47575a537ae648250f2a014fd4388932b679a6eca1a9e5267f84be9ce571df3ac991bf05dba92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1391156c1fae51174fa4ad877e72106563ca8fc40cc8efcf3bd9044ab4daab38c9644a3faff5520194e02cd54f5c40f1746cfcb0b0c536b265d947c0975a6b74"} build_url:https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010780 build_url: 'https://queue.taskcluster.net/v1/task/NSIXmWoUQpSjHm2eqhmqgg/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/78094dedf9d45f190912e84dc240c0a7e53df4d57ff69580c71eab363ed5ebf5c8c051533b15b9af5017b59a9be63d6d2a22a3499ad72b59c33a13b5456424a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/53805b8ef092ebee13334c8c8746b74a8cbc46666e228b9ddba47575a537ae648250f2a014fd4388932b679a6eca1a9e5267f84be9ce571df3ac991bf05dba92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1391156c1fae51174fa4ad877e72106563ca8fc40cc8efcf3bd9044ab4daab38c9644a3faff5520194e02cd54f5c40f1746cfcb0b0c536b265d947c0975a6b74"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 11:30:35.170244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:30:35.170546) ========= 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.kt7Jau2QVP/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.VGP9HrpAbW/Listeners TMPDIR=/var/folders/rx/f1wvrtx55vx08syn1stbjr9000000w/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.004995 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:30:35.217639) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 11:30:35.217922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 11:30:35.218191) ========= ========= Total master_lag: 0.20 =========