builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0342 starttime: 1474892619.93 results: success (0) buildid: 20160926030203 builduid: 854aba1db67b485e88ec5b703b09252b revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:39.926316) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:39.926785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:39.927075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.055210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.055472) ========= 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.SrFvlVETHT/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.c8X6pP8x3M/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-09-26 05:23:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-09-26 05:23:40 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.516869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.595655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.595975) ========= 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.SrFvlVETHT/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.c8X6pP8x3M/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.026536 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.645771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:40.646122) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SrFvlVETHT/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.c8X6pP8x3M/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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-09-26 05:23:40,726 truncating revision to first 12 chars 2016-09-26 05:23:40,726 Setting DEBUG logging. 2016-09-26 05:23:40,726 attempt 1/10 2016-09-26 05:23:40,726 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29beaebdfacc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 05:23:41,351 unpacking tar archive at: mozilla-central-29beaebdfacc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.562815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.563094) ========= script_repo_revision: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.563446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.563717) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 05:23:41.582641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-26 05:23:41.582996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SrFvlVETHT/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.c8X6pP8x3M/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:23:41 INFO - MultiFileLogger online at 20160926 05:23:41 in /builds/slave/test 05:23:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:23:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:41 INFO - {'append_to_log': False, 05:23:41 INFO - 'base_work_dir': '/builds/slave/test', 05:23:41 INFO - 'blob_upload_branch': 'Firefox', 05:23:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:41 INFO - 'branch': 'Firefox', 05:23:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:41 INFO - 'config_files': ('talos/mac_config.py',), 05:23:41 INFO - 'default_actions': ('clobber', 05:23:41 INFO - 'read-buildbot-config', 05:23:41 INFO - 'download-and-extract', 05:23:41 INFO - 'populate-webroot', 05:23:41 INFO - 'create-virtualenv', 05:23:41 INFO - 'install', 05:23:41 INFO - 'run-tests'), 05:23:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:41 INFO - 'download_minidump_stackwalk': True, 05:23:41 INFO - 'download_symbols': 'ondemand', 05:23:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:41 INFO - 'installer_path': 'installer.exe', 05:23:41 INFO - 'log_level': 'info', 05:23:41 INFO - 'log_name': 'talos', 05:23:41 INFO - 'log_to_console': True, 05:23:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:23:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:23:41 INFO - 'opt_config_files': (), 05:23:41 INFO - 'pip_index': False, 05:23:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:41 INFO - 'cmd': ('bash', 05:23:41 INFO - '-c', 05:23:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:41 INFO - 'enabled': True, 05:23:41 INFO - 'halt_on_failure': False, 05:23:41 INFO - 'name': 'check_screen_resolution'},), 05:23:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:23:41 INFO - 'cmd': ('bash', 05:23:41 INFO - '-c', 05:23:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:23:41 INFO - 'enabled': True, 05:23:41 INFO - 'halt_on_failure': False, 05:23:41 INFO - 'name': 'check_screen_resolution'},), 05:23:41 INFO - 'run_cmd_checks_enabled': True, 05:23:41 INFO - 'sps_profile': False, 05:23:41 INFO - 'sps_profile_interval': 0, 05:23:41 INFO - 'suite': 'dromaeojs-e10s', 05:23:41 INFO - 'system_bits': '32', 05:23:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:41 INFO - 'title': 't-yosemite-r7-0342', 05:23:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:41 INFO - 'use_talos_json': True, 05:23:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:41 INFO - 'work_dir': 'build'} 05:23:41 INFO - [mozharness: 2016-09-26 12:23:41.776829Z] Running clobber step. 05:23:41 INFO - Running pre-action listener: _resource_record_pre_action 05:23:41 INFO - Running main action method: clobber 05:23:41 INFO - rmtree: /builds/slave/test/build 05:23:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:43 INFO - Running post-action listener: _resource_record_post_action 05:23:43 INFO - [mozharness: 2016-09-26 12:23:43.999287Z] Finished clobber step (success) 05:23:43 INFO - [mozharness: 2016-09-26 12:23:43.999425Z] Running read-buildbot-config step. 05:23:43 INFO - Running pre-action listener: _resource_record_pre_action 05:23:43 INFO - Running main action method: read_buildbot_config 05:23:44 INFO - Using buildbot properties: 05:23:44 INFO - { 05:23:44 INFO - "project": "", 05:23:44 INFO - "product": "firefox", 05:23:44 INFO - "script_repo_revision": "production", 05:23:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:23:44 INFO - "repository": "", 05:23:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:23:44 INFO - "buildid": "20160926030203", 05:23:44 INFO - "stage_platform": "macosx64", 05:23:44 INFO - "basedir": "/builds/slave/test", 05:23:44 INFO - "nightly_build": "True", 05:23:44 INFO - "buildnumber": 33, 05:23:44 INFO - "slavename": "t-yosemite-r7-0342", 05:23:44 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:23:44 INFO - "platform": "yosemite_r7", 05:23:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:23:44 INFO - "branch": "mozilla-central", 05:23:44 INFO - "repo_path": "mozilla-central", 05:23:44 INFO - "revision": "29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49", 05:23:44 INFO - "pgo_build": "False", 05:23:44 INFO - "builduid": "854aba1db67b485e88ec5b703b09252b", 05:23:44 INFO - "slavebuilddir": "test" 05:23:44 INFO - } 05:23:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:23:44 INFO - Running post-action listener: _resource_record_post_action 05:23:44 INFO - [mozharness: 2016-09-26 12:23:44.002923Z] Finished read-buildbot-config step (success) 05:23:44 INFO - [mozharness: 2016-09-26 12:23:44.003037Z] Running download-and-extract step. 05:23:44 INFO - Running pre-action listener: _resource_record_pre_action 05:23:44 INFO - Running main action method: download_and_extract 05:23:44 INFO - mkdir: /builds/slave/test/build/tests 05:23: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')]} 05:23:44 INFO - trying https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:23:44 INFO - Downloading https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/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 05:23:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/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 05:23:45 INFO - Downloaded 1199 bytes. 05:23:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:23:45 INFO - Using the following test package requirements: 05:23:45 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:23:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:23:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:23:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'jsshell-mac.zip'], 05:23:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:23:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:23:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:23:45 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:23:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:23:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:23:45 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:23:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:23:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:23:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:23:45 INFO - Fetch https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:23:45 INFO - Expected file size: 16438988 05:23:52 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 05:23:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:23:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:23:52 INFO - Fetch https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:23:53 INFO - Expected file size: 16438988 05:23:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:23:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:23:59 INFO - Fetch https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:24:00 INFO - Expected file size: 14414059 05:24: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')]} 05:24:01 INFO - trying https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:24:01 INFO - Downloading https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/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 05:24:06 INFO - Downloaded 111715330 bytes. 05:24:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:24:06 INFO - mkdir: /builds/slave/test/properties 05:24:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:06 INFO - Contents: 05:24:06 INFO - build_url:https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - Running post-action listener: set_extra_try_arguments 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.148446Z] Finished download-and-extract step (success) 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.148564Z] Running populate-webroot step. 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: populate_webroot 05:24:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:07 INFO - '--tppagecycles', 05:24:07 INFO - '7'], 05:24:07 INFO - 'tests': ['tsvgm']}}, 05:24:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['damp', 'tps']}, 05:24:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'tests': ['damp', 'tps']}, 05:24:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['dromaeo_dom']}, 05:24:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['basic_compositor_video']}, 05:24:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:24:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['a11yr', 05:24:07 INFO - 'ts_paint', 05:24:07 INFO - 'tpaint', 05:24:07 INFO - 'sessionrestore', 05:24:07 INFO - 'sessionrestore_no_auto_restore', 05:24:07 INFO - 'tabpaint']}, 05:24:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tsvgx', 05:24:07 INFO - 'tsvgr_opacity', 05:24:07 INFO - 'tart', 05:24:07 INFO - 'tscrollx', 05:24:07 INFO - 'cart']}, 05:24:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:07 INFO - 'tsvgr_opacity', 05:24:07 INFO - 'tart', 05:24:07 INFO - 'tscrollx', 05:24:07 INFO - 'cart']}, 05:24:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s'], 05:24:07 INFO - 'tests': ['tp5o']}, 05:24:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'tests': ['tp5o']}, 05:24:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--disable-e10s', 05:24:07 INFO - '--xperf_path', 05:24:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:07 INFO - 'tests': ['tp5n']}, 05:24:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:07 INFO - 'talos_options': ['--xperf_path', 05:24:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:07 INFO - 'tests': ['tp5n']}}, 05:24:07 INFO - 'talos.zip': {'path': '', 05:24:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.166885Z] Finished populate-webroot step (success) 05:24:07 INFO - [mozharness: 2016-09-26 12:24:07.167026Z] Running create-virtualenv step. 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: create_virtualenv 05:24:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:07 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 05:24:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:07 INFO - Using real prefix '/tools/python27' 05:24:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:10 INFO - Installing pip.................done. 05:24:10 INFO - Return code: 0 05:24:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:10 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:10 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 05:24:10 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 05:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:10 INFO - 'HOME': '/Users/cltbld', 05:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:10 INFO - 'LOGNAME': 'cltbld', 05:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:10 INFO - 'MOZ_NO_REMOTE': '1', 05:24:10 INFO - 'NO_EM_RESTART': '1', 05:24:10 INFO - 'PAGER': '/bin/cat', 05:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:10 INFO - 'PWD': '/builds/slave/test', 05:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:10 INFO - 'SHELL': '/bin/bash', 05:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:10 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:10 INFO - 'USER': 'cltbld', 05:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:10 INFO - 'XPC_FLAGS': '0x0', 05:24:10 INFO - 'XPC_SERVICE_NAME': '0', 05:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:11 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 05:24:11 INFO - Cleaning up... 05:24:11 INFO - Return code: 0 05:24:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24:11 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')]} 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:11 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')]} 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:11 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:11 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 05:24:11 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 05:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:11 INFO - 'HOME': '/Users/cltbld', 05:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:11 INFO - 'LOGNAME': 'cltbld', 05:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:11 INFO - 'MOZ_NO_REMOTE': '1', 05:24:11 INFO - 'NO_EM_RESTART': '1', 05:24:11 INFO - 'PAGER': '/bin/cat', 05:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:11 INFO - 'PWD': '/builds/slave/test', 05:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:11 INFO - 'SHELL': '/bin/bash', 05:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:11 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:11 INFO - 'USER': 'cltbld', 05:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:11 INFO - 'XPC_FLAGS': '0x0', 05:24:11 INFO - 'XPC_SERVICE_NAME': '0', 05:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:11 INFO - Downloading/unpacking psutil>=3.1.1 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:15 INFO - Installing collected packages: psutil 05:24:15 INFO - Running setup.py install for psutil 05:24:15 INFO - building 'psutil._psutil_osx' extension 05:24:15 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 05:24:15 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 05:24:15 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 05:24:15 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 05:24:16 INFO - building 'psutil._psutil_posix' extension 05:24:16 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 05:24:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:24:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:24:16 INFO - ^ 05:24:16 INFO - 1 warning generated. 05:24:16 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 05:24:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:16 INFO - Successfully installed psutil 05:24:16 INFO - Cleaning up... 05:24:16 INFO - Return code: 0 05:24:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:16 INFO - 'HOME': '/Users/cltbld', 05:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:16 INFO - 'LOGNAME': 'cltbld', 05:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:16 INFO - 'MOZ_NO_REMOTE': '1', 05:24:16 INFO - 'NO_EM_RESTART': '1', 05:24:16 INFO - 'PAGER': '/bin/cat', 05:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:16 INFO - 'PWD': '/builds/slave/test', 05:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:16 INFO - 'SHELL': '/bin/bash', 05:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:16 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:16 INFO - 'USER': 'cltbld', 05:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:16 INFO - 'XPC_FLAGS': '0x0', 05:24:16 INFO - 'XPC_SERVICE_NAME': '0', 05:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:19 INFO - Installing collected packages: mozsystemmonitor 05:24:19 INFO - Running setup.py install for mozsystemmonitor 05:24:19 INFO - Successfully installed mozsystemmonitor 05:24:19 INFO - Cleaning up... 05:24:19 INFO - Return code: 0 05:24:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24:19 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')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:19 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 05:24:19 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 05:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:19 INFO - 'HOME': '/Users/cltbld', 05:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PAGER': '/bin/cat', 05:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:19 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - 'XPC_FLAGS': '0x0', 05:24:19 INFO - 'XPC_SERVICE_NAME': '0', 05:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 INFO - Downloading/unpacking jsonschema==2.5.1 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 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 05:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:22 INFO - warning: no files found matching '*.txt' 05:24:22 INFO - no previously-included directories found matching 'build' 05:24:22 INFO - no previously-included directories found matching 'dist' 05:24:22 INFO - no previously-included directories found matching '.git*' 05:24:22 INFO - Installing collected packages: jsonschema, functools32 05:24:22 INFO - Running setup.py install for functools32 05:24:22 INFO - warning: no files found matching '*.txt' 05:24:22 INFO - no previously-included directories found matching 'build' 05:24:22 INFO - no previously-included directories found matching 'dist' 05:24:22 INFO - no previously-included directories found matching '.git*' 05:24:22 INFO - Successfully installed jsonschema functools32 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:22 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 05:24:22 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 05:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:22 INFO - 'HOME': '/Users/cltbld', 05:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PAGER': '/bin/cat', 05:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:22 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - 'XPC_FLAGS': '0x0', 05:24:22 INFO - 'XPC_SERVICE_NAME': '0', 05:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:24:23 INFO - Cleaning up... 05:24:23 INFO - Return code: 0 05:24:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:23 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:23 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 05:24:23 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 05:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:23 INFO - 'HOME': '/Users/cltbld', 05:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:23 INFO - 'LOGNAME': 'cltbld', 05:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:23 INFO - 'MOZ_NO_REMOTE': '1', 05:24:23 INFO - 'NO_EM_RESTART': '1', 05:24:23 INFO - 'PAGER': '/bin/cat', 05:24:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:23 INFO - 'PWD': '/builds/slave/test', 05:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:23 INFO - 'SHELL': '/bin/bash', 05:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:23 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:23 INFO - 'USER': 'cltbld', 05:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:23 INFO - 'XPC_FLAGS': '0x0', 05:24:23 INFO - 'XPC_SERVICE_NAME': '0', 05:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:25 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 05:24:25 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 05:24:25 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 05:24:25 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 05:24:25 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 05:24:25 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 05:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:26 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 05:24:26 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 05:24:26 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 05:24:26 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 05:24:26 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 05:24:26 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 05:24:27 INFO - Downloading docopt-0.6.1.tar.gz 05:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:27 INFO - Running setup.py install for blobuploader 05:24:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:27 INFO - Running setup.py install for requests 05:24:27 INFO - Running setup.py install for docopt 05:24:27 INFO - Successfully installed blobuploader requests docopt 05:24:27 INFO - Cleaning up... 05:24:28 INFO - Return code: 0 05:24:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:28 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')]} 05:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 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')]} 05:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:28 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:28 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 05:24:28 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 05:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:28 INFO - 'HOME': '/Users/cltbld', 05:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:28 INFO - 'LOGNAME': 'cltbld', 05:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:28 INFO - 'MOZ_NO_REMOTE': '1', 05:24:28 INFO - 'NO_EM_RESTART': '1', 05:24:28 INFO - 'PAGER': '/bin/cat', 05:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:28 INFO - 'PWD': '/builds/slave/test', 05:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:28 INFO - 'SHELL': '/bin/bash', 05:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:28 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:28 INFO - 'USER': 'cltbld', 05:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:28 INFO - 'XPC_FLAGS': '0x0', 05:24:28 INFO - 'XPC_SERVICE_NAME': '0', 05:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-DxuaiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-uB4bti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-fwagF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-x50_rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-9k4Mb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ohl6ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:28 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-tSzhdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-GZA2VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-R8yIIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-t5grMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-KMsh35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Jl_ctS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Z2Xqu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-A6SZVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ANNAz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Lb5agc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:29 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-nosRA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:30 INFO - Running setup.py install for manifestparser 05:24:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozcrash 05:24:30 INFO - Running setup.py install for mozdebug 05:24:30 INFO - Running setup.py install for mozdevice 05:24:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozfile 05:24:30 INFO - Running setup.py install for mozhttpd 05:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozinfo 05:24:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for mozInstall 05:24:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for mozleak 05:24:31 INFO - Running setup.py install for mozlog 05:24:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for moznetwork 05:24:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Running setup.py install for mozprocess 05:24:31 INFO - Running setup.py install for mozprofile 05:24:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:32 INFO - Running setup.py install for mozrunner 05:24:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:32 INFO - Running setup.py install for mozscreenshot 05:24:32 INFO - Running setup.py install for moztest 05:24:32 INFO - Running setup.py install for mozversion 05:24:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:32 INFO - Cleaning up... 05:24:32 INFO - Return code: 0 05:24:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:32 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')]} 05:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:32 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')]} 05:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:32 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 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:32 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 05:24:32 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 05:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:32 INFO - 'HOME': '/Users/cltbld', 05:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:32 INFO - 'LOGNAME': 'cltbld', 05:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:32 INFO - 'MOZ_NO_REMOTE': '1', 05:24:32 INFO - 'NO_EM_RESTART': '1', 05:24:32 INFO - 'PAGER': '/bin/cat', 05:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:32 INFO - 'PWD': '/builds/slave/test', 05:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:32 INFO - 'SHELL': '/bin/bash', 05:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:32 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:32 INFO - 'USER': 'cltbld', 05:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:32 INFO - 'XPC_FLAGS': '0x0', 05:24:32 INFO - 'XPC_SERVICE_NAME': '0', 05:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:32 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-cLgria-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-Xv5AkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-mPMtFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-aLtKIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-T5alqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-RmaNHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-vgf6ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-skloke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-SP1_ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-4w9eEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:33 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)) 05:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:33 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-4vfzCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:34 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)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:34 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-9pt0xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:34 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)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:34 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-YC5WEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:34 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)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:34 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ynbfrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:34 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)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:34 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-YWRfuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:34 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)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:34 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-f7xscW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:34 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)) 05:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:34 INFO - Running setup.py (path:/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/pip-ZvC7bK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:34 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)) 05:24:34 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)) 05:24:34 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)) 05:24:34 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)) 05:24:34 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)) 05:24:34 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)) 05:24:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:34 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 05:24:34 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 05:24:34 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 05:24:34 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 05:24:34 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 05:24:34 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 05:24:37 INFO - Downloading blessings-1.6.tar.gz 05:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:37 INFO - Installing collected packages: blessings 05:24:37 INFO - Running setup.py install for blessings 05:24:37 INFO - Successfully installed blessings 05:24:37 INFO - Cleaning up... 05:24:37 INFO - Return code: 0 05:24:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:37 INFO - Reading from file tmpfile_stdout 05:24:37 INFO - Current package versions: 05:24:37 INFO - blessings == 1.6 05:24:37 INFO - blobuploader == 1.2.4 05:24:37 INFO - docopt == 0.6.1 05:24:37 INFO - functools32 == 3.2.3-2 05:24:37 INFO - jsonschema == 2.5.1 05:24:37 INFO - manifestparser == 1.1 05:24:37 INFO - mozInstall == 1.12 05:24:37 INFO - mozcrash == 0.17 05:24:37 INFO - mozdebug == 0.1 05:24:37 INFO - mozdevice == 0.48 05:24:37 INFO - mozfile == 1.2 05:24:37 INFO - mozhttpd == 0.7 05:24:37 INFO - mozinfo == 0.9 05:24:37 INFO - mozleak == 0.1 05:24:37 INFO - mozlog == 3.4 05:24:37 INFO - moznetwork == 0.27 05:24:37 INFO - mozprocess == 0.23 05:24:37 INFO - mozprofile == 0.28 05:24:37 INFO - mozrunner == 6.12 05:24:37 INFO - mozscreenshot == 0.1 05:24:37 INFO - mozsystemmonitor == 0.3 05:24:37 INFO - moztest == 0.7 05:24:37 INFO - mozversion == 1.4 05:24:37 INFO - psutil == 3.1.1 05:24:37 INFO - requests == 1.2.3 05:24:37 INFO - wsgiref == 0.1.2 05:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:37 INFO - 'HOME': '/Users/cltbld', 05:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:37 INFO - 'LOGNAME': 'cltbld', 05:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:37 INFO - 'MOZ_NO_REMOTE': '1', 05:24:37 INFO - 'NO_EM_RESTART': '1', 05:24:37 INFO - 'PAGER': '/bin/cat', 05:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:37 INFO - 'PWD': '/builds/slave/test', 05:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:37 INFO - 'SHELL': '/bin/bash', 05:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:37 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:37 INFO - 'USER': 'cltbld', 05:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:37 INFO - 'XPC_FLAGS': '0x0', 05:24:37 INFO - 'XPC_SERVICE_NAME': '0', 05:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 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)) 05:24:38 INFO - Cleaning up... 05:24:38 INFO - Return code: 0 05:24:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dcac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9add24a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, '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.SrFvlVETHT/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.c8X6pP8x3M/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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 05:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:24:38 INFO - 'HOME': '/Users/cltbld', 05:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:24:38 INFO - 'LOGNAME': 'cltbld', 05:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:38 INFO - 'MOZ_NO_REMOTE': '1', 05:24:38 INFO - 'NO_EM_RESTART': '1', 05:24:38 INFO - 'PAGER': '/bin/cat', 05:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:38 INFO - 'PWD': '/builds/slave/test', 05:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:24:38 INFO - 'SHELL': '/bin/bash', 05:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:24:38 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:24:38 INFO - 'USER': 'cltbld', 05:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:38 INFO - 'XPC_FLAGS': '0x0', 05:24:38 INFO - 'XPC_SERVICE_NAME': '0', 05:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:38 INFO - Cleaning up... 05:24:38 INFO - Return code: 0 05:24:38 INFO - Running post-action listener: _resource_record_post_action 05:24:38 INFO - Running post-action listener: _start_resource_monitoring 05:24:38 INFO - Starting resource monitoring. 05:24:38 INFO - [mozharness: 2016-09-26 12:24:38.379185Z] Finished create-virtualenv step (success) 05:24:38 INFO - [mozharness: 2016-09-26 12:24:38.379987Z] Running install step. 05:24:38 INFO - Running pre-action listener: _resource_record_pre_action 05:24:38 INFO - Running main action method: install 05:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:38 INFO - Reading from file tmpfile_stdout 05:24:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:38 INFO - Reading from file tmpfile_stdout 05:24:38 INFO - Output received: 05:24:38 INFO - Usage: mozinstall [options] installer 05:24:38 INFO - Options: 05:24:38 INFO - -h, --help show this help message and exit 05:24:38 INFO - -d DEST, --destination=DEST 05:24:38 INFO - Directory to install application into. [default: 05:24:38 INFO - "/builds/slave/test"] 05:24:38 INFO - --app=APP Application being installed. [default: firefox] 05:24:38 INFO - mkdir: /builds/slave/test/build/application 05:24:38 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'] 05:24:38 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 05:25:12 INFO - Reading from file tmpfile_stdout 05:25:12 INFO - Output received: 05:25:12 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:25:12 INFO - Running post-action listener: _resource_record_post_action 05:25:12 INFO - [mozharness: 2016-09-26 12:25:12.884884Z] Finished install step (success) 05:25:12 INFO - [mozharness: 2016-09-26 12:25:12.885030Z] Running run-tests step. 05:25:12 INFO - Running pre-action listener: _resource_record_pre_action 05:25:12 INFO - Running main action method: run_tests 05:25:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:12 INFO - 2016-09-26 05:25:12.899 screenresolution[1644:7974] starting screenresolution argv=screenresolution get 05:25:12 INFO - 2016-09-26 05:25:12.902 screenresolution[1644:7974] Display 0: 1600x1200x32@60 05:25:12 INFO - 2016-09-26 05:25:12.907 screenresolution[1645:7976] starting screenresolution argv=screenresolution list 05:25:12 INFO - Available Modes on Display 0 05:25:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:13 INFO - Intel Iris: 05:25:13 INFO - Chipset Model: Intel Iris 05:25:13 INFO - Type: GPU 05:25:13 INFO - Bus: Built-In 05:25:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:13 INFO - Vendor: Intel (0x8086) 05:25:13 INFO - Device ID: 0x0a2e 05:25:13 INFO - Revision ID: 0x0009 05:25:13 INFO - Displays: 05:25:13 INFO - Display: 05:25:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:13 INFO - Display Serial Number: 1600x1200 60 05:25:13 INFO - Main Display: Yes 05:25:13 INFO - Mirror: Off 05:25:13 INFO - Online: Yes 05:25:13 INFO - Rotation: Supported 05:25:13 INFO - Return code: 0 05:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:13 INFO - Python 2.7.3 05:25:13 INFO - Return code: 0 05:25:13 INFO - grabbing minidump binary from tooltool 05:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:13 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 0x10dac0d30>, '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 0x10d8e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dab8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:13 INFO - Return code: 0 05:25:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--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 05:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0342 --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 05:25:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFvlVETHT/Render', 05:25:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:13 INFO - 'HOME': '/Users/cltbld', 05:25:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:13 INFO - 'LOGNAME': 'cltbld', 05:25:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:13 INFO - 'MOZ_NO_REMOTE': '1', 05:25:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:13 INFO - 'NO_EM_RESTART': '1', 05:25:13 INFO - 'PAGER': '/bin/cat', 05:25:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:13 INFO - 'PWD': '/builds/slave/test', 05:25:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:13 INFO - 'SHELL': '/bin/bash', 05:25:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.c8X6pP8x3M/Listeners', 05:25:13 INFO - 'TMPDIR': '/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/', 05:25:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:13 INFO - 'USER': 'cltbld', 05:25:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:13 INFO - 'XPC_FLAGS': '0x0', 05:25:13 INFO - 'XPC_SERVICE_NAME': '0', 05:25:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0342', '--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 05:25:13 INFO - mozversion application_buildid: 20160926030203 05:25:13 INFO - mozversion application_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 05:25:13 INFO - mozversion application_display_name: Nightly 05:25:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:13 INFO - mozversion application_name: Firefox 05:25:13 INFO - mozversion application_remotingname: firefox 05:25:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:25:13 INFO - mozversion application_vendor: Mozilla 05:25:13 INFO - mozversion application_version: 52.0a1 05:25:13 INFO - mozversion platform_buildid: 20160926030203 05:25:13 INFO - mozversion platform_changeset: 29beaebdfaccbdaeb4c1ee5a43a9795ab015ef49 05:25:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:25:13 INFO - mozversion platform_version: 52.0a1 05:25:13 INFO - using testdate: 1474892713 05:25:13 INFO - actual date: 1474892713 05:25:13 INFO - starting webserver on 'localhost:49280' 05:25:13 INFO - SUITE-START | Running 2 tests 05:25:13 INFO - TEST-START | dromaeo_css 05:25:13 INFO - operating with platform_type : mac_ 05:25:13 INFO - Initialising browser for dromaeo_css test... 05:25:13 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpJ7ntzW/profile http://localhost:49280/getInfo.html) 05:25:16 INFO - PROCESS | 1655 | 2016-09-26 05:25:16.364 plugin-container[1658:8152] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 05:25:16 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:25:16 INFO - PROCESS | 1655 | 2016-09-26 05:25:16.364 plugin-container[1658:8152] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d0f, name = 'com.apple.CFPasteboardClient' 05:25:16 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:25:16 INFO - PROCESS | 1655 | 2016-09-26 05:25:16.364 plugin-container[1658:8152] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:25:16 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 05:25:16 INFO - PROCESS | 1655 | colorDepth:24 05:25:16 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 05:25:16 INFO - PROCESS | 1655 | __metrics 05:25:16 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 05:25:17 INFO - TEST-INFO | 1655: exit 0 05:25:17 INFO - Browser initialized. 05:25:17 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:17 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmpJ7ntzW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:20 INFO - PROCESS | 1660 | 2016-09-26 05:25:20.019 plugin-container[1661:8286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x871b, name = 'com.apple.tsm.portname' 05:25:20 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:25:20 INFO - PROCESS | 1660 | 2016-09-26 05:25:20.019 plugin-container[1661:8286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.CFPasteboardClient' 05:25:20 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:25:20 INFO - PROCESS | 1660 | 2016-09-26 05:25:20.019 plugin-container[1661:8286] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:25:29 INFO - PROCESS | 1660 | RSS: Main: 239529984 05:25:29 INFO - PROCESS | 1660 | 05:26:19 INFO - PROCESS | 1660 | 1474892779265 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] 05:28:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 05:28:32 INFO - PROCESS | 1660 | RSS: Main: 255508480 05:28:32 INFO - PROCESS | 1660 | 05:31:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 05:31:35 INFO - PROCESS | 1660 | RSS: Main: 264007680 05:31:35 INFO - PROCESS | 1660 | 05:34:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 05:34:38 INFO - PROCESS | 1660 | RSS: Main: 268046336 05:34:38 INFO - PROCESS | 1660 | 05:37:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 05:37:40 INFO - PROCESS | 1660 | RSS: Main: 269479936 05:37:40 INFO - PROCESS | 1660 | 05:40:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 05:40:44 INFO - PROCESS | 1660 | RSS: Main: 274849792 05:40:44 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 05:43:47 INFO - PROCESS | 1660 | RSS: Main: 277647360 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | __start_tp_report 05:43:47 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 05:43:47 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 05:43:47 INFO - PROCESS | 1660 | |i|pagename|runs| 05:43:47 INFO - PROCESS | 1660 | |0;dojo.html;2851.5294976328905;3389.6440873708275;3423.2297733010078;3431.965680343196;3446.7931924084555;4594.8851278718;5470.152126420401;5723.484886360232;5771.538276937846;5774.566907481934;5579.609427340078;5715.2855893013375;5720.0561907285355;5736.311642602883;5777.59556831022;4166.479190101238;4339.696221264497;4571.679982401233;4891.682040667354;5349.732513374335;5241.135212689902;5263.499967503081;5309.787608495655;5340.839774806743;5363.812266570651;4627.884302892421;5197.896042079156;5255.710935898524;5263.973680131575;5304.602154838402;5106.106431374495;5124.692518448905;5157.458466860963;5178.6116041297055;5211.088059589557;4160.583941605815;5108.2593024011685;5147.794088236466;5187.325647665817;5192.273081768555;5623.0721930881355;5757.510611597977;5797.536197104221;5802.245708057968;5808.780156167168;5471.261379713727;5850.654349499597;6234.345393733638;6257.405546473078;6289.276733175652;6227.750889964396;6280.905786413207;6284.874302513924;6295.338989406138;6324.367563243685;5784.623999440023;5891.410858914117;5931.347551769302;5966.134910437962;5986.132010858489;6204.627722336674;6262.436380725757;6301.464375528131;6315.210598675166;6356.2054743157105;6162.722677479434;6190.473809726133;6191.81424557264;6211.2857021443115;6235.750569977241;6244.781432649836;6276.215473065867;6276.403741644536;6286.937130628635;6315.905261421082;6067.271927368655;6130.049842274366;6139.124180917401;6155.446009859134;6172.783952561728;6111.1967345965195;6173;6218.720157592919;6219.40915613016;6245.094461303176;4955.876103097451;4960.652754307164;4970.353853998957;4977.352944117314;4979.053979743837;3869.903252418656;4366.825326986948;4422.933655995163;4497.078098989699;4512.120136573402;5540.612157149041;5940.61386009908;5955.285365756137;6042.12389203563;6044.637321760621;6251.468625166821;6263.780767673201;6265.279492858289;6269.686515674198;6276.372362763778;5840.561957853178;5869.295684517885;6003.3996600339615;6015.278166619946;6038.909416358758;5429.484199001088;5475.233467314579;5496.1755736639025;5501.449855014466;5553.055980483327;6338.239411270677;6363.077353783768;6391.041343798467;6399.9360006400275;6500.772472963424;6137.907931381123;6236.781712640036;6245.3754624539;6246.656433896179;6250.156228909221;6178.042403427476;6298.622082675054;6327.272363678236;6331.3352098029045;6369.426751592379;6240.968795155995;6256.186695729526;6260.499160067275;6282.994720844826;6286.6856657166045;5953.345132035559;6134.620279381683;6173.043178307369;6204.5967012145875;6268.874622507433;5786;6066.848328791815;6193.783217587363;6209.689515524296;6223.128761973237;6073.514118870568;6078.270607527125;6098.725557350019;6128.380904898417;6135;5102.260172275073;5989.850253743692;6064;6070.2108725865355;6092.268927728701;4950.529699678525;5081.44104148536;5408.540274076748;5676.978143934131;6178.536609754196;4799.688020278671;5855.531557475477;5933.910991335047;5966.0454327307425;6006.609570377911 05:43:47 INFO - PROCESS | 1660 | |1;ext.html;466.28425367061556;468.2648242259652;518.0855789531478;526.830436431123;534.7353060235184;38868;40882.79558602207;41027.99999999996;41061.58938410615;41133.7943310283;42957;43195.784021079926;43329.566704332945;43347.78326108365;43428.56571434285;10060.849087263698;10062.446565438899;10086.142677872389;10090.798184036315;10150.0864922157;9911.454869982148;10013.799724005552;10016.49917504122;10029.297949143564;10054.346467479627;8350.248477637011;9908;10008.899911000906;10020.448875311891;10049.447280399576;9970.551325190347;10043.74890627733;10053.04496072872;10074.798504029952;10084.94108118648;8169.550674712888;9961.601535938555;9969;9983.301168918179;10024.19806415485;40463.7976810117;40667.7966610168;40697;40920;41022.79488602568;3375.8987230383127;3409.0454672691685;3426.246225830338;3442.277121804424;3957.8021098945223;30605.540916886264;30658.333499730357;30721.846390768125;31310;32196.678033219603;2948.3366242595457;2957.935143348393;3186.2990142168687;3221.2808235934467;3228.983855080733;329388;369470;392430;396237;397813.01093494636;57819;58126;58167.709161453924;58205.126923096184;58358.8328233433;34007;34971.77598784081;55787.72106139525;55872.72063639737;56163;15764.369425222863;16237.675246495004;16288.452597003266;16290.637857510832;16350.591235219215;12334.876651233551;12388.194767340094;12434.75130497385;12465.563705270271;12470.81293780594;18741.81258187428;18812.341568045325;18816;18841;18873.43379698611;7237.095363079615;8088.555129467818;8152.510849349058;8199.836003280021;8282.337413006944;801.6272433318535;824.6371596497522;862.4782006885744;975.5171190260725;1083.3175099687146;26984;29195.85402072976;29899.701002989692;30098.398032039237;30771.538426923613;985.2069084386994;985.9408435493893;994.3188915592842;995.7012896131132;1040.9642405806119;11623.244489108181;12766.68083297925;15486.148261845707;15533.766993495106;15865.762013569805;619945;623170;625072;625517;628927;57595.71202143963;57831.8433631325;58292.708536457896;58332.4166758327;58585.70707146437;1146.4668928948079;1392.1994852959588;1409.0981771666347;1409.901306908527;1410.7601707709714;25256;27430.862845685642;29741.85129074341;30368.696313036588;30792.384152317278;45204.54795452135;48196.79508012328;56144.71927640335;56402;59333.70333148307;503008;569611;572531;573890;574748;30813.537796932615;36852.26295474022;40831.18337633171;41132.14905329207;42588.148237035704;41953.580464194965;46702.83242918818;47063;47981.04037919152;48108.518914810404;36313.72901948419;39371;39568.80215599019;39906.40140397838;41286.79356603198;34606.65393346135;37116.628833711315;39109.804450977565;40328.79835600803;40687.77936661905;31597.684023159472;37723;38112.61887381202;38189.809050954565;39032.804835975636;30525.389492210477;32992.83503582467;34761.65238347584;34924.12689682778;35141.82429087838;24115.879420602785;25553.744462555136;25632.02316839762;25977.42564796694;26090 05:43:47 INFO - PROCESS | 1660 | |2;jquery.html;297.6606668398026;358.77217966591206;363.1792149741584;372.05126926337834;393.2901113490151;18993.620127597438;19512.31706890259;20584.485387865294;20625.690614640793;20826.583468330624;20014.69977950332;20081.497962550944;20201.48488863334;20514.179432822708;20708.171673133093;5120.692758434497;5857.76568937242;6051.364606716297;6132.938670613281;6144.754209831602;5855.209546711182;5935;6026.9095963560585;6031.6984150792505;6039;5719.227904232917;5958.195643588104;5970.194023806774;5973.761049558012;5976.790812321569;5973.074173503114;6024.427679370453;6026;6029.547783916202;6048.123022161806;4531.796069176895;4999.650024498286;5043.36957880265;5131.179011358202;5151.768170432302;24325.270241892595;24441.511169776506;24528.632070518957;24687.88904499302;24977.125800597074;1630.331564058742;2102.127617038927;2166.42589713726;2183.170395249811;2323.4075310795806;9917.206623470105;9947.75130621733;10031.448270345129;10445.95540445957;10455.738606534822;1851.6204178143448;1854.7774267088037;1877.1007669981338;1927.691767232202;1959.5786905815319;117530;121013.39493302566;124650.9999999991;126663;128294.35852820677;11276.718082048015;11538.480768365444;11550.306981581132;11597.304161750322;11725.88274117248;14231.146131232159;14307;14331.355089021019;14339.641508962359;14383.712325753635;8309.95845020771;8407.747767566983;8450.323974082059;8459.492430454193;8466.983961924609;8435.83128337442;8454.900862887785;8543.786405339917;8621.741347759576;8628.78428039304;4391.7584532851;4494.505604383515;4496.258117410591;4586.678932474695;4616.261398176276;1873.6790562653296;1900.4393703857395;1916.9137388817537;1923.9615207695767;1924.5573518090916;785.8271180340316;823.3248736036393;882.2456799436518;907.7912080221586;926.8656044873455;20158.092885820173;20854.37436876896;20908.477288067617;21133.154673813184;21190.926275992624;855.3755758296478;921.7925966657449;930.9162175404247;938.7420856052786;962.1100482054072;7496.6251687415415;9950.426688125146;10884;10947.938579616262;10981.341119532854;530180.349098252;539394;544356;544574;550543;47657.523424766005;59379;61768;104919.32782352733;106196.40705389425;875.6497401039508;918.1644703319947;966.7873067925045;968.4431451915318;972.2756546372998;16884.831151688817;18338.532917366847;18417.53956151107;18776.155073021473;18975.240990360784;36760.63239367572;40666.59333406747;46335.53664463447;51518.484815151365;54034;79986.6000669993;80545;81618.59190704246;82158.58920705358;83274.75087873565;6618.966905165636;6907.516473846783;8129.5204962487005;8171.591420429074;8249.917500824915;12635.810462842881;12807.423665934868;12865.67835804075;13134;13159.47362105505;10798.11275870267;11213.943930280297;11226.326420414802;11494.885051149382;11723.41382930867;11096.389698566656;11249.775004500028;11474.77050459003;11475.540978360772;11800.52797888075;11282.661520154408;11416.82874756896;11548;11786.469608867794;12017.4592143352;8045.316148127475;8090.1909809018625;8203.179682031749;8270.421070525006;8471.110533394152;8317.750467485985;9118.452892826452;11483.770324593293;11817.172797904064;11892 05:43:47 INFO - PROCESS | 1660 | |3;mootools.html;1493.402638944422;1545.0034727600696;1715.8627309815215;1814.4919422561688;1835.8164183581653;8074.475159114668;8334.83330333393;8510.106438823927;9037.412568183063;9063.410878292907;8587.184217499344;8872.822543549126;8894;8903.955480222607;8939.195472407482;2393.521295740859;2396.2332053742766;2426.350081944277;2426.5874801283826;2432.7323994360604;2391.497785465054;2404.4589967257316;2426.745191754867;2437.841540299875;2440.2191298784396;2409.6987876515436;2414.2515820095828;2422.2975337152293;2425.745296743843;2435.841670291434;2398.6761787158684;2399.748026457214;2407.5064611754547;2419.7096348438213;2423.1882319423016;2385.1413491143176;2393.258089992108;2393.80849532037;2397.077125306752;2402.423418379594;8880;8928.419652722618;8996;9017.053209412983;9023.278137748965;5263.6841789492755;5399.325084364455;5423.267858839045;5423.755930983076;5431.918521222185;3433.7424693147864;3600.891973240807;3633.454981752758;3661.121330880596;3662.901129661091;1053.847192157133;1080.1790639114251;1084.4577711144427;1098.3903933317006;1101.3226865477754;11704.063674905987;11801.40992950349;11824.645260642195;11830.585929492427;11835.467403966843;4399.780010999437;4644.930326045112;4683.461401938753;4819.228923372244;4843.15244832153;10002.49987500622;10072.143867771176;10078.899211007796;10092.596296148218;10093.343932644502;5238.895222095537;5256.26412302278;5257.579393648499;5262.842114736564;5276.63063585553;4390.1878152541885;4516.435445569304;4736.313234581035;4785.880352991134;4866.6350023747655;3895.8831235062994;3920.353141731582;4000.3599424092004;4025.637692607621;4052.959470405317;1097.5280629329304;1105.4748994227677;1109.2401704832216;1198.2930071258;1303.1464390824026;908.7364664247294;924.177482040984;925.4678559828126;938.1931538876561;957.4064080270277;4920.458749537548;5989;6150.876982460415;6229.068988613544;6275.215598050244;429.2830972276306;436.4478934148305;441.8563966710832;442.1400376268128;445.6657506869848;4008.6392224699916;4022.899427514277;4100.384942258685;4130.483689538808;4172.624463798273;9839.458829764431;10691.679249622524;10743.194260430499;10756.56973721058;10802.973717496825;8880.600372983232;10426.27016108865;10679.305845120043;10710.303830251165;10724.73188170302;8154.796130096795;8314.127016663284;8327.125651806473;8353.289970352587;8376.497410155533;5705.686187259575;5883.382244864228;5937.287525496968;5948.405159484017;6007.519398448201;8493;10033.899661003297;10113.443760593238;10118.79762404733;10149.543270552695;9891.406515609087;10237.976202379703;10300.845487317845;10311.535980881028;10328.173746100143;6942.166939967236;7130.251323611154;7308.671109800178;7509.66206520697;7568.735094271674;8248.83502329938;8411.957940210259;8423.957880210559;8531.061583225715;8562.315014798676;6274;7590.582517961344;7618.847623047397;7662.885056724042;7742.845143097219;7190.245024272376;7338.77983660491;7352.154502232098;7383.741569045058;7466.178720340649;6982.231954484901;6988.126484189476;7040.049593304839;7063.858722825617;7071.540349877241;5024.748762561784;5045.066662667418;5087.440381557952;5097.2608971698155;5174.172132458939;5035.370578677665;5115.488451154854;5193.532582067632;5217.452167522356;5290.127129023668 05:43:47 INFO - PROCESS | 1660 | |4;prototype.html;239.86807256009192;261.2059339607593;305.6210299228956;310.6334525260192;310.77003017766845;4103.948025987006;4417.624501917341;4924.236743304785;5435.4292799256;5600.131979543172;5238.79044838206;5359.5712343012565;5426.158945363465;5452.9182062269;5491.258680078188;4158.877103182146;4162.271602469556;4163.916721665565;4178.519470260913;4183.719872669387;3309.7186739127205;3390.4236279832367;3835.9041023974346;4186.225548273564;4189.204051230272;3728.291624591319;3771.811409429531;4076.714629975888;4101.507819061717;4115.71190016699;4072.694547908904;4080.4083407905837;4112.300908845504;4124.340105583093;4131.710780245384;3255.746537583024;3550.349087674244;3578.6958108560802;3581.4448760442174;3583.372909740785;4389.7173469795525;4424.911501769979;4868.831480444704;5387.568994480433;5432.782688692448;4762.404699412574;4786.641001924835;4791.856244312677;4797.352357431771;4800.567948884583;4239.618434340924;5604.495595396434;5824.446677565625;5870.178175055496;5871.794487192928;3405.7786243894316;3799.411091280856;3831.2720583089404;3896.6814745226543;3910.081130934228;5967.761289548413;5973.133895585116;6035.577509574332;6055.153178280622;6127.754889804447;3486.738494612914;3825.5218097737784;3968.761874287552;4010.6590939770444;4011.656095208138;3402.7788193767324;3895.552011518655;4003.3794761811964;4037.2127435149864;4050.4531888195306;4258.105143211304;4538.160440318552;4704.29435584665;4710.411198600175;4730.2431610942085;5379.973100134553;5820.82537523875;5882.382349853289;5935.287765468085;5939;1290.1871820753054;1329.2224048931485;1337.6455239361576;1365.4401695305075;1371.5405339211477;796.8366484870587;905.158202871336;907.2424525521131;916.7387294621001;925.4956048953337;4751.904961900812;5337.733113344318;5397.892042159135;5418.593605479605;5425.240466334716;4930.309756634074;5002.849914502571;5064.1897296433135;5600.943990560124;5766.682832444172;4533.9319910201375;5155.911855698449;5334.439883812144;5406.8918621627345;5440.401555828856;2155.5904378168098;2283.549945784439;2324.6629238760625;2519.4583164619694;2537.857963916245;5049.798008079709;5099.311592934981;5105.897882042338;5121.61587880903;5127.256547800548;4046.8349433053177;4381.408509851193;4648.604868586141;4801.591864691471;4980;4311.981612871003;4653.930191047137;4840.709557426495;5091.949080509147;5153.871153221125;4576.496585375673;4688.835890743944;4868.926966095582;4874.829380971649;4951.9752401237765;3840.519935008124;4299.054208074219;4673.906521869611;4775.570198682135;4834.419869615669;4342.264373444709;4431.540495025292;4988.226824842155;5173.379194496684;5185.585153187812;2944.1020488751137;3425.0067480431394;3437.604675462254;3446.276281980812;3478.3217272631596;4346.500152482378;4571.72569645809;4731.645126615586;4795.506336704963;5019.7741101651245;4816.8554943351755;5107.693538387709;5782.335031471434;5833.591648584558;5838.357780644041;5801.564882633735;5809.593328466966;5826.766929322949;5831.271091113611;5834.18321434991;4388.934165987449;5372.435894231049;5500.669959802424;5612;5652.208690783212;5292.788288468418;5508.641938274;5867.5305975521005;5872.588918775645;5883.264591926009;5096.362954630671;5468.863278417913;5712.34308054579;5750.166225897305;5752.28096487939 05:43:47 INFO - PROCESS | 1660 | |5;yui.html;707.1761397971363;727.9999999999997;741.8034220931451;758.5486635451907;801.5911884938683;12528.686782830433;13438.46246150153;15100.924495377521;15676.294566744524;16200.189990500472;14597;14654.120752754816;14738.926305368484;14745.705085898275;14750.409983600643;718.4503854551273;854.2824027816632;860.853654878669;862.241227719609;863.8661007543841;679.9014142949269;695.8817001109799;835.8871552340447;859.5659192107977;865.4763867859948;842.9325653947669;860.2343913916619;885.5218182181615;913.447364344572;925.0656836595053;876.5967654878732;902.3728508686465;911.1207684584408;920.1672486399818;921.7280902133853;679.6669631880393;683.040328338685;684.9623270720108;686.2005763285766;687.0450074396592;11961.94019029908;14398.992070555065;14659.267036648125;14664.266786660732;14968.625784355369;14467.27663616815;14555.199464029474;14633.926830365781;14821.258937053211;14825.555233343017;11922.403879805976;11992.760144797143;12079.335636539987;12344.074194435363;12449.626511204679;3759.4924685167425;3868.651821336065;3875.360565506688;3977.8607748728655;3992.640662340403;75814;118774.21838672427;121098.39450802778;121385;121931;11083;11120.443977801078;11147;11239.719007024889;11305.208635395607;20053.39839804808;21863.781362186175;22916.312510624706;22958.852057397064;23000.769992300196;6087.665178415141;7849.450538462253;7963.920360796318;8013.519188848688;8164.428490005761;4281.293586558245;4364.388985542027;4377.080813029236;4491.6631252655525;4512.796924138422;3510.1751088494184;3603.045193023851;3613.584437789635;3648.288583726148;3678.9816050919576;572.7995201679379;644.3492073006297;649.1042361541043;655.4035827397046;675.7432175773273;530.0406264660976;648.8054726195171;664.8703502817001;667.5794249622803;679.2596070283316;8348.582570871433;9320.533973301308;9369.109934556207;9380.765480863032;9674.516274186262;550.4000639303179;645.4449173710605;655.8032590222914;682.1507223506766;693.015917397297;4478.619317357996;4666.4633567139535;4691.577758001797;4704.317873908264;4723.551262630044;157433;158813.41186588217;161081;161786;165626;139774.3011284937;141975.48147111206;142577;142979;144756;99911.50221244236;114458;120702;123052;123433;8966.598745455502;9031.277497800029;9068.319876009195;9121.817563648823;9176.35765496409;65969;66311;66913.66543167253;68085.65957170182;68363.65818170877;85261.57369213115;86495;91440;92150.07849921416;93426.53286733523;10857.402842843403;11416.675797085558;12833.743325133632;12918.547850825176;13252.602421927357;14343.856561434251;14356.49752258666;14412.207328597027;14921.626959326104;15113.773293400387;13505;13707.931460342634;13725.931370343083;13772.862271377158;13903.235322057384;13569;13748.207542957249;13800.654983625489;13910.234937078558;14307.141571505743;13252.801207981694;13414.337547339568;13720.81182801063;14015.229162395759;14170.858291416955;11096.833547496955;11166.498516468133;11323.886761132284;11591.014763745176;11687.88312116868;10325.277230594087;10821.837672434762;11598.103229970886;11679.416029198675;11699.590514331958 05:43:47 INFO - PROCESS | 1660 | __end_tp_report 05:43:47 INFO - PROCESS | 1660 | __start_cc_report 05:43:47 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,350 05:43:47 INFO - PROCESS | 1660 | __end_cc_report 05:43:47 INFO - PROCESS | 1660 | __startTimestamp1474893827841__endTimestamp 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | ------- Summary: start ------- 05:43:47 INFO - PROCESS | 1660 | Number of tests: 6 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5704.42 Median:5986.13 stddev:707.65 (11.8%) stddev-sans-first:673.50 05:43:47 INFO - PROCESS | 1660 | Values: 2851.5 3389.6 3423.2 3432.0 3446.8 4594.9 5470.2 5723.5 5771.5 5774.6 5579.6 5715.3 5720.1 5736.3 5777.6 4166.5 4339.7 4571.7 4891.7 5349.7 5241.1 5263.5 5309.8 5340.8 5363.8 4627.9 5197.9 5255.7 5264.0 5304.6 5106.1 5124.7 5157.5 5178.6 5211.1 4160.6 5108.3 5147.8 5187.3 5192.3 5623.1 5757.5 5797.5 5802.2 5808.8 5471.3 5850.7 6234.3 6257.4 6289.3 6227.8 6280.9 6284.9 6295.3 6324.4 5784.6 5891.4 5931.3 5966.1 5986.1 6204.6 6262.4 6301.5 6315.2 6356.2 6162.7 6190.5 6191.8 6211.3 6235.8 6244.8 6276.2 6276.4 6286.9 6315.9 6067.3 6130.0 6139.1 6155.4 6172.8 6111.2 6173.0 6218.7 6219.4 6245.1 4955.9 4960.7 4970.4 4977.4 4979.1 3869.9 4366.8 4422.9 4497.1 4512.1 5540.6 5940.6 5955.3 6042.1 6044.6 6251.5 6263.8 6265.3 6269.7 6276.4 5840.6 5869.3 6003.4 6015.3 6038.9 5429.5 5475.2 5496.2 5501.4 5553.1 6338.2 6363.1 6391.0 6399.9 6500.8 6137.9 6236.8 6245.4 6246.7 6250.2 6178.0 6298.6 6327.3 6331.3 6369.4 6241.0 6256.2 6260.5 6283.0 6286.7 5953.3 6134.6 6173.0 6204.6 6268.9 5786.0 6066.8 6193.8 6209.7 6223.1 6073.5 6078.3 6098.7 6128.4 6135.0 5102.3 5989.9 6064.0 6070.2 6092.3 4950.5 5081.4 5408.5 5677.0 6178.5 4799.7 5855.5 5933.9 5966.0 6006.6 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:66079.81 Median:38528.90 stddev:141803.62 (368.0%) stddev-sans-first:142115.85 05:43:47 INFO - PROCESS | 1660 | Values: 466.3 468.3 518.1 526.8 534.7 38868.0 40882.8 41028.0 41061.6 41133.8 42957.0 43195.8 43329.6 43347.8 43428.6 10060.8 10062.4 10086.1 10090.8 10150.1 9911.5 10013.8 10016.5 10029.3 10054.3 8350.2 9908.0 10008.9 10020.4 10049.4 9970.6 10043.7 10053.0 10074.8 10084.9 8169.6 9961.6 9969.0 9983.3 10024.2 40463.8 40667.8 40697.0 40920.0 41022.8 3375.9 3409.0 3426.2 3442.3 3957.8 30605.5 30658.3 30721.8 31310.0 32196.7 2948.3 2957.9 3186.3 3221.3 3229.0 329388.0 369470.0 392430.0 396237.0 397813.0 57819.0 58126.0 58167.7 58205.1 58358.8 34007.0 34971.8 55787.7 55872.7 56163.0 15764.4 16237.7 16288.5 16290.6 16350.6 12334.9 12388.2 12434.8 12465.6 12470.8 18741.8 18812.3 18816.0 18841.0 18873.4 7237.1 8088.6 8152.5 8199.8 8282.3 801.6 824.6 862.5 975.5 1083.3 26984.0 29195.9 29899.7 30098.4 30771.5 985.2 985.9 994.3 995.7 1041.0 11623.2 12766.7 15486.1 15533.8 15865.8 619945.0 623170.0 625072.0 625517.0 628927.0 57595.7 57831.8 58292.7 58332.4 58585.7 1146.5 1392.2 1409.1 1409.9 1410.8 25256.0 27430.9 29741.9 30368.7 30792.4 45204.5 48196.8 56144.7 56402.0 59333.7 503008.0 569611.0 572531.0 573890.0 574748.0 30813.5 36852.3 40831.2 41132.1 42588.1 41953.6 46702.8 47063.0 47981.0 48108.5 36313.7 39371.0 39568.8 39906.4 41286.8 34606.7 37116.6 39109.8 40328.8 40687.8 31597.7 37723.0 38112.6 38189.8 39032.8 30525.4 32992.8 34761.7 34924.1 35141.8 24115.9 25553.7 25632.0 25977.4 26090.0 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:31994.26 Median:382.67 stddev:90174.14 (23564.4%) stddev-sans-first:90395.70 05:43:47 INFO - PROCESS | 1660 | Values: 297.7 358.8 363.2 372.1 393.3 18993.6 19512.3 20584.5 20625.7 20826.6 20014.7 20081.5 20201.5 20514.2 20708.2 5120.7 5857.8 6051.4 6132.9 6144.8 5855.2 5935.0 6026.9 6031.7 6039.0 5719.2 5958.2 5970.2 5973.8 5976.8 5973.1 6024.4 6026.0 6029.5 6048.1 4531.8 4999.7 5043.4 5131.2 5151.8 24325.3 24441.5 24528.6 24687.9 24977.1 1630.3 2102.1 2166.4 2183.2 2323.4 9917.2 9947.8 10031.4 10446.0 10455.7 1851.6 1854.8 1877.1 1927.7 1959.6 117530.0 121013.4 124651.0 126663.0 128294.4 11276.7 11538.5 11550.3 11597.3 11725.9 14231.1 14307.0 14331.4 14339.6 14383.7 8310.0 8407.7 8450.3 8459.5 8467.0 8435.8 8454.9 8543.8 8621.7 8628.8 4391.8 4494.5 4496.3 4586.7 4616.3 1873.7 1900.4 1916.9 1924.0 1924.6 785.8 823.3 882.2 907.8 926.9 20158.1 20854.4 20908.5 21133.2 21190.9 855.4 921.8 930.9 938.7 962.1 7496.6 9950.4 10884.0 10947.9 10981.3 530180.3 539394.0 544356.0 544574.0 550543.0 47657.5 59379.0 61768.0 104919.3 106196.4 875.6 918.2 966.8 968.4 972.3 16884.8 18338.5 18417.5 18776.2 18975.2 36760.6 40666.6 46335.5 51518.5 54034.0 79986.6 80545.0 81618.6 82158.6 83274.8 6619.0 6907.5 8129.5 8171.6 8249.9 12635.8 12807.4 12865.7 13134.0 13159.5 10798.1 11213.9 11226.3 11494.9 11723.4 11096.4 11249.8 11474.8 11475.5 11800.5 11282.7 11416.8 11548.0 11786.5 12017.5 8045.3 8090.2 8203.2 8270.4 8471.1 8317.8 9118.5 11483.8 11817.2 11892.0 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5721.79 Median:4709.89 stddev:3209.45 (68.1%) stddev-sans-first:3202.73 05:43:47 INFO - PROCESS | 1660 | Values: 1493.4 1545.0 1715.9 1814.5 1835.8 8074.5 8334.8 8510.1 9037.4 9063.4 8587.2 8872.8 8894.0 8904.0 8939.2 2393.5 2396.2 2426.4 2426.6 2432.7 2391.5 2404.5 2426.7 2437.8 2440.2 2409.7 2414.3 2422.3 2425.7 2435.8 2398.7 2399.7 2407.5 2419.7 2423.2 2385.1 2393.3 2393.8 2397.1 2402.4 8880.0 8928.4 8996.0 9017.1 9023.3 5263.7 5399.3 5423.3 5423.8 5431.9 3433.7 3600.9 3633.5 3661.1 3662.9 1053.8 1080.2 1084.5 1098.4 1101.3 11704.1 11801.4 11824.6 11830.6 11835.5 4399.8 4644.9 4683.5 4819.2 4843.2 10002.5 10072.1 10078.9 10092.6 10093.3 5238.9 5256.3 5257.6 5262.8 5276.6 4390.2 4516.4 4736.3 4785.9 4866.6 3895.9 3920.4 4000.4 4025.6 4053.0 1097.5 1105.5 1109.2 1198.3 1303.1 908.7 924.2 925.5 938.2 957.4 4920.5 5989.0 6150.9 6229.1 6275.2 429.3 436.4 441.9 442.1 445.7 4008.6 4022.9 4100.4 4130.5 4172.6 9839.5 10691.7 10743.2 10756.6 10803.0 8880.6 10426.3 10679.3 10710.3 10724.7 8154.8 8314.1 8327.1 8353.3 8376.5 5705.7 5883.4 5937.3 5948.4 6007.5 8493.0 10033.9 10113.4 10118.8 10149.5 9891.4 10238.0 10300.8 10311.5 10328.2 6942.2 7130.3 7308.7 7509.7 7568.7 8248.8 8412.0 8424.0 8531.1 8562.3 6274.0 7590.6 7618.8 7662.9 7742.8 7190.2 7338.8 7352.2 7383.7 7466.2 6982.2 6988.1 7040.0 7063.9 7071.5 5024.7 5045.1 5087.4 5097.3 5174.2 5035.4 5115.5 5193.5 5217.5 5290.1 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4387.85 Median:4789.25 stddev:1365.55 (28.5%) stddev-sans-first:1333.41 05:43:47 INFO - PROCESS | 1660 | Values: 239.9 261.2 305.6 310.6 310.8 4103.9 4417.6 4924.2 5435.4 5600.1 5238.8 5359.6 5426.2 5452.9 5491.3 4158.9 4162.3 4163.9 4178.5 4183.7 3309.7 3390.4 3835.9 4186.2 4189.2 3728.3 3771.8 4076.7 4101.5 4115.7 4072.7 4080.4 4112.3 4124.3 4131.7 3255.7 3550.3 3578.7 3581.4 3583.4 4389.7 4424.9 4868.8 5387.6 5432.8 4762.4 4786.6 4791.9 4797.4 4800.6 4239.6 5604.5 5824.4 5870.2 5871.8 3405.8 3799.4 3831.3 3896.7 3910.1 5967.8 5973.1 6035.6 6055.2 6127.8 3486.7 3825.5 3968.8 4010.7 4011.7 3402.8 3895.6 4003.4 4037.2 4050.5 4258.1 4538.2 4704.3 4710.4 4730.2 5380.0 5820.8 5882.4 5935.3 5939.0 1290.2 1329.2 1337.6 1365.4 1371.5 796.8 905.2 907.2 916.7 925.5 4751.9 5337.7 5397.9 5418.6 5425.2 4930.3 5002.8 5064.2 5600.9 5766.7 4533.9 5155.9 5334.4 5406.9 5440.4 2155.6 2283.5 2324.7 2519.5 2537.9 5049.8 5099.3 5105.9 5121.6 5127.3 4046.8 4381.4 4648.6 4801.6 4980.0 4312.0 4653.9 4840.7 5091.9 5153.9 4576.5 4688.8 4868.9 4874.8 4952.0 3840.5 4299.1 4673.9 4775.6 4834.4 4342.3 4431.5 4988.2 5173.4 5185.6 2944.1 3425.0 3437.6 3446.3 3478.3 4346.5 4571.7 4731.6 4795.5 5019.8 4816.9 5107.7 5782.3 5833.6 5838.4 5801.6 5809.6 5826.8 5831.3 5834.2 4388.9 5372.4 5500.7 5612.0 5652.2 5292.8 5508.6 5867.5 5872.6 5883.3 5096.4 5468.9 5712.3 5750.2 5752.3 05:43:47 INFO - PROCESS | 1660 | 05:43:47 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:25887.59 Median:3630.94 stddev:42339.38 (1166.1%) stddev-sans-first:42415.94 05:43:47 INFO - PROCESS | 1660 | Values: 707.2 728.0 741.8 758.5 801.6 12528.7 13438.5 15100.9 15676.3 16200.2 14597.0 14654.1 14738.9 14745.7 14750.4 718.5 854.3 860.9 862.2 863.9 679.9 695.9 835.9 859.6 865.5 842.9 860.2 885.5 913.4 925.1 876.6 902.4 911.1 920.2 921.7 679.7 683.0 685.0 686.2 687.0 11961.9 14399.0 14659.3 14664.3 14968.6 14467.3 14555.2 14633.9 14821.3 14825.6 11922.4 11992.8 12079.3 12344.1 12449.6 3759.5 3868.7 3875.4 3977.9 3992.6 75814.0 118774.2 121098.4 121385.0 121931.0 11083.0 11120.4 11147.0 11239.7 11305.2 20053.4 21863.8 22916.3 22958.9 23000.8 6087.7 7849.5 7963.9 8013.5 8164.4 4281.3 4364.4 4377.1 4491.7 4512.8 3510.2 3603.0 3613.6 3648.3 3679.0 572.8 644.3 649.1 655.4 675.7 530.0 648.8 664.9 667.6 679.3 8348.6 9320.5 9369.1 9380.8 9674.5 550.4 645.4 655.8 682.2 693.0 4478.6 4666.5 4691.6 4704.3 4723.6 157433.0 158813.4 161081.0 161786.0 165626.0 139774.3 141975.5 142577.0 142979.0 144756.0 99911.5 114458.0 120702.0 123052.0 123433.0 8966.6 9031.3 9068.3 9121.8 9176.4 65969.0 66311.0 66913.7 68085.7 68363.7 85261.6 86495.0 91440.0 92150.1 93426.5 10857.4 11416.7 12833.7 12918.5 13252.6 14343.9 14356.5 14412.2 14921.6 15113.8 13505.0 13707.9 13725.9 13772.9 13903.2 13569.0 13748.2 13800.7 13910.2 14307.1 13252.8 13414.3 13720.8 14015.2 14170.9 11096.8 11166.5 11323.9 11591.0 11687.9 10325.3 10821.8 11598.1 11679.4 11699.6 05:43:47 INFO - PROCESS | 1660 | -------- Summary: end -------- 05:43:47 INFO - PROCESS | 1660 | 05:43:48 INFO - TEST-INFO | 1660: exit 0 05:43:48 INFO - TEST-OK | dromaeo_css | took 1115000ms 05:43:48 INFO - TEST-START | kraken 05:43:48 INFO - operating with platform_type : mac_ 05:43:48 INFO - Initialising browser for kraken test... 05:43:48 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmp6kxent/profile http://localhost:49280/getInfo.html) 05:43:51 INFO - PROCESS | 1668 | 2016-09-26 05:43:51.341 plugin-container[1670:10298] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8927, name = 'com.apple.tsm.portname' 05:43:51 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:43:51 INFO - PROCESS | 1668 | 2016-09-26 05:43:51.343 plugin-container[1670:10298] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 05:43:51 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:43:51 INFO - PROCESS | 1668 | 2016-09-26 05:43:51.343 plugin-container[1670:10298] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:43:51 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:43:51 INFO - PROCESS | 1668 | colorDepth:24 05:43:51 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:43:51 INFO - PROCESS | 1668 | __metrics 05:43:51 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 05:43:52 INFO - TEST-INFO | 1668: exit 0 05:43:52 INFO - Browser initialized. 05:43:52 INFO - Running cycle 1/1 for kraken test... 05:43:52 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/T/tmp6kxent/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:55 INFO - PROCESS | 1671 | 2016-09-26 05:43:54.995 plugin-container[1672:10412] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.tsm.portname' 05:43:55 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:43:55 INFO - PROCESS | 1671 | 2016-09-26 05:43:54.996 plugin-container[1672:10412] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c03, name = 'com.apple.CFPasteboardClient' 05:43:55 INFO - PROCESS | 1671 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:43:55 INFO - PROCESS | 1671 | 2016-09-26 05:43:54.996 plugin-container[1672:10412] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:44:04 INFO - PROCESS | 1671 | RSS: Main: 239665152 05:44:04 INFO - PROCESS | 1671 | 05:44:07 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:08 INFO - PROCESS | 1671 | RSS: Main: 253251584 05:44:08 INFO - PROCESS | 1671 | 05:44:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 05:44:11 INFO - PROCESS | 1671 | RSS: Main: 260718592 05:44:11 INFO - PROCESS | 1671 | 05:44:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 05:44:15 INFO - PROCESS | 1671 | RSS: Main: 261660672 05:44:15 INFO - PROCESS | 1671 | 05:44:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 05:44:18 INFO - PROCESS | 1671 | RSS: Main: 263835648 05:44:18 INFO - PROCESS | 1671 | 05:44:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:21 INFO - PROCESS | 1671 | RSS: Main: 264212480 05:44:21 INFO - PROCESS | 1671 | 05:44:23 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:24 INFO - PROCESS | 1671 | RSS: Main: 264560640 05:44:24 INFO - PROCESS | 1671 | 05:44:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:28 INFO - PROCESS | 1671 | RSS: Main: 264839168 05:44:28 INFO - PROCESS | 1671 | 05:44:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 05:44:32 INFO - PROCESS | 1671 | RSS: Main: 264937472 05:44:32 INFO - PROCESS | 1671 | 05:44:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:34 INFO - PROCESS | 1671 | RSS: Main: 264728576 05:44:34 INFO - PROCESS | 1671 | 05:44:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:36 INFO - PROCESS | 1671 | RSS: Main: 264724480 05:44:36 INFO - PROCESS | 1671 | 05:44:39 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:40 INFO - PROCESS | 1671 | RSS: Main: 264765440 05:44:40 INFO - PROCESS | 1671 | 05:44:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:43 INFO - PROCESS | 1671 | RSS: Main: 265129984 05:44:43 INFO - PROCESS | 1671 | 05:44:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:47 INFO - PROCESS | 1671 | RSS: Main: 264925184 05:44:47 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 05:44:49 INFO - PROCESS | 1671 | RSS: Main: 266641408 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | __start_tp_report 05:44:49 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:44:49 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:44:49 INFO - PROCESS | 1671 | |i|pagename|runs| 05:44:49 INFO - PROCESS | 1671 | |0;ai-astar;113;117;116;116;117;117;117;116;117;119 05:44:49 INFO - PROCESS | 1671 | |1;audio-beat-detection;142;109;110;146;116;137;114;114;138;110 05:44:49 INFO - PROCESS | 1671 | |2;audio-dft;198;210;269;199;274;283;197;196;189;201 05:44:49 INFO - PROCESS | 1671 | |3;audio-fft;85;59;60;84;62;61;58;60;78;59 05:44:49 INFO - PROCESS | 1671 | |4;audio-oscillator;85;59;101;105;100;71;88;75;65;88 05:44:49 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;96;86;90;87;90;86;90;87;109;87 05:44:49 INFO - PROCESS | 1671 | |6;imaging-darkroom;159;150;129;152;149;96;105;128;97;153 05:44:49 INFO - PROCESS | 1671 | |7;imaging-desaturate;98;91;91;115;117;90;90;91;111;89 05:44:49 INFO - PROCESS | 1671 | |8;json-parse-financial;57;56;57;57;58;60;58;57;57;56 05:44:49 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;68;75;57;95;117;108;100;82;71;70 05:44:49 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;90;77;112;106;107;109;110;99;110 05:44:49 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;141;138;140;142;151;157;149;136;207;158 05:44:49 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;240;171;174;172;173;170;220;227;194;172 05:44:49 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;70;63;67;90;87;91;91;77;70 05:44:49 INFO - PROCESS | 1671 | __end_tp_report 05:44:49 INFO - PROCESS | 1671 | __start_cc_report 05:44:49 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,928 05:44:49 INFO - PROCESS | 1671 | __end_cc_report 05:44:49 INFO - PROCESS | 1671 | __startTimestamp1474893889511__endTimestamp 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:44:49 INFO - PROCESS | 1671 | Number of tests: 14 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:1.51 (1.3%) stddev-sans-first:0.93 05:44:49 INFO - PROCESS | 1671 | Values: 113.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 119.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:123.60 Median:126.50 stddev:15.10 (11.9%) stddev-sans-first:14.48 05:44:49 INFO - PROCESS | 1671 | Values: 142.0 109.0 110.0 146.0 116.0 137.0 114.0 114.0 138.0 110.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:221.60 Median:205.50 stddev:37.58 (18.3%) stddev-sans-first:38.88 05:44:49 INFO - PROCESS | 1671 | Values: 198.0 210.0 269.0 199.0 274.0 283.0 197.0 196.0 189.0 201.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.50 stddev:11.06 (18.0%) stddev-sans-first:9.51 05:44:49 INFO - PROCESS | 1671 | Values: 85.0 59.0 60.0 84.0 62.0 61.0 58.0 60.0 78.0 59.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:73.00 stddev:15.83 (21.7%) stddev-sans-first:16.78 05:44:49 INFO - PROCESS | 1671 | Values: 85.0 59.0 101.0 105.0 100.0 71.0 88.0 75.0 65.0 88.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:88.50 stddev:7.07 (8.0%) stddev-sans-first:7.24 05:44:49 INFO - PROCESS | 1671 | Values: 96.0 86.0 90.0 87.0 90.0 86.0 90.0 87.0 109.0 87.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:131.80 Median:152.50 stddev:24.63 (16.1%) stddev-sans-first:24.07 05:44:49 INFO - PROCESS | 1671 | Values: 159.0 150.0 129.0 152.0 149.0 96.0 105.0 128.0 97.0 153.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:90.50 stddev:11.42 (12.6%) stddev-sans-first:12.11 05:44:49 INFO - PROCESS | 1671 | Values: 98.0 91.0 91.0 115.0 117.0 90.0 90.0 91.0 111.0 89.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:1.16 (2.0%) stddev-sans-first:1.22 05:44:49 INFO - PROCESS | 1671 | Values: 57.0 56.0 57.0 57.0 58.0 60.0 58.0 57.0 57.0 56.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:84.30 Median:70.50 stddev:19.65 (27.9%) stddev-sans-first:19.94 05:44:49 INFO - PROCESS | 1671 | Values: 68.0 75.0 57.0 95.0 117.0 108.0 100.0 82.0 71.0 70.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:100.60 Median:94.50 stddev:12.17 (12.9%) stddev-sans-first:11.70 05:44:49 INFO - PROCESS | 1671 | Values: 86.0 90.0 77.0 112.0 106.0 107.0 109.0 110.0 99.0 110.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:150.00 stddev:20.85 (13.9%) stddev-sans-first:21.74 05:44:49 INFO - PROCESS | 1671 | Values: 141.0 138.0 140.0 142.0 151.0 157.0 149.0 136.0 207.0 158.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.30 Median:184.00 stddev:27.33 (14.9%) stddev-sans-first:22.60 05:44:49 INFO - PROCESS | 1671 | Values: 240.0 171.0 174.0 172.0 173.0 170.0 220.0 227.0 194.0 172.0 05:44:49 INFO - PROCESS | 1671 | 05:44:49 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:82.00 stddev:11.23 (13.7%) stddev-sans-first:11.38 05:44:49 INFO - PROCESS | 1671 | Values: 68.0 70.0 63.0 67.0 90.0 87.0 91.0 91.0 77.0 70.0 05:44:49 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:44:49 INFO - PROCESS | 1671 | 05:44:50 INFO - TEST-INFO | 1671: exit 0 05:44:50 INFO - TEST-OK | kraken | took 61887ms 05:44:50 INFO - SUITE-END | took 1176s 05:44:50 INFO - Completed test suite (00:19:37) 05:44:50 INFO - javascript benchmark 05:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7260.696075686837, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2851.5294976328905, 3389.6440873708275, 3423.2297733010078, 3431.965680343196, 3446.7931924084555, 4594.8851278718, 5470.152126420401, 5723.484886360232, 5771.538276937846, 5774.566907481934, 5579.609427340078, 5715.2855893013375, 5720.0561907285355, 5736.311642602883, 5777.59556831022, 4166.479190101238, 4339.696221264497, 4571.679982401233, 4891.682040667354, 5349.732513374335, 5241.135212689902, 5263.499967503081, 5309.787608495655, 5340.839774806743, 5363.812266570651, 4627.884302892421, 5197.896042079156, 5255.710935898524, 5263.973680131575, 5304.602154838402, 5106.106431374495, 5124.692518448905, 5157.458466860963, 5178.6116041297055, 5211.088059589557, 4160.583941605815, 5108.2593024011685, 5147.794088236466, 5187.325647665817, 5192.273081768555, 5623.0721930881355, 5757.510611597977, 5797.536197104221, 5802.245708057968, 5808.780156167168, 5471.261379713727, 5850.654349499597, 6234.345393733638, 6257.405546473078, 6289.276733175652, 6227.750889964396, 6280.905786413207, 6284.874302513924, 6295.338989406138, 6324.367563243685, 5784.623999440023, 5891.410858914117, 5931.347551769302, 5966.134910437962, 5986.132010858489, 6204.627722336674, 6262.436380725757, 6301.464375528131, 6315.210598675166, 6356.2054743157105, 6162.722677479434, 6190.473809726133, 6191.81424557264, 6211.2857021443115, 6235.750569977241, 6244.781432649836, 6276.215473065867, 6276.403741644536, 6286.937130628635, 6315.905261421082, 6067.271927368655, 6130.049842274366, 6139.124180917401, 6155.446009859134, 6172.783952561728, 6111.1967345965195, 6173.0, 6218.720157592919, 6219.40915613016, 6245.094461303176, 4955.876103097451, 4960.652754307164, 4970.353853998957, 4977.352944117314, 4979.053979743837, 3869.903252418656, 4366.825326986948, 4422.933655995163, 4497.078098989699, 4512.120136573402, 5540.612157149041, 5940.61386009908, 5955.285365756137, 6042.12389203563, 6044.637321760621, 6251.468625166821, 6263.780767673201, 6265.279492858289, 6269.686515674198, 6276.372362763778, 5840.561957853178, 5869.295684517885, 6003.3996600339615, 6015.278166619946, 6038.909416358758, 5429.484199001088, 5475.233467314579, 5496.1755736639025, 5501.449855014466, 5553.055980483327, 6338.239411270677, 6363.077353783768, 6391.041343798467, 6399.9360006400275, 6500.772472963424, 6137.907931381123, 6236.781712640036, 6245.3754624539, 6246.656433896179, 6250.156228909221, 6178.042403427476, 6298.622082675054, 6327.272363678236, 6331.3352098029045, 6369.426751592379, 6240.968795155995, 6256.186695729526, 6260.499160067275, 6282.994720844826, 6286.6856657166045, 5953.345132035559, 6134.620279381683, 6173.043178307369, 6204.5967012145875, 6268.874622507433, 5786.0, 6066.848328791815, 6193.783217587363, 6209.689515524296, 6223.128761973237, 6073.514118870568, 6078.270607527125, 6098.725557350019, 6128.380904898417, 6135.0, 5102.260172275073, 5989.850253743692, 6064.0, 6070.2108725865355, 6092.268927728701, 4950.529699678525, 5081.44104148536, 5408.540274076748, 5676.978143934131, 6178.536609754196, 4799.688020278671, 5855.531557475477, 5933.910991335047, 5966.0454327307425, 6006.609570377911], "value": 5657.451181860258, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.28425367061556, 468.2648242259652, 518.0855789531478, 526.830436431123, 534.7353060235184, 38868.0, 40882.79558602207, 41027.99999999996, 41061.58938410615, 41133.7943310283, 42957.0, 43195.784021079926, 43329.566704332945, 43347.78326108365, 43428.56571434285, 10060.849087263698, 10062.446565438899, 10086.142677872389, 10090.798184036315, 10150.0864922157, 9911.454869982148, 10013.799724005552, 10016.49917504122, 10029.297949143564, 10054.346467479627, 8350.248477637011, 9908.0, 10008.899911000906, 10020.448875311891, 10049.447280399576, 9970.551325190347, 10043.74890627733, 10053.04496072872, 10074.798504029952, 10084.94108118648, 8169.550674712888, 9961.601535938555, 9969.0, 9983.301168918179, 10024.19806415485, 40463.7976810117, 40667.7966610168, 40697.0, 40920.0, 41022.79488602568, 3375.8987230383127, 3409.0454672691685, 3426.246225830338, 3442.277121804424, 3957.8021098945223, 30605.540916886264, 30658.333499730357, 30721.846390768125, 31310.0, 32196.678033219603, 2948.3366242595457, 2957.935143348393, 3186.2990142168687, 3221.2808235934467, 3228.983855080733, 329388.0, 369470.0, 392430.0, 396237.0, 397813.01093494636, 57819.0, 58126.0, 58167.709161453924, 58205.126923096184, 58358.8328233433, 34007.0, 34971.77598784081, 55787.72106139525, 55872.72063639737, 56163.0, 15764.369425222863, 16237.675246495004, 16288.452597003266, 16290.637857510832, 16350.591235219215, 12334.876651233551, 12388.194767340094, 12434.75130497385, 12465.563705270271, 12470.81293780594, 18741.81258187428, 18812.341568045325, 18816.0, 18841.0, 18873.43379698611, 7237.095363079615, 8088.555129467818, 8152.510849349058, 8199.836003280021, 8282.337413006944, 801.6272433318535, 824.6371596497522, 862.4782006885744, 975.5171190260725, 1083.3175099687146, 26984.0, 29195.85402072976, 29899.701002989692, 30098.398032039237, 30771.538426923613, 985.2069084386994, 985.9408435493893, 994.3188915592842, 995.7012896131132, 1040.9642405806119, 11623.244489108181, 12766.68083297925, 15486.148261845707, 15533.766993495106, 15865.762013569805, 619945.0, 623170.0, 625072.0, 625517.0, 628927.0, 57595.71202143963, 57831.8433631325, 58292.708536457896, 58332.4166758327, 58585.70707146437, 1146.4668928948079, 1392.1994852959588, 1409.0981771666347, 1409.901306908527, 1410.7601707709714, 25256.0, 27430.862845685642, 29741.85129074341, 30368.696313036588, 30792.384152317278, 45204.54795452135, 48196.79508012328, 56144.71927640335, 56402.0, 59333.70333148307, 503008.0, 569611.0, 572531.0, 573890.0, 574748.0, 30813.537796932615, 36852.26295474022, 40831.18337633171, 41132.14905329207, 42588.148237035704, 41953.580464194965, 46702.83242918818, 47063.0, 47981.04037919152, 48108.518914810404, 36313.72901948419, 39371.0, 39568.80215599019, 39906.40140397838, 41286.79356603198, 34606.65393346135, 37116.628833711315, 39109.804450977565, 40328.79835600803, 40687.77936661905, 31597.684023159472, 37723.0, 38112.61887381202, 38189.809050954565, 39032.804835975636, 30525.389492210477, 32992.83503582467, 34761.65238347584, 34924.12689682778, 35141.82429087838, 24115.879420602785, 25553.744462555136, 25632.02316839762, 25977.42564796694, 26090.0], "value": 19818.30957705112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.6606668398026, 358.77217966591206, 363.1792149741584, 372.05126926337834, 393.2901113490151, 18993.620127597438, 19512.31706890259, 20584.485387865294, 20625.690614640793, 20826.583468330624, 20014.69977950332, 20081.497962550944, 20201.48488863334, 20514.179432822708, 20708.171673133093, 5120.692758434497, 5857.76568937242, 6051.364606716297, 6132.938670613281, 6144.754209831602, 5855.209546711182, 5935.0, 6026.9095963560585, 6031.6984150792505, 6039.0, 5719.227904232917, 5958.195643588104, 5970.194023806774, 5973.761049558012, 5976.790812321569, 5973.074173503114, 6024.427679370453, 6026.0, 6029.547783916202, 6048.123022161806, 4531.796069176895, 4999.650024498286, 5043.36957880265, 5131.179011358202, 5151.768170432302, 24325.270241892595, 24441.511169776506, 24528.632070518957, 24687.88904499302, 24977.125800597074, 1630.331564058742, 2102.127617038927, 2166.42589713726, 2183.170395249811, 2323.4075310795806, 9917.206623470105, 9947.75130621733, 10031.448270345129, 10445.95540445957, 10455.738606534822, 1851.6204178143448, 1854.7774267088037, 1877.1007669981338, 1927.691767232202, 1959.5786905815319, 117530.0, 121013.39493302566, 124650.9999999991, 126663.0, 128294.35852820677, 11276.718082048015, 11538.480768365444, 11550.306981581132, 11597.304161750322, 11725.88274117248, 14231.146131232159, 14307.0, 14331.355089021019, 14339.641508962359, 14383.712325753635, 8309.95845020771, 8407.747767566983, 8450.323974082059, 8459.492430454193, 8466.983961924609, 8435.83128337442, 8454.900862887785, 8543.786405339917, 8621.741347759576, 8628.78428039304, 4391.7584532851, 4494.505604383515, 4496.258117410591, 4586.678932474695, 4616.261398176276, 1873.6790562653296, 1900.4393703857395, 1916.9137388817537, 1923.9615207695767, 1924.5573518090916, 785.8271180340316, 823.3248736036393, 882.2456799436518, 907.7912080221586, 926.8656044873455, 20158.092885820173, 20854.37436876896, 20908.477288067617, 21133.154673813184, 21190.926275992624, 855.3755758296478, 921.7925966657449, 930.9162175404247, 938.7420856052786, 962.1100482054072, 7496.6251687415415, 9950.426688125146, 10884.0, 10947.938579616262, 10981.341119532854, 530180.349098252, 539394.0, 544356.0, 544574.0, 550543.0, 47657.523424766005, 59379.0, 61768.0, 104919.32782352733, 106196.40705389425, 875.6497401039508, 918.1644703319947, 966.7873067925045, 968.4431451915318, 972.2756546372998, 16884.831151688817, 18338.532917366847, 18417.53956151107, 18776.155073021473, 18975.240990360784, 36760.63239367572, 40666.59333406747, 46335.53664463447, 51518.484815151365, 54034.0, 79986.6000669993, 80545.0, 81618.59190704246, 82158.58920705358, 83274.75087873565, 6618.966905165636, 6907.516473846783, 8129.5204962487005, 8171.591420429074, 8249.917500824915, 12635.810462842881, 12807.423665934868, 12865.67835804075, 13134.0, 13159.47362105505, 10798.11275870267, 11213.943930280297, 11226.326420414802, 11494.885051149382, 11723.41382930867, 11096.389698566656, 11249.775004500028, 11474.77050459003, 11475.540978360772, 11800.52797888075, 11282.661520154408, 11416.82874756896, 11548.0, 11786.469608867794, 12017.4592143352, 8045.316148127475, 8090.1909809018625, 8203.179682031749, 8270.421070525006, 8471.110533394152, 8317.750467485985, 9118.452892826452, 11483.770324593293, 11817.172797904064, 11892.0], "value": 9264.465059594822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.402638944422, 1545.0034727600696, 1715.8627309815215, 1814.4919422561688, 1835.8164183581653, 8074.475159114668, 8334.83330333393, 8510.106438823927, 9037.412568183063, 9063.410878292907, 8587.184217499344, 8872.822543549126, 8894.0, 8903.955480222607, 8939.195472407482, 2393.521295740859, 2396.2332053742766, 2426.350081944277, 2426.5874801283826, 2432.7323994360604, 2391.497785465054, 2404.4589967257316, 2426.745191754867, 2437.841540299875, 2440.2191298784396, 2409.6987876515436, 2414.2515820095828, 2422.2975337152293, 2425.745296743843, 2435.841670291434, 2398.6761787158684, 2399.748026457214, 2407.5064611754547, 2419.7096348438213, 2423.1882319423016, 2385.1413491143176, 2393.258089992108, 2393.80849532037, 2397.077125306752, 2402.423418379594, 8880.0, 8928.419652722618, 8996.0, 9017.053209412983, 9023.278137748965, 5263.6841789492755, 5399.325084364455, 5423.267858839045, 5423.755930983076, 5431.918521222185, 3433.7424693147864, 3600.891973240807, 3633.454981752758, 3661.121330880596, 3662.901129661091, 1053.847192157133, 1080.1790639114251, 1084.4577711144427, 1098.3903933317006, 1101.3226865477754, 11704.063674905987, 11801.40992950349, 11824.645260642195, 11830.585929492427, 11835.467403966843, 4399.780010999437, 4644.930326045112, 4683.461401938753, 4819.228923372244, 4843.15244832153, 10002.49987500622, 10072.143867771176, 10078.899211007796, 10092.596296148218, 10093.343932644502, 5238.895222095537, 5256.26412302278, 5257.579393648499, 5262.842114736564, 5276.63063585553, 4390.1878152541885, 4516.435445569304, 4736.313234581035, 4785.880352991134, 4866.6350023747655, 3895.8831235062994, 3920.353141731582, 4000.3599424092004, 4025.637692607621, 4052.959470405317, 1097.5280629329304, 1105.4748994227677, 1109.2401704832216, 1198.2930071258, 1303.1464390824026, 908.7364664247294, 924.177482040984, 925.4678559828126, 938.1931538876561, 957.4064080270277, 4920.458749537548, 5989.0, 6150.876982460415, 6229.068988613544, 6275.215598050244, 429.2830972276306, 436.4478934148305, 441.8563966710832, 442.1400376268128, 445.6657506869848, 4008.6392224699916, 4022.899427514277, 4100.384942258685, 4130.483689538808, 4172.624463798273, 9839.458829764431, 10691.679249622524, 10743.194260430499, 10756.56973721058, 10802.973717496825, 8880.600372983232, 10426.27016108865, 10679.305845120043, 10710.303830251165, 10724.73188170302, 8154.796130096795, 8314.127016663284, 8327.125651806473, 8353.289970352587, 8376.497410155533, 5705.686187259575, 5883.382244864228, 5937.287525496968, 5948.405159484017, 6007.519398448201, 8493.0, 10033.899661003297, 10113.443760593238, 10118.79762404733, 10149.543270552695, 9891.406515609087, 10237.976202379703, 10300.845487317845, 10311.535980881028, 10328.173746100143, 6942.166939967236, 7130.251323611154, 7308.671109800178, 7509.66206520697, 7568.735094271674, 8248.83502329938, 8411.957940210259, 8423.957880210559, 8531.061583225715, 8562.315014798676, 6274.0, 7590.582517961344, 7618.847623047397, 7662.885056724042, 7742.845143097219, 7190.245024272376, 7338.77983660491, 7352.154502232098, 7383.741569045058, 7466.178720340649, 6982.231954484901, 6988.126484189476, 7040.049593304839, 7063.858722825617, 7071.540349877241, 5024.748762561784, 5045.066662667418, 5087.440381557952, 5097.2608971698155, 5174.172132458939, 5035.370578677665, 5115.488451154854, 5193.532582067632, 5217.452167522356, 5290.127129023668], "value": 4525.750264871708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [239.86807256009192, 261.2059339607593, 305.6210299228956, 310.6334525260192, 310.77003017766845, 4103.948025987006, 4417.624501917341, 4924.236743304785, 5435.4292799256, 5600.131979543172, 5238.79044838206, 5359.5712343012565, 5426.158945363465, 5452.9182062269, 5491.258680078188, 4158.877103182146, 4162.271602469556, 4163.916721665565, 4178.519470260913, 4183.719872669387, 3309.7186739127205, 3390.4236279832367, 3835.9041023974346, 4186.225548273564, 4189.204051230272, 3728.291624591319, 3771.811409429531, 4076.714629975888, 4101.507819061717, 4115.71190016699, 4072.694547908904, 4080.4083407905837, 4112.300908845504, 4124.340105583093, 4131.710780245384, 3255.746537583024, 3550.349087674244, 3578.6958108560802, 3581.4448760442174, 3583.372909740785, 4389.7173469795525, 4424.911501769979, 4868.831480444704, 5387.568994480433, 5432.782688692448, 4762.404699412574, 4786.641001924835, 4791.856244312677, 4797.352357431771, 4800.567948884583, 4239.618434340924, 5604.495595396434, 5824.446677565625, 5870.178175055496, 5871.794487192928, 3405.7786243894316, 3799.411091280856, 3831.2720583089404, 3896.6814745226543, 3910.081130934228, 5967.761289548413, 5973.133895585116, 6035.577509574332, 6055.153178280622, 6127.754889804447, 3486.738494612914, 3825.5218097737784, 3968.761874287552, 4010.6590939770444, 4011.656095208138, 3402.7788193767324, 3895.552011518655, 4003.3794761811964, 4037.2127435149864, 4050.4531888195306, 4258.105143211304, 4538.160440318552, 4704.29435584665, 4710.411198600175, 4730.2431610942085, 5379.973100134553, 5820.82537523875, 5882.382349853289, 5935.287765468085, 5939.0, 1290.1871820753054, 1329.2224048931485, 1337.6455239361576, 1365.4401695305075, 1371.5405339211477, 796.8366484870587, 905.158202871336, 907.2424525521131, 916.7387294621001, 925.4956048953337, 4751.904961900812, 5337.733113344318, 5397.892042159135, 5418.593605479605, 5425.240466334716, 4930.309756634074, 5002.849914502571, 5064.1897296433135, 5600.943990560124, 5766.682832444172, 4533.9319910201375, 5155.911855698449, 5334.439883812144, 5406.8918621627345, 5440.401555828856, 2155.5904378168098, 2283.549945784439, 2324.6629238760625, 2519.4583164619694, 2537.857963916245, 5049.798008079709, 5099.311592934981, 5105.897882042338, 5121.61587880903, 5127.256547800548, 4046.8349433053177, 4381.408509851193, 4648.604868586141, 4801.591864691471, 4980.0, 4311.981612871003, 4653.930191047137, 4840.709557426495, 5091.949080509147, 5153.871153221125, 4576.496585375673, 4688.835890743944, 4868.926966095582, 4874.829380971649, 4951.9752401237765, 3840.519935008124, 4299.054208074219, 4673.906521869611, 4775.570198682135, 4834.419869615669, 4342.264373444709, 4431.540495025292, 4988.226824842155, 5173.379194496684, 5185.585153187812, 2944.1020488751137, 3425.0067480431394, 3437.604675462254, 3446.276281980812, 3478.3217272631596, 4346.500152482378, 4571.72569645809, 4731.645126615586, 4795.506336704963, 5019.7741101651245, 4816.8554943351755, 5107.693538387709, 5782.335031471434, 5833.591648584558, 5838.357780644041, 5801.564882633735, 5809.593328466966, 5826.766929322949, 5831.271091113611, 5834.18321434991, 4388.934165987449, 5372.435894231049, 5500.669959802424, 5612.0, 5652.208690783212, 5292.788288468418, 5508.641938274, 5867.5305975521005, 5872.588918775645, 5883.264591926009, 5096.362954630671, 5468.863278417913, 5712.34308054579, 5750.166225897305, 5752.28096487939], "value": 3954.4927428914143, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.1761397971363, 727.9999999999997, 741.8034220931451, 758.5486635451907, 801.5911884938683, 12528.686782830433, 13438.46246150153, 15100.924495377521, 15676.294566744524, 16200.189990500472, 14597.0, 14654.120752754816, 14738.926305368484, 14745.705085898275, 14750.409983600643, 718.4503854551273, 854.2824027816632, 860.853654878669, 862.241227719609, 863.8661007543841, 679.9014142949269, 695.8817001109799, 835.8871552340447, 859.5659192107977, 865.4763867859948, 842.9325653947669, 860.2343913916619, 885.5218182181615, 913.447364344572, 925.0656836595053, 876.5967654878732, 902.3728508686465, 911.1207684584408, 920.1672486399818, 921.7280902133853, 679.6669631880393, 683.040328338685, 684.9623270720108, 686.2005763285766, 687.0450074396592, 11961.94019029908, 14398.992070555065, 14659.267036648125, 14664.266786660732, 14968.625784355369, 14467.27663616815, 14555.199464029474, 14633.926830365781, 14821.258937053211, 14825.555233343017, 11922.403879805976, 11992.760144797143, 12079.335636539987, 12344.074194435363, 12449.626511204679, 3759.4924685167425, 3868.651821336065, 3875.360565506688, 3977.8607748728655, 3992.640662340403, 75814.0, 118774.21838672427, 121098.39450802778, 121385.0, 121931.0, 11083.0, 11120.443977801078, 11147.0, 11239.719007024889, 11305.208635395607, 20053.39839804808, 21863.781362186175, 22916.312510624706, 22958.852057397064, 23000.769992300196, 6087.665178415141, 7849.450538462253, 7963.920360796318, 8013.519188848688, 8164.428490005761, 4281.293586558245, 4364.388985542027, 4377.080813029236, 4491.6631252655525, 4512.796924138422, 3510.1751088494184, 3603.045193023851, 3613.584437789635, 3648.288583726148, 3678.9816050919576, 572.7995201679379, 644.3492073006297, 649.1042361541043, 655.4035827397046, 675.7432175773273, 530.0406264660976, 648.8054726195171, 664.8703502817001, 667.5794249622803, 679.2596070283316, 8348.582570871433, 9320.533973301308, 9369.109934556207, 9380.765480863032, 9674.516274186262, 550.4000639303179, 645.4449173710605, 655.8032590222914, 682.1507223506766, 693.015917397297, 4478.619317357996, 4666.4633567139535, 4691.577758001797, 4704.317873908264, 4723.551262630044, 157433.0, 158813.41186588217, 161081.0, 161786.0, 165626.0, 139774.3011284937, 141975.48147111206, 142577.0, 142979.0, 144756.0, 99911.50221244236, 114458.0, 120702.0, 123052.0, 123433.0, 8966.598745455502, 9031.277497800029, 9068.319876009195, 9121.817563648823, 9176.35765496409, 65969.0, 66311.0, 66913.66543167253, 68085.65957170182, 68363.65818170877, 85261.57369213115, 86495.0, 91440.0, 92150.07849921416, 93426.53286733523, 10857.402842843403, 11416.675797085558, 12833.743325133632, 12918.547850825176, 13252.602421927357, 14343.856561434251, 14356.49752258666, 14412.207328597027, 14921.626959326104, 15113.773293400387, 13505.0, 13707.931460342634, 13725.931370343083, 13772.862271377158, 13903.235322057384, 13569.0, 13748.207542957249, 13800.654983625489, 13910.234937078558, 14307.141571505743, 13252.801207981694, 13414.337547339568, 13720.81182801063, 14015.229162395759, 14170.858291416955, 11096.833547496955, 11166.498516468133, 11323.886761132284, 11591.014763745176, 11687.88312116868, 10325.277230594087, 10821.837672434762, 11598.103229970886, 11679.416029198675, 11699.590514331958], "value": 7880.120453711725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 146.0, 116.0, 137.0, 114.0, 114.0, 138.0, 110.0], "value": 123.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 210.0, 269.0, 199.0, 274.0, 283.0, 197.0, 196.0, 189.0, 201.0], "value": 221.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 60.0, 84.0, 62.0, 61.0, 58.0, 60.0, 78.0, 59.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 101.0, 105.0, 100.0, 71.0, 88.0, 75.0, 65.0, 88.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 86.0, 90.0, 87.0, 90.0, 86.0, 90.0, 87.0, 109.0, 87.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 150.0, 129.0, 152.0, 149.0, 96.0, 105.0, 128.0, 97.0, 153.0], "value": 131.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 91.0, 91.0, 115.0, 117.0, 90.0, 90.0, 91.0, 111.0, 89.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 58.0, 60.0, 58.0, 57.0, 57.0, 56.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 57.0, 95.0, 117.0, 108.0, 100.0, 82.0, 71.0, 70.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 77.0, 112.0, 106.0, 107.0, 109.0, 110.0, 99.0, 110.0], "value": 100.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 140.0, 142.0, 151.0, 157.0, 149.0, 136.0, 207.0, 158.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [240.0, 171.0, 174.0, 172.0, 173.0, 170.0, 220.0, 227.0, 194.0, 172.0], "value": 191.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 63.0, 67.0, 90.0, 87.0, 91.0, 91.0, 77.0, 70.0], "value": 77.4, "unit": "score"}]}]} 05:44:50 INFO - Return code: 0 05:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:44:50 ERROR - # TBPL SUCCESS # 05:44:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:44:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:44:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:44:50 INFO - 2016-09-26 05:44:50.861 screenresolution[1676:10798] starting screenresolution argv=screenresolution get 05:44:50 INFO - 2016-09-26 05:44:50.863 screenresolution[1676:10798] Display 0: 1600x1200x32@60 05:44:50 INFO - 2016-09-26 05:44:50.869 screenresolution[1677:10801] starting screenresolution argv=screenresolution list 05:44:50 INFO - Available Modes on Display 0 05:44:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:44:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:44:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:44:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:44:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:44:51 INFO - Intel Iris: 05:44:51 INFO - Chipset Model: Intel Iris 05:44:51 INFO - Type: GPU 05:44:51 INFO - Bus: Built-In 05:44:51 INFO - VRAM (Dynamic, Max): 1536 MB 05:44:51 INFO - Vendor: Intel (0x8086) 05:44:51 INFO - Device ID: 0x0a2e 05:44:51 INFO - Revision ID: 0x0009 05:44:51 INFO - Displays: 05:44:51 INFO - Display: 05:44:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:44:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:44:51 INFO - Display Serial Number: 1600x1200 60 05:44:51 INFO - Main Display: Yes 05:44:51 INFO - Mirror: Off 05:44:51 INFO - Online: Yes 05:44:51 INFO - Rotation: Supported 05:44:51 INFO - Return code: 0 05:44:51 INFO - Running post-action listener: _resource_record_post_action 05:44:51 INFO - [mozharness: 2016-09-26 12:44:51.106307Z] Finished run-tests step (success) 05:44:51 INFO - Running post-run listener: _resource_record_post_run 05:44:51 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 33349632; Write bytes: 712868864; Read time: 203; Write time: 2141 05:44:51 INFO - TinderboxPrint: CPU usage
54.5% 05:44:51 INFO - TinderboxPrint: I/O read bytes / time
33,349,632 / 203 05:44:51 INFO - TinderboxPrint: I/O write bytes / time
712,868,864 / 2,141 05:44:51 INFO - TinderboxPrint: CPU idle
2,208.6 (45.5%) 05:44:51 INFO - TinderboxPrint: CPU system
982.6 (20.3%) 05:44:51 INFO - TinderboxPrint: CPU user
1,658.6 (34.2%) 05:44:51 INFO - TinderboxPrint: Swap in / out
436,289,536 / 0 05:44:51 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397179392; Write bytes: 391288832; Read time: 29816; Write time: 872 05:44:51 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31326208; Write bytes: 302754816; Read time: 186; Write time: 1219 05:44:51 INFO - Running post-run listener: _upload_blobber_files 05:44:51 INFO - Blob upload gear active. 05:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:51 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 05:44:51 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:51 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:52 INFO - (blobuploader) - INFO - Done attempting. 05:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:53 INFO - (blobuploader) - INFO - Done attempting. 05:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:55 INFO - (blobuploader) - INFO - Done attempting. 05:44:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:55 INFO - Return code: 0 05:44:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7abcf091104ae5b8299fa30ee032994ff947f03b2be58c3a0ab4a55b384b24cc3425a1c82a7b704af076016f8ce99c231542afaf7d994f0cd45950670a97ed27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9e27fb387ea22956f990a2fc93f9628d8a56795e94ddb9d27225a5378855382ac03a719d7c845ecff91799ceddabb85dea94a81210e0f797abd715d3e25d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0accab25b760e27729b55f871ea27d9c75551ede3cf2c36426505428e1fd8b7b814412fe3361add4dd308205a5cc205d4bce6debd834c7934b6dadafdbc993fa"} 05:44:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:55 INFO - Contents: 05:44:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7abcf091104ae5b8299fa30ee032994ff947f03b2be58c3a0ab4a55b384b24cc3425a1c82a7b704af076016f8ce99c231542afaf7d994f0cd45950670a97ed27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9e27fb387ea22956f990a2fc93f9628d8a56795e94ddb9d27225a5378855382ac03a719d7c845ecff91799ceddabb85dea94a81210e0f797abd715d3e25d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0accab25b760e27729b55f871ea27d9c75551ede3cf2c36426505428e1fd8b7b814412fe3361add4dd308205a5cc205d4bce6debd834c7934b6dadafdbc993fa"} 05:44:55 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:55 INFO - Copying logs to upload dir... 05:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.206825 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-26 05:44:55.827407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:55.831553) ========= 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.SrFvlVETHT/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.c8X6pP8x3M/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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/Firefox/sha512/7abcf091104ae5b8299fa30ee032994ff947f03b2be58c3a0ab4a55b384b24cc3425a1c82a7b704af076016f8ce99c231542afaf7d994f0cd45950670a97ed27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9e27fb387ea22956f990a2fc93f9628d8a56795e94ddb9d27225a5378855382ac03a719d7c845ecff91799ceddabb85dea94a81210e0f797abd715d3e25d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0accab25b760e27729b55f871ea27d9c75551ede3cf2c36426505428e1fd8b7b814412fe3361add4dd308205a5cc205d4bce6debd834c7934b6dadafdbc993fa"} build_url:https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010795 build_url: 'https://queue.taskcluster.net/v1/task/BaY5hVPPQn6i91c9xPRQKQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7abcf091104ae5b8299fa30ee032994ff947f03b2be58c3a0ab4a55b384b24cc3425a1c82a7b704af076016f8ce99c231542afaf7d994f0cd45950670a97ed27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b9e27fb387ea22956f990a2fc93f9628d8a56795e94ddb9d27225a5378855382ac03a719d7c845ecff91799ceddabb85dea94a81210e0f797abd715d3e25d4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0accab25b760e27729b55f871ea27d9c75551ede3cf2c36426505428e1fd8b7b814412fe3361add4dd308205a5cc205d4bce6debd834c7934b6dadafdbc993fa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:55.864410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:55.864782) ========= 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.SrFvlVETHT/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.c8X6pP8x3M/Listeners TMPDIR=/var/folders/p8/w8ptrvz123vfhzsj5l69kq9c00000w/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.005047 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 05:44:55.914161) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:44:55.914508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 05:44:55.914859) ========= ========= Total master_lag: 0.17 =========