builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0330 starttime: 1475776744.35 results: success (0) buildid: 20161006091105 builduid: 58c025a76e854fd29184f57fca90da3f revision: 6d63144fb5dc98ed4556f0af0514a1a7c39c90cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.347946) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.348580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.349095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.402953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.403380) ========= 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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-10-06 10:59:04-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.5M=0s 2016-10-06 10:59:04 (66.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113884 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.539672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.540033) ========= 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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.021519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:04.588997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 10:59:04.589502) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 6d63144fb5dc98ed4556f0af0514a1a7c39c90cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 6d63144fb5dc98ed4556f0af0514a1a7c39c90cd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a3tIzQHFpS/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.VRiJyWtxjK/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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-10-06 10:59:04,669 truncating revision to first 12 chars 2016-10-06 10:59:04,669 Setting DEBUG logging. 2016-10-06 10:59:04,669 attempt 1/10 2016-10-06 10:59:04,669 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/6d63144fb5dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 10:59:06,149 unpacking tar archive at: autoland-6d63144fb5dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.750292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 10:59:06.362565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:06.362927) ========= script_repo_revision: 6d63144fb5dc98ed4556f0af0514a1a7c39c90cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:06.363336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:06.363612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 10:59:06.381738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-06 10:59:06.382219) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a3tIzQHFpS/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.VRiJyWtxjK/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:06 INFO - MultiFileLogger online at 20161006 10:59:06 in /builds/slave/test 10:59:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:59:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:59:06 INFO - {'append_to_log': False, 10:59:06 INFO - 'base_work_dir': '/builds/slave/test', 10:59:06 INFO - 'blob_upload_branch': 'Autoland', 10:59:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:59:06 INFO - 'branch': 'Autoland', 10:59:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:59:06 INFO - 'config_files': ('talos/mac_config.py',), 10:59:06 INFO - 'default_actions': ('clobber', 10:59:06 INFO - 'read-buildbot-config', 10:59:06 INFO - 'download-and-extract', 10:59:06 INFO - 'populate-webroot', 10:59:06 INFO - 'create-virtualenv', 10:59:06 INFO - 'install', 10:59:06 INFO - 'run-tests'), 10:59:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:59:06 INFO - 'download_minidump_stackwalk': True, 10:59:06 INFO - 'download_symbols': 'ondemand', 10:59:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:59:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:59:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:59:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:59:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:59:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:59:06 INFO - 'installer_path': 'installer.exe', 10:59:06 INFO - 'log_level': 'info', 10:59:06 INFO - 'log_name': 'talos', 10:59:06 INFO - 'log_to_console': True, 10:59:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:59:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:59:06 INFO - 'opt_config_files': (), 10:59:06 INFO - 'pip_index': False, 10:59:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:59:06 INFO - 'cmd': ('bash', 10:59:06 INFO - '-c', 10:59:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:59:06 INFO - 'enabled': True, 10:59:06 INFO - 'halt_on_failure': False, 10:59:06 INFO - 'name': 'check_screen_resolution'},), 10:59:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:59:06 INFO - 'cmd': ('bash', 10:59:06 INFO - '-c', 10:59:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:59:06 INFO - 'enabled': True, 10:59:06 INFO - 'halt_on_failure': False, 10:59:06 INFO - 'name': 'check_screen_resolution'},), 10:59:06 INFO - 'run_cmd_checks_enabled': True, 10:59:06 INFO - 'sps_profile': False, 10:59:06 INFO - 'sps_profile_interval': 0, 10:59:06 INFO - 'suite': 'dromaeojs-e10s', 10:59:06 INFO - 'system_bits': '32', 10:59:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:59:06 INFO - 'title': 't-yosemite-r7-0330', 10:59:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:59:06 INFO - 'use_talos_json': True, 10:59:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:59:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:59:06 INFO - 'work_dir': 'build'} 10:59:06 INFO - [mozharness: 2016-10-06 17:59:06.581300Z] Running clobber step. 10:59:06 INFO - Running pre-action listener: _resource_record_pre_action 10:59:06 INFO - Running main action method: clobber 10:59:06 INFO - rmtree: /builds/slave/test/build 10:59:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:59:08 INFO - Running post-action listener: _resource_record_post_action 10:59:08 INFO - [mozharness: 2016-10-06 17:59:08.023913Z] Finished clobber step (success) 10:59:08 INFO - [mozharness: 2016-10-06 17:59:08.024042Z] Running read-buildbot-config step. 10:59:08 INFO - Running pre-action listener: _resource_record_pre_action 10:59:08 INFO - Running main action method: read_buildbot_config 10:59:08 INFO - Using buildbot properties: 10:59:08 INFO - { 10:59:08 INFO - "project": "", 10:59:08 INFO - "product": "firefox", 10:59:08 INFO - "script_repo_revision": "production", 10:59:08 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 10:59:08 INFO - "repository": "", 10:59:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 10:59:08 INFO - "buildid": "20161006091105", 10:59:08 INFO - "pgo_build": "False", 10:59:08 INFO - "basedir": "/builds/slave/test", 10:59:08 INFO - "buildnumber": 248, 10:59:08 INFO - "slavename": "t-yosemite-r7-0330", 10:59:08 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:59:08 INFO - "platform": "yosemite_r7", 10:59:08 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 10:59:08 INFO - "branch": "autoland", 10:59:08 INFO - "repo_path": "integration/autoland", 10:59:08 INFO - "revision": "6d63144fb5dc98ed4556f0af0514a1a7c39c90cd", 10:59:08 INFO - "stage_platform": "macosx64", 10:59:08 INFO - "builduid": "58c025a76e854fd29184f57fca90da3f", 10:59:08 INFO - "slavebuilddir": "test" 10:59:08 INFO - } 10:59:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:59:08 INFO - Running post-action listener: _resource_record_post_action 10:59:08 INFO - [mozharness: 2016-10-06 17:59:08.027383Z] Finished read-buildbot-config step (success) 10:59:08 INFO - [mozharness: 2016-10-06 17:59:08.027514Z] Running download-and-extract step. 10:59:08 INFO - Running pre-action listener: _resource_record_pre_action 10:59:08 INFO - Running main action method: download_and_extract 10:59:08 INFO - mkdir: /builds/slave/test/build/tests 10:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:08 INFO - trying https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:59:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:59:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:59:09 INFO - Downloaded 1199 bytes. 10:59:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:59:09 INFO - Using the following test package requirements: 10:59:09 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:59:09 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:59:09 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:59:09 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'jsshell-mac.zip'], 10:59:09 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:59:09 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:59:09 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:59:09 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:59:09 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:59:09 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:59:09 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:59:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:59:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:59:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:59:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:59:10 INFO - Http code: 200 10:59:10 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 10:59:10 INFO - x-amz-cf-id: tByBAIHrRKzrPrCSGyn7umO1aSYLHwRWK9TLKNKdnzfzTGU6cMW0Dg== 10:59:10 INFO - x-amz-version-id: VVPoUXDyKF0VDI1nnVX7SNHGC8NTQyFv 10:59:10 INFO - Expected file size: 16478258 10:59:10 INFO - Obtained file size: 16478258 10:59:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:59:17 INFO - Http code: 200 10:59:17 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 10:59:17 INFO - x-amz-cf-id: 5Zw2h7dXhgbSNPi1CcfM5cGbefBV9BVzKH1POIZoLynelc2iL2WCMA== 10:59:17 INFO - x-amz-version-id: VVPoUXDyKF0VDI1nnVX7SNHGC8NTQyFv 10:59:18 INFO - Expected file size: 16478258 10:59:18 INFO - Obtained file size: 16478258 10:59:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:59:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:59:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:59:25 INFO - Http code: 200 10:59:25 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 10:59:25 INFO - x-amz-cf-id: 0Ob0HHxGFizzZF84Tihz2liLzYt9lecugGUMoD8HdK-lxSm0XW_1Tw== 10:59:25 INFO - x-amz-version-id: 2TT1e_itB04dCx0MDdqytu92JdUl.pT9 10:59:25 INFO - Expected file size: 14409006 10:59:25 INFO - Obtained file size: 14409006 10:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:25 INFO - trying https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:59:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:59:28 INFO - Downloaded 111673146 bytes. 10:59:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:59:28 INFO - mkdir: /builds/slave/test/properties 10:59:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:28 INFO - Contents: 10:59:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:59:29 INFO - Running post-action listener: _resource_record_post_action 10:59:29 INFO - Running post-action listener: set_extra_try_arguments 10:59:29 INFO - [mozharness: 2016-10-06 17:59:29.296077Z] Finished download-and-extract step (success) 10:59:29 INFO - [mozharness: 2016-10-06 17:59:29.296229Z] Running populate-webroot step. 10:59:29 INFO - Running pre-action listener: _resource_record_pre_action 10:59:29 INFO - Running main action method: populate_webroot 10:59:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:59:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:59:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:59:29 INFO - '--tppagecycles', 10:59:29 INFO - '7'], 10:59:29 INFO - 'tests': ['tsvgm']}}, 10:59:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:59:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['damp', 'tps']}, 10:59:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'tests': ['damp', 'tps']}, 10:59:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['dromaeo_dom']}, 10:59:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['basic_compositor_video']}, 10:59:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:59:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['a11yr', 10:59:29 INFO - 'ts_paint', 10:59:29 INFO - 'tpaint', 10:59:29 INFO - 'sessionrestore', 10:59:29 INFO - 'sessionrestore_no_auto_restore', 10:59:29 INFO - 'tabpaint']}, 10:59:29 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:29 INFO - 'ts_paint', 10:59:29 INFO - 'tpaint', 10:59:29 INFO - 'sessionrestore', 10:59:29 INFO - 'sessionrestore_no_auto_restore', 10:59:29 INFO - 'tabpaint']}, 10:59:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:59:29 INFO - 'ts_paint', 10:59:29 INFO - 'tpaint', 10:59:29 INFO - 'sessionrestore', 10:59:29 INFO - 'sessionrestore_no_auto_restore', 10:59:29 INFO - 'tabpaint']}, 10:59:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:59:29 INFO - 'ts_paint', 10:59:29 INFO - 'tpaint', 10:59:29 INFO - 'sessionrestore', 10:59:29 INFO - 'sessionrestore_no_auto_restore', 10:59:29 INFO - 'tabpaint']}, 10:59:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['a11yr', 10:59:29 INFO - 'ts_paint', 10:59:29 INFO - 'tpaint', 10:59:29 INFO - 'sessionrestore', 10:59:29 INFO - 'sessionrestore_no_auto_restore', 10:59:29 INFO - 'tabpaint']}, 10:59:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['a11yr', 10:59:29 INFO - 'ts_paint', 10:59:29 INFO - 'tpaint', 10:59:29 INFO - 'sessionrestore', 10:59:29 INFO - 'sessionrestore_no_auto_restore', 10:59:29 INFO - 'tabpaint']}, 10:59:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['tsvgx', 10:59:29 INFO - 'tsvgr_opacity', 10:59:29 INFO - 'tart', 10:59:29 INFO - 'tscrollx', 10:59:29 INFO - 'cart']}, 10:59:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:29 INFO - 'tsvgr_opacity', 10:59:29 INFO - 'tart', 10:59:29 INFO - 'tscrollx', 10:59:29 INFO - 'cart']}, 10:59:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'talos_options': ['--disable-e10s'], 10:59:29 INFO - 'tests': ['tp5o']}, 10:59:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'tests': ['tp5o']}, 10:59:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'talos_options': ['--disable-e10s', 10:59:29 INFO - '--xperf_path', 10:59:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:29 INFO - 'tests': ['tp5n']}, 10:59:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:29 INFO - 'talos_options': ['--xperf_path', 10:59:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:29 INFO - 'tests': ['tp5n']}}, 10:59:29 INFO - 'talos.zip': {'path': '', 10:59:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:59:29 INFO - Running post-action listener: _resource_record_post_action 10:59:29 INFO - [mozharness: 2016-10-06 17:59:29.314799Z] Finished populate-webroot step (success) 10:59:29 INFO - [mozharness: 2016-10-06 17:59:29.314931Z] Running create-virtualenv step. 10:59:29 INFO - Running pre-action listener: _resource_record_pre_action 10:59:29 INFO - Running main action method: create_virtualenv 10:59:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:29 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 10:59:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:29 INFO - Using real prefix '/tools/python27' 10:59:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:32 INFO - Installing pip.................done. 10:59:32 INFO - Return code: 0 10:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:59:33 INFO - Reading from file tmpfile_stdout 10:59:33 INFO - Output received: 10:59:33 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) 10:59:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59:33 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')]} 10:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:33 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')]} 10:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:33 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:33 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 10:59:33 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 10:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:33 INFO - 'HOME': '/Users/cltbld', 10:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:33 INFO - 'LOGNAME': 'cltbld', 10:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:33 INFO - 'MOZ_NO_REMOTE': '1', 10:59:33 INFO - 'NO_EM_RESTART': '1', 10:59:33 INFO - 'PAGER': '/bin/cat', 10:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:33 INFO - 'PWD': '/builds/slave/test', 10:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:33 INFO - 'SHELL': '/bin/bash', 10:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:33 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:33 INFO - 'USER': 'cltbld', 10:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:33 INFO - 'XPC_FLAGS': '0x0', 10:59:33 INFO - 'XPC_SERVICE_NAME': '0', 10:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:33 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 10:59:33 INFO - Cleaning up... 10:59:33 INFO - Return code: 0 10:59:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:33 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')]} 10:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:33 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')]} 10:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:33 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:33 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 10:59:33 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 10:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:33 INFO - 'HOME': '/Users/cltbld', 10:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:33 INFO - 'LOGNAME': 'cltbld', 10:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:33 INFO - 'MOZ_NO_REMOTE': '1', 10:59:33 INFO - 'NO_EM_RESTART': '1', 10:59:33 INFO - 'PAGER': '/bin/cat', 10:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:33 INFO - 'PWD': '/builds/slave/test', 10:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:33 INFO - 'SHELL': '/bin/bash', 10:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:33 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:33 INFO - 'USER': 'cltbld', 10:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:33 INFO - 'XPC_FLAGS': '0x0', 10:59:33 INFO - 'XPC_SERVICE_NAME': '0', 10:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:33 INFO - Downloading/unpacking psutil>=3.1.1 10:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:37 INFO - Installing collected packages: psutil 10:59:37 INFO - Running setup.py install for psutil 10:59:37 INFO - building 'psutil._psutil_osx' extension 10:59:37 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 10:59:37 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 10:59:37 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 10:59:37 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 10:59:37 INFO - building 'psutil._psutil_posix' extension 10:59:37 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 10:59:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:59:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:59:37 INFO - ^ 10:59:37 INFO - 1 warning generated. 10:59:37 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 10:59:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:38 INFO - Successfully installed psutil 10:59:38 INFO - Cleaning up... 10:59:38 INFO - Return code: 0 10:59:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:38 INFO - 'HOME': '/Users/cltbld', 10:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:38 INFO - 'LOGNAME': 'cltbld', 10:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:38 INFO - 'MOZ_NO_REMOTE': '1', 10:59:38 INFO - 'NO_EM_RESTART': '1', 10:59:38 INFO - 'PAGER': '/bin/cat', 10:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:38 INFO - 'PWD': '/builds/slave/test', 10:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:38 INFO - 'SHELL': '/bin/bash', 10:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:38 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:38 INFO - 'USER': 'cltbld', 10:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:38 INFO - 'XPC_FLAGS': '0x0', 10:59:38 INFO - 'XPC_SERVICE_NAME': '0', 10:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:38 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 10:59:38 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 10:59:38 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 10:59:38 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 10:59:38 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 10:59:38 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 10:59:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:40 INFO - Installing collected packages: mozsystemmonitor 10:59:40 INFO - Running setup.py install for mozsystemmonitor 10:59:41 INFO - Successfully installed mozsystemmonitor 10:59:41 INFO - Cleaning up... 10:59:41 INFO - Return code: 0 10:59:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:41 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')]} 10:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:41 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')]} 10:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:41 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:41 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 10:59:41 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 10:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:41 INFO - 'HOME': '/Users/cltbld', 10:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:41 INFO - 'LOGNAME': 'cltbld', 10:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:41 INFO - 'MOZ_NO_REMOTE': '1', 10:59:41 INFO - 'NO_EM_RESTART': '1', 10:59:41 INFO - 'PAGER': '/bin/cat', 10:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:41 INFO - 'PWD': '/builds/slave/test', 10:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:41 INFO - 'SHELL': '/bin/bash', 10:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:41 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:41 INFO - 'USER': 'cltbld', 10:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:41 INFO - 'XPC_FLAGS': '0x0', 10:59:41 INFO - 'XPC_SERVICE_NAME': '0', 10:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:43 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 10:59:43 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 10:59:43 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 10:59:43 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 10:59:43 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 10:59:43 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 10:59:44 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:44 INFO - warning: no files found matching '*.txt' 10:59:44 INFO - no previously-included directories found matching 'build' 10:59:44 INFO - no previously-included directories found matching 'dist' 10:59:44 INFO - no previously-included directories found matching '.git*' 10:59:44 INFO - Installing collected packages: jsonschema, functools32 10:59:44 INFO - Running setup.py install for functools32 10:59:44 INFO - warning: no files found matching '*.txt' 10:59:44 INFO - no previously-included directories found matching 'build' 10:59:44 INFO - no previously-included directories found matching 'dist' 10:59:44 INFO - no previously-included directories found matching '.git*' 10:59:44 INFO - Successfully installed jsonschema functools32 10:59:44 INFO - Cleaning up... 10:59:44 INFO - Return code: 0 10:59:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:44 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 10:59:44 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 10:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:44 INFO - 'HOME': '/Users/cltbld', 10:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:44 INFO - 'LOGNAME': 'cltbld', 10:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:44 INFO - 'MOZ_NO_REMOTE': '1', 10:59:44 INFO - 'NO_EM_RESTART': '1', 10:59:44 INFO - 'PAGER': '/bin/cat', 10:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:44 INFO - 'PWD': '/builds/slave/test', 10:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:44 INFO - 'SHELL': '/bin/bash', 10:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:44 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:44 INFO - 'USER': 'cltbld', 10:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:44 INFO - 'XPC_FLAGS': '0x0', 10:59:44 INFO - 'XPC_SERVICE_NAME': '0', 10:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:44 INFO - Cleaning up... 10:59:44 INFO - Return code: 0 10:59:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:44 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 10:59:44 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 10:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:44 INFO - 'HOME': '/Users/cltbld', 10:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:44 INFO - 'LOGNAME': 'cltbld', 10:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:44 INFO - 'MOZ_NO_REMOTE': '1', 10:59:44 INFO - 'NO_EM_RESTART': '1', 10:59:44 INFO - 'PAGER': '/bin/cat', 10:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:44 INFO - 'PWD': '/builds/slave/test', 10:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:44 INFO - 'SHELL': '/bin/bash', 10:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:44 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:44 INFO - 'USER': 'cltbld', 10:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:44 INFO - 'XPC_FLAGS': '0x0', 10:59:44 INFO - 'XPC_SERVICE_NAME': '0', 10:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:45 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 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 10:59:48 INFO - Downloading docopt-0.6.1.tar.gz 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:48 INFO - Running setup.py install for blobuploader 10:59:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:49 INFO - Running setup.py install for requests 10:59:49 INFO - Running setup.py install for docopt 10:59:49 INFO - Successfully installed blobuploader requests docopt 10:59:49 INFO - Cleaning up... 10:59:49 INFO - Return code: 0 10:59:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:49 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')]} 10:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:49 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')]} 10:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:49 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:49 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 10:59:49 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 10:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:49 INFO - 'HOME': '/Users/cltbld', 10:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:49 INFO - 'LOGNAME': 'cltbld', 10:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:49 INFO - 'MOZ_NO_REMOTE': '1', 10:59:49 INFO - 'NO_EM_RESTART': '1', 10:59:49 INFO - 'PAGER': '/bin/cat', 10:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:49 INFO - 'PWD': '/builds/slave/test', 10:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:49 INFO - 'SHELL': '/bin/bash', 10:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:49 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:49 INFO - 'USER': 'cltbld', 10:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:49 INFO - 'XPC_FLAGS': '0x0', 10:59:49 INFO - 'XPC_SERVICE_NAME': '0', 10:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-s0bzG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-iYF1PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-9ciWqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-2WRq2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-OUe5Ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-8f59Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-lGHPzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-EbmdRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:50 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-o405gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-om4yQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-rx288E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-oiEs2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-AnK9pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-WAtB1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-jjulyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-TB9tgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:51 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-LhIfTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:51 INFO - Running setup.py install for manifestparser 10:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozcrash 10:59:52 INFO - Running setup.py install for mozdebug 10:59:52 INFO - Running setup.py install for mozdevice 10:59:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozfile 10:59:52 INFO - Running setup.py install for mozhttpd 10:59:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozinfo 10:59:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozInstall 10:59:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Running setup.py install for mozleak 10:59:53 INFO - Running setup.py install for mozlog 10:59:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Running setup.py install for moznetwork 10:59:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Running setup.py install for mozprocess 10:59:53 INFO - Running setup.py install for mozprofile 10:59:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:53 INFO - Running setup.py install for mozrunner 10:59:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:54 INFO - Running setup.py install for mozscreenshot 10:59:54 INFO - Running setup.py install for moztest 10:59:54 INFO - Running setup.py install for mozversion 10:59:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:54 INFO - Cleaning up... 10:59:54 INFO - Return code: 0 10:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:54 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')]} 10:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:54 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')]} 10:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:54 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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 10:59:54 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 10:59:54 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 10:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 10:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:54 INFO - 'HOME': '/Users/cltbld', 10:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:54 INFO - 'LOGNAME': 'cltbld', 10:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:54 INFO - 'MOZ_NO_REMOTE': '1', 10:59:54 INFO - 'NO_EM_RESTART': '1', 10:59:54 INFO - 'PAGER': '/bin/cat', 10:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:54 INFO - 'PWD': '/builds/slave/test', 10:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:54 INFO - 'SHELL': '/bin/bash', 10:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 10:59:54 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 10:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:54 INFO - 'USER': 'cltbld', 10:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:54 INFO - 'XPC_FLAGS': '0x0', 10:59:54 INFO - 'XPC_SERVICE_NAME': '0', 10:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:54 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-0kJUAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:54 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)) 10:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:54 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ZD7jk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:54 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-K8isos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-1APm6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-AoHfBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-eWKyze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-Z9FQgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-I1MhUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-cIxpV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-u7621Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-DWrvE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:55 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)) 10:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:55 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-aJJkbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:56 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-ycwUjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:56 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-DAjawq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:56 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-qgPTy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:56 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-XKYuQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:56 INFO - Running setup.py (path:/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/pip-lPEON8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:56 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)) 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:56 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)) 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 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 10:59:56 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 10:59:59 INFO - Downloading blessings-1.6.tar.gz 10:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:00 INFO - Installing collected packages: blessings 11:00:00 INFO - Running setup.py install for blessings 11:00:00 INFO - Successfully installed blessings 11:00:00 INFO - Cleaning up... 11:00:00 INFO - Return code: 0 11:00:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:00 INFO - Reading from file tmpfile_stdout 11:00:00 INFO - Current package versions: 11:00:00 INFO - blessings == 1.6 11:00:00 INFO - blobuploader == 1.2.4 11:00:00 INFO - docopt == 0.6.1 11:00:00 INFO - functools32 == 3.2.3-2 11:00:00 INFO - jsonschema == 2.5.1 11:00:00 INFO - manifestparser == 1.1 11:00:00 INFO - mozInstall == 1.12 11:00:00 INFO - mozcrash == 0.17 11:00:00 INFO - mozdebug == 0.1 11:00:00 INFO - mozdevice == 0.48 11:00:00 INFO - mozfile == 1.2 11:00:00 INFO - mozhttpd == 0.7 11:00:00 INFO - mozinfo == 0.9 11:00:00 INFO - mozleak == 0.1 11:00:00 INFO - mozlog == 3.4 11:00:00 INFO - moznetwork == 0.27 11:00:00 INFO - mozprocess == 0.23 11:00:00 INFO - mozprofile == 0.28 11:00:00 INFO - mozrunner == 6.12 11:00:00 INFO - mozscreenshot == 0.1 11:00:00 INFO - mozsystemmonitor == 0.3 11:00:00 INFO - moztest == 0.7 11:00:00 INFO - mozversion == 1.4 11:00:00 INFO - psutil == 3.1.1 11:00:00 INFO - requests == 1.2.3 11:00:00 INFO - wsgiref == 0.1.2 11:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:00 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:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:00 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:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:00 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:00:00 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:00:00 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:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 11:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:00 INFO - 'HOME': '/Users/cltbld', 11:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:00 INFO - 'LOGNAME': 'cltbld', 11:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:00 INFO - 'MOZ_NO_REMOTE': '1', 11:00:00 INFO - 'NO_EM_RESTART': '1', 11:00:00 INFO - 'PAGER': '/bin/cat', 11:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:00 INFO - 'PWD': '/builds/slave/test', 11:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:00 INFO - 'SHELL': '/bin/bash', 11:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 11:00:00 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 11:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:00 INFO - 'USER': 'cltbld', 11:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:00 INFO - 'XPC_FLAGS': '0x0', 11:00:00 INFO - 'XPC_SERVICE_NAME': '0', 11:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 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:00:00 INFO - Cleaning up... 11:00:00 INFO - Return code: 0 11:00:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:00:00 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:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:02 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 0x104f4b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8833dd73e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, '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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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:00:02 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:00:02 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:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 11:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:02 INFO - 'HOME': '/Users/cltbld', 11:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:02 INFO - 'LOGNAME': 'cltbld', 11:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:02 INFO - 'MOZ_NO_REMOTE': '1', 11:00:02 INFO - 'NO_EM_RESTART': '1', 11:00:02 INFO - 'PAGER': '/bin/cat', 11:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:02 INFO - 'PWD': '/builds/slave/test', 11:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:02 INFO - 'SHELL': '/bin/bash', 11:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 11:00:02 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 11:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:02 INFO - 'USER': 'cltbld', 11:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:02 INFO - 'XPC_FLAGS': '0x0', 11:00:02 INFO - 'XPC_SERVICE_NAME': '0', 11:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:00:02 INFO - Cleaning up... 11:00:02 INFO - Return code: 0 11:00:02 INFO - Running post-action listener: _resource_record_post_action 11:00:02 INFO - Running post-action listener: _start_resource_monitoring 11:00:02 INFO - Starting resource monitoring. 11:00:02 INFO - [mozharness: 2016-10-06 18:00:02.576252Z] Finished create-virtualenv step (success) 11:00:02 INFO - [mozharness: 2016-10-06 18:00:02.577276Z] Running install step. 11:00:02 INFO - Running pre-action listener: _resource_record_pre_action 11:00:02 INFO - Running main action method: install 11:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:02 INFO - Reading from file tmpfile_stdout 11:00:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:00:02 INFO - Reading from file tmpfile_stdout 11:00:02 INFO - Output received: 11:00:02 INFO - Usage: mozinstall [options] installer 11:00:02 INFO - Options: 11:00:02 INFO - -h, --help show this help message and exit 11:00:02 INFO - -d DEST, --destination=DEST 11:00:02 INFO - Directory to install application into. [default: 11:00:02 INFO - "/builds/slave/test"] 11:00:02 INFO - --app=APP Application being installed. [default: firefox] 11:00:02 INFO - mkdir: /builds/slave/test/build/application 11:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:00:37 INFO - Reading from file tmpfile_stdout 11:00:37 INFO - Output received: 11:00:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:00:37 INFO - Running post-action listener: _resource_record_post_action 11:00:37 INFO - [mozharness: 2016-10-06 18:00:37.273154Z] Finished install step (success) 11:00:37 INFO - [mozharness: 2016-10-06 18:00:37.273314Z] Running run-tests step. 11:00:37 INFO - Running pre-action listener: _resource_record_pre_action 11:00:37 INFO - Running main action method: run_tests 11:00:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:00:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:00:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:00:37 INFO - 2016-10-06 11:00:37.289 screenresolution[1953:22383] starting screenresolution argv=screenresolution get 11:00:37 INFO - 2016-10-06 11:00:37.291 screenresolution[1953:22383] Display 0: 1600x1200x32@60 11:00:37 INFO - 2016-10-06 11:00:37.297 screenresolution[1954:22392] starting screenresolution argv=screenresolution list 11:00:37 INFO - Available Modes on Display 0 11:00:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:00:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:00:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:00:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:00:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:00:37 INFO - Intel Iris: 11:00:37 INFO - Chipset Model: Intel Iris 11:00:37 INFO - Type: GPU 11:00:37 INFO - Bus: Built-In 11:00:37 INFO - VRAM (Dynamic, Max): 1536 MB 11:00:37 INFO - Vendor: Intel (0x8086) 11:00:37 INFO - Device ID: 0x0a2e 11:00:37 INFO - Revision ID: 0x0009 11:00:37 INFO - Displays: 11:00:37 INFO - Display: 11:00:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:00:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:00:37 INFO - Display Serial Number: 1600x1200 60 11:00:37 INFO - Main Display: Yes 11:00:37 INFO - Mirror: Off 11:00:37 INFO - Online: Yes 11:00:37 INFO - Rotation: Supported 11:00:37 INFO - Return code: 0 11:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:37 INFO - Python 2.7.3 11:00:37 INFO - Return code: 0 11:00:37 INFO - grabbing minidump binary from tooltool 11:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:37 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 0x104d5fd30>, '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 0x104b85db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d57b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:37 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:00:37 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:00:37 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:00:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:37 INFO - Return code: 0 11:00:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:00:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:00:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0330 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:00:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a3tIzQHFpS/Render', 11:00:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:37 INFO - 'HOME': '/Users/cltbld', 11:00:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:37 INFO - 'LOGNAME': 'cltbld', 11:00:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:37 INFO - 'MOZ_NO_REMOTE': '1', 11:00:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:37 INFO - 'NO_EM_RESTART': '1', 11:00:37 INFO - 'PAGER': '/bin/cat', 11:00:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:37 INFO - 'PWD': '/builds/slave/test', 11:00:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:37 INFO - 'SHELL': '/bin/bash', 11:00:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VRiJyWtxjK/Listeners', 11:00:37 INFO - 'TMPDIR': '/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/', 11:00:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:37 INFO - 'USER': 'cltbld', 11:00:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:37 INFO - 'XPC_FLAGS': '0x0', 11:00:37 INFO - 'XPC_SERVICE_NAME': '0', 11:00:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0330', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:00:37 INFO - mozversion application_buildid: 20161006091105 11:00:37 INFO - mozversion application_changeset: 6d63144fb5dc98ed4556f0af0514a1a7c39c90cd 11:00:37 INFO - mozversion application_display_name: Nightly 11:00:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:37 INFO - mozversion application_name: Firefox 11:00:37 INFO - mozversion application_remotingname: firefox 11:00:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:00:37 INFO - mozversion application_vendor: Mozilla 11:00:37 INFO - mozversion application_version: 52.0a1 11:00:37 INFO - mozversion platform_buildid: 20161006091105 11:00:37 INFO - mozversion platform_changeset: 6d63144fb5dc98ed4556f0af0514a1a7c39c90cd 11:00:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:00:37 INFO - mozversion platform_version: 52.0a1 11:00:37 INFO - using testdate: 1475776837 11:00:37 INFO - actual date: 1475776837 11:00:37 INFO - starting webserver on 'localhost:55873' 11:00:37 INFO - SUITE-START | Running 2 tests 11:00:37 INFO - TEST-START | dromaeo_css 11:00:37 INFO - operating with platform_type : mac_ 11:00:37 INFO - Initialising browser for dromaeo_css test... 11:00:37 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmp8mRUuI/profile http://localhost:55873/getInfo.html) 11:00:40 INFO - PROCESS | 1964 | 2016-10-06 11:00:40.773 plugin-container[1966:22554] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 11:00:40 INFO - PROCESS | 1964 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:40 INFO - PROCESS | 1964 | 2016-10-06 11:00:40.775 plugin-container[1966:22554] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 11:00:40 INFO - PROCESS | 1964 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:40 INFO - PROCESS | 1964 | 2016-10-06 11:00:40.775 plugin-container[1966:22554] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:00:40 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 11:00:40 INFO - PROCESS | 1964 | colorDepth:24 11:00:40 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 11:00:40 INFO - PROCESS | 1964 | __metrics 11:00:40 ERROR - PROCESS | 1964 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 11:00:41 INFO - TEST-INFO | 1964: exit 0 11:00:41 INFO - Browser initialized. 11:00:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:41 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmp8mRUuI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:44 INFO - PROCESS | 1967 | 2016-10-06 11:00:44.076 plugin-container[1968:22671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431f, name = 'com.apple.tsm.portname' 11:00:44 INFO - PROCESS | 1967 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:44 INFO - PROCESS | 1967 | 2016-10-06 11:00:44.078 plugin-container[1968:22671] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 11:00:44 INFO - PROCESS | 1967 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:44 INFO - PROCESS | 1967 | 2016-10-06 11:00:44.078 plugin-container[1968:22671] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:00:53 INFO - PROCESS | 1967 | RSS: Main: 240025600 11:00:53 INFO - PROCESS | 1967 | 11:01:43 INFO - PROCESS | 1967 | 1475776903373 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:03:57 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:55873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55873/tests/dromaeo/cssquery-ext.html) 11:03:59 INFO - PROCESS | 1967 | RSS: Main: 256012288 11:03:59 INFO - PROCESS | 1967 | 11:07:01 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:55873/tests/dromaeo/cssquery-ext.html (next: http://localhost:55873/tests/dromaeo/cssquery-jquery.html) 11:07:02 INFO - PROCESS | 1967 | RSS: Main: 266534912 11:07:02 INFO - PROCESS | 1967 | 11:10:04 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:55873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55873/tests/dromaeo/cssquery-mootools.html) 11:10:04 INFO - PROCESS | 1967 | RSS: Main: 270651392 11:10:04 INFO - PROCESS | 1967 | 11:13:06 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:55873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55873/tests/dromaeo/cssquery-prototype.html) 11:13:07 INFO - PROCESS | 1967 | RSS: Main: 270815232 11:13:07 INFO - PROCESS | 1967 | 11:16:10 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:55873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55873/tests/dromaeo/cssquery-yui.html) 11:16:11 INFO - PROCESS | 1967 | RSS: Main: 276197376 11:16:11 INFO - PROCESS | 1967 | 11:19:13 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:55873/tests/dromaeo/cssquery-yui.html (next: http://localhost:55873/tests/dromaeo/cssquery-dojo.html) 11:19:14 INFO - PROCESS | 1967 | RSS: Main: 278953984 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | __start_tp_report 11:19:14 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 11:19:14 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 11:19:14 INFO - PROCESS | 1967 | |i|pagename|runs| 11:19:14 INFO - PROCESS | 1967 | |0;dojo.html;3236.77342586019;3329.1011426914747;3350.7654464187503;3363.0583436637735;3384.8476818543163;5603.995006242198;5653.830385088449;5686.203931449595;5711.971440142804;5730.942690573093;5499.065158922983;5643.5203007744285;5646.096624540074;5698.344690360599;5714.399988001252;4248.874048377167;5196.272521846944;5229.686218826863;5268.841934741964;5278.577713782888;5197.558207552363;5218.295530103444;5253.028189784883;5254.159334506479;5269.1832765921345;5108.540231379176;5157.948420515803;5253.842384728464;5264.6051546134;5274.894502109955;4830.9275360869615;5190;5229.738513074331;5288.8413347599635;5290.92063619046;5001.749912504397;5039.3196918415915;5114.693118412907;5120.948790512084;5170.353705786777;5378.865528361783;5547.5007249347345;5551.944480555183;5582.413846546095;5605.131204663284;6009.399060094;6040.879182416371;6133.969330153365;6143.96928015357;6147.938520614782;6070.362611925729;6079.057746049325;6105.572609917308;6107.643995706967;6169.352218017133;5745.712714364265;5793.2179155814265;5806.1000544915605;5814.953308404528;5837.445442682981;6088.056351265561;6244.718987645567;6254.6247225166635;6258.655773932386;6292;5989.9101513477335;6031.366706495843;6083.087536869505;6107.175531303306;6142.355052719489;6110.837817827694;6118.20463339763;6147.692615369214;6156.6921653917125;6159.876802463926;6124.692665960331;6128.773097670088;6136.825445958321;6149.647077642911;6163.691815409212;4987.927595566898;5784.797532086357;5997.970010150008;6027.397260274025;6035.577509574287;4894.657373983858;4915.459299477055;4939.5554400104165;4944.381952255968;4973.452920178777;4405.207062728676;4416.977915110404;4425.380446737459;4447.444069491314;4476.574725401082;5547.334319881559;5722.62802917809;5750.2237197978575;5790.594658373958;5842.211301474246;6147.415995480422;6147.569670123138;6159.414855588712;6168.784092556829;6169.691515424211;5794.971025144847;5828.184054232411;5839.299284085937;5841.474267315962;5877.500412464903;5200.609954253446;5294.814681486129;5330.946690533123;5342.252084708144;5373.946260537423;6095.933211688026;6238.625682459067;6270.435660790551;6286.9626511625065;6293.087502312048;4664.813407463664;4770.666053376231;5447.96488667152;6137.018077107641;6170.969145154246;5641.379448260606;6063.878722425615;6096.451319381277;6261.74953001893;6289.811305660837;5270.314859068297;5662.8301150965535;6089.665068421102;6133.478654314434;6142.754289828536;5947.6431414115295;6101.664408457577;6103.05402662588;6119.418655227746;6134.754609815557;5862.091375836752;5954.702264886825;6017.669028203491;6053.243344581927;6060.454559089703;5998.280206375263;6043.516518678407;6064.514838812796;6065.029595264737;6105.9694701526205;5813.186153938536;5820.243368362086;5953.880922381441;5980;5997.520198384206;5859.121131830259;5961.672108033927;6014.609050411709;6017.06735456005;6017.428344307284;5908.852278693067;5952.494038006645;5977.22296101504;5992.161097446274;6043.214382130295 11:19:14 INFO - PROCESS | 1967 | |1;ext.html;495.9702417854929;515.7343967856552;522.5036215595185;529.1586377659521;534.0094125397387;40164.59835401645;41783.582164178384;41854.116564754586;41854.37218441726;42045.579544204586;33999;42900;43324.783376083156;43387.915302117464;43403.56596434035;9884.703458896245;10051.497425128751;10066.345687530324;10110.39337639744;10150.0864922157;9810.558524866363;9916.008399160062;9942.204623630128;9967.302288839785;9973.152282056033;8510.70212542561;9795.755106122333;9917;9957.651482198124;9976.351537150098;9756.609735610602;9871.555779989918;9913.65302214419;9931.652392166312;9939.850902236472;9855.605775768961;9868.506574671237;9942.403455792602;9942.602295908155;9953.452560109192;39747.602523974965;41364.37953430701;41638;41723.1655366894;41797;3560.2701446203464;3615.1685112424025;3920.15716620925;4095.303798354257;4220.662347012231;29257;31350.52974205389;31407.214819629462;31472.370552589047;31678.841605792055;3178.507331363642;3324.5345651608795;3348.916277093068;3369.25876307212;3388.390089783838;500576;500723.49638251576;501855;503500;506056;58385.41614583885;58775.41224587699;58855.705721471975;58956;59120;61588.69205653943;61636;61640;61660;61802.69098654478;16106.355745770272;16186.433474828324;16245.025298482129;16306.347746090261;16349.591260218353;12574.622761316992;12748.553800616934;12761.361931903368;12762.9361853192;12767.978561715041;15560.066396016275;15962.920185398998;15996.440124595583;16029;16098.919505402398;6826.781296078794;6833.829154271183;6859.279775623488;6922.342377474132;6938.022663540866;851.4976164063232;947.4978261521404;1057.39728354837;1119.7144728094283;1121.8036843552509;22024.779752202274;23892.88053559721;29338;30189.547156792665;30825.845870770503;1068.0654427376046;1083.7615724540588;1104.0119093411352;1146.043054049861;1148.758760660254;12574;14942;15484.922575387276;15849.603759905864;15864.44474443389;639304;652905;653699;653987;654473;47271.5272847274;57834.421655782906;58011.709941450026;58162;58181.70909145427;1354.4582167133226;1373.3656948231574;1391.6033930329806;1401.9439222430988;1413.7172565486944;25774.613380799678;27496.58755118635;28656.426871462038;29295.85352073226;29941.550876737303;42018.57981420269;48325.03349933052;48983.53049408524;49055;49281.75359123181;580958;587112;587355.0632246812;587402;589401;23972;25937.22188334353;26128.8693556531;27897.16308510748;38921.80539097286;38791.6120838788;44956.550434495235;46303.07393852037;47046.52953470421;47964.7601761989;33704;37204.33207254633;37231.81384093062;38219.42670859995;38252.80873595614;38327.2334553313;38526;38816;39213.80393098016;39235.41146882742;37775.62224377721;38302.42546361862;38663.806680966416;38711.22577548377;40403.1919361617;25680.61479077778;33994.15014624654;35185.824070879484;35656.573737050225;35990.92027239187;24167.637485438085;25701.742982570682;25902.48195036051;26049.348766280236;26490.86754566215 11:19:14 INFO - PROCESS | 1967 | |2;jquery.html;361.92761447710456;363.4439307858975;366.32413197650345;370.57384008390363;392.0179949227186;19636.410907672776;20744.89627551864;21007;21203.257885973995;21404.14383424665;20047.69928451071;20314;20500.28249011281;20767.688484672704;20804.8959755201;5125.974370128144;5918.792842250522;6180.227471566054;6217.751289948396;6232.750689972396;5264.289320941682;6063.211782468273;6102.969485152568;6107.664078475682;6193.597416167935;5279.419263880989;5492.780288788444;6093.756249750005;6168.105624684418;6199.039148931923;6157;6220.7822726204595;6221.097940798604;6226.097215903714;6564.737410503574;6030.33666296707;6035.275766907956;6039.339181725017;6060.696965151725;6105.542084343692;13385.129966552144;16476.67046659072;20011.899940500203;24933.750662493323;25138.371540711447;2183.355910006536;2251.6960210371553;2256.605094108541;2281.646344816556;3036.9848150759326;9325.860112098324;9832.360896541773;10138.39169649816;10343.345064789597;14624.122552646875;1787.6692811829853;1870.8690391672587;1904.866659333847;1906.761654793151;1963.3619073801071;118239.8176018246;123468;127051;127217.09174362393;131612;11031.669049928514;11189.832152517718;11311.377874216832;11473.024792892531;11625.59310424131;14257.287135643177;14416.495422660366;14438.061526000776;14446.783298250535;14509;8315.417920745489;8465.788355291166;8477.576121193915;8601.397902146915;8616.526091064927;7430.925690743132;8033.1163572007035;8372.28835548985;8417.579121043924;8539.957300213584;4379.824807007748;4484.730916144977;4486.820527178941;4569.497355290915;4613.331066995267;1643.4412299818118;1713.2975480053367;1807.7198034304704;1871.9344822931132;1934.071645610087;792.5442870349572;817.4032955942076;909.6997990663198;934.8270569944582;954.9474778887089;14736.968412211043;18111.45665630033;18722.81277187238;19574.217031318873;19746.40760777179;793.4564823096198;910.6220918318955;918.9586468608928;968.801395713877;999.3604093380243;9421.434713917188;10383.584656613803;10724.785504290026;10780.191485638608;10790.406527640898;425293;514943;516541;599038;603138;103833;135223;136986;145556.27221864034;146874;951.362587066667;973.956171972263;1016.5527168046036;1032.9741756455999;1044.1438020823005;17284.87648302856;18710.90644546823;19125.948072856125;19144.80855191486;19430.90284548568;57301.713491432274;58618;60110.09834852568;60268;60660.696696516236;66386.00420993786;72193;74498.88251676338;75660;77222.45555088979;6621.702023408862;7958.880616790869;8096.664050431613;8146.0632027317615;8283.710070147516;10534.736631584272;12465.252084874937;12674.556390526288;12869.22784632925;12900.161489503153;10306.175505959654;10579.62971296001;11068;11112.22214444981;11184.664460066211;8529.232369086812;10230.6419275325;10395.896041039492;10458.424786636808;11179.496922638338;10907.98202332571;11057.115430765358;11214.943925280322;11366.772664546828;11498.137639677225;7848.60756962161;8082.030156381272;8134.227248411392;8203.30271926869;8258.793530161794;10476.423796691255;10824.945875270574;10940;11173.273737207055;11269.436528173723 11:19:14 INFO - PROCESS | 1967 | |3;mootools.html;1384.8822850057745;1544.7914531538242;1717.5791930976904;1815.2466726308583;1820.9908950455247;8040.31657309128;8270.545120018396;8442.746717598475;9011.279097672186;9044.321675874311;8453.239208471236;8715.694950676727;8759.299256059516;8864.98052723937;8868.91131088689;2324.4421338878715;2332.3819187915215;2337.1703045418885;2337.9649305260436;2340.578695834749;1963.2735887721562;2295.5867943770113;2318.7449380568123;2346.4837735698206;2352.9176478823247;2289.8626082435026;2333.136739406422;2347.80043696286;2354.705661792276;2362.5629258587132;2290.5876942150408;2302.7121609798774;2318.107528601484;2324.0471406723245;2336.264076815806;2300.0224904415722;2303.896324665394;2304.7695230476984;2304.896279667419;2311.1217737259904;8804.251638610725;8903.510306933116;8934.821303573892;9005.639774409015;9011.369204155711;5098.546914129455;5227.3465816772905;5365.731713414314;5386.111291636876;5396.649217800869;2746.917592472229;2782.6660800704044;2802.7807903562016;2942.396808654221;3642.05306620278;1079.1852151625471;1089.5696200000955;1090.1769164280997;1092.6175838456556;1109.2457129152174;9711;11505.482253298622;11597.014253788439;11762.58830940913;11777.116716246315;4217.810198541073;4595.747233902168;4654.789754663744;4770.809167633256;4791.089692958327;8475.788105297293;9218.677346292847;9475.905240947503;9935.503224838874;10134.290599657954;5278.9208161877605;5317.30874986257;5354.946450535523;5358.089124848785;5359.758810853521;4404.427424434803;4520.706154099973;4818.542238487338;4845.63657725672;4920.065187614342;3586.6234045424853;3817.8854634361014;3901.336772748583;3904.2386734587053;4019.532870502304;1267.7781388257017;1286.0676009892752;1287.7875150600046;1290.2967882504058;1290.4064130499887;771.4908160613968;824.5135370131532;865.2299453486402;908.8818453601122;927.8144371125802;5614.9438505615235;5747.918977526004;5765.88468230633;5767.163761254595;5945.494632956247;408.88142438692444;426.2625657612348;431.10760725298957;438.2374668077586;447.5479765436932;3933.272344616198;3961.7821019844187;4013.5585085640555;4077.8776636700945;4093.8771836844944;10566.471676416302;10823.891761082288;10982.121430285559;10996.945015275032;11083.057940075183;9229.030951750105;10742.677719668422;10793.974572415607;10932.836007459895;10946;8172.550509721904;8180.9590952044855;8231.382646301432;8244.628991695388;8336.749897503085;4981.775820088033;5888.528917686661;5994.07091900756;5996.70016499182;6027.517798576191;9511.857322140311;10165.695029149138;10227.43749093807;10266.178705703674;10286.948565257426;8330.291925186428;9773.804523909625;10356.637517686844;10400.531976061247;10412.271141020055;7611.657475413509;7876.09424916142;7890.605469726605;8253.33973282124;8367.368363169124;8380.958095209486;8676.479411235347;8691.521966291915;8696.91303086961;8700.956495217484;7521.135069467081;7532.698692052257;7549.320561149523;7582.393408527194;7654.387648988179;7338.706451742084;7425.405967522477;7466.962665186857;7529.661165247468;7575.734849280248;6904.240533541206;6937.098177236927;6942.271061538668;7051.083359163276;7066.152061752623;4792.688475249098;4994.600431965507;5088.287639730367;5119.667221630582;5143.279940808215;5038.924416133834;5071.492850714899;5173.534381905646;5174.404943431554;5185.9887321971855 11:19:14 INFO - PROCESS | 1967 | |4;prototype.html;248.05614636308837;272.72863500816686;308.8131680333398;311.9610048743907;313.0857894946755;4120.608542188487;4236.301010333299;4517.9548204517905;5296.258523806665;5655.4910058094765;5259.237410575464;5423.620346575742;5506.944930550693;5520.337559492857;5557.166425036236;3917.412388141773;4203.453551038361;4217.261979153651;4231.386448964899;4248.851290204843;3865.2849222893715;4163.7501749894955;4220.662347012231;4237.300845360512;4240.473429565354;3619.963800362002;4064.0855807443236;4129.380592911058;4137.875863724078;4152.211079894825;3395.3718562066097;4158.14757974616;4170.311898536723;4173.580982465945;4180.498340199196;3573.4818451324413;3576.946345804815;3594.478800573902;3606.945895811565;3612.729045321585;5181.4300426953005;5186.896262074775;5242.187460943522;5342.572594192456;5365.624406291561;4110.1779644071;4754.597393768847;4771.642126840501;4792.0895029944195;4808;5069.594432445432;5777.855553611152;5817.883642327172;5826.708664566755;5867.325257595346;3340.9643010666528;3411.522386865841;3663.358912190383;3918.294706952747;3924.5682974872743;5095.439501654815;5197.220416937452;5312.893742125175;6153.476954458876;6242.406971337716;3705.370087085148;3808.5239345081864;3906.90232744178;4040.111175541435;4058.7158898877387;3309.1561651779125;3442.3115376924716;3718.6095459976855;4103.835846566104;4114.177164567099;3845.615438456132;4070.531888832763;4384.7369157850635;4789.994101238779;4805.438232574357;5207.869803254949;5881.000229960917;5932.673702946379;5940.198073260141;5983.730732117066;1154.8671902731126;1347.730453909222;1351.6485713714505;1361.754884120848;1377.5936098850864;892.8081011849254;903.263839970422;919.8685616691507;930.432436213909;934.6401635370296;4937.012597480519;5369.516743493026;5376.838694839083;5392.973035134799;5429;5026.949730502722;5908.793192238337;5939.812037592499;5952.642841429528;5994.430529099728;4536.954630453653;5073.7716802743225;5350.545203657655;5378.838634840961;5443.727813609304;2801.8599070046416;3124.9218769530944;3137.8431078445988;3167.857446414917;3183;5551.111822108443;6211.565190436626;6242.781502647385;6252.74989000444;6257;4822.638302127284;5544.86137846549;6097.725602347905;6255.749770009149;6310.8422289442215;4830.975845120752;6261.624302541862;6361.9045714314325;6376.872462550723;6395.456386207225;5439.428859969805;5758.683272420057;5990.850228744316;6055.303640081271;6099.072445226405;5545.417731138334;6029.282518376485;6042.607230530001;6043.697815109315;6115.84710382244;5346.358436987586;5846.298444186725;6342.334054924167;6375.6812159392775;6389.9232749355715;3218.197809226747;3514.648535146465;3969.9404508932967;4004.1591265833335;4021.6983726220064;5371.448561933207;5783.797567085132;6127.724252408741;6138.877222455615;6140.109684095692;5720.513756330759;5747.511461525817;5834.38738932406;5849.356570777296;5875.618084824473;4872.222832985306;5396.7571459283645;5816.5055970243;5877.912586171572;5908.291005079246;5216.035033518811;5372.636040142481;5582.637128586629;5588.385277619377;5623.314931313352;5478.808241711521;5859.070464767617;5884.440978107073;5886.851299275648;5912.46787789101;5092.719900405513;5480.753366098455;5743.368229494668;5818.214541036906;5830.530834153672 11:19:14 INFO - PROCESS | 1967 | |5;yui.html;688.4423616870339;750.0099868174009;757.9886301705471;769.8575763483755;828.0229329391318;15641.139737314443;16399.83600164001;16425.75361369579;16427.507174784776;16478.588035299123;14524.636884077903;14728.410863565445;14999.625009374771;15005.699886002274;15203.54389368318;839.5340585974797;852.86780549015;858.3605214115493;861.6036623153357;862.4221771413137;682.2120450879243;690.8187000229614;702.722424642266;861.2980420956932;868.4962721621476;884.0143240287098;911.5761171055458;912.2884150362728;913.8492148795441;916.8258030974093;869.2654706772767;905.6377449020445;907.160876189522;907.7140700679331;908.5548081440113;662.261578340152;675.6722989350161;676.2966514824576;677.8237658208901;680.0275605883585;15638.765418518731;15756.448524301595;15763.605909852231;15949.282282297325;15971.920140399223;14632.92683536586;14651.706965860623;14692.779608305884;14742.484013059491;15029.549113526611;11737.631742095475;11897.643070707893;11957.162998590102;12252.142350035501;12474.875251247462;3840.961590384088;3927.764334139932;3935.6064393560414;4046.615571520701;4053.493313335833;83273.58363208146;118297.40851295774;120191;122820;123034.38482807529;11255.212135150461;11382.772344553228;11422.942885285687;11431.256968297033;11524.193306468635;22594.435139121655;23673.171438999554;23791.40521486942;23866.045358185824;23876.880615596812;7539.811504712426;7903.407244456689;7999.400044996532;8157.3881958852135;8168;3138.544910987894;4349.499807522176;4389.912201756011;4439.556044395535;4521.909561808746;2939.8383088930314;3509.137655479135;3665.138692407282;3677.7793332400142;3678.613745556678;553.6567328256507;638.2436812377348;642.5213216153995;643.4498503779295;654.2280109470775;501.3657722980433;517.9378474583074;525.7844283843606;551.4788524844064;618.1716499890168;9254.491002994766;9303.674371396968;9397.859032114524;9466.857997130048;9551.952240238754;657.7829316325601;679.894616334469;683.2620769568953;684.9931500685029;703.2791388826391;3794.29805485986;4468.32975053738;4528.41130653013;4573.285018118206;4625.074985003012;168050;172656;173701;173959;180201.0989945042;114802.32060582499;138339;144443;144538;147449;108528.91471085188;119740;121248;123030;126184;8932.553372331487;9039.322050846082;9111.635534578543;9172.724818255463;9192.36781381028;49397.27109551148;50546.74726626343;54177.729111354194;61090;61476;83437;85613.57193214243;89169;97448.5127574386;100454.4977275109;13014.4143513544;13207.933960330136;13283.468661253442;13467.86532134666;14010.43958241659;14777.482788102365;14837.92581037088;14884.404623814926;15231.695366092838;15398.307076181824;13681.384337705027;13826.585202443943;13848.446062157402;13933.58199254024;13995;13610.93194534021;13688.726225475235;13729.313534323044;13805.447782088604;13918.791218131533;11198.38408887519;11635.53457861676;11691.532338706356;11706.473208705798;13666.590002299947;8357.247847693738;8943.418677785923;9291.72124836256;11506;11564.190506664452;8992.55037248148;10761.139108871428;11326.773464530499;11506.30962142274;11756.412179391167 11:19:14 INFO - PROCESS | 1967 | __end_tp_report 11:19:14 INFO - PROCESS | 1967 | __start_cc_report 11:19:14 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,355 11:19:14 INFO - PROCESS | 1967 | __end_cc_report 11:19:14 INFO - PROCESS | 1967 | __startTimestamp1475777954168__endTimestamp 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | ------- Summary: start ------- 11:19:14 INFO - PROCESS | 1967 | Number of tests: 6 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5644.71 Median:5841.47 stddev:626.51 (10.7%) stddev-sans-first:599.28 11:19:14 INFO - PROCESS | 1967 | Values: 3236.8 3329.1 3350.8 3363.1 3384.8 5604.0 5653.8 5686.2 5712.0 5730.9 5499.1 5643.5 5646.1 5698.3 5714.4 4248.9 5196.3 5229.7 5268.8 5278.6 5197.6 5218.3 5253.0 5254.2 5269.2 5108.5 5157.9 5253.8 5264.6 5274.9 4830.9 5190.0 5229.7 5288.8 5290.9 5001.7 5039.3 5114.7 5120.9 5170.4 5378.9 5547.5 5551.9 5582.4 5605.1 6009.4 6040.9 6134.0 6144.0 6147.9 6070.4 6079.1 6105.6 6107.6 6169.4 5745.7 5793.2 5806.1 5815.0 5837.4 6088.1 6244.7 6254.6 6258.7 6292.0 5989.9 6031.4 6083.1 6107.2 6142.4 6110.8 6118.2 6147.7 6156.7 6159.9 6124.7 6128.8 6136.8 6149.6 6163.7 4987.9 5784.8 5998.0 6027.4 6035.6 4894.7 4915.5 4939.6 4944.4 4973.5 4405.2 4417.0 4425.4 4447.4 4476.6 5547.3 5722.6 5750.2 5790.6 5842.2 6147.4 6147.6 6159.4 6168.8 6169.7 5795.0 5828.2 5839.3 5841.5 5877.5 5200.6 5294.8 5330.9 5342.3 5373.9 6095.9 6238.6 6270.4 6287.0 6293.1 4664.8 4770.7 5448.0 6137.0 6171.0 5641.4 6063.9 6096.5 6261.7 6289.8 5270.3 5662.8 6089.7 6133.5 6142.8 5947.6 6101.7 6103.1 6119.4 6134.8 5862.1 5954.7 6017.7 6053.2 6060.5 5998.3 6043.5 6064.5 6065.0 6106.0 5813.2 5820.2 5953.9 5980.0 5997.5 5859.1 5961.7 6014.6 6017.1 6017.4 5908.9 5952.5 5977.2 5992.2 6043.2 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:70802.93 Median:39491.51 stddev:155938.28 (394.9%) stddev-sans-first:156286.38 11:19:14 INFO - PROCESS | 1967 | Values: 496.0 515.7 522.5 529.2 534.0 40164.6 41783.6 41854.1 41854.4 42045.6 33999.0 42900.0 43324.8 43387.9 43403.6 9884.7 10051.5 10066.3 10110.4 10150.1 9810.6 9916.0 9942.2 9967.3 9973.2 8510.7 9795.8 9917.0 9957.7 9976.4 9756.6 9871.6 9913.7 9931.7 9939.9 9855.6 9868.5 9942.4 9942.6 9953.5 39747.6 41364.4 41638.0 41723.2 41797.0 3560.3 3615.2 3920.2 4095.3 4220.7 29257.0 31350.5 31407.2 31472.4 31678.8 3178.5 3324.5 3348.9 3369.3 3388.4 500576.0 500723.5 501855.0 503500.0 506056.0 58385.4 58775.4 58855.7 58956.0 59120.0 61588.7 61636.0 61640.0 61660.0 61802.7 16106.4 16186.4 16245.0 16306.3 16349.6 12574.6 12748.6 12761.4 12762.9 12768.0 15560.1 15962.9 15996.4 16029.0 16098.9 6826.8 6833.8 6859.3 6922.3 6938.0 851.5 947.5 1057.4 1119.7 1121.8 22024.8 23892.9 29338.0 30189.5 30825.8 1068.1 1083.8 1104.0 1146.0 1148.8 12574.0 14942.0 15484.9 15849.6 15864.4 639304.0 652905.0 653699.0 653987.0 654473.0 47271.5 57834.4 58011.7 58162.0 58181.7 1354.5 1373.4 1391.6 1401.9 1413.7 25774.6 27496.6 28656.4 29295.9 29941.6 42018.6 48325.0 48983.5 49055.0 49281.8 580958.0 587112.0 587355.1 587402.0 589401.0 23972.0 25937.2 26128.9 27897.2 38921.8 38791.6 44956.6 46303.1 47046.5 47964.8 33704.0 37204.3 37231.8 38219.4 38252.8 38327.2 38526.0 38816.0 39213.8 39235.4 37775.6 38302.4 38663.8 38711.2 40403.2 25680.6 33994.2 35185.8 35656.6 35990.9 24167.6 25701.7 25902.5 26049.3 26490.9 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:33351.15 Median:13607.70 stddev:90540.50 (665.4%) stddev-sans-first:90760.61 11:19:14 INFO - PROCESS | 1967 | Values: 361.9 363.4 366.3 370.6 392.0 19636.4 20744.9 21007.0 21203.3 21404.1 20047.7 20314.0 20500.3 20767.7 20804.9 5126.0 5918.8 6180.2 6217.8 6232.8 5264.3 6063.2 6103.0 6107.7 6193.6 5279.4 5492.8 6093.8 6168.1 6199.0 6157.0 6220.8 6221.1 6226.1 6564.7 6030.3 6035.3 6039.3 6060.7 6105.5 13385.1 16476.7 20011.9 24933.8 25138.4 2183.4 2251.7 2256.6 2281.6 3037.0 9325.9 9832.4 10138.4 10343.3 14624.1 1787.7 1870.9 1904.9 1906.8 1963.4 118239.8 123468.0 127051.0 127217.1 131612.0 11031.7 11189.8 11311.4 11473.0 11625.6 14257.3 14416.5 14438.1 14446.8 14509.0 8315.4 8465.8 8477.6 8601.4 8616.5 7430.9 8033.1 8372.3 8417.6 8540.0 4379.8 4484.7 4486.8 4569.5 4613.3 1643.4 1713.3 1807.7 1871.9 1934.1 792.5 817.4 909.7 934.8 954.9 14737.0 18111.5 18722.8 19574.2 19746.4 793.5 910.6 919.0 968.8 999.4 9421.4 10383.6 10724.8 10780.2 10790.4 425293.0 514943.0 516541.0 599038.0 603138.0 103833.0 135223.0 136986.0 145556.3 146874.0 951.4 974.0 1016.6 1033.0 1044.1 17284.9 18710.9 19125.9 19144.8 19430.9 57301.7 58618.0 60110.1 60268.0 60660.7 66386.0 72193.0 74498.9 75660.0 77222.5 6621.7 7958.9 8096.7 8146.1 8283.7 10534.7 12465.3 12674.6 12869.2 12900.2 10306.2 10579.6 11068.0 11112.2 11184.7 8529.2 10230.6 10395.9 10458.4 11179.5 10908.0 11057.1 11214.9 11366.8 11498.1 7848.6 8082.0 8134.2 8203.3 8258.8 10476.4 10824.9 10940.0 11173.3 11269.4 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5681.75 Median:4882.85 stddev:3231.60 (66.2%) stddev-sans-first:3224.53 11:19:14 INFO - PROCESS | 1967 | Values: 1384.9 1544.8 1717.6 1815.2 1821.0 8040.3 8270.5 8442.7 9011.3 9044.3 8453.2 8715.7 8759.3 8865.0 8868.9 2324.4 2332.4 2337.2 2338.0 2340.6 1963.3 2295.6 2318.7 2346.5 2352.9 2289.9 2333.1 2347.8 2354.7 2362.6 2290.6 2302.7 2318.1 2324.0 2336.3 2300.0 2303.9 2304.8 2304.9 2311.1 8804.3 8903.5 8934.8 9005.6 9011.4 5098.5 5227.3 5365.7 5386.1 5396.6 2746.9 2782.7 2802.8 2942.4 3642.1 1079.2 1089.6 1090.2 1092.6 1109.2 9711.0 11505.5 11597.0 11762.6 11777.1 4217.8 4595.7 4654.8 4770.8 4791.1 8475.8 9218.7 9475.9 9935.5 10134.3 5278.9 5317.3 5354.9 5358.1 5359.8 4404.4 4520.7 4818.5 4845.6 4920.1 3586.6 3817.9 3901.3 3904.2 4019.5 1267.8 1286.1 1287.8 1290.3 1290.4 771.5 824.5 865.2 908.9 927.8 5614.9 5747.9 5765.9 5767.2 5945.5 408.9 426.3 431.1 438.2 447.5 3933.3 3961.8 4013.6 4077.9 4093.9 10566.5 10823.9 10982.1 10996.9 11083.1 9229.0 10742.7 10794.0 10932.8 10946.0 8172.6 8181.0 8231.4 8244.6 8336.7 4981.8 5888.5 5994.1 5996.7 6027.5 9511.9 10165.7 10227.4 10266.2 10286.9 8330.3 9773.8 10356.6 10400.5 10412.3 7611.7 7876.1 7890.6 8253.3 8367.4 8381.0 8676.5 8691.5 8696.9 8701.0 7521.1 7532.7 7549.3 7582.4 7654.4 7338.7 7425.4 7467.0 7529.7 7575.7 6904.2 6937.1 6942.3 7051.1 7066.2 4792.7 4994.6 5088.3 5119.7 5143.3 5038.9 5071.5 5173.5 5174.4 5186.0 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:4677.34 Median:5304.58 stddev:1483.92 (28.0%) stddev-sans-first:1450.37 11:19:14 INFO - PROCESS | 1967 | Values: 248.1 272.7 308.8 312.0 313.1 4120.6 4236.3 4518.0 5296.3 5655.5 5259.2 5423.6 5506.9 5520.3 5557.2 3917.4 4203.5 4217.3 4231.4 4248.9 3865.3 4163.8 4220.7 4237.3 4240.5 3620.0 4064.1 4129.4 4137.9 4152.2 3395.4 4158.1 4170.3 4173.6 4180.5 3573.5 3576.9 3594.5 3606.9 3612.7 5181.4 5186.9 5242.2 5342.6 5365.6 4110.2 4754.6 4771.6 4792.1 4808.0 5069.6 5777.9 5817.9 5826.7 5867.3 3341.0 3411.5 3663.4 3918.3 3924.6 5095.4 5197.2 5312.9 6153.5 6242.4 3705.4 3808.5 3906.9 4040.1 4058.7 3309.2 3442.3 3718.6 4103.8 4114.2 3845.6 4070.5 4384.7 4790.0 4805.4 5207.9 5881.0 5932.7 5940.2 5983.7 1154.9 1347.7 1351.6 1361.8 1377.6 892.8 903.3 919.9 930.4 934.6 4937.0 5369.5 5376.8 5393.0 5429.0 5026.9 5908.8 5939.8 5952.6 5994.4 4537.0 5073.8 5350.5 5378.8 5443.7 2801.9 3124.9 3137.8 3167.9 3183.0 5551.1 6211.6 6242.8 6252.7 6257.0 4822.6 5544.9 6097.7 6255.7 6310.8 4831.0 6261.6 6361.9 6376.9 6395.5 5439.4 5758.7 5990.9 6055.3 6099.1 5545.4 6029.3 6042.6 6043.7 6115.8 5346.4 5846.3 6342.3 6375.7 6389.9 3218.2 3514.6 3969.9 4004.2 4021.7 5371.4 5783.8 6127.7 6138.9 6140.1 5720.5 5747.5 5834.4 5849.4 5875.6 4872.2 5396.8 5816.5 5877.9 5908.3 5216.0 5372.6 5582.6 5588.4 5623.3 5478.8 5859.1 5884.4 5886.9 5912.5 5092.7 5480.8 5743.4 5818.2 5830.5 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:26061.05 Median:3678.20 stddev:43290.91 (1177.0%) stddev-sans-first:43370.43 11:19:14 INFO - PROCESS | 1967 | Values: 688.4 750.0 758.0 769.9 828.0 15641.1 16399.8 16425.8 16427.5 16478.6 14524.6 14728.4 14999.6 15005.7 15203.5 839.5 852.9 858.4 861.6 862.4 682.2 690.8 702.7 861.3 868.5 884.0 911.6 912.3 913.8 916.8 869.3 905.6 907.2 907.7 908.6 662.3 675.7 676.3 677.8 680.0 15638.8 15756.4 15763.6 15949.3 15971.9 14632.9 14651.7 14692.8 14742.5 15029.5 11737.6 11897.6 11957.2 12252.1 12474.9 3841.0 3927.8 3935.6 4046.6 4053.5 83273.6 118297.4 120191.0 122820.0 123034.4 11255.2 11382.8 11422.9 11431.3 11524.2 22594.4 23673.2 23791.4 23866.0 23876.9 7539.8 7903.4 7999.4 8157.4 8168.0 3138.5 4349.5 4389.9 4439.6 4521.9 2939.8 3509.1 3665.1 3677.8 3678.6 553.7 638.2 642.5 643.4 654.2 501.4 517.9 525.8 551.5 618.2 9254.5 9303.7 9397.9 9466.9 9552.0 657.8 679.9 683.3 685.0 703.3 3794.3 4468.3 4528.4 4573.3 4625.1 168050.0 172656.0 173701.0 173959.0 180201.1 114802.3 138339.0 144443.0 144538.0 147449.0 108528.9 119740.0 121248.0 123030.0 126184.0 8932.6 9039.3 9111.6 9172.7 9192.4 49397.3 50546.7 54177.7 61090.0 61476.0 83437.0 85613.6 89169.0 97448.5 100454.5 13014.4 13207.9 13283.5 13467.9 14010.4 14777.5 14837.9 14884.4 15231.7 15398.3 13681.4 13826.6 13848.4 13933.6 13995.0 13610.9 13688.7 13729.3 13805.4 13918.8 11198.4 11635.5 11691.5 11706.5 13666.6 8357.2 8943.4 9291.7 11506.0 11564.2 8992.6 10761.1 11326.8 11506.3 11756.4 11:19:14 INFO - PROCESS | 1967 | -------- Summary: end -------- 11:19:14 INFO - PROCESS | 1967 | 11:19:14 INFO - TEST-INFO | 1967: exit 0 11:19:14 INFO - TEST-OK | dromaeo_css | took 1116886ms 11:19:14 INFO - TEST-START | kraken 11:19:14 INFO - operating with platform_type : mac_ 11:19:14 INFO - Initialising browser for kraken test... 11:19:14 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpiSVFDu/profile http://localhost:55873/getInfo.html) 11:19:17 INFO - PROCESS | 1971 | 2016-10-06 11:19:17.593 plugin-container[1972:24554] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 11:19:17 INFO - PROCESS | 1971 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:17 INFO - PROCESS | 1971 | 2016-10-06 11:19:17.596 plugin-container[1972:24554] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 11:19:17 INFO - PROCESS | 1971 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:17 INFO - PROCESS | 1971 | 2016-10-06 11:19:17.596 plugin-container[1972:24554] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:19:17 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 11:19:17 INFO - PROCESS | 1971 | colorDepth:24 11:19:17 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 11:19:17 INFO - PROCESS | 1971 | __metrics 11:19:17 ERROR - PROCESS | 1971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 11:19:18 INFO - TEST-INFO | 1971: exit 0 11:19:18 INFO - Browser initialized. 11:19:18 INFO - Running cycle 1/1 for kraken test... 11:19:18 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/tmpiSVFDu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:21 INFO - PROCESS | 1973 | 2016-10-06 11:19:21.113 plugin-container[1974:24669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.tsm.portname' 11:19:21 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:21 INFO - PROCESS | 1973 | 2016-10-06 11:19:21.116 plugin-container[1974:24669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 11:19:21 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:21 INFO - PROCESS | 1973 | 2016-10-06 11:19:21.116 plugin-container[1974:24669] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:19:30 INFO - PROCESS | 1973 | RSS: Main: 240459776 11:19:30 INFO - PROCESS | 1973 | 11:19:33 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55873/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:34 INFO - PROCESS | 1973 | RSS: Main: 253751296 11:19:34 INFO - PROCESS | 1973 | 11:19:37 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55873/tests/kraken/driver.html?testName=audio-dft) 11:19:37 INFO - PROCESS | 1973 | RSS: Main: 262074368 11:19:37 INFO - PROCESS | 1973 | 11:19:41 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55873/tests/kraken/driver.html?testName=audio-fft) 11:19:41 INFO - PROCESS | 1973 | RSS: Main: 262574080 11:19:41 INFO - PROCESS | 1973 | 11:19:43 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55873/tests/kraken/driver.html?testName=audio-oscillator) 11:19:44 INFO - PROCESS | 1973 | RSS: Main: 263331840 11:19:44 INFO - PROCESS | 1973 | 11:19:46 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:47 INFO - PROCESS | 1973 | RSS: Main: 263651328 11:19:47 INFO - PROCESS | 1973 | 11:19:49 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55873/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:50 INFO - PROCESS | 1973 | RSS: Main: 264314880 11:19:50 INFO - PROCESS | 1973 | 11:19:53 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55873/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:54 INFO - PROCESS | 1973 | RSS: Main: 264523776 11:19:54 INFO - PROCESS | 1973 | 11:19:57 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55873/tests/kraken/driver.html?testName=json-parse-financial) 11:19:57 INFO - PROCESS | 1973 | RSS: Main: 266194944 11:19:57 INFO - PROCESS | 1973 | 11:19:59 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:00 INFO - PROCESS | 1973 | RSS: Main: 265191424 11:20:00 INFO - PROCESS | 1973 | 11:20:01 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:02 INFO - PROCESS | 1973 | RSS: Main: 265269248 11:20:02 INFO - PROCESS | 1973 | 11:20:04 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:05 INFO - PROCESS | 1973 | RSS: Main: 265285632 11:20:05 INFO - PROCESS | 1973 | 11:20:08 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:09 INFO - PROCESS | 1973 | RSS: Main: 265711616 11:20:09 INFO - PROCESS | 1973 | 11:20:12 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:12 INFO - PROCESS | 1973 | RSS: Main: 265629696 11:20:12 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:55873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55873/tests/kraken/driver.html?testName=ai-astar) 11:20:14 INFO - PROCESS | 1973 | RSS: Main: 266981376 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | __start_tp_report 11:20:14 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 11:20:14 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 11:20:14 INFO - PROCESS | 1973 | |i|pagename|runs| 11:20:14 INFO - PROCESS | 1973 | |0;ai-astar;114;116;119;117;117;120;117;119;118;117 11:20:14 INFO - PROCESS | 1973 | |1;audio-beat-detection;146;125;116;150;116;117;124;147;182;100 11:20:14 INFO - PROCESS | 1973 | |2;audio-dft;208;215;212;198;195;225;253;201;194;198 11:20:14 INFO - PROCESS | 1973 | |3;audio-fft;82;57;58;84;63;60;59;73;74;63 11:20:14 INFO - PROCESS | 1973 | |4;audio-oscillator;99;73;75;84;99;101;76;93;58;89 11:20:14 INFO - PROCESS | 1973 | |5;imaging-gaussian-blur;91;87;88;86;90;85;90;86;88;88 11:20:14 INFO - PROCESS | 1973 | |6;imaging-darkroom;151;118;95;95;95;96;96;94;95;152 11:20:14 INFO - PROCESS | 1973 | |7;imaging-desaturate;91;92;91;132;144;93;91;153;126;93 11:20:14 INFO - PROCESS | 1973 | |8;json-parse-financial;57;57;56;56;57;56;58;55;55;63 11:20:14 INFO - PROCESS | 1973 | |9;json-stringify-tinderbox;69;76;71;87;79;75;69;63;84;105 11:20:14 INFO - PROCESS | 1973 | |10;stanford-crypto-aes;91;87;94;109;113;87;90;92;88;92 11:20:14 INFO - PROCESS | 1973 | |11;stanford-crypto-ccm;139;161;139;165;167;165;157;168;193;149 11:20:14 INFO - PROCESS | 1973 | |12;stanford-crypto-pbkdf2;176;190;176;179;175;174;179;176;177;172 11:20:14 INFO - PROCESS | 1973 | |13;stanford-crypto-sha256-iterative;62;85;99;68;68;67;68;77;86;94 11:20:14 INFO - PROCESS | 1973 | __end_tp_report 11:20:14 INFO - PROCESS | 1973 | __start_cc_report 11:20:14 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,927 11:20:14 INFO - PROCESS | 1973 | __end_cc_report 11:20:14 INFO - PROCESS | 1973 | __startTimestamp1475778014937__endTimestamp 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | ------- Summary: start ------- 11:20:14 INFO - PROCESS | 1973 | Number of tests: 14 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#0] ai-astar Cycles:10 Average:117.40 Median:117.50 stddev:1.71 (1.5%) stddev-sans-first:1.30 11:20:14 INFO - PROCESS | 1973 | Values: 114.0 116.0 119.0 117.0 117.0 120.0 117.0 119.0 118.0 117.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:135.50 stddev:23.85 (17.6%) stddev-sans-first:24.77 11:20:14 INFO - PROCESS | 1973 | Values: 146.0 125.0 116.0 150.0 116.0 117.0 124.0 147.0 182.0 100.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#2] audio-dft Cycles:10 Average:209.90 Median:210.00 stddev:18.13 (8.6%) stddev-sans-first:19.21 11:20:14 INFO - PROCESS | 1973 | Values: 208.0 215.0 212.0 198.0 195.0 225.0 253.0 201.0 194.0 198.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#3] audio-fft Cycles:10 Average:67.30 Median:68.00 stddev:10.13 (14.9%) stddev-sans-first:9.25 11:20:14 INFO - PROCESS | 1973 | Values: 82.0 57.0 58.0 84.0 63.0 60.0 59.0 73.0 74.0 63.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#4] audio-oscillator Cycles:10 Average:84.70 Median:86.50 stddev:14.07 (16.3%) stddev-sans-first:13.94 11:20:14 INFO - PROCESS | 1973 | Values: 99.0 73.0 75.0 84.0 99.0 101.0 76.0 93.0 58.0 89.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:1.97 (2.2%) stddev-sans-first:1.74 11:20:14 INFO - PROCESS | 1973 | Values: 91.0 87.0 88.0 86.0 90.0 85.0 90.0 86.0 88.0 88.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#6] imaging-darkroom Cycles:10 Average:108.70 Median:95.00 stddev:23.66 (24.9%) stddev-sans-first:19.53 11:20:14 INFO - PROCESS | 1973 | Values: 151.0 118.0 95.0 95.0 95.0 96.0 96.0 94.0 95.0 152.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#7] imaging-desaturate Cycles:10 Average:110.60 Median:91.00 stddev:25.22 (27.7%) stddev-sans-first:25.74 11:20:14 INFO - PROCESS | 1973 | Values: 91.0 92.0 91.0 132.0 144.0 93.0 91.0 153.0 126.0 93.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:2.31 (4.1%) stddev-sans-first:2.45 11:20:14 INFO - PROCESS | 1973 | Values: 57.0 57.0 56.0 56.0 57.0 56.0 58.0 55.0 55.0 63.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#9] json-stringify-tinderbox Cycles:10 Average:77.80 Median:75.50 stddev:12.00 (15.9%) stddev-sans-first:12.30 11:20:14 INFO - PROCESS | 1973 | Values: 69.0 76.0 71.0 87.0 79.0 75.0 69.0 63.0 84.0 105.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:90.50 stddev:9.14 (10.1%) stddev-sans-first:9.62 11:20:14 INFO - PROCESS | 1973 | Values: 91.0 87.0 94.0 109.0 113.0 87.0 90.0 92.0 88.0 92.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#11] stanford-crypto-ccm Cycles:10 Average:160.30 Median:165.00 stddev:15.86 (9.6%) stddev-sans-first:14.83 11:20:14 INFO - PROCESS | 1973 | Values: 139.0 161.0 139.0 165.0 167.0 165.0 157.0 168.0 193.0 149.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:176.50 stddev:4.90 (2.8%) stddev-sans-first:5.17 11:20:14 INFO - PROCESS | 1973 | Values: 176.0 190.0 176.0 179.0 175.0 174.0 179.0 176.0 177.0 172.0 11:20:14 INFO - PROCESS | 1973 | 11:20:14 INFO - PROCESS | 1973 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:81.00 stddev:12.84 (15.9%) stddev-sans-first:12.35 11:20:14 INFO - PROCESS | 1973 | Values: 62.0 85.0 99.0 68.0 68.0 67.0 68.0 77.0 86.0 94.0 11:20:14 INFO - PROCESS | 1973 | -------- Summary: end -------- 11:20:14 INFO - PROCESS | 1973 | 11:20:15 INFO - TEST-INFO | 1973: exit 0 11:20:15 INFO - TEST-OK | kraken | took 61015ms 11:20:15 INFO - SUITE-END | took 1177s 11:20:16 INFO - Completed test suite (00:19:38) 11:20:16 INFO - javascript benchmark 11:20:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7335.226645538047, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.77342586019, 3329.1011426914747, 3350.7654464187503, 3363.0583436637735, 3384.8476818543163, 5603.995006242198, 5653.830385088449, 5686.203931449595, 5711.971440142804, 5730.942690573093, 5499.065158922983, 5643.5203007744285, 5646.096624540074, 5698.344690360599, 5714.399988001252, 4248.874048377167, 5196.272521846944, 5229.686218826863, 5268.841934741964, 5278.577713782888, 5197.558207552363, 5218.295530103444, 5253.028189784883, 5254.159334506479, 5269.1832765921345, 5108.540231379176, 5157.948420515803, 5253.842384728464, 5264.6051546134, 5274.894502109955, 4830.9275360869615, 5190.0, 5229.738513074331, 5288.8413347599635, 5290.92063619046, 5001.749912504397, 5039.3196918415915, 5114.693118412907, 5120.948790512084, 5170.353705786777, 5378.865528361783, 5547.5007249347345, 5551.944480555183, 5582.413846546095, 5605.131204663284, 6009.399060094, 6040.879182416371, 6133.969330153365, 6143.96928015357, 6147.938520614782, 6070.362611925729, 6079.057746049325, 6105.572609917308, 6107.643995706967, 6169.352218017133, 5745.712714364265, 5793.2179155814265, 5806.1000544915605, 5814.953308404528, 5837.445442682981, 6088.056351265561, 6244.718987645567, 6254.6247225166635, 6258.655773932386, 6292.0, 5989.9101513477335, 6031.366706495843, 6083.087536869505, 6107.175531303306, 6142.355052719489, 6110.837817827694, 6118.20463339763, 6147.692615369214, 6156.6921653917125, 6159.876802463926, 6124.692665960331, 6128.773097670088, 6136.825445958321, 6149.647077642911, 6163.691815409212, 4987.927595566898, 5784.797532086357, 5997.970010150008, 6027.397260274025, 6035.577509574287, 4894.657373983858, 4915.459299477055, 4939.5554400104165, 4944.381952255968, 4973.452920178777, 4405.207062728676, 4416.977915110404, 4425.380446737459, 4447.444069491314, 4476.574725401082, 5547.334319881559, 5722.62802917809, 5750.2237197978575, 5790.594658373958, 5842.211301474246, 6147.415995480422, 6147.569670123138, 6159.414855588712, 6168.784092556829, 6169.691515424211, 5794.971025144847, 5828.184054232411, 5839.299284085937, 5841.474267315962, 5877.500412464903, 5200.609954253446, 5294.814681486129, 5330.946690533123, 5342.252084708144, 5373.946260537423, 6095.933211688026, 6238.625682459067, 6270.435660790551, 6286.9626511625065, 6293.087502312048, 4664.813407463664, 4770.666053376231, 5447.96488667152, 6137.018077107641, 6170.969145154246, 5641.379448260606, 6063.878722425615, 6096.451319381277, 6261.74953001893, 6289.811305660837, 5270.314859068297, 5662.8301150965535, 6089.665068421102, 6133.478654314434, 6142.754289828536, 5947.6431414115295, 6101.664408457577, 6103.05402662588, 6119.418655227746, 6134.754609815557, 5862.091375836752, 5954.702264886825, 6017.669028203491, 6053.243344581927, 6060.454559089703, 5998.280206375263, 6043.516518678407, 6064.514838812796, 6065.029595264737, 6105.9694701526205, 5813.186153938536, 5820.243368362086, 5953.880922381441, 5980.0, 5997.520198384206, 5859.121131830259, 5961.672108033927, 6014.609050411709, 6017.06735456005, 6017.428344307284, 5908.852278693067, 5952.494038006645, 5977.22296101504, 5992.161097446274, 6043.214382130295], "value": 5606.697355473423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.9702417854929, 515.7343967856552, 522.5036215595185, 529.1586377659521, 534.0094125397387, 40164.59835401645, 41783.582164178384, 41854.116564754586, 41854.37218441726, 42045.579544204586, 33999.0, 42900.0, 43324.783376083156, 43387.915302117464, 43403.56596434035, 9884.703458896245, 10051.497425128751, 10066.345687530324, 10110.39337639744, 10150.0864922157, 9810.558524866363, 9916.008399160062, 9942.204623630128, 9967.302288839785, 9973.152282056033, 8510.70212542561, 9795.755106122333, 9917.0, 9957.651482198124, 9976.351537150098, 9756.609735610602, 9871.555779989918, 9913.65302214419, 9931.652392166312, 9939.850902236472, 9855.605775768961, 9868.506574671237, 9942.403455792602, 9942.602295908155, 9953.452560109192, 39747.602523974965, 41364.37953430701, 41638.0, 41723.1655366894, 41797.0, 3560.2701446203464, 3615.1685112424025, 3920.15716620925, 4095.303798354257, 4220.662347012231, 29257.0, 31350.52974205389, 31407.214819629462, 31472.370552589047, 31678.841605792055, 3178.507331363642, 3324.5345651608795, 3348.916277093068, 3369.25876307212, 3388.390089783838, 500576.0, 500723.49638251576, 501855.0, 503500.0, 506056.0, 58385.41614583885, 58775.41224587699, 58855.705721471975, 58956.0, 59120.0, 61588.69205653943, 61636.0, 61640.0, 61660.0, 61802.69098654478, 16106.355745770272, 16186.433474828324, 16245.025298482129, 16306.347746090261, 16349.591260218353, 12574.622761316992, 12748.553800616934, 12761.361931903368, 12762.9361853192, 12767.978561715041, 15560.066396016275, 15962.920185398998, 15996.440124595583, 16029.0, 16098.919505402398, 6826.781296078794, 6833.829154271183, 6859.279775623488, 6922.342377474132, 6938.022663540866, 851.4976164063232, 947.4978261521404, 1057.39728354837, 1119.7144728094283, 1121.8036843552509, 22024.779752202274, 23892.88053559721, 29338.0, 30189.547156792665, 30825.845870770503, 1068.0654427376046, 1083.7615724540588, 1104.0119093411352, 1146.043054049861, 1148.758760660254, 12574.0, 14942.0, 15484.922575387276, 15849.603759905864, 15864.44474443389, 639304.0, 652905.0, 653699.0, 653987.0, 654473.0, 47271.5272847274, 57834.421655782906, 58011.709941450026, 58162.0, 58181.70909145427, 1354.4582167133226, 1373.3656948231574, 1391.6033930329806, 1401.9439222430988, 1413.7172565486944, 25774.613380799678, 27496.58755118635, 28656.426871462038, 29295.85352073226, 29941.550876737303, 42018.57981420269, 48325.03349933052, 48983.53049408524, 49055.0, 49281.75359123181, 580958.0, 587112.0, 587355.0632246812, 587402.0, 589401.0, 23972.0, 25937.22188334353, 26128.8693556531, 27897.16308510748, 38921.80539097286, 38791.6120838788, 44956.550434495235, 46303.07393852037, 47046.52953470421, 47964.7601761989, 33704.0, 37204.33207254633, 37231.81384093062, 38219.42670859995, 38252.80873595614, 38327.2334553313, 38526.0, 38816.0, 39213.80393098016, 39235.41146882742, 37775.62224377721, 38302.42546361862, 38663.806680966416, 38711.22577548377, 40403.1919361617, 25680.61479077778, 33994.15014624654, 35185.824070879484, 35656.573737050225, 35990.92027239187, 24167.637485438085, 25701.742982570682, 25902.48195036051, 26049.348766280236, 26490.86754566215], "value": 19963.348560790397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.92761447710456, 363.4439307858975, 366.32413197650345, 370.57384008390363, 392.0179949227186, 19636.410907672776, 20744.89627551864, 21007.0, 21203.257885973995, 21404.14383424665, 20047.69928451071, 20314.0, 20500.28249011281, 20767.688484672704, 20804.8959755201, 5125.974370128144, 5918.792842250522, 6180.227471566054, 6217.751289948396, 6232.750689972396, 5264.289320941682, 6063.211782468273, 6102.969485152568, 6107.664078475682, 6193.597416167935, 5279.419263880989, 5492.780288788444, 6093.756249750005, 6168.105624684418, 6199.039148931923, 6157.0, 6220.7822726204595, 6221.097940798604, 6226.097215903714, 6564.737410503574, 6030.33666296707, 6035.275766907956, 6039.339181725017, 6060.696965151725, 6105.542084343692, 13385.129966552144, 16476.67046659072, 20011.899940500203, 24933.750662493323, 25138.371540711447, 2183.355910006536, 2251.6960210371553, 2256.605094108541, 2281.646344816556, 3036.9848150759326, 9325.860112098324, 9832.360896541773, 10138.39169649816, 10343.345064789597, 14624.122552646875, 1787.6692811829853, 1870.8690391672587, 1904.866659333847, 1906.761654793151, 1963.3619073801071, 118239.8176018246, 123468.0, 127051.0, 127217.09174362393, 131612.0, 11031.669049928514, 11189.832152517718, 11311.377874216832, 11473.024792892531, 11625.59310424131, 14257.287135643177, 14416.495422660366, 14438.061526000776, 14446.783298250535, 14509.0, 8315.417920745489, 8465.788355291166, 8477.576121193915, 8601.397902146915, 8616.526091064927, 7430.925690743132, 8033.1163572007035, 8372.28835548985, 8417.579121043924, 8539.957300213584, 4379.824807007748, 4484.730916144977, 4486.820527178941, 4569.497355290915, 4613.331066995267, 1643.4412299818118, 1713.2975480053367, 1807.7198034304704, 1871.9344822931132, 1934.071645610087, 792.5442870349572, 817.4032955942076, 909.6997990663198, 934.8270569944582, 954.9474778887089, 14736.968412211043, 18111.45665630033, 18722.81277187238, 19574.217031318873, 19746.40760777179, 793.4564823096198, 910.6220918318955, 918.9586468608928, 968.801395713877, 999.3604093380243, 9421.434713917188, 10383.584656613803, 10724.785504290026, 10780.191485638608, 10790.406527640898, 425293.0, 514943.0, 516541.0, 599038.0, 603138.0, 103833.0, 135223.0, 136986.0, 145556.27221864034, 146874.0, 951.362587066667, 973.956171972263, 1016.5527168046036, 1032.9741756455999, 1044.1438020823005, 17284.87648302856, 18710.90644546823, 19125.948072856125, 19144.80855191486, 19430.90284548568, 57301.713491432274, 58618.0, 60110.09834852568, 60268.0, 60660.696696516236, 66386.00420993786, 72193.0, 74498.88251676338, 75660.0, 77222.45555088979, 6621.702023408862, 7958.880616790869, 8096.664050431613, 8146.0632027317615, 8283.710070147516, 10534.736631584272, 12465.252084874937, 12674.556390526288, 12869.22784632925, 12900.161489503153, 10306.175505959654, 10579.62971296001, 11068.0, 11112.22214444981, 11184.664460066211, 8529.232369086812, 10230.6419275325, 10395.896041039492, 10458.424786636808, 11179.496922638338, 10907.98202332571, 11057.115430765358, 11214.943925280322, 11366.772664546828, 11498.137639677225, 7848.60756962161, 8082.030156381272, 8134.227248411392, 8203.30271926869, 8258.793530161794, 10476.423796691255, 10824.945875270574, 10940.0, 11173.273737207055, 11269.436528173723], "value": 9453.392409706756, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.8822850057745, 1544.7914531538242, 1717.5791930976904, 1815.2466726308583, 1820.9908950455247, 8040.31657309128, 8270.545120018396, 8442.746717598475, 9011.279097672186, 9044.321675874311, 8453.239208471236, 8715.694950676727, 8759.299256059516, 8864.98052723937, 8868.91131088689, 2324.4421338878715, 2332.3819187915215, 2337.1703045418885, 2337.9649305260436, 2340.578695834749, 1963.2735887721562, 2295.5867943770113, 2318.7449380568123, 2346.4837735698206, 2352.9176478823247, 2289.8626082435026, 2333.136739406422, 2347.80043696286, 2354.705661792276, 2362.5629258587132, 2290.5876942150408, 2302.7121609798774, 2318.107528601484, 2324.0471406723245, 2336.264076815806, 2300.0224904415722, 2303.896324665394, 2304.7695230476984, 2304.896279667419, 2311.1217737259904, 8804.251638610725, 8903.510306933116, 8934.821303573892, 9005.639774409015, 9011.369204155711, 5098.546914129455, 5227.3465816772905, 5365.731713414314, 5386.111291636876, 5396.649217800869, 2746.917592472229, 2782.6660800704044, 2802.7807903562016, 2942.396808654221, 3642.05306620278, 1079.1852151625471, 1089.5696200000955, 1090.1769164280997, 1092.6175838456556, 1109.2457129152174, 9711.0, 11505.482253298622, 11597.014253788439, 11762.58830940913, 11777.116716246315, 4217.810198541073, 4595.747233902168, 4654.789754663744, 4770.809167633256, 4791.089692958327, 8475.788105297293, 9218.677346292847, 9475.905240947503, 9935.503224838874, 10134.290599657954, 5278.9208161877605, 5317.30874986257, 5354.946450535523, 5358.089124848785, 5359.758810853521, 4404.427424434803, 4520.706154099973, 4818.542238487338, 4845.63657725672, 4920.065187614342, 3586.6234045424853, 3817.8854634361014, 3901.336772748583, 3904.2386734587053, 4019.532870502304, 1267.7781388257017, 1286.0676009892752, 1287.7875150600046, 1290.2967882504058, 1290.4064130499887, 771.4908160613968, 824.5135370131532, 865.2299453486402, 908.8818453601122, 927.8144371125802, 5614.9438505615235, 5747.918977526004, 5765.88468230633, 5767.163761254595, 5945.494632956247, 408.88142438692444, 426.2625657612348, 431.10760725298957, 438.2374668077586, 447.5479765436932, 3933.272344616198, 3961.7821019844187, 4013.5585085640555, 4077.8776636700945, 4093.8771836844944, 10566.471676416302, 10823.891761082288, 10982.121430285559, 10996.945015275032, 11083.057940075183, 9229.030951750105, 10742.677719668422, 10793.974572415607, 10932.836007459895, 10946.0, 8172.550509721904, 8180.9590952044855, 8231.382646301432, 8244.628991695388, 8336.749897503085, 4981.775820088033, 5888.528917686661, 5994.07091900756, 5996.70016499182, 6027.517798576191, 9511.857322140311, 10165.695029149138, 10227.43749093807, 10266.178705703674, 10286.948565257426, 8330.291925186428, 9773.804523909625, 10356.637517686844, 10400.531976061247, 10412.271141020055, 7611.657475413509, 7876.09424916142, 7890.605469726605, 8253.33973282124, 8367.368363169124, 8380.958095209486, 8676.479411235347, 8691.521966291915, 8696.91303086961, 8700.956495217484, 7521.135069467081, 7532.698692052257, 7549.320561149523, 7582.393408527194, 7654.387648988179, 7338.706451742084, 7425.405967522477, 7466.962665186857, 7529.661165247468, 7575.734849280248, 6904.240533541206, 6937.098177236927, 6942.271061538668, 7051.083359163276, 7066.152061752623, 4792.688475249098, 4994.600431965507, 5088.287639730367, 5119.667221630582, 5143.279940808215, 5038.924416133834, 5071.492850714899, 5173.534381905646, 5174.404943431554, 5185.9887321971855], "value": 4466.045678318516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.05614636308837, 272.72863500816686, 308.8131680333398, 311.9610048743907, 313.0857894946755, 4120.608542188487, 4236.301010333299, 4517.9548204517905, 5296.258523806665, 5655.4910058094765, 5259.237410575464, 5423.620346575742, 5506.944930550693, 5520.337559492857, 5557.166425036236, 3917.412388141773, 4203.453551038361, 4217.261979153651, 4231.386448964899, 4248.851290204843, 3865.2849222893715, 4163.7501749894955, 4220.662347012231, 4237.300845360512, 4240.473429565354, 3619.963800362002, 4064.0855807443236, 4129.380592911058, 4137.875863724078, 4152.211079894825, 3395.3718562066097, 4158.14757974616, 4170.311898536723, 4173.580982465945, 4180.498340199196, 3573.4818451324413, 3576.946345804815, 3594.478800573902, 3606.945895811565, 3612.729045321585, 5181.4300426953005, 5186.896262074775, 5242.187460943522, 5342.572594192456, 5365.624406291561, 4110.1779644071, 4754.597393768847, 4771.642126840501, 4792.0895029944195, 4808.0, 5069.594432445432, 5777.855553611152, 5817.883642327172, 5826.708664566755, 5867.325257595346, 3340.9643010666528, 3411.522386865841, 3663.358912190383, 3918.294706952747, 3924.5682974872743, 5095.439501654815, 5197.220416937452, 5312.893742125175, 6153.476954458876, 6242.406971337716, 3705.370087085148, 3808.5239345081864, 3906.90232744178, 4040.111175541435, 4058.7158898877387, 3309.1561651779125, 3442.3115376924716, 3718.6095459976855, 4103.835846566104, 4114.177164567099, 3845.615438456132, 4070.531888832763, 4384.7369157850635, 4789.994101238779, 4805.438232574357, 5207.869803254949, 5881.000229960917, 5932.673702946379, 5940.198073260141, 5983.730732117066, 1154.8671902731126, 1347.730453909222, 1351.6485713714505, 1361.754884120848, 1377.5936098850864, 892.8081011849254, 903.263839970422, 919.8685616691507, 930.432436213909, 934.6401635370296, 4937.012597480519, 5369.516743493026, 5376.838694839083, 5392.973035134799, 5429.0, 5026.949730502722, 5908.793192238337, 5939.812037592499, 5952.642841429528, 5994.430529099728, 4536.954630453653, 5073.7716802743225, 5350.545203657655, 5378.838634840961, 5443.727813609304, 2801.8599070046416, 3124.9218769530944, 3137.8431078445988, 3167.857446414917, 3183.0, 5551.111822108443, 6211.565190436626, 6242.781502647385, 6252.74989000444, 6257.0, 4822.638302127284, 5544.86137846549, 6097.725602347905, 6255.749770009149, 6310.8422289442215, 4830.975845120752, 6261.624302541862, 6361.9045714314325, 6376.872462550723, 6395.456386207225, 5439.428859969805, 5758.683272420057, 5990.850228744316, 6055.303640081271, 6099.072445226405, 5545.417731138334, 6029.282518376485, 6042.607230530001, 6043.697815109315, 6115.84710382244, 5346.358436987586, 5846.298444186725, 6342.334054924167, 6375.6812159392775, 6389.9232749355715, 3218.197809226747, 3514.648535146465, 3969.9404508932967, 4004.1591265833335, 4021.6983726220064, 5371.448561933207, 5783.797567085132, 6127.724252408741, 6138.877222455615, 6140.109684095692, 5720.513756330759, 5747.511461525817, 5834.38738932406, 5849.356570777296, 5875.618084824473, 4872.222832985306, 5396.7571459283645, 5816.5055970243, 5877.912586171572, 5908.291005079246, 5216.035033518811, 5372.636040142481, 5582.637128586629, 5588.385277619377, 5623.314931313352, 5478.808241711521, 5859.070464767617, 5884.440978107073, 5886.851299275648, 5912.46787789101, 5092.719900405513, 5480.753366098455, 5743.368229494668, 5818.214541036906, 5830.530834153672], "value": 4198.760094869868, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.4423616870339, 750.0099868174009, 757.9886301705471, 769.8575763483755, 828.0229329391318, 15641.139737314443, 16399.83600164001, 16425.75361369579, 16427.507174784776, 16478.588035299123, 14524.636884077903, 14728.410863565445, 14999.625009374771, 15005.699886002274, 15203.54389368318, 839.5340585974797, 852.86780549015, 858.3605214115493, 861.6036623153357, 862.4221771413137, 682.2120450879243, 690.8187000229614, 702.722424642266, 861.2980420956932, 868.4962721621476, 884.0143240287098, 911.5761171055458, 912.2884150362728, 913.8492148795441, 916.8258030974093, 869.2654706772767, 905.6377449020445, 907.160876189522, 907.7140700679331, 908.5548081440113, 662.261578340152, 675.6722989350161, 676.2966514824576, 677.8237658208901, 680.0275605883585, 15638.765418518731, 15756.448524301595, 15763.605909852231, 15949.282282297325, 15971.920140399223, 14632.92683536586, 14651.706965860623, 14692.779608305884, 14742.484013059491, 15029.549113526611, 11737.631742095475, 11897.643070707893, 11957.162998590102, 12252.142350035501, 12474.875251247462, 3840.961590384088, 3927.764334139932, 3935.6064393560414, 4046.615571520701, 4053.493313335833, 83273.58363208146, 118297.40851295774, 120191.0, 122820.0, 123034.38482807529, 11255.212135150461, 11382.772344553228, 11422.942885285687, 11431.256968297033, 11524.193306468635, 22594.435139121655, 23673.171438999554, 23791.40521486942, 23866.045358185824, 23876.880615596812, 7539.811504712426, 7903.407244456689, 7999.400044996532, 8157.3881958852135, 8168.0, 3138.544910987894, 4349.499807522176, 4389.912201756011, 4439.556044395535, 4521.909561808746, 2939.8383088930314, 3509.137655479135, 3665.138692407282, 3677.7793332400142, 3678.613745556678, 553.6567328256507, 638.2436812377348, 642.5213216153995, 643.4498503779295, 654.2280109470775, 501.3657722980433, 517.9378474583074, 525.7844283843606, 551.4788524844064, 618.1716499890168, 9254.491002994766, 9303.674371396968, 9397.859032114524, 9466.857997130048, 9551.952240238754, 657.7829316325601, 679.894616334469, 683.2620769568953, 684.9931500685029, 703.2791388826391, 3794.29805485986, 4468.32975053738, 4528.41130653013, 4573.285018118206, 4625.074985003012, 168050.0, 172656.0, 173701.0, 173959.0, 180201.0989945042, 114802.32060582499, 138339.0, 144443.0, 144538.0, 147449.0, 108528.91471085188, 119740.0, 121248.0, 123030.0, 126184.0, 8932.553372331487, 9039.322050846082, 9111.635534578543, 9172.724818255463, 9192.36781381028, 49397.27109551148, 50546.74726626343, 54177.729111354194, 61090.0, 61476.0, 83437.0, 85613.57193214243, 89169.0, 97448.5127574386, 100454.4977275109, 13014.4143513544, 13207.933960330136, 13283.468661253442, 13467.86532134666, 14010.43958241659, 14777.482788102365, 14837.92581037088, 14884.404623814926, 15231.695366092838, 15398.307076181824, 13681.384337705027, 13826.585202443943, 13848.446062157402, 13933.58199254024, 13995.0, 13610.93194534021, 13688.726225475235, 13729.313534323044, 13805.447782088604, 13918.791218131533, 11198.38408887519, 11635.53457861676, 11691.532338706356, 11706.473208705798, 13666.590002299947, 8357.247847693738, 8943.418677785923, 9291.72124836256, 11506.0, 11564.190506664452, 8992.55037248148, 10761.139108871428, 11326.773464530499, 11506.30962142274, 11756.412179391167], "value": 7849.87800943795, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 119.0, 117.0, 117.0, 120.0, 117.0, 119.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 116.0, 150.0, 116.0, 117.0, 124.0, 147.0, 182.0, 100.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 215.0, 212.0, 198.0, 195.0, 225.0, 253.0, 201.0, 194.0, 198.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 58.0, 84.0, 63.0, 60.0, 59.0, 73.0, 74.0, 63.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 73.0, 75.0, 84.0, 99.0, 101.0, 76.0, 93.0, 58.0, 89.0], "value": 84.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 88.0, 86.0, 90.0, 85.0, 90.0, 86.0, 88.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 152.0], "value": 108.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 91.0, 132.0, 144.0, 93.0, 91.0, 153.0, 126.0, 93.0], "value": 110.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 56.0, 58.0, 55.0, 55.0, 63.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 76.0, 71.0, 87.0, 79.0, 75.0, 69.0, 63.0, 84.0, 105.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 94.0, 109.0, 113.0, 87.0, 90.0, 92.0, 88.0, 92.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 161.0, 139.0, 165.0, 167.0, 165.0, 157.0, 168.0, 193.0, 149.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 190.0, 176.0, 179.0, 175.0, 174.0, 179.0, 176.0, 177.0, 172.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 85.0, 99.0, 68.0, 68.0, 67.0, 68.0, 77.0, 86.0, 94.0], "value": 77.4, "unit": "score"}]}]} 11:20:16 INFO - Return code: 0 11:20:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:20:16 ERROR - # TBPL SUCCESS # 11:20:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:20:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:20:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:20:16 INFO - 2016-10-06 11:20:16.224 screenresolution[1978:25053] starting screenresolution argv=screenresolution get 11:20:16 INFO - 2016-10-06 11:20:16.226 screenresolution[1978:25053] Display 0: 1600x1200x32@60 11:20:16 INFO - 2016-10-06 11:20:16.232 screenresolution[1979:25056] starting screenresolution argv=screenresolution list 11:20:16 INFO - Available Modes on Display 0 11:20:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:20:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:20:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:20:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:20:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:20:16 INFO - Intel Iris: 11:20:16 INFO - Chipset Model: Intel Iris 11:20:16 INFO - Type: GPU 11:20:16 INFO - Bus: Built-In 11:20:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:20:16 INFO - Vendor: Intel (0x8086) 11:20:16 INFO - Device ID: 0x0a2e 11:20:16 INFO - Revision ID: 0x0009 11:20:16 INFO - Displays: 11:20:16 INFO - Display: 11:20:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:20:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:20:16 INFO - Display Serial Number: 1600x1200 60 11:20:16 INFO - Main Display: Yes 11:20:16 INFO - Mirror: Off 11:20:16 INFO - Online: Yes 11:20:16 INFO - Rotation: Supported 11:20:16 INFO - Return code: 0 11:20:16 INFO - Running post-action listener: _resource_record_post_action 11:20:16 INFO - [mozharness: 2016-10-06 18:20:16.467105Z] Finished run-tests step (success) 11:20:16 INFO - Running post-run listener: _resource_record_post_run 11:20:16 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 294912; Write bytes: 708712448; Read time: 3; Write time: 1978 11:20:16 INFO - TinderboxPrint: CPU usage
54.3% 11:20:16 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 3 11:20:16 INFO - TinderboxPrint: I/O write bytes / time
708,712,448 / 1,978 11:20:16 INFO - TinderboxPrint: CPU idle
2,216.2 (45.7%) 11:20:16 INFO - TinderboxPrint: CPU system
981.5 (20.2%) 11:20:16 INFO - TinderboxPrint: CPU user
1,656.1 (34.1%) 11:20:16 INFO - TinderboxPrint: Swap in / out
407,552,000 / 0 11:20:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393656832; Write bytes: 389338624; Read time: 29146; Write time: 761 11:20:16 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 294912; Write bytes: 297128448; Read time: 3; Write time: 1157 11:20:16 INFO - Running post-run listener: _upload_blobber_files 11:20:16 INFO - Blob upload gear active. 11:20:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:20:16 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:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:20:17 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:20:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:20:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:18 INFO - (blobuploader) - INFO - Done attempting. 11:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:19 INFO - (blobuploader) - INFO - Done attempting. 11:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:21 INFO - (blobuploader) - INFO - Done attempting. 11:20:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:21 INFO - Return code: 0 11:20:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47e81aa7850759bb7b11b383f6f5fe8fb41dbeb6893b6e81c295df4ee0e95e22bc441e6f49b0755c20c6d905cdda3dd00617bcca4a5127e4445131034633a1e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dbd6583fca7f80d6b7371eaf1e64c0b2e75abbd592c90ac952e927ab5bc3e2347f59e996de6c681fa71159fa185790e3453ea60d8fdbc4e71098c8c5ba6e2664", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d7cf1162d3211e3ccf0626cee9410885f791eeb37453eeb4f24910077f8c411c7c69487292c469e9b4ac422323f33cf588714a893ac9312380a5850660ce1ca5"} 11:20:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:21 INFO - Contents: 11:20:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47e81aa7850759bb7b11b383f6f5fe8fb41dbeb6893b6e81c295df4ee0e95e22bc441e6f49b0755c20c6d905cdda3dd00617bcca4a5127e4445131034633a1e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dbd6583fca7f80d6b7371eaf1e64c0b2e75abbd592c90ac952e927ab5bc3e2347f59e996de6c681fa71159fa185790e3453ea60d8fdbc4e71098c8c5ba6e2664", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d7cf1162d3211e3ccf0626cee9410885f791eeb37453eeb4f24910077f8c411c7c69487292c469e9b4ac422323f33cf588714a893ac9312380a5850660ce1ca5"} 11:20:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:21 INFO - Copying logs to upload dir... 11:20:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.262065 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-06 11:20:21.784986) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 11:20:21.786179) ========= 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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47e81aa7850759bb7b11b383f6f5fe8fb41dbeb6893b6e81c295df4ee0e95e22bc441e6f49b0755c20c6d905cdda3dd00617bcca4a5127e4445131034633a1e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dbd6583fca7f80d6b7371eaf1e64c0b2e75abbd592c90ac952e927ab5bc3e2347f59e996de6c681fa71159fa185790e3453ea60d8fdbc4e71098c8c5ba6e2664", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d7cf1162d3211e3ccf0626cee9410885f791eeb37453eeb4f24910077f8c411c7c69487292c469e9b4ac422323f33cf588714a893ac9312380a5850660ce1ca5"} build_url:https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/Y1oI1ZBQS0mS60eSD73b3w/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/47e81aa7850759bb7b11b383f6f5fe8fb41dbeb6893b6e81c295df4ee0e95e22bc441e6f49b0755c20c6d905cdda3dd00617bcca4a5127e4445131034633a1e9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dbd6583fca7f80d6b7371eaf1e64c0b2e75abbd592c90ac952e927ab5bc3e2347f59e996de6c681fa71159fa185790e3453ea60d8fdbc4e71098c8c5ba6e2664", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d7cf1162d3211e3ccf0626cee9410885f791eeb37453eeb4f24910077f8c411c7c69487292c469e9b4ac422323f33cf588714a893ac9312380a5850660ce1ca5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 11:20:21.825315) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:20:21.825694) ========= 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.a3tIzQHFpS/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.VRiJyWtxjK/Listeners TMPDIR=/var/folders/kg/hnzl1l9x12nbzbrqlx0f6z4h00000w/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.005342 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 11:20:21.878859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 11:20:21.881308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 11:20:21.881787) ========= ========= Total master_lag: 0.29 =========