builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0261 starttime: 1491259831.28 results: success (0) buildid: 20170403144327 builduid: 428835c142ef4e8e9e29e880fc41b7b9 revision: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.280653) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.281119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.281396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.307439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.307771) ========= 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.JqhDfhh26y/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.v5SFOrhr5n/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-03 15:50:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-04-03 15:50:31 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.491180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.491497) ========= 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.JqhDfhh26y/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.v5SFOrhr5n/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.031910 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:31.546029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 15:50:31.546382) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a593ea93f6637df49eedc998b1f5ae4781a0f56 --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 2a593ea93f6637df49eedc998b1f5ae4781a0f56 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JqhDfhh26y/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.v5SFOrhr5n/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-03 15:50:31,655 truncating revision to first 12 chars 2017-04-03 15:50:31,655 Setting DEBUG logging. 2017-04-03 15:50:31,656 attempt 1/10 2017-04-03 15:50:31,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a593ea93f66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 15:50:33,089 unpacking tar archive at: mozilla-central-2a593ea93f66/testing/mozharness/ program finished with exit code 0 elapsedTime=1.709270 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 15:50:33.382871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:33.383436) ========= script_repo_revision: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:33.384083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:33.384543) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 15:50:33.406084) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-03 15:50:33.406640) ========= /tools/buildbot/bin/python -u 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', '-u', '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:50:33 INFO - MultiFileLogger online at 20170403 15:50:33 in /builds/slave/test 15:50:33 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 15:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:33 INFO - {'append_to_log': False, 15:50:33 INFO - 'base_work_dir': '/builds/slave/test', 15:50:33 INFO - 'blob_upload_branch': 'Firefox', 15:50:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:33 INFO - 'branch': 'Firefox', 15:50:33 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:33 INFO - 'config_files': ('talos/mac_config.py',), 15:50:33 INFO - 'default_actions': ('clobber', 15:50:33 INFO - 'read-buildbot-config', 15:50:33 INFO - 'download-and-extract', 15:50:33 INFO - 'populate-webroot', 15:50:33 INFO - 'create-virtualenv', 15:50:33 INFO - 'install', 15:50:33 INFO - 'run-tests'), 15:50:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:33 INFO - 'download_minidump_stackwalk': True, 15:50:33 INFO - 'download_symbols': 'ondemand', 15:50:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:33 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:33 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:33 INFO - 'gecko_profile': False, 15:50:33 INFO - 'gecko_profile_interval': 0, 15:50:33 INFO - 'installer_path': 'installer.exe', 15:50:33 INFO - 'log_level': 'info', 15:50:33 INFO - 'log_name': 'talos', 15:50:33 INFO - 'log_to_console': True, 15:50:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:50:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:50:33 INFO - 'opt_config_files': (), 15:50:33 INFO - 'pip_index': False, 15:50:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:33 INFO - 'cmd': ('bash', 15:50:33 INFO - '-c', 15:50:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:33 INFO - 'enabled': True, 15:50:33 INFO - 'halt_on_failure': False, 15:50:33 INFO - 'name': 'check_screen_resolution'},), 15:50:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:33 INFO - 'cmd': ('bash', 15:50:33 INFO - '-c', 15:50:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:33 INFO - 'enabled': True, 15:50:33 INFO - 'halt_on_failure': False, 15:50:33 INFO - 'name': 'check_screen_resolution'},), 15:50:33 INFO - 'run_cmd_checks_enabled': True, 15:50:33 INFO - 'suite': 'dromaeojs-e10s', 15:50:33 INFO - 'system_bits': '32', 15:50:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:33 INFO - 'title': 't-yosemite-r7-0261', 15:50:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:33 INFO - 'use_talos_json': True, 15:50:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:33 INFO - 'work_dir': 'build'} 15:50:33 INFO - [mozharness: 2017-04-03 22:50:33.625210Z] Running clobber step. 15:50:33 INFO - Running pre-action listener: _resource_record_pre_action 15:50:33 INFO - Running main action method: clobber 15:50:33 INFO - rmtree: /builds/slave/test/build 15:50:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:36 INFO - Running post-action listener: _resource_record_post_action 15:50:36 INFO - [mozharness: 2017-04-03 22:50:36.042108Z] Finished clobber step (success) 15:50:36 INFO - [mozharness: 2017-04-03 22:50:36.042258Z] Running read-buildbot-config step. 15:50:36 INFO - Running pre-action listener: _resource_record_pre_action 15:50:36 INFO - Running main action method: read_buildbot_config 15:50:36 INFO - Using buildbot properties: 15:50:36 INFO - { 15:50:36 INFO - "project": "", 15:50:36 INFO - "product": "firefox", 15:50:36 INFO - "script_repo_revision": "production", 15:50:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:50:36 INFO - "repository": "", 15:50:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:50:36 INFO - "buildid": "20170403144327", 15:50:36 INFO - "pgo_build": "False", 15:50:36 INFO - "basedir": "/builds/slave/test", 15:50:36 INFO - "buildnumber": 18, 15:50:36 INFO - "slavename": "t-yosemite-r7-0261", 15:50:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:50:36 INFO - "platform": "yosemite_r7", 15:50:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:50:36 INFO - "branch": "mozilla-central", 15:50:36 INFO - "repo_path": "mozilla-central", 15:50:36 INFO - "revision": "2a593ea93f6637df49eedc998b1f5ae4781a0f56", 15:50:36 INFO - "stage_platform": "macosx64", 15:50:36 INFO - "builduid": "428835c142ef4e8e9e29e880fc41b7b9", 15:50:36 INFO - "slavebuilddir": "test" 15:50:36 INFO - } 15:50:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 15:50:36 INFO - Running post-action listener: _resource_record_post_action 15:50:36 INFO - [mozharness: 2017-04-03 22:50:36.045593Z] Finished read-buildbot-config step (success) 15:50:36 INFO - [mozharness: 2017-04-03 22:50:36.045704Z] Running download-and-extract step. 15:50:36 INFO - Running pre-action listener: _resource_record_pre_action 15:50:36 INFO - Running main action method: download_and_extract 15:50:36 INFO - mkdir: /builds/slave/test/build/tests 15:50:36 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')]} 15:50:36 INFO - trying https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 15:50:36 INFO - Downloading https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 15:50:36 INFO - Downloaded 1325 bytes. 15:50:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 15:50:36 INFO - Using the following test package requirements: 15:50:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 15:50:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:50:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 15:50:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 15:50:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'jsshell-mac.zip'], 15:50:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 15:50:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 15:50:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 15:50:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 15:50:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 15:50:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 15:50:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 15:50:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:50:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:50:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:50:36 INFO - Fetch https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:50:38 INFO - Expected file size: 52519747 15:50:38 INFO - Obtained file size: 52519747 15:50:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:50:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 15:50:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:50:55 INFO - Fetch https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 15:50:57 INFO - Expected file size: 52519747 15:50:57 INFO - Obtained file size: 52519747 15:51:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 15:51:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:51:12 INFO - Fetch https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 15:51:13 INFO - Expected file size: 14404152 15:51:13 INFO - Obtained file size: 14404152 15:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:14 INFO - trying https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 15:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 15:51:16 INFO - Downloaded 75574102 bytes. 15:51:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:51:16 INFO - mkdir: /builds/slave/test/properties 15:51:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:16 INFO - Contents: 15:51:16 INFO - build_url:https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 15:51:16 INFO - Running post-action listener: _resource_record_post_action 15:51:16 INFO - Running post-action listener: set_extra_try_arguments 15:51:16 INFO - [mozharness: 2017-04-03 22:51:16.857841Z] Finished download-and-extract step (success) 15:51:16 INFO - [mozharness: 2017-04-03 22:51:16.857995Z] Running populate-webroot step. 15:51:16 INFO - Running pre-action listener: _resource_record_pre_action 15:51:16 INFO - Running main action method: populate_webroot 15:51:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:16 INFO - '--tppagecycles', 15:51:16 INFO - '7'], 15:51:16 INFO - 'tests': ['tsvgm']}}, 15:51:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['damp', 'tps']}, 15:51:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'tests': ['damp', 'tps']}, 15:51:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['dromaeo_dom']}, 15:51:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['basic_compositor_video']}, 15:51:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:51:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['a11yr', 15:51:16 INFO - 'ts_paint', 15:51:16 INFO - 'tpaint', 15:51:16 INFO - 'sessionrestore', 15:51:16 INFO - 'sessionrestore_no_auto_restore', 15:51:16 INFO - 'tabpaint']}, 15:51:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:16 INFO - 'ts_paint', 15:51:16 INFO - 'tpaint', 15:51:16 INFO - 'sessionrestore', 15:51:16 INFO - 'sessionrestore_no_auto_restore', 15:51:16 INFO - 'tabpaint']}, 15:51:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:16 INFO - 'ts_paint', 15:51:16 INFO - 'tpaint', 15:51:16 INFO - 'sessionrestore', 15:51:16 INFO - 'sessionrestore_no_auto_restore', 15:51:16 INFO - 'tabpaint']}, 15:51:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:16 INFO - 'ts_paint', 15:51:16 INFO - 'tpaint', 15:51:16 INFO - 'sessionrestore', 15:51:16 INFO - 'sessionrestore_no_auto_restore', 15:51:16 INFO - 'tabpaint']}, 15:51:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['a11yr', 15:51:16 INFO - 'ts_paint', 15:51:16 INFO - 'tpaint', 15:51:16 INFO - 'sessionrestore', 15:51:16 INFO - 'sessionrestore_no_auto_restore', 15:51:16 INFO - 'tabpaint']}, 15:51:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['a11yr', 15:51:16 INFO - 'ts_paint', 15:51:16 INFO - 'tpaint', 15:51:16 INFO - 'sessionrestore', 15:51:16 INFO - 'sessionrestore_no_auto_restore', 15:51:16 INFO - 'tabpaint']}, 15:51:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['tsvgx', 15:51:16 INFO - 'tsvgr_opacity', 15:51:16 INFO - 'tart', 15:51:16 INFO - 'tscrollx', 15:51:16 INFO - 'cart', 15:51:16 INFO - 'tsvg_static']}, 15:51:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:16 INFO - 'tsvgr_opacity', 15:51:16 INFO - 'tart', 15:51:16 INFO - 'tscrollx', 15:51:16 INFO - 'cart', 15:51:16 INFO - 'tsvg_static']}, 15:51:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'talos_options': ['--disable-e10s'], 15:51:16 INFO - 'tests': ['tp5o']}, 15:51:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:51:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'talos_options': ['--disable-e10s', 15:51:16 INFO - '--xperf_path', 15:51:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:16 INFO - 'tests': ['tp5n']}, 15:51:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:51:16 INFO - 'talos_options': ['--xperf_path', 15:51:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:16 INFO - 'tests': ['tp5n']}}, 15:51:16 INFO - 'talos.zip': {'path': '', 15:51:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:16 INFO - Running post-action listener: _resource_record_post_action 15:51:16 INFO - [mozharness: 2017-04-03 22:51:16.876631Z] Finished populate-webroot step (success) 15:51:16 INFO - [mozharness: 2017-04-03 22:51:16.876766Z] Running create-virtualenv step. 15:51:16 INFO - Running pre-action listener: _resource_record_pre_action 15:51:16 INFO - Running main action method: create_virtualenv 15:51:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:16 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 15:51:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:17 INFO - Using real prefix '/tools/python27' 15:51:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:20 INFO - Installing pip.................done. 15:51:20 INFO - Return code: 0 15:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:51:20 INFO - Reading from file tmpfile_stdout 15:51:20 INFO - Output received: 15:51:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:51:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:20 INFO - 'HOME': '/Users/cltbld', 15:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:20 INFO - 'LOGNAME': 'cltbld', 15:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:20 INFO - 'MOZ_NO_REMOTE': '1', 15:51:20 INFO - 'NO_EM_RESTART': '1', 15:51:20 INFO - 'PAGER': '/bin/cat', 15:51:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:20 INFO - 'PWD': '/builds/slave/test', 15:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:20 INFO - 'SHELL': '/bin/bash', 15:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:20 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:20 INFO - 'USER': 'cltbld', 15:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:20 INFO - 'XPC_FLAGS': '0x0', 15:51:20 INFO - 'XPC_SERVICE_NAME': '0', 15:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:21 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 15:51:21 INFO - Cleaning up... 15:51:21 INFO - Return code: 0 15:51:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:51:21 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')]} 15:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:21 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')]} 15:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:21 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:21 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 15:51:21 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 15:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:21 INFO - 'HOME': '/Users/cltbld', 15:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:21 INFO - 'LOGNAME': 'cltbld', 15:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:21 INFO - 'MOZ_NO_REMOTE': '1', 15:51:21 INFO - 'NO_EM_RESTART': '1', 15:51:21 INFO - 'PAGER': '/bin/cat', 15:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:21 INFO - 'PWD': '/builds/slave/test', 15:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:21 INFO - 'SHELL': '/bin/bash', 15:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:21 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:21 INFO - 'USER': 'cltbld', 15:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:21 INFO - 'XPC_FLAGS': '0x0', 15:51:21 INFO - 'XPC_SERVICE_NAME': '0', 15:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:21 INFO - Downloading/unpacking psutil>=3.1.1 15:51:21 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 15:51:21 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 15:51:21 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 15:51:21 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 15:51:21 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 15:51:21 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 15:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:24 INFO - Installing collected packages: psutil 15:51:24 INFO - Running setup.py install for psutil 15:51:25 INFO - building 'psutil._psutil_osx' extension 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 INFO - building 'psutil._psutil_posix' extension 15:51:25 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 15:51:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:51:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:51:25 INFO - ^ 15:51:25 INFO - 1 warning generated. 15:51:25 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 15:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:26 INFO - Successfully installed psutil 15:51:26 INFO - Cleaning up... 15:51:26 INFO - Return code: 0 15:51:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:51:26 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')]} 15:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:26 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')]} 15:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:27 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:27 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 15:51:27 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 15:51:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:27 INFO - 'HOME': '/Users/cltbld', 15:51:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:27 INFO - 'LOGNAME': 'cltbld', 15:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:27 INFO - 'MOZ_NO_REMOTE': '1', 15:51:27 INFO - 'NO_EM_RESTART': '1', 15:51:27 INFO - 'PAGER': '/bin/cat', 15:51:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:27 INFO - 'PWD': '/builds/slave/test', 15:51:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:27 INFO - 'SHELL': '/bin/bash', 15:51:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:27 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:27 INFO - 'USER': 'cltbld', 15:51:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:27 INFO - 'XPC_FLAGS': '0x0', 15:51:27 INFO - 'XPC_SERVICE_NAME': '0', 15:51:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:27 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 15:51:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:51:30 INFO - Installing collected packages: mozsystemmonitor 15:51:30 INFO - Running setup.py install for mozsystemmonitor 15:51:30 INFO - Successfully installed mozsystemmonitor 15:51:30 INFO - Cleaning up... 15:51:30 INFO - Return code: 0 15:51:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:30 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:30 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 15:51:30 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 15:51:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:30 INFO - 'HOME': '/Users/cltbld', 15:51:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:30 INFO - 'LOGNAME': 'cltbld', 15:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:30 INFO - 'MOZ_NO_REMOTE': '1', 15:51:30 INFO - 'NO_EM_RESTART': '1', 15:51:30 INFO - 'PAGER': '/bin/cat', 15:51:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:30 INFO - 'PWD': '/builds/slave/test', 15:51:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:30 INFO - 'SHELL': '/bin/bash', 15:51:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:30 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:30 INFO - 'USER': 'cltbld', 15:51:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:30 INFO - 'XPC_FLAGS': '0x0', 15:51:30 INFO - 'XPC_SERVICE_NAME': '0', 15:51:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:30 INFO - Downloading/unpacking jsonschema==2.5.1 15:51:30 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 15:51:30 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 15:51:30 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 15:51:30 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 15:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:34 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:34 INFO - warning: no files found matching '*.txt' 15:51:34 INFO - no previously-included directories found matching 'build' 15:51:34 INFO - no previously-included directories found matching 'dist' 15:51:34 INFO - no previously-included directories found matching '.git*' 15:51:34 INFO - Installing collected packages: jsonschema, functools32 15:51:34 INFO - Running setup.py install for functools32 15:51:34 INFO - warning: no files found matching '*.txt' 15:51:34 INFO - no previously-included directories found matching 'build' 15:51:34 INFO - no previously-included directories found matching 'dist' 15:51:34 INFO - no previously-included directories found matching '.git*' 15:51:34 INFO - Successfully installed jsonschema functools32 15:51:34 INFO - Cleaning up... 15:51:34 INFO - Return code: 0 15:51:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:34 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 15:51:34 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 15:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:34 INFO - 'HOME': '/Users/cltbld', 15:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:34 INFO - 'LOGNAME': 'cltbld', 15:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:34 INFO - 'MOZ_NO_REMOTE': '1', 15:51:34 INFO - 'NO_EM_RESTART': '1', 15:51:34 INFO - 'PAGER': '/bin/cat', 15:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:34 INFO - 'PWD': '/builds/slave/test', 15:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:34 INFO - 'SHELL': '/bin/bash', 15:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:34 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:34 INFO - 'USER': 'cltbld', 15:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:34 INFO - 'XPC_FLAGS': '0x0', 15:51:34 INFO - 'XPC_SERVICE_NAME': '0', 15:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:51:34 INFO - Cleaning up... 15:51:34 INFO - Return code: 0 15:51:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:34 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 15:51:34 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 15:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:34 INFO - 'HOME': '/Users/cltbld', 15:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:34 INFO - 'LOGNAME': 'cltbld', 15:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:34 INFO - 'MOZ_NO_REMOTE': '1', 15:51:34 INFO - 'NO_EM_RESTART': '1', 15:51:34 INFO - 'PAGER': '/bin/cat', 15:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:34 INFO - 'PWD': '/builds/slave/test', 15:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:34 INFO - 'SHELL': '/bin/bash', 15:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:34 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:34 INFO - 'USER': 'cltbld', 15:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:34 INFO - 'XPC_FLAGS': '0x0', 15:51:34 INFO - 'XPC_SERVICE_NAME': '0', 15:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:37 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 15:51:37 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 15:51:37 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 15:51:37 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 15:51:37 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 15:51:37 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 15:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:38 INFO - Downloading docopt-0.6.1.tar.gz 15:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:38 INFO - Running setup.py install for blobuploader 15:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:39 INFO - Running setup.py install for requests 15:51:39 INFO - Running setup.py install for docopt 15:51:39 INFO - Successfully installed blobuploader requests docopt 15:51:39 INFO - Cleaning up... 15:51:39 INFO - Return code: 0 15:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:39 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')]} 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:39 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')]} 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:39 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:39 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 15:51:39 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 15:51:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:39 INFO - 'HOME': '/Users/cltbld', 15:51:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:39 INFO - 'LOGNAME': 'cltbld', 15:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:39 INFO - 'MOZ_NO_REMOTE': '1', 15:51:39 INFO - 'NO_EM_RESTART': '1', 15:51:39 INFO - 'PAGER': '/bin/cat', 15:51:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:39 INFO - 'PWD': '/builds/slave/test', 15:51:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:39 INFO - 'SHELL': '/bin/bash', 15:51:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:39 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:39 INFO - 'USER': 'cltbld', 15:51:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:39 INFO - 'XPC_FLAGS': '0x0', 15:51:39 INFO - 'XPC_SERVICE_NAME': '0', 15:51:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-ExKKg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-SdB7wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-PKkWIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-MIEJpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-TzDeNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-jsmFO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-PvNDTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-4OQZ5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:40 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-BjkWrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-KkmiTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-6oT1g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-m5c0V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Htu6ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-YPTmSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-pApc28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-JngKlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:41 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-7Smoz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:41 INFO - Running setup.py install for manifestparser 15:51:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Running setup.py install for mozcrash 15:51:42 INFO - Running setup.py install for mozdebug 15:51:42 INFO - Running setup.py install for mozdevice 15:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Running setup.py install for mozfile 15:51:42 INFO - Running setup.py install for mozhttpd 15:51:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Running setup.py install for mozinfo 15:51:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Running setup.py install for mozInstall 15:51:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozleak 15:51:43 INFO - Running setup.py install for mozlog 15:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for moznetwork 15:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozprocess 15:51:43 INFO - Running setup.py install for mozprofile 15:51:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozrunner 15:51:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:43 INFO - Running setup.py install for mozscreenshot 15:51:44 INFO - Running setup.py install for moztest 15:51:44 INFO - Running setup.py install for mozversion 15:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:44 INFO - Cleaning up... 15:51:44 INFO - Return code: 0 15:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:44 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:44 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 15:51:44 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 15:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:44 INFO - 'HOME': '/Users/cltbld', 15:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:44 INFO - 'LOGNAME': 'cltbld', 15:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:44 INFO - 'MOZ_NO_REMOTE': '1', 15:51:44 INFO - 'NO_EM_RESTART': '1', 15:51:44 INFO - 'PAGER': '/bin/cat', 15:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:44 INFO - 'PWD': '/builds/slave/test', 15:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:44 INFO - 'SHELL': '/bin/bash', 15:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:44 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:44 INFO - 'USER': 'cltbld', 15:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:44 INFO - 'XPC_FLAGS': '0x0', 15:51:44 INFO - 'XPC_SERVICE_NAME': '0', 15:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:44 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-Q_u4Xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:44 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)) 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:44 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-z70pxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:44 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-izOdO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-EEMX1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-h2POID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-GUKDuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2CsFRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-sflk8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-dW5all-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-s06EcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-SOaDwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:45 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-4mzBaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 15:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:45 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-xotNfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-RbM7wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-2FJa98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:46 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)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-skW5yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:46 INFO - Running setup.py (path:/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/pip-c_u7L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:46 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)) 15:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:46 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)) 15:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:49 INFO - Downloading blessings-1.6.tar.gz 15:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:49 INFO - Installing collected packages: blessings 15:51:49 INFO - Running setup.py install for blessings 15:51:49 INFO - Successfully installed blessings 15:51:49 INFO - Cleaning up... 15:51:49 INFO - Return code: 0 15:51:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:49 INFO - Reading from file tmpfile_stdout 15:51:49 INFO - Current package versions: 15:51:49 INFO - blessings == 1.6 15:51:49 INFO - blobuploader == 1.2.4 15:51:49 INFO - docopt == 0.6.1 15:51:49 INFO - functools32 == 3.2.3-2 15:51:49 INFO - jsonschema == 2.5.1 15:51:49 INFO - manifestparser == 1.1 15:51:49 INFO - mozInstall == 1.12 15:51:49 INFO - mozcrash == 1.0 15:51:49 INFO - mozdebug == 0.1 15:51:49 INFO - mozdevice == 0.49 15:51:49 INFO - mozfile == 1.2 15:51:49 INFO - mozhttpd == 0.7 15:51:49 INFO - mozinfo == 0.9 15:51:49 INFO - mozleak == 0.1 15:51:49 INFO - mozlog == 3.4 15:51:49 INFO - moznetwork == 0.27 15:51:49 INFO - mozprocess == 0.25 15:51:49 INFO - mozprofile == 0.28 15:51:49 INFO - mozrunner == 6.13 15:51:49 INFO - mozscreenshot == 0.1 15:51:49 INFO - mozsystemmonitor == 0.3 15:51:49 INFO - moztest == 0.8 15:51:49 INFO - mozversion == 1.4 15:51:49 INFO - psutil == 3.1.1 15:51:49 INFO - requests == 1.2.3 15:51:49 INFO - wsgiref == 0.1.2 15:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:49 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:49 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 15:51:49 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 15:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:49 INFO - 'HOME': '/Users/cltbld', 15:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:49 INFO - 'LOGNAME': 'cltbld', 15:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:49 INFO - 'MOZ_NO_REMOTE': '1', 15:51:49 INFO - 'NO_EM_RESTART': '1', 15:51:49 INFO - 'PAGER': '/bin/cat', 15:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:49 INFO - 'PWD': '/builds/slave/test', 15:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:49 INFO - 'SHELL': '/bin/bash', 15:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:49 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:49 INFO - 'USER': 'cltbld', 15:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:49 INFO - 'XPC_FLAGS': '0x0', 15:51:49 INFO - 'XPC_SERVICE_NAME': '0', 15:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 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)) 15:51:50 INFO - Cleaning up... 15:51:50 INFO - Return code: 0 15:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:50 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')]} 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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')]} 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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 0x104566b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104569768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86ac94f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, '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.JqhDfhh26y/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.v5SFOrhr5n/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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 15:51:50 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 15:51:50 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 15:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:50 INFO - 'HOME': '/Users/cltbld', 15:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:50 INFO - 'LOGNAME': 'cltbld', 15:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:50 INFO - 'MOZ_NO_REMOTE': '1', 15:51:50 INFO - 'NO_EM_RESTART': '1', 15:51:50 INFO - 'PAGER': '/bin/cat', 15:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:50 INFO - 'PWD': '/builds/slave/test', 15:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:50 INFO - 'SHELL': '/bin/bash', 15:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:51:50 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:50 INFO - 'USER': 'cltbld', 15:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:50 INFO - 'XPC_FLAGS': '0x0', 15:51:50 INFO - 'XPC_SERVICE_NAME': '0', 15:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:50 INFO - Cleaning up... 15:51:50 INFO - Return code: 0 15:51:50 INFO - Running post-action listener: _resource_record_post_action 15:51:50 INFO - Running post-action listener: _start_resource_monitoring 15:51:50 INFO - Starting resource monitoring. 15:51:50 INFO - [mozharness: 2017-04-03 22:51:50.344693Z] Finished create-virtualenv step (success) 15:51:50 INFO - [mozharness: 2017-04-03 22:51:50.345683Z] Running install step. 15:51:50 INFO - Running pre-action listener: _resource_record_pre_action 15:51:50 INFO - Running main action method: install 15:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:50 INFO - Reading from file tmpfile_stdout 15:51:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:50 INFO - Reading from file tmpfile_stdout 15:51:50 INFO - Output received: 15:51:50 INFO - Usage: mozinstall [options] installer 15:51:50 INFO - Options: 15:51:50 INFO - -h, --help show this help message and exit 15:51:50 INFO - -d DEST, --destination=DEST 15:51:50 INFO - Directory to install application into. [default: 15:51:50 INFO - "/builds/slave/test"] 15:51:50 INFO - --app=APP Application being installed. [default: firefox] 15:51:50 INFO - mkdir: /builds/slave/test/build/application 15:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:52:11 INFO - Reading from file tmpfile_stdout 15:52:11 INFO - Output received: 15:52:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:52:11 INFO - Running post-action listener: _resource_record_post_action 15:52:11 INFO - [mozharness: 2017-04-03 22:52:11.209262Z] Finished install step (success) 15:52:11 INFO - [mozharness: 2017-04-03 22:52:11.209387Z] Running run-tests step. 15:52:11 INFO - Running pre-action listener: _resource_record_pre_action 15:52:11 INFO - Running main action method: run_tests 15:52:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:52:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:52:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:52:11 INFO - 2017-04-03 15:52:11.223 screenresolution[1620:7423] starting screenresolution argv=screenresolution get 15:52:11 INFO - 2017-04-03 15:52:11.226 screenresolution[1620:7423] Display 0: 1600x1200x32@60 15:52:11 INFO - 2017-04-03 15:52:11.232 screenresolution[1621:7426] starting screenresolution argv=screenresolution list 15:52:11 INFO - Available Modes on Display 0 15:52:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:52:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:52:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:52:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:52:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:52:11 INFO - Intel Iris: 15:52:11 INFO - Chipset Model: Intel Iris 15:52:11 INFO - Type: GPU 15:52:11 INFO - Bus: Built-In 15:52:11 INFO - VRAM (Dynamic, Max): 1536 MB 15:52:11 INFO - Vendor: Intel (0x8086) 15:52:11 INFO - Device ID: 0x0a2e 15:52:11 INFO - Revision ID: 0x0009 15:52:11 INFO - Displays: 15:52:11 INFO - Display: 15:52:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:52:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:52:11 INFO - Display Serial Number: 1600x1200 60 15:52:11 INFO - Main Display: Yes 15:52:11 INFO - Mirror: Off 15:52:11 INFO - Online: Yes 15:52:11 INFO - Rotation: Supported 15:52:11 INFO - Return code: 0 15:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:11 INFO - Python 2.7.3 15:52:11 INFO - Return code: 0 15:52:11 INFO - grabbing minidump binary from tooltool 15:52: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')]} 15:52:11 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 0x104344d30>, '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 0x10426bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104339be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:11 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 15:52:11 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 15:52:11 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 15:52:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:11 INFO - Return code: 0 15:52:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:52:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:11 INFO - ENV: RUST_BACKTRACE is now 1 15:52:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:52:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:11 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 15:52:11 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0261 --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 15:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JqhDfhh26y/Render', 15:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:11 INFO - 'HOME': '/Users/cltbld', 15:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:11 INFO - 'LOGNAME': 'cltbld', 15:52:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:11 INFO - 'MOZ_NO_REMOTE': '1', 15:52:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:11 INFO - 'NO_EM_RESTART': '1', 15:52:11 INFO - 'PAGER': '/bin/cat', 15:52:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:11 INFO - 'PWD': '/builds/slave/test', 15:52:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:11 INFO - 'RUST_BACKTRACE': '1', 15:52:11 INFO - 'SHELL': '/bin/bash', 15:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.v5SFOrhr5n/Listeners', 15:52:11 INFO - 'TMPDIR': '/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/', 15:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:11 INFO - 'USER': 'cltbld', 15:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:11 INFO - 'XPC_FLAGS': '0x0', 15:52:11 INFO - 'XPC_SERVICE_NAME': '0', 15:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:52:11 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0261', '--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 15:52:11 INFO - mozversion application_buildid: 20170403144327 15:52:11 INFO - mozversion application_changeset: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 15:52:11 INFO - mozversion application_display_name: Nightly 15:52:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:11 INFO - mozversion application_name: Firefox 15:52:11 INFO - mozversion application_remotingname: firefox 15:52:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:52:11 INFO - mozversion application_vendor: Mozilla 15:52:11 INFO - mozversion application_version: 55.0a1 15:52:11 INFO - mozversion platform_buildid: 20170403144327 15:52:11 INFO - mozversion platform_changeset: 2a593ea93f6637df49eedc998b1f5ae4781a0f56 15:52:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:52:11 INFO - mozversion platform_version: 55.0a1 15:52:11 INFO - using testdate: 1491259931 15:52:11 INFO - actual date: 1491259931 15:52:11 INFO - starting webserver on 'localhost:49240' 15:52:11 INFO - SUITE-START | Running 2 tests 15:52:11 INFO - TEST-START | dromaeo_css 15:52:11 INFO - operating with platform_type : mac_ 15:52:11 INFO - Initialising browser for dromaeo_css test... 15:52:11 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpUhGgBn/profile http://localhost:49240/getInfo.html) 15:52:14 INFO - PID 1631 | 2017-04-03 15:52:14.609 plugin-container[1633:7624] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 15:52:14 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:14 INFO - PID 1631 | 2017-04-03 15:52:14.611 plugin-container[1633:7624] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 15:52:14 INFO - PID 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:14 INFO - PID 1631 | 2017-04-03 15:52:14.612 plugin-container[1633:7624] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:52:14 INFO - PID 1631 | __metrics Screen width/height:1600/1200 15:52:14 INFO - PID 1631 | colorDepth:24 15:52:14 INFO - PID 1631 | Browser inner width/height: 1024/689 15:52:14 INFO - PID 1631 | __metrics 15:52:14 ERROR - PID 1631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 15:52:15 INFO - TEST-INFO | 1631: exit 0 15:52:15 INFO - Browser initialized. 15:52:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:15 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmpUhGgBn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:18 INFO - PID 1634 | 2017-04-03 15:52:18.142 plugin-container[1635:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873b, name = 'com.apple.tsm.portname' 15:52:18 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:18 INFO - PID 1634 | 2017-04-03 15:52:18.143 plugin-container[1635:7753] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460f, name = 'com.apple.CFPasteboardClient' 15:52:18 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:52:18 INFO - PID 1634 | 2017-04-03 15:52:18.143 plugin-container[1635:7753] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:52:27 INFO - PID 1634 | RSS: Main: 229117952 15:52:27 INFO - PID 1634 | 15:55:31 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 15:55:33 INFO - PID 1634 | RSS: Main: 253730816 15:55:33 INFO - PID 1634 | 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 15:57:16 INFO - PID 1634 | 15:57:16 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:57:16 INFO - PID 1634 | Full stack: 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 15:57:16 INFO - PID 1634 | 15:57:16 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:57:16 INFO - PID 1634 | Full stack: 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 15:57:16 INFO - PID 1634 | 15:57:16 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:57:16 INFO - PID 1634 | Full stack: 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | ************************* 15:57:16 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 15:57:16 INFO - PID 1634 | 15:57:16 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 15:57:16 INFO - PID 1634 | Full stack: 15:57:16 INFO - PID 1634 | ************************* 15:58:35 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 15:58:36 INFO - PID 1634 | RSS: Main: 261279744 15:58:36 INFO - PID 1634 | 16:01:38 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 16:01:38 INFO - PID 1634 | RSS: Main: 276377600 16:01:38 INFO - PID 1634 | 16:04:40 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 16:04:41 INFO - PID 1634 | RSS: Main: 268689408 16:04:41 INFO - PID 1634 | 16:07:44 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 16:07:44 INFO - PID 1634 | RSS: Main: 279023616 16:07:44 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 16:10:47 INFO - PID 1634 | RSS: Main: 272728064 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | __start_tp_report 16:10:47 INFO - PID 1634 | _x_x_mozilla_page_load 16:10:47 INFO - PID 1634 | _x_x_mozilla_page_load_details 16:10:47 INFO - PID 1634 | |i|pagename|runs| 16:10:47 INFO - PID 1634 | |0;dojo.html;3543.2027793746424;3545.1668857818418;3560.21675231449;3601.567811862577;3602.9459558106632;6112.969435152818;6198.473129783968;6222.191115155029;6223.906641400383;6252.562320637546;6111.014442317729;6145.924463218941;6175.536834737391;6187.9690601547045;6231.968840155804;5479.863003424906;5494.835154945358;5504.036793561111;5522.282103326582;5589.357223919261;5009.724465154415;5263.078961181797;5414.052540805344;5508.173773933902;5576.609637325389;5436.320459942507;5503.2020357048;5514.779408823642;5534.280543529356;5545.306836645419;5441.918371224435;5446.400895901487;5492.505674489275;5497.505224529811;5547.140193270049;5436.2661040759385;5438.755256013489;5441.1838224266285;5457.945420545783;5472.589555783332;6064.363241859585;6119.3197658210165;6152.477039451652;6169.568130230886;6169.660668663222;6564.835879103013;6571.112899758519;6582.9670851645915;6605.7027433765115;6608.107905432753;6679.165104361955;6688.4649228061635;6691.4312283455965;6693.163354580677;6700.765473208463;6110.694465276719;6133.754649814046;6290.842728931768;6295.9926411773895;6327.462165715966;6699.665016749143;6728.158980127484;6768.9661551691925;6779.661016949133;6825.69284382204;5260.421353651172;6227.941249987513;6276.623402595859;6475.514336424787;6548.836279092966;5531.25328080712;5589.189567512688;6495.902561461582;6656.167979002625;6705.2959439258175;5408.215808707715;5512.751926163332;6581.670916454158;6593.604383736991;6618.073469714244;6361.936380636134;6402.071699603532;6513.185851768529;6565.934340656532;6610.537262391683;5210.635255532152;5234.947650523446;5249.685018898878;5250.448702886219;5279.736013199325;4683.344331793552;4699.859004229878;4704.929426058612;4728.527147285244;4739.146953548395;5642.069058605284;6180.196574445294;6195.473384762256;6278.843028924222;6332;6614.867702646016;6678.666066696645;6702.664866756642;6708.966455167791;6724.899126513106;6301.464375528131;6301.6534090625455;6357.904631430532;6360.300366959631;6404.199475065617;5728.885422291531;5916.970415147896;5922.170896074553;5942.227510423617;5946.70266486674;6736;6853.623050732258;6917.066196063467;6925.757598484029;6957.026016357815;6688.933110668831;6706.295838936841;6720.630365329954;6724.226713927961;6725.9663701681175;6847.623380714109;6884.5180837342905;6895.172579290517;6923.480738944499;6927.134108236471;6303.180586523723;6350.333215012357;6546.672666366758;6595.373439523238;6707.362800534137;5510.9448905510435;6671.499637527108;6739.494537909578;6741.797746067626;6758;6182.783602573888;6310.463610593151;6449.935500644933;6493.415592596689;6494.545381823227;6373.8725225496155;6456.935430645822;6494.64279464634;6500;6522.119513865568;5257.132573125392;5910.674912879833;6295.55931084838;6326.588771729823;6376.617402955838;5388.865278368072;6361.777337793155;6462.903056454251;6485.6108633482145;6492.675366231764;6203.503719702503;6242.843928901813;6288.496920246461;6291.213598300213;6296.5277604178955 16:10:47 INFO - PID 1634 | |1;ext.html;700.5866538742141;704.2323866984987;791.3313250303491;1190.9702257443557;1194.3669854976865;37183.070423239435;38340.808295958515;38468.80765596168;38484.037899052535;38520;37954;38238.617613823924;38274.8086259569;38368.61631383685;38512.80743596285;8025.839483210318;8213.58932053398;8511.659533618647;8697.913020869773;8729.912700872974;8566.700165494209;8639.870401943976;8651.740447786577;8668.219860212579;8669.133086691343;8588.828223435528;8598.742037738846;8650.43772154811;8677.349198810083;8694.913050869505;7297.817554561126;8554.230119289232;8614.22471977525;8619.224269815715;8641.783955401166;7182.604956727378;7197.496175267734;7234.638268086627;7814.72648457307;8339.082700902896;37382;37488;37506.62493375059;37565.87302380933;37575.24849502995;2893.291143669793;2910.156054744122;2941.485240082977;2941.6430370208936;2958.304798372381;27148;27281.863590681918;27369.31576710578;28317.57523637147;28379.148625541267;2800.9439811203865;2801.29967508123;2833.914982550527;2850.7861910356805;2884.855757212131;256851;262156;279738;305626;306784;39317.82046538608;43199.56800431955;46033.539664602926;46039.76980115078;46086.539134608895;47768.80577985509;47836.760816195696;47979.760101199274;48000.03999919982;48201.517984820406;13210.867891321155;13231.536896208587;13263.403146858414;13278.468861245441;13370;9463.432194068379;10789.97495237951;10851.511681974172;10887.782244355227;10918.563257469772;12906.386701662292;13007.739845203043;13041;13061.869381306255;13163.60509184726;4760.857174284777;5589.329280486368;5598.480683692354;5633.492985631313;5657.20799088128;864.567716141929;883.8099808541194;889.590788237418;910.7495438754263;940.4451373689556;21356.35930922075;21766.911654417218;23630.409239769142;23784;23990;847.6482259862212;919.7056941778567;979.5151400057017;1001.8547310640062;1032.3289861589876;11762.000229980547;11877.346745929057;12195.817062744067;12208;12247.816282755766;479475;482941;483585;484730;488074;48583.5141648579;51339;51404.22893656598;51491.71270718262;51518.742406288475;1300.174389262806;1356.2608378433777;1360.2654566534159;1362.005735812882;1372.1286982766017;22789.886050570305;23114.422139445975;23129.306120816404;23349.766502334758;23558.52882942366;37564;37652.246955061295;37694.62305376911;37773.811130945265;37852.432213516266;446577.76711116236;449856;451426;452201;452777;26633.53515556663;31544;32187.839060804545;32231.838840805645;32245.838770805996;40089.71458060363;40380.798096009334;40391.52877706718;40500.44913374279;41021.58978410297;28072.017479388123;28108.578371324857;28159.296017598903;29489.85255073711;29637.407251855275;25209;28317.15048548547;29285.974990875216;29412.705872941;29567.85216073992;33361.83319083389;33981.83009084939;34274.14314642154;34530;34547.309053819285;20407.591848162658;23262.41843953847;27990.694013381126;29339.03922970457;29770.85114574413;19877.701834472206;23435.765642344042;23481.765182347957;23715.40711482227;23939.16212932539 16:10:47 INFO - PID 1634 | |2;jquery.html;394.8262764383669;411.95468498465164;419.4128220491312;432.3083067092652;434.0905802344088;17951.012694301808;20080.09639566221;21049;21109.366718998415;21211.045502952365;19652.115654795532;19806.801931980677;19841.404757857286;20340.898295508538;20561.897190514028;5968.253968253968;6181.938180618181;6199.597026193283;6224.284207316148;6226.43962043416;5283.260343551906;5940.673262970535;6094.725737341808;6115.235595550556;6130.386961303879;6075.119107729377;6123.326434092246;6125.509959203276;6136.079588061804;6152.384761523835;5968.612040217394;6064.151018857341;6122.755089796403;6236.189295391616;6271.090691849702;4709.1994360958715;4761.571458568746;5581.49766521011;5596.608237423382;5598.496135347838;25240.242792716246;26314.473710525876;26354.506364893958;26437.867810661017;26482.6027609586;1761.788585369751;2006.3379084902094;2011.426743378145;2043.2644248070683;2092.61286661968;13621;15857.127857967807;16214.837851621569;16219.51341459758;16227;1839.5309196154894;1905.6093500832296;1913.1199648161862;1917.7986311437237;1924.5862139639905;126509.67451627382;133531.33234333864;141159;155323.99999999886;158264;11927.224730392496;12237.632871013884;12324.137310388187;12356.567520136932;12685.746285074432;13466.394012269471;15769.921150394404;15824.28790704421;15838.445654402041;15859.762103568455;6751.831204219934;7138.286171382821;8503.702370417006;8506.61720222579;8572.3999320047;7907.809441367737;7929.841403171904;7977.960110199412;8033.437659363905;8163.142869998684;7525.887111693329;7570.205128461543;7614.923850761532;7634.6182690865235;7679.808004799925;1771.76081229035;1771.867109966732;2099.4436474334316;2104.074207348762;2348;710.5168485429957;805.7099444200084;841.8737189421513;854.4232642965973;884.9247813935759;15622.921885390728;17504.912475437795;17984.730229046574;19616.901915490333;19859.60280794376;767.3822572828815;787.0909099989522;865.312076898867;902.9593119549864;923.0907556057278;9816.214702823758;10214.795704085876;10217.795644087077;10248.64129755455;10350.964903509588;581401;619788;666773.319468466;680309;681338;151654;153384.46615533702;154227;157538.8891110491;158550.207248963;1124.6738445850613;1135.647949135754;1151.8963293303643;1163.086976723285;1176.4117941029485;19564.90217548903;20369.472289578636;20612.07245673978;20702.068406922026;20776.376708698765;46766.532334676216;61158.38841611705;62161.689191553756;62180;65075.67462162659;86706;86890;87244;87948;88173.11826881648;8487.108853570286;8492.915070849212;8502.702405415781;8833.779155521164;8923.866142008004;10801.459927003776;13909.860901391261;14078.917114036814;14113.788293175405;14317.64205894861;11480.483378247833;11816.70458238551;11839.112066594867;11984.820227696417;12038.518459261883;8022.828293914173;9690.95154524223;9735;9822.5088745561;9975.551100200364;10845.132389408986;11174.608888688857;11781.882181178422;12026.458809353426;12252.754944900873;8629.784255393413;8663.95668021656;8812.471251724917;8889.911100888909;8904.065073167225;11324.716882077684;11437.59968401102;11734.589289374831;11756.529738810352;11836.408179591159 16:10:47 INFO - PID 1634 | |3;mootools.html;1298.4870975964495;1319.2875847042596;1331.8013787591174;1361.55068827287;1367.432515506065;10349.965003499647;10742.248042637018;10792.676219713401;10819.729506762334;11052.392118433483;10525.157987361012;10820.891791082087;10831.025207731303;10843.566257349696;10899.400532970683;2399.908041840958;2419.8790060496995;2425.0784701813286;2427.2718184544656;2435.9756402436014;1942.3881477334594;2318.8840557972117;2378.131981826638;2428.3807629054654;2432.0514999150346;2346.577616029114;2399.700037495313;2403.927882163529;2419.9879000604974;2424.4302588891683;2244.5286489837154;2337.6610391493223;2352.2825538210923;2352.6706261123454;2401.771831675988;2008.1866843928233;2088.8120069193847;2316.5366926614574;2380.595298799208;2382.988085059581;10798.622048228275;10858.402787846666;10890.782184356269;10898.891011089947;10949.83575246372;5202.661826981234;5842.444967728059;5988.9101663475085;6208.192934918432;6242.408185912564;2963.5554666799935;3626.963730362689;3886.941695874564;3949.4273330367223;3958.802059896994;1178.110526552456;1183.4910988275037;1217.446062041769;1233.5682511121126;1239.5847391123984;13279.53521626748;14845.851541484555;15041.623959400993;15228.46700365493;15258.465953691679;5112;5216.869578260574;5279.472052794767;5295.867603309871;5332.226827110047;9194.770130746785;9729.513524323755;11161.609343673095;11175.608853690082;11177.161712871568;5741.8564535886935;6076.574639775174;6091.939080609226;6108.236470441195;6150.7232174552255;5263.6841789492755;5542.057850165482;5607.018771714934;5655.406182350794;5712.257406537206;4067.3288907330552;4154.958450415517;4169.187008533307;4215.409842622035;4239.300515414922;1092.6175838456477;1189.2685998111272;1219.3963987825905;1222.8654847966716;1240.34881687115;713.3651050565002;733.9853202935911;736.3041925380464;747.9326860582573;780.8711562592222;5790.478856902899;5838.12428135783;5995.700214989233;6017.097435384728;6173.351798061229;524.6511070138315;537.0815904802753;538.4265756968815;542.4006472847447;548.0135755639832;3479.3563190809273;3568.6431356864105;3663.5420572428447;3693.390590552529;3721.1441368484857;12920.547780827626;13487.865121348661;13983.30083495821;13997.510087147104;14071.2964351782;13788.310584470737;13892.86107138936;13952.860471395155;13970.511032113827;14029.22839243831;9992.65025724096;10052.899471005196;10084.294099412971;10210.4384258865;10229.846552301722;6527.11883895668;6532.183477065367;6595.340465953558;6644.169478815148;6694.83262918431;10249.33379330341;12102.273863568214;12408.255504669749;12450.003999679822;12490.875091249334;10281.845772313272;12731.80902286448;12735.55425560101;12827.358632068546;12995.740085198433;8831.955840221015;8987.056359082202;9113.863292050492;9145.3598248122;9166.770830729285;10099.04059114383;10113.039261270167;10162.288639795144;10164.186865050926;10219.182465402899;8410.831783364176;8634.007089184573;8639.740807775777;8718;8870.645174193218;8351.874721879056;8368.037675667376;8416.873746893923;8427.283680887193;8527.573621319034;7680.423968202295;7683.423743219393;7692.346150577264;7785.805354866174;7801.9609901950125;5702.40124786908;5793.652380857162;5872.29532456108;5917.822465326047;5983.670898100646;4872.561469467623;5834.27071616048;5904.143899134516;5986.55100867428;6002.729877155626 16:10:47 INFO - PID 1634 | |4;prototype.html;367.8853075182196;386.025286152465;387.12509728014686;399.1876531258887;401.24365570898857;4936.259561065837;5963.880722385555;6185.226846644169;6239.65681887496;6363.154685141303;6096.085587161928;6200.78297259596;6223.190985171933;6234.470070044041;6236;4418.845340413086;4487.75317357546;4575.565321294472;4599.517050709677;4617.422822147231;4505.6483055083345;4536;4557.609928971662;4576.23814831289;4591.334256532801;4535;4546.181687296285;4550.271956486963;4550.453945526525;4555.362249285103;4038.575949525287;4311.935320970188;4355.324924636687;4377.651096910866;4461.754603496839;3409.7272218222483;3855.4409610606585;3871.2257548490134;3883.786391748453;3888.358420860555;5082.23766435034;5792.4497172768515;6026.8548975694475;6105.694715264219;6135.3864613538735;4218.91562168758;4772.5943294819635;4792.568668819823;5231.686098834082;5406.8918621627745;5758.539316854683;5990.311114221877;6379.393957574023;6621.337866213388;6664.700088496029;4380.474343078819;4406.259527486624;4409.889752756207;4410.073884484262;4414.845480408202;6748.966255168692;6988.860222795566;7006.964965175192;7072.575645461237;7077.48749194039;3165.6517783043846;3837.7527303626434;4386.0789234261165;4421.894526368408;4469.195544801902;3648.9565843127934;4302.870913872589;4321.373400856858;4533.863984080483;4576.633869290449;4569.897846990355;4679.113127484212;4955.702657840469;5382.19696401702;5423.3491980962535;4997.925031124536;5433.809816656398;6062.363451837582;6098.817035488943;6358.933346662353;1423.487544483985;1462.531989763287;1511.1537538978207;1540.4518458948908;1559.1502631065869;840.6007146605435;862.7153039497076;977.7950721123821;1022.6676330192718;1033.7932413517326;5718.456746609066;6281.780137695158;6343.492520598341;6358.078078678565;6391.105245265667;5939.406059394112;6880.759173428906;6937.7571784987285;6956.5478243913985;6978.371946524736;6354.3010268870385;6427.9109289480175;6459.515536334794;6463.6768161591735;6470.805875823733;3329.200991762008;3535.858565657345;3571.017970058203;3609.4405367168133;3650.452432135148;6304.810855674337;6766.646670665887;7036.859262814715;7068.11648543932;7158.99774031636;6371.39471750183;6502.577332473374;6916.827079322957;7097.325754053357;7132.750353737594;6960.512764106566;7037.612931288828;7061.329173728487;7156.463265255126;7184.892226616605;5684.232628595087;6104.786332478342;6297.905531416941;6611.30581288977;6940.68127055878;5822.417758224144;5833.562482813721;6432.874247006662;6745.797626071226;6776.390124888783;5738.48353648157;6212.565120441525;6949.5125537824015;7010.474214433836;7135.500514963903;3458.9827050864583;4333.804978776026;4431.401760762255;4448.310511870665;4463.218936686132;5754.9424505754405;6067.089936509559;6858.965705171442;6866.553674011173;6925.653717314013;5807.216025836627;6075.422834830684;6142.754289828356;6363.331850155667;6664.76673316451;6747.411760003245;6755.932440675727;6766.289539598271;6782.253952065367;6785.796426107225;6124.234470691164;6647.268800432045;6647.700853461509;6649.73401063952;6658.400743933069;5598.300212473441;6560.737570497126;6717.093192418961;6719.664016799043;6742.292059333699;5234.2672025915645;6554.344565543408;6570.605763654196;6576.375244351779;6579.276279609144 16:10:47 INFO - PID 1634 | |5;yui.html;648.8280605639509;660.0956689335611;662.1557514169436;679.6567733294686;686.7295503318861;15168.544943651694;15392.99945503543;15707.371705131782;15708.293126809293;15864.365425383;14012.299385030734;14314;14398.856011439882;14499.855001449982;14574.708505829876;723.724984505887;806.3468590441731;817.9816128919504;818.3739439328889;829.4401279136589;805.6616221187115;836.0135040652028;840.197611281228;841.3269384492412;842.751388340441;839.9664013439456;848.6478111583685;866.2333834556431;871.4030888841164;872.7512658892217;840.8948881389827;844.9535275559841;848.7878030492377;853.9103394143588;866.3069544364515;623.0436280309702;633.5786701843268;640.0782872663397;653.8561516466369;654.9541532092755;15349;15588.376464941502;15640.843591564166;15683.764743528856;15767.29047192879;14214.857851421457;14343.354549045318;14442.277886105652;14576.562703118923;14589.416423343053;10035.197184225244;10694.82356940736;10950.616728414467;11670.533178672842;11687.766244675144;3003.714647108521;3029.666736658966;3039.1946134274435;3085.7222849943614;3134.26344808972;97215.56961075959;100862.48706269411;108190.45904770505;110479;110760.4461977693;10993.376827316926;11146.275492092987;11196.832047519294;11226.438678066064;11532.942335288437;22732.09071637149;22835.429114271945;22885.771142288697;22932.16542676582;23059.423514412272;7712.807179820549;7718.575478348745;7734.4585878989055;7883.2116788321855;8011.038675358995;3482.529858469125;3988.8205030773684;4124.6906482013965;4190.53904070552;4195.790210489463;3242.3191129862994;3868.825902834379;3884.4173373993563;3891.6886649068006;3950.861719839792;731.5829976913109;741.4476215219696;751.9547828518364;753.3534623570691;759.7606753872512;526.6708307307932;529.2722506553489;554.6727430815838;571.3971759793375;587.9000569903127;9547.449313926078;9702.660406885725;9799.314048016571;9949.950250248703;10654.297213407728;534.981275655358;557.1920714963319;568.4798409455302;576.247996364748;585.3093349847136;4348.086901750605;4843.4430040545085;4854.732989685601;4907.705537667752;5039.168537191395;102695.97304026864;105623.41564876532;106319;107129;108221;91323;91692;92620.61069083969;92894.0710592899;92908.07091929129;55576;62745.74508509713;81184.78222826662;81211.59394202991;81790.13734519383;10078.294519383866;10523;10562.471876405994;10587.470626468492;10610.734731631772;39543;40127.39808902927;40659.390109148975;41218.38172427356;41299.58700412957;62001;67230;71708;71718;73088;12887.871121288666;13051;13059.804102938653;13215.801762973371;13652.453901843815;14350.138991660533;14440.080056299179;14533.982621216413;14575.781363279348;15016.249187540361;13543.632426848797;13721;13883.861161388257;14131.15213087218;14211.715765684836;13187.406566704713;13427.328633568477;13631.86368136306;14088.577342679737;14099.506517271846;13397.464101435833;13592;13593.320333983063;13607.040458744681;14027.088239264414;7792.88310675329;9536.475493847627;9704.70885873425;9892.752681183028;10299.639512617023;8486.575671216538;9608.711738647851;11071.667849964513;11128.833067503832;11347.886521135013 16:10:47 INFO - PID 1634 | __end_tp_report 16:10:47 INFO - PID 1634 | __start_cc_report 16:10:47 INFO - PID 1634 | _x_x_mozilla_cycle_collect,430 16:10:47 INFO - PID 1634 | __end_cc_report 16:10:47 INFO - PID 1634 | __startTimestamp1491261047765__endTimestamp 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | ------- Summary: start ------- 16:10:47 INFO - PID 1634 | Number of tests: 6 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | [#0] dojo.html Cycles:165 Average:6076.25 Median:6291.21 stddev:710.14 (11.3%) stddev-sans-first:683.95 16:10:47 INFO - PID 1634 | Values: 3543.2 3545.2 3560.2 3601.6 3602.9 6113.0 6198.5 6222.2 6223.9 6252.6 6111.0 6145.9 6175.5 6188.0 6232.0 5479.9 5494.8 5504.0 5522.3 5589.4 5009.7 5263.1 5414.1 5508.2 5576.6 5436.3 5503.2 5514.8 5534.3 5545.3 5441.9 5446.4 5492.5 5497.5 5547.1 5436.3 5438.8 5441.2 5457.9 5472.6 6064.4 6119.3 6152.5 6169.6 6169.7 6564.8 6571.1 6583.0 6605.7 6608.1 6679.2 6688.5 6691.4 6693.2 6700.8 6110.7 6133.8 6290.8 6296.0 6327.5 6699.7 6728.2 6769.0 6779.7 6825.7 5260.4 6227.9 6276.6 6475.5 6548.8 5531.3 5589.2 6495.9 6656.2 6705.3 5408.2 5512.8 6581.7 6593.6 6618.1 6361.9 6402.1 6513.2 6565.9 6610.5 5210.6 5234.9 5249.7 5250.4 5279.7 4683.3 4699.9 4704.9 4728.5 4739.1 5642.1 6180.2 6195.5 6278.8 6332.0 6614.9 6678.7 6702.7 6709.0 6724.9 6301.5 6301.7 6357.9 6360.3 6404.2 5728.9 5917.0 5922.2 5942.2 5946.7 6736.0 6853.6 6917.1 6925.8 6957.0 6688.9 6706.3 6720.6 6724.2 6726.0 6847.6 6884.5 6895.2 6923.5 6927.1 6303.2 6350.3 6546.7 6595.4 6707.4 5510.9 6671.5 6739.5 6741.8 6758.0 6182.8 6310.5 6449.9 6493.4 6494.5 6373.9 6456.9 6494.6 6500.0 6522.1 5257.1 5910.7 6295.6 6326.6 6376.6 5388.9 6361.8 6462.9 6485.6 6492.7 6203.5 6242.8 6288.5 6291.2 6296.5 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | [#1] ext.html Cycles:180 Average:52849.13 Median:37497.31 stddev:110691.92 (295.2%) stddev-sans-first:110933.19 16:10:47 INFO - PID 1634 | Values: 700.6 704.2 791.3 1191.0 1194.4 37183.1 38340.8 38468.8 38484.0 38520.0 37954.0 38238.6 38274.8 38368.6 38512.8 8025.8 8213.6 8511.7 8697.9 8729.9 8566.7 8639.9 8651.7 8668.2 8669.1 8588.8 8598.7 8650.4 8677.3 8694.9 7297.8 8554.2 8614.2 8619.2 8641.8 7182.6 7197.5 7234.6 7814.7 8339.1 37382.0 37488.0 37506.6 37565.9 37575.2 2893.3 2910.2 2941.5 2941.6 2958.3 27148.0 27281.9 27369.3 28317.6 28379.1 2800.9 2801.3 2833.9 2850.8 2884.9 256851.0 262156.0 279738.0 305626.0 306784.0 39317.8 43199.6 46033.5 46039.8 46086.5 47768.8 47836.8 47979.8 48000.0 48201.5 13210.9 13231.5 13263.4 13278.5 13370.0 9463.4 10790.0 10851.5 10887.8 10918.6 12906.4 13007.7 13041.0 13061.9 13163.6 4760.9 5589.3 5598.5 5633.5 5657.2 864.6 883.8 889.6 910.7 940.4 21356.4 21766.9 23630.4 23784.0 23990.0 847.6 919.7 979.5 1001.9 1032.3 11762.0 11877.3 12195.8 12208.0 12247.8 479475.0 482941.0 483585.0 484730.0 488074.0 48583.5 51339.0 51404.2 51491.7 51518.7 1300.2 1356.3 1360.3 1362.0 1372.1 22789.9 23114.4 23129.3 23349.8 23558.5 37564.0 37652.2 37694.6 37773.8 37852.4 446577.8 449856.0 451426.0 452201.0 452777.0 26633.5 31544.0 32187.8 32231.8 32245.8 40089.7 40380.8 40391.5 40500.4 41021.6 28072.0 28108.6 28159.3 29489.9 29637.4 25209.0 28317.2 29286.0 29412.7 29567.9 33361.8 33981.8 34274.1 34530.0 34547.3 20407.6 23262.4 27990.7 29339.0 29770.9 19877.7 23435.8 23481.8 23715.4 23939.2 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | [#2] jquery.html Cycles:180 Average:38524.54 Median:26334.49 stddev:109005.09 (413.9%) stddev-sans-first:109273.28 16:10:47 INFO - PID 1634 | Values: 394.8 412.0 419.4 432.3 434.1 17951.0 20080.1 21049.0 21109.4 21211.0 19652.1 19806.8 19841.4 20340.9 20561.9 5968.3 6181.9 6199.6 6224.3 6226.4 5283.3 5940.7 6094.7 6115.2 6130.4 6075.1 6123.3 6125.5 6136.1 6152.4 5968.6 6064.2 6122.8 6236.2 6271.1 4709.2 4761.6 5581.5 5596.6 5598.5 25240.2 26314.5 26354.5 26437.9 26482.6 1761.8 2006.3 2011.4 2043.3 2092.6 13621.0 15857.1 16214.8 16219.5 16227.0 1839.5 1905.6 1913.1 1917.8 1924.6 126509.7 133531.3 141159.0 155324.0 158264.0 11927.2 12237.6 12324.1 12356.6 12685.7 13466.4 15769.9 15824.3 15838.4 15859.8 6751.8 7138.3 8503.7 8506.6 8572.4 7907.8 7929.8 7978.0 8033.4 8163.1 7525.9 7570.2 7614.9 7634.6 7679.8 1771.8 1771.9 2099.4 2104.1 2348.0 710.5 805.7 841.9 854.4 884.9 15622.9 17504.9 17984.7 19616.9 19859.6 767.4 787.1 865.3 903.0 923.1 9816.2 10214.8 10217.8 10248.6 10351.0 581401.0 619788.0 666773.3 680309.0 681338.0 151654.0 153384.5 154227.0 157538.9 158550.2 1124.7 1135.6 1151.9 1163.1 1176.4 19564.9 20369.5 20612.1 20702.1 20776.4 46766.5 61158.4 62161.7 62180.0 65075.7 86706.0 86890.0 87244.0 87948.0 88173.1 8487.1 8492.9 8502.7 8833.8 8923.9 10801.5 13909.9 14078.9 14113.8 14317.6 11480.5 11816.7 11839.1 11984.8 12038.5 8022.8 9691.0 9735.0 9822.5 9975.6 10845.1 11174.6 11781.9 12026.5 12252.8 8629.8 8664.0 8812.5 8889.9 8904.1 11324.7 11437.6 11734.6 11756.5 11836.4 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | [#3] mootools.html Cycles:180 Average:6629.94 Median:2434.01 stddev:4160.89 (170.9%) stddev-sans-first:4153.28 16:10:47 INFO - PID 1634 | Values: 1298.5 1319.3 1331.8 1361.6 1367.4 10350.0 10742.2 10792.7 10819.7 11052.4 10525.2 10820.9 10831.0 10843.6 10899.4 2399.9 2419.9 2425.1 2427.3 2436.0 1942.4 2318.9 2378.1 2428.4 2432.1 2346.6 2399.7 2403.9 2420.0 2424.4 2244.5 2337.7 2352.3 2352.7 2401.8 2008.2 2088.8 2316.5 2380.6 2383.0 10798.6 10858.4 10890.8 10898.9 10949.8 5202.7 5842.4 5988.9 6208.2 6242.4 2963.6 3627.0 3886.9 3949.4 3958.8 1178.1 1183.5 1217.4 1233.6 1239.6 13279.5 14845.9 15041.6 15228.5 15258.5 5112.0 5216.9 5279.5 5295.9 5332.2 9194.8 9729.5 11161.6 11175.6 11177.2 5741.9 6076.6 6091.9 6108.2 6150.7 5263.7 5542.1 5607.0 5655.4 5712.3 4067.3 4155.0 4169.2 4215.4 4239.3 1092.6 1189.3 1219.4 1222.9 1240.3 713.4 734.0 736.3 747.9 780.9 5790.5 5838.1 5995.7 6017.1 6173.4 524.7 537.1 538.4 542.4 548.0 3479.4 3568.6 3663.5 3693.4 3721.1 12920.5 13487.9 13983.3 13997.5 14071.3 13788.3 13892.9 13952.9 13970.5 14029.2 9992.7 10052.9 10084.3 10210.4 10229.8 6527.1 6532.2 6595.3 6644.2 6694.8 10249.3 12102.3 12408.3 12450.0 12490.9 10281.8 12731.8 12735.6 12827.4 12995.7 8832.0 8987.1 9113.9 9145.4 9166.8 10099.0 10113.0 10162.3 10164.2 10219.2 8410.8 8634.0 8639.7 8718.0 8870.6 8351.9 8368.0 8416.9 8427.3 8527.6 7680.4 7683.4 7692.3 7785.8 7802.0 5702.4 5793.7 5872.3 5917.8 5983.7 4872.6 5834.3 5904.1 5986.6 6002.7 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | [#4] prototype.html Cycles:180 Average:5282.37 Median:6044.61 stddev:1702.63 (28.2%) stddev-sans-first:1666.97 16:10:47 INFO - PID 1634 | Values: 367.9 386.0 387.1 399.2 401.2 4936.3 5963.9 6185.2 6239.7 6363.2 6096.1 6200.8 6223.2 6234.5 6236.0 4418.8 4487.8 4575.6 4599.5 4617.4 4505.6 4536.0 4557.6 4576.2 4591.3 4535.0 4546.2 4550.3 4550.5 4555.4 4038.6 4311.9 4355.3 4377.7 4461.8 3409.7 3855.4 3871.2 3883.8 3888.4 5082.2 5792.4 6026.9 6105.7 6135.4 4218.9 4772.6 4792.6 5231.7 5406.9 5758.5 5990.3 6379.4 6621.3 6664.7 4380.5 4406.3 4409.9 4410.1 4414.8 6749.0 6988.9 7007.0 7072.6 7077.5 3165.7 3837.8 4386.1 4421.9 4469.2 3649.0 4302.9 4321.4 4533.9 4576.6 4569.9 4679.1 4955.7 5382.2 5423.3 4997.9 5433.8 6062.4 6098.8 6358.9 1423.5 1462.5 1511.2 1540.5 1559.2 840.6 862.7 977.8 1022.7 1033.8 5718.5 6281.8 6343.5 6358.1 6391.1 5939.4 6880.8 6937.8 6956.5 6978.4 6354.3 6427.9 6459.5 6463.7 6470.8 3329.2 3535.9 3571.0 3609.4 3650.5 6304.8 6766.6 7036.9 7068.1 7159.0 6371.4 6502.6 6916.8 7097.3 7132.8 6960.5 7037.6 7061.3 7156.5 7184.9 5684.2 6104.8 6297.9 6611.3 6940.7 5822.4 5833.6 6432.9 6745.8 6776.4 5738.5 6212.6 6949.5 7010.5 7135.5 3459.0 4333.8 4431.4 4448.3 4463.2 5754.9 6067.1 6859.0 6866.6 6925.7 5807.2 6075.4 6142.8 6363.3 6664.8 6747.4 6755.9 6766.3 6782.3 6785.8 6124.2 6647.3 6647.7 6649.7 6658.4 5598.3 6560.7 6717.1 6719.7 6742.3 5234.3 6554.3 6570.6 6576.4 6579.3 16:10:47 INFO - PID 1634 | 16:10:47 INFO - PID 1634 | [#5] yui.html Cycles:180 Average:20283.44 Median:21765.91 stddev:29469.70 (135.4%) stddev-sans-first:29515.50 16:10:47 INFO - PID 1634 | Values: 648.8 660.1 662.2 679.7 686.7 15168.5 15393.0 15707.4 15708.3 15864.4 14012.3 14314.0 14398.9 14499.9 14574.7 723.7 806.3 818.0 818.4 829.4 805.7 836.0 840.2 841.3 842.8 840.0 848.6 866.2 871.4 872.8 840.9 845.0 848.8 853.9 866.3 623.0 633.6 640.1 653.9 655.0 15349.0 15588.4 15640.8 15683.8 15767.3 14214.9 14343.4 14442.3 14576.6 14589.4 10035.2 10694.8 10950.6 11670.5 11687.8 3003.7 3029.7 3039.2 3085.7 3134.3 97215.6 100862.5 108190.5 110479.0 110760.4 10993.4 11146.3 11196.8 11226.4 11532.9 22732.1 22835.4 22885.8 22932.2 23059.4 7712.8 7718.6 7734.5 7883.2 8011.0 3482.5 3988.8 4124.7 4190.5 4195.8 3242.3 3868.8 3884.4 3891.7 3950.9 731.6 741.4 752.0 753.4 759.8 526.7 529.3 554.7 571.4 587.9 9547.4 9702.7 9799.3 9950.0 10654.3 535.0 557.2 568.5 576.2 585.3 4348.1 4843.4 4854.7 4907.7 5039.2 102696.0 105623.4 106319.0 107129.0 108221.0 91323.0 91692.0 92620.6 92894.1 92908.1 55576.0 62745.7 81184.8 81211.6 81790.1 10078.3 10523.0 10562.5 10587.5 10610.7 39543.0 40127.4 40659.4 41218.4 41299.6 62001.0 67230.0 71708.0 71718.0 73088.0 12887.9 13051.0 13059.8 13215.8 13652.5 14350.1 14440.1 14534.0 14575.8 15016.2 13543.6 13721.0 13883.9 14131.2 14211.7 13187.4 13427.3 13631.9 14088.6 14099.5 13397.5 13592.0 13593.3 13607.0 14027.1 7792.9 9536.5 9704.7 9892.8 10299.6 8486.6 9608.7 11071.7 11128.8 11347.9 16:10:47 INFO - PID 1634 | -------- Summary: end -------- 16:10:47 INFO - PID 1634 | 16:10:48 INFO - TEST-INFO | 1634: exit 0 16:10:48 INFO - TEST-OK | dromaeo_css | took 1116758ms 16:10:48 INFO - TEST-START | kraken 16:10:48 INFO - operating with platform_type : mac_ 16:10:48 INFO - Initialising browser for kraken test... 16:10:48 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmp1FHL21/profile http://localhost:49240/getInfo.html) 16:10:51 INFO - PID 1646 | 2017-04-03 16:10:51.515 plugin-container[1647:10183] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 16:10:51 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:10:51 INFO - PID 1646 | 2017-04-03 16:10:51.520 plugin-container[1647:10183] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 16:10:51 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:10:51 INFO - PID 1646 | 2017-04-03 16:10:51.520 plugin-container[1647:10183] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:10:51 INFO - PID 1646 | __metrics Screen width/height:1600/1200 16:10:51 INFO - PID 1646 | colorDepth:24 16:10:51 INFO - PID 1646 | Browser inner width/height: 1024/689 16:10:51 INFO - PID 1646 | __metrics 16:10:51 ERROR - PID 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 16:10:52 INFO - TEST-INFO | 1646: exit 0 16:10:52 INFO - Browser initialized. 16:10:52 INFO - Running cycle 1/1 for kraken test... 16:10:52 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/T/tmp1FHL21/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:54 INFO - PID 1648 | 2017-04-03 16:10:54.869 plugin-container[1649:10317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463b, name = 'com.apple.tsm.portname' 16:10:54 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:10:54 INFO - PID 1648 | 2017-04-03 16:10:54.870 plugin-container[1649:10317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 16:10:54 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:10:54 INFO - PID 1648 | 2017-04-03 16:10:54.870 plugin-container[1649:10317] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:11:04 INFO - PID 1648 | RSS: Main: 228941824 16:11:04 INFO - PID 1648 | 16:11:07 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:08 INFO - PID 1648 | RSS: Main: 243871744 16:11:08 INFO - PID 1648 | 16:11:11 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 16:11:11 INFO - PID 1648 | RSS: Main: 252346368 16:11:11 INFO - PID 1648 | 16:11:15 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 16:11:16 INFO - PID 1648 | RSS: Main: 254205952 16:11:16 INFO - PID 1648 | 16:11:18 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 16:11:18 INFO - PID 1648 | RSS: Main: 256360448 16:11:18 INFO - PID 1648 | 16:11:20 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:21 INFO - PID 1648 | RSS: Main: 256724992 16:11:21 INFO - PID 1648 | 16:11:24 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:25 INFO - PID 1648 | RSS: Main: 262561792 16:11:25 INFO - PID 1648 | 16:11:28 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:29 INFO - PID 1648 | RSS: Main: 263499776 16:11:29 INFO - PID 1648 | 16:11:32 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 16:11:33 INFO - PID 1648 | RSS: Main: 263757824 16:11:33 INFO - PID 1648 | 16:11:34 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:35 INFO - PID 1648 | RSS: Main: 263151616 16:11:35 INFO - PID 1648 | 16:11:37 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:37 INFO - PID 1648 | RSS: Main: 263053312 16:11:37 INFO - PID 1648 | 16:11:40 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:40 INFO - PID 1648 | RSS: Main: 263610368 16:11:40 INFO - PID 1648 | 16:11:43 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:44 INFO - PID 1648 | RSS: Main: 263827456 16:11:44 INFO - PID 1648 | 16:11:47 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:48 INFO - PID 1648 | RSS: Main: 261046272 16:11:48 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 16:11:50 INFO - PID 1648 | RSS: Main: 264327168 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | __start_tp_report 16:11:50 INFO - PID 1648 | _x_x_mozilla_page_load 16:11:50 INFO - PID 1648 | _x_x_mozilla_page_load_details 16:11:50 INFO - PID 1648 | |i|pagename|runs| 16:11:50 INFO - PID 1648 | |0;ai-astar;110;122;133;181;123;125;125;123;121;123 16:11:50 INFO - PID 1648 | |1;audio-beat-detection;153;117;115;158;117;122;155;138;136;118 16:11:50 INFO - PID 1648 | |2;audio-dft;214;217;205;281;279;318;301;211;212;217 16:11:50 INFO - PID 1648 | |3;audio-fft;80;59;63;87;62;59;58;64;101;50 16:11:50 INFO - PID 1648 | |4;audio-oscillator;82;73;90;71;74;69;83;73;71;83 16:11:50 INFO - PID 1648 | |5;imaging-gaussian-blur;91;93;99;128;127;142;91;91;91;91 16:11:50 INFO - PID 1648 | |6;imaging-darkroom;101;100;104;100;101;111;113;100;100;131 16:11:50 INFO - PID 1648 | |7;imaging-desaturate;105;103;149;104;147;163;101;102;156;123 16:11:50 INFO - PID 1648 | |8;json-parse-financial;51;53;53;54;53;54;53;54;53;53 16:11:50 INFO - PID 1648 | |9;json-stringify-tinderbox;58;65;60;78;92;98;62;58;61;59 16:11:50 INFO - PID 1648 | |10;stanford-crypto-aes;89;85;89;87;87;90;105;88;87;85 16:11:50 INFO - PID 1648 | |11;stanford-crypto-ccm;168;170;171;157;160;189;153;148;192;150 16:11:50 INFO - PID 1648 | |12;stanford-crypto-pbkdf2;193;197;199;200;195;227;261;200;200;203 16:11:50 INFO - PID 1648 | |13;stanford-crypto-sha256-iterative;72;73;60;57;63;61;76;109;106;62 16:11:50 INFO - PID 1648 | __end_tp_report 16:11:50 INFO - PID 1648 | __start_cc_report 16:11:50 INFO - PID 1648 | _x_x_mozilla_cycle_collect,1029 16:11:50 INFO - PID 1648 | __end_cc_report 16:11:50 INFO - PID 1648 | __startTimestamp1491261110672__endTimestamp 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | ------- Summary: start ------- 16:11:50 INFO - PID 1648 | Number of tests: 14 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#0] ai-astar Cycles:10 Average:128.60 Median:124.00 stddev:19.24 (15.5%) stddev-sans-first:19.20 16:11:50 INFO - PID 1648 | Values: 110.0 122.0 133.0 181.0 123.0 125.0 125.0 123.0 121.0 123.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:137.00 stddev:17.40 (12.7%) stddev-sans-first:16.87 16:11:50 INFO - PID 1648 | Values: 153.0 117.0 115.0 158.0 117.0 122.0 155.0 138.0 136.0 118.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#2] audio-dft Cycles:10 Average:245.50 Median:248.00 stddev:43.83 (17.7%) stddev-sans-first:44.98 16:11:50 INFO - PID 1648 | Values: 214.0 217.0 205.0 281.0 279.0 318.0 301.0 211.0 212.0 217.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#3] audio-fft Cycles:10 Average:68.30 Median:62.50 stddev:15.83 (25.3%) stddev-sans-first:16.22 16:11:50 INFO - PID 1648 | Values: 80.0 59.0 63.0 87.0 62.0 59.0 58.0 64.0 101.0 50.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:7.02 (9.0%) stddev-sans-first:7.19 16:11:50 INFO - PID 1648 | Values: 82.0 73.0 90.0 71.0 74.0 69.0 83.0 73.0 71.0 83.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:91.00 stddev:19.83 (21.8%) stddev-sans-first:20.43 16:11:50 INFO - PID 1648 | Values: 91.0 93.0 99.0 128.0 127.0 142.0 91.0 91.0 91.0 91.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:102.50 stddev:9.98 (9.7%) stddev-sans-first:10.42 16:11:50 INFO - PID 1648 | Values: 101.0 100.0 104.0 100.0 101.0 111.0 113.0 100.0 100.0 131.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#7] imaging-desaturate Cycles:10 Average:125.30 Median:135.00 stddev:25.60 (19.0%) stddev-sans-first:26.08 16:11:50 INFO - PID 1648 | Values: 105.0 103.0 149.0 104.0 147.0 163.0 101.0 102.0 156.0 123.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.50 16:11:50 INFO - PID 1648 | Values: 51.0 53.0 53.0 54.0 53.0 54.0 53.0 54.0 53.0 53.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:63.50 stddev:14.92 (23.5%) stddev-sans-first:15.27 16:11:50 INFO - PID 1648 | Values: 58.0 65.0 60.0 78.0 92.0 98.0 62.0 58.0 61.0 59.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:87.50 stddev:5.79 (6.6%) stddev-sans-first:6.14 16:11:50 INFO - PID 1648 | Values: 89.0 85.0 89.0 87.0 87.0 90.0 105.0 88.0 87.0 85.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:165.80 Median:169.00 stddev:15.33 (9.1%) stddev-sans-first:16.24 16:11:50 INFO - PID 1648 | Values: 168.0 170.0 171.0 157.0 160.0 189.0 153.0 148.0 192.0 150.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.50 Median:200.00 stddev:21.03 (10.5%) stddev-sans-first:21.64 16:11:50 INFO - PID 1648 | Values: 193.0 197.0 199.0 200.0 195.0 227.0 261.0 200.0 200.0 203.0 16:11:50 INFO - PID 1648 | 16:11:50 INFO - PID 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:62.50 stddev:18.79 (30.1%) stddev-sans-first:19.92 16:11:50 INFO - PID 1648 | Values: 72.0 73.0 60.0 57.0 63.0 61.0 76.0 109.0 106.0 62.0 16:11:50 INFO - PID 1648 | -------- Summary: end -------- 16:11:50 INFO - PID 1648 | 16:11:51 INFO - TEST-INFO | 1648: exit 0 16:11:51 INFO - TEST-OK | kraken | took 63279ms 16:11:51 INFO - SUITE-END | took 1180s 16:11:52 INFO - Completed test suite (00:19:40) 16:11:52 INFO - javascript benchmark 16:11:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7494.857513345329, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3543.2027793746424, 3545.1668857818418, 3560.21675231449, 3601.567811862577, 3602.9459558106632, 6112.969435152818, 6198.473129783968, 6222.191115155029, 6223.906641400383, 6252.562320637546, 6111.014442317729, 6145.924463218941, 6175.536834737391, 6187.9690601547045, 6231.968840155804, 5479.863003424906, 5494.835154945358, 5504.036793561111, 5522.282103326582, 5589.357223919261, 5009.724465154415, 5263.078961181797, 5414.052540805344, 5508.173773933902, 5576.609637325389, 5436.320459942507, 5503.2020357048, 5514.779408823642, 5534.280543529356, 5545.306836645419, 5441.918371224435, 5446.400895901487, 5492.505674489275, 5497.505224529811, 5547.140193270049, 5436.2661040759385, 5438.755256013489, 5441.1838224266285, 5457.945420545783, 5472.589555783332, 6064.363241859585, 6119.3197658210165, 6152.477039451652, 6169.568130230886, 6169.660668663222, 6564.835879103013, 6571.112899758519, 6582.9670851645915, 6605.7027433765115, 6608.107905432753, 6679.165104361955, 6688.4649228061635, 6691.4312283455965, 6693.163354580677, 6700.765473208463, 6110.694465276719, 6133.754649814046, 6290.842728931768, 6295.9926411773895, 6327.462165715966, 6699.665016749143, 6728.158980127484, 6768.9661551691925, 6779.661016949133, 6825.69284382204, 5260.421353651172, 6227.941249987513, 6276.623402595859, 6475.514336424787, 6548.836279092966, 5531.25328080712, 5589.189567512688, 6495.902561461582, 6656.167979002625, 6705.2959439258175, 5408.215808707715, 5512.751926163332, 6581.670916454158, 6593.604383736991, 6618.073469714244, 6361.936380636134, 6402.071699603532, 6513.185851768529, 6565.934340656532, 6610.537262391683, 5210.635255532152, 5234.947650523446, 5249.685018898878, 5250.448702886219, 5279.736013199325, 4683.344331793552, 4699.859004229878, 4704.929426058612, 4728.527147285244, 4739.146953548395, 5642.069058605284, 6180.196574445294, 6195.473384762256, 6278.843028924222, 6332.0, 6614.867702646016, 6678.666066696645, 6702.664866756642, 6708.966455167791, 6724.899126513106, 6301.464375528131, 6301.6534090625455, 6357.904631430532, 6360.300366959631, 6404.199475065617, 5728.885422291531, 5916.970415147896, 5922.170896074553, 5942.227510423617, 5946.70266486674, 6736.0, 6853.623050732258, 6917.066196063467, 6925.757598484029, 6957.026016357815, 6688.933110668831, 6706.295838936841, 6720.630365329954, 6724.226713927961, 6725.9663701681175, 6847.623380714109, 6884.5180837342905, 6895.172579290517, 6923.480738944499, 6927.134108236471, 6303.180586523723, 6350.333215012357, 6546.672666366758, 6595.373439523238, 6707.362800534137, 5510.9448905510435, 6671.499637527108, 6739.494537909578, 6741.797746067626, 6758.0, 6182.783602573888, 6310.463610593151, 6449.935500644933, 6493.415592596689, 6494.545381823227, 6373.8725225496155, 6456.935430645822, 6494.64279464634, 6500.0, 6522.119513865568, 5257.132573125392, 5910.674912879833, 6295.55931084838, 6326.588771729823, 6376.617402955838, 5388.865278368072, 6361.777337793155, 6462.903056454251, 6485.6108633482145, 6492.675366231764, 6203.503719702503, 6242.843928901813, 6288.496920246461, 6291.213598300213, 6296.5277604178955], "value": 6032.1188316365115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5866538742141, 704.2323866984987, 791.3313250303491, 1190.9702257443557, 1194.3669854976865, 37183.070423239435, 38340.808295958515, 38468.80765596168, 38484.037899052535, 38520.0, 37954.0, 38238.617613823924, 38274.8086259569, 38368.61631383685, 38512.80743596285, 8025.839483210318, 8213.58932053398, 8511.659533618647, 8697.913020869773, 8729.912700872974, 8566.700165494209, 8639.870401943976, 8651.740447786577, 8668.219860212579, 8669.133086691343, 8588.828223435528, 8598.742037738846, 8650.43772154811, 8677.349198810083, 8694.913050869505, 7297.817554561126, 8554.230119289232, 8614.22471977525, 8619.224269815715, 8641.783955401166, 7182.604956727378, 7197.496175267734, 7234.638268086627, 7814.72648457307, 8339.082700902896, 37382.0, 37488.0, 37506.62493375059, 37565.87302380933, 37575.24849502995, 2893.291143669793, 2910.156054744122, 2941.485240082977, 2941.6430370208936, 2958.304798372381, 27148.0, 27281.863590681918, 27369.31576710578, 28317.57523637147, 28379.148625541267, 2800.9439811203865, 2801.29967508123, 2833.914982550527, 2850.7861910356805, 2884.855757212131, 256851.0, 262156.0, 279738.0, 305626.0, 306784.0, 39317.82046538608, 43199.56800431955, 46033.539664602926, 46039.76980115078, 46086.539134608895, 47768.80577985509, 47836.760816195696, 47979.760101199274, 48000.03999919982, 48201.517984820406, 13210.867891321155, 13231.536896208587, 13263.403146858414, 13278.468861245441, 13370.0, 9463.432194068379, 10789.97495237951, 10851.511681974172, 10887.782244355227, 10918.563257469772, 12906.386701662292, 13007.739845203043, 13041.0, 13061.869381306255, 13163.60509184726, 4760.857174284777, 5589.329280486368, 5598.480683692354, 5633.492985631313, 5657.20799088128, 864.567716141929, 883.8099808541194, 889.590788237418, 910.7495438754263, 940.4451373689556, 21356.35930922075, 21766.911654417218, 23630.409239769142, 23784.0, 23990.0, 847.6482259862212, 919.7056941778567, 979.5151400057017, 1001.8547310640062, 1032.3289861589876, 11762.000229980547, 11877.346745929057, 12195.817062744067, 12208.0, 12247.816282755766, 479475.0, 482941.0, 483585.0, 484730.0, 488074.0, 48583.5141648579, 51339.0, 51404.22893656598, 51491.71270718262, 51518.742406288475, 1300.174389262806, 1356.2608378433777, 1360.2654566534159, 1362.005735812882, 1372.1286982766017, 22789.886050570305, 23114.422139445975, 23129.306120816404, 23349.766502334758, 23558.52882942366, 37564.0, 37652.246955061295, 37694.62305376911, 37773.811130945265, 37852.432213516266, 446577.76711116236, 449856.0, 451426.0, 452201.0, 452777.0, 26633.53515556663, 31544.0, 32187.839060804545, 32231.838840805645, 32245.838770805996, 40089.71458060363, 40380.798096009334, 40391.52877706718, 40500.44913374279, 41021.58978410297, 28072.017479388123, 28108.578371324857, 28159.296017598903, 29489.85255073711, 29637.407251855275, 25209.0, 28317.15048548547, 29285.974990875216, 29412.705872941, 29567.85216073992, 33361.83319083389, 33981.83009084939, 34274.14314642154, 34530.0, 34547.309053819285, 20407.591848162658, 23262.41843953847, 27990.694013381126, 29339.03922970457, 29770.85114574413, 19877.701834472206, 23435.765642344042, 23481.765182347957, 23715.40711482227, 23939.16212932539], "value": 16949.15370591053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8262764383669, 411.95468498465164, 419.4128220491312, 432.3083067092652, 434.0905802344088, 17951.012694301808, 20080.09639566221, 21049.0, 21109.366718998415, 21211.045502952365, 19652.115654795532, 19806.801931980677, 19841.404757857286, 20340.898295508538, 20561.897190514028, 5968.253968253968, 6181.938180618181, 6199.597026193283, 6224.284207316148, 6226.43962043416, 5283.260343551906, 5940.673262970535, 6094.725737341808, 6115.235595550556, 6130.386961303879, 6075.119107729377, 6123.326434092246, 6125.509959203276, 6136.079588061804, 6152.384761523835, 5968.612040217394, 6064.151018857341, 6122.755089796403, 6236.189295391616, 6271.090691849702, 4709.1994360958715, 4761.571458568746, 5581.49766521011, 5596.608237423382, 5598.496135347838, 25240.242792716246, 26314.473710525876, 26354.506364893958, 26437.867810661017, 26482.6027609586, 1761.788585369751, 2006.3379084902094, 2011.426743378145, 2043.2644248070683, 2092.61286661968, 13621.0, 15857.127857967807, 16214.837851621569, 16219.51341459758, 16227.0, 1839.5309196154894, 1905.6093500832296, 1913.1199648161862, 1917.7986311437237, 1924.5862139639905, 126509.67451627382, 133531.33234333864, 141159.0, 155323.99999999886, 158264.0, 11927.224730392496, 12237.632871013884, 12324.137310388187, 12356.567520136932, 12685.746285074432, 13466.394012269471, 15769.921150394404, 15824.28790704421, 15838.445654402041, 15859.762103568455, 6751.831204219934, 7138.286171382821, 8503.702370417006, 8506.61720222579, 8572.3999320047, 7907.809441367737, 7929.841403171904, 7977.960110199412, 8033.437659363905, 8163.142869998684, 7525.887111693329, 7570.205128461543, 7614.923850761532, 7634.6182690865235, 7679.808004799925, 1771.76081229035, 1771.867109966732, 2099.4436474334316, 2104.074207348762, 2348.0, 710.5168485429957, 805.7099444200084, 841.8737189421513, 854.4232642965973, 884.9247813935759, 15622.921885390728, 17504.912475437795, 17984.730229046574, 19616.901915490333, 19859.60280794376, 767.3822572828815, 787.0909099989522, 865.312076898867, 902.9593119549864, 923.0907556057278, 9816.214702823758, 10214.795704085876, 10217.795644087077, 10248.64129755455, 10350.964903509588, 581401.0, 619788.0, 666773.319468466, 680309.0, 681338.0, 151654.0, 153384.46615533702, 154227.0, 157538.8891110491, 158550.207248963, 1124.6738445850613, 1135.647949135754, 1151.8963293303643, 1163.086976723285, 1176.4117941029485, 19564.90217548903, 20369.472289578636, 20612.07245673978, 20702.068406922026, 20776.376708698765, 46766.532334676216, 61158.38841611705, 62161.689191553756, 62180.0, 65075.67462162659, 86706.0, 86890.0, 87244.0, 87948.0, 88173.11826881648, 8487.108853570286, 8492.915070849212, 8502.702405415781, 8833.779155521164, 8923.866142008004, 10801.459927003776, 13909.860901391261, 14078.917114036814, 14113.788293175405, 14317.64205894861, 11480.483378247833, 11816.70458238551, 11839.112066594867, 11984.820227696417, 12038.518459261883, 8022.828293914173, 9690.95154524223, 9735.0, 9822.5088745561, 9975.551100200364, 10845.132389408986, 11174.608888688857, 11781.882181178422, 12026.458809353426, 12252.754944900873, 8629.784255393413, 8663.95668021656, 8812.471251724917, 8889.911100888909, 8904.065073167225, 11324.716882077684, 11437.59968401102, 11734.589289374831, 11756.529738810352, 11836.408179591159], "value": 10050.046424311067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.4870975964495, 1319.2875847042596, 1331.8013787591174, 1361.55068827287, 1367.432515506065, 10349.965003499647, 10742.248042637018, 10792.676219713401, 10819.729506762334, 11052.392118433483, 10525.157987361012, 10820.891791082087, 10831.025207731303, 10843.566257349696, 10899.400532970683, 2399.908041840958, 2419.8790060496995, 2425.0784701813286, 2427.2718184544656, 2435.9756402436014, 1942.3881477334594, 2318.8840557972117, 2378.131981826638, 2428.3807629054654, 2432.0514999150346, 2346.577616029114, 2399.700037495313, 2403.927882163529, 2419.9879000604974, 2424.4302588891683, 2244.5286489837154, 2337.6610391493223, 2352.2825538210923, 2352.6706261123454, 2401.771831675988, 2008.1866843928233, 2088.8120069193847, 2316.5366926614574, 2380.595298799208, 2382.988085059581, 10798.622048228275, 10858.402787846666, 10890.782184356269, 10898.891011089947, 10949.83575246372, 5202.661826981234, 5842.444967728059, 5988.9101663475085, 6208.192934918432, 6242.408185912564, 2963.5554666799935, 3626.963730362689, 3886.941695874564, 3949.4273330367223, 3958.802059896994, 1178.110526552456, 1183.4910988275037, 1217.446062041769, 1233.5682511121126, 1239.5847391123984, 13279.53521626748, 14845.851541484555, 15041.623959400993, 15228.46700365493, 15258.465953691679, 5112.0, 5216.869578260574, 5279.472052794767, 5295.867603309871, 5332.226827110047, 9194.770130746785, 9729.513524323755, 11161.609343673095, 11175.608853690082, 11177.161712871568, 5741.8564535886935, 6076.574639775174, 6091.939080609226, 6108.236470441195, 6150.7232174552255, 5263.6841789492755, 5542.057850165482, 5607.018771714934, 5655.406182350794, 5712.257406537206, 4067.3288907330552, 4154.958450415517, 4169.187008533307, 4215.409842622035, 4239.300515414922, 1092.6175838456477, 1189.2685998111272, 1219.3963987825905, 1222.8654847966716, 1240.34881687115, 713.3651050565002, 733.9853202935911, 736.3041925380464, 747.9326860582573, 780.8711562592222, 5790.478856902899, 5838.12428135783, 5995.700214989233, 6017.097435384728, 6173.351798061229, 524.6511070138315, 537.0815904802753, 538.4265756968815, 542.4006472847447, 548.0135755639832, 3479.3563190809273, 3568.6431356864105, 3663.5420572428447, 3693.390590552529, 3721.1441368484857, 12920.547780827626, 13487.865121348661, 13983.30083495821, 13997.510087147104, 14071.2964351782, 13788.310584470737, 13892.86107138936, 13952.860471395155, 13970.511032113827, 14029.22839243831, 9992.65025724096, 10052.899471005196, 10084.294099412971, 10210.4384258865, 10229.846552301722, 6527.11883895668, 6532.183477065367, 6595.340465953558, 6644.169478815148, 6694.83262918431, 10249.33379330341, 12102.273863568214, 12408.255504669749, 12450.003999679822, 12490.875091249334, 10281.845772313272, 12731.80902286448, 12735.55425560101, 12827.358632068546, 12995.740085198433, 8831.955840221015, 8987.056359082202, 9113.863292050492, 9145.3598248122, 9166.770830729285, 10099.04059114383, 10113.039261270167, 10162.288639795144, 10164.186865050926, 10219.182465402899, 8410.831783364176, 8634.007089184573, 8639.740807775777, 8718.0, 8870.645174193218, 8351.874721879056, 8368.037675667376, 8416.873746893923, 8427.283680887193, 8527.573621319034, 7680.423968202295, 7683.423743219393, 7692.346150577264, 7785.805354866174, 7801.9609901950125, 5702.40124786908, 5793.652380857162, 5872.29532456108, 5917.822465326047, 5983.670898100646, 4872.561469467623, 5834.27071616048, 5904.143899134516, 5986.55100867428, 6002.729877155626], "value": 4970.166041601311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.8853075182196, 386.025286152465, 387.12509728014686, 399.1876531258887, 401.24365570898857, 4936.259561065837, 5963.880722385555, 6185.226846644169, 6239.65681887496, 6363.154685141303, 6096.085587161928, 6200.78297259596, 6223.190985171933, 6234.470070044041, 6236.0, 4418.845340413086, 4487.75317357546, 4575.565321294472, 4599.517050709677, 4617.422822147231, 4505.6483055083345, 4536.0, 4557.609928971662, 4576.23814831289, 4591.334256532801, 4535.0, 4546.181687296285, 4550.271956486963, 4550.453945526525, 4555.362249285103, 4038.575949525287, 4311.935320970188, 4355.324924636687, 4377.651096910866, 4461.754603496839, 3409.7272218222483, 3855.4409610606585, 3871.2257548490134, 3883.786391748453, 3888.358420860555, 5082.23766435034, 5792.4497172768515, 6026.8548975694475, 6105.694715264219, 6135.3864613538735, 4218.91562168758, 4772.5943294819635, 4792.568668819823, 5231.686098834082, 5406.8918621627745, 5758.539316854683, 5990.311114221877, 6379.393957574023, 6621.337866213388, 6664.700088496029, 4380.474343078819, 4406.259527486624, 4409.889752756207, 4410.073884484262, 4414.845480408202, 6748.966255168692, 6988.860222795566, 7006.964965175192, 7072.575645461237, 7077.48749194039, 3165.6517783043846, 3837.7527303626434, 4386.0789234261165, 4421.894526368408, 4469.195544801902, 3648.9565843127934, 4302.870913872589, 4321.373400856858, 4533.863984080483, 4576.633869290449, 4569.897846990355, 4679.113127484212, 4955.702657840469, 5382.19696401702, 5423.3491980962535, 4997.925031124536, 5433.809816656398, 6062.363451837582, 6098.817035488943, 6358.933346662353, 1423.487544483985, 1462.531989763287, 1511.1537538978207, 1540.4518458948908, 1559.1502631065869, 840.6007146605435, 862.7153039497076, 977.7950721123821, 1022.6676330192718, 1033.7932413517326, 5718.456746609066, 6281.780137695158, 6343.492520598341, 6358.078078678565, 6391.105245265667, 5939.406059394112, 6880.759173428906, 6937.7571784987285, 6956.5478243913985, 6978.371946524736, 6354.3010268870385, 6427.9109289480175, 6459.515536334794, 6463.6768161591735, 6470.805875823733, 3329.200991762008, 3535.858565657345, 3571.017970058203, 3609.4405367168133, 3650.452432135148, 6304.810855674337, 6766.646670665887, 7036.859262814715, 7068.11648543932, 7158.99774031636, 6371.39471750183, 6502.577332473374, 6916.827079322957, 7097.325754053357, 7132.750353737594, 6960.512764106566, 7037.612931288828, 7061.329173728487, 7156.463265255126, 7184.892226616605, 5684.232628595087, 6104.786332478342, 6297.905531416941, 6611.30581288977, 6940.68127055878, 5822.417758224144, 5833.562482813721, 6432.874247006662, 6745.797626071226, 6776.390124888783, 5738.48353648157, 6212.565120441525, 6949.5125537824015, 7010.474214433836, 7135.500514963903, 3458.9827050864583, 4333.804978776026, 4431.401760762255, 4448.310511870665, 4463.218936686132, 5754.9424505754405, 6067.089936509559, 6858.965705171442, 6866.553674011173, 6925.653717314013, 5807.216025836627, 6075.422834830684, 6142.754289828356, 6363.331850155667, 6664.76673316451, 6747.411760003245, 6755.932440675727, 6766.289539598271, 6782.253952065367, 6785.796426107225, 6124.234470691164, 6647.268800432045, 6647.700853461509, 6649.73401063952, 6658.400743933069, 5598.300212473441, 6560.737570497126, 6717.093192418961, 6719.664016799043, 6742.292059333699, 5234.2672025915645, 6554.344565543408, 6570.605763654196, 6576.375244351779, 6579.276279609144], "value": 4745.21672762167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.8280605639509, 660.0956689335611, 662.1557514169436, 679.6567733294686, 686.7295503318861, 15168.544943651694, 15392.99945503543, 15707.371705131782, 15708.293126809293, 15864.365425383, 14012.299385030734, 14314.0, 14398.856011439882, 14499.855001449982, 14574.708505829876, 723.724984505887, 806.3468590441731, 817.9816128919504, 818.3739439328889, 829.4401279136589, 805.6616221187115, 836.0135040652028, 840.197611281228, 841.3269384492412, 842.751388340441, 839.9664013439456, 848.6478111583685, 866.2333834556431, 871.4030888841164, 872.7512658892217, 840.8948881389827, 844.9535275559841, 848.7878030492377, 853.9103394143588, 866.3069544364515, 623.0436280309702, 633.5786701843268, 640.0782872663397, 653.8561516466369, 654.9541532092755, 15349.0, 15588.376464941502, 15640.843591564166, 15683.764743528856, 15767.29047192879, 14214.857851421457, 14343.354549045318, 14442.277886105652, 14576.562703118923, 14589.416423343053, 10035.197184225244, 10694.82356940736, 10950.616728414467, 11670.533178672842, 11687.766244675144, 3003.714647108521, 3029.666736658966, 3039.1946134274435, 3085.7222849943614, 3134.26344808972, 97215.56961075959, 100862.48706269411, 108190.45904770505, 110479.0, 110760.4461977693, 10993.376827316926, 11146.275492092987, 11196.832047519294, 11226.438678066064, 11532.942335288437, 22732.09071637149, 22835.429114271945, 22885.771142288697, 22932.16542676582, 23059.423514412272, 7712.807179820549, 7718.575478348745, 7734.4585878989055, 7883.2116788321855, 8011.038675358995, 3482.529858469125, 3988.8205030773684, 4124.6906482013965, 4190.53904070552, 4195.790210489463, 3242.3191129862994, 3868.825902834379, 3884.4173373993563, 3891.6886649068006, 3950.861719839792, 731.5829976913109, 741.4476215219696, 751.9547828518364, 753.3534623570691, 759.7606753872512, 526.6708307307932, 529.2722506553489, 554.6727430815838, 571.3971759793375, 587.9000569903127, 9547.449313926078, 9702.660406885725, 9799.314048016571, 9949.950250248703, 10654.297213407728, 534.981275655358, 557.1920714963319, 568.4798409455302, 576.247996364748, 585.3093349847136, 4348.086901750605, 4843.4430040545085, 4854.732989685601, 4907.705537667752, 5039.168537191395, 102695.97304026864, 105623.41564876532, 106319.0, 107129.0, 108221.0, 91323.0, 91692.0, 92620.61069083969, 92894.0710592899, 92908.07091929129, 55576.0, 62745.74508509713, 81184.78222826662, 81211.59394202991, 81790.13734519383, 10078.294519383866, 10523.0, 10562.471876405994, 10587.470626468492, 10610.734731631772, 39543.0, 40127.39808902927, 40659.390109148975, 41218.38172427356, 41299.58700412957, 62001.0, 67230.0, 71708.0, 71718.0, 73088.0, 12887.871121288666, 13051.0, 13059.804102938653, 13215.801762973371, 13652.453901843815, 14350.138991660533, 14440.080056299179, 14533.982621216413, 14575.781363279348, 15016.249187540361, 13543.632426848797, 13721.0, 13883.861161388257, 14131.15213087218, 14211.715765684836, 13187.406566704713, 13427.328633568477, 13631.86368136306, 14088.577342679737, 14099.506517271846, 13397.464101435833, 13592.0, 13593.320333983063, 13607.040458744681, 14027.088239264414, 7792.88310675329, 9536.475493847627, 9704.70885873425, 9892.752681183028, 10299.639512617023, 8486.575671216538, 9608.711738647851, 11071.667849964513, 11128.833067503832, 11347.886521135013], "value": 7313.67949238182, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1646.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 133.0, 181.0, 123.0, 125.0, 125.0, 123.0, 121.0, 123.0], "value": 128.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 115.0, 158.0, 117.0, 122.0, 155.0, 138.0, 136.0, 118.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 217.0, 205.0, 281.0, 279.0, 318.0, 301.0, 211.0, 212.0, 217.0], "value": 245.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 63.0, 87.0, 62.0, 59.0, 58.0, 64.0, 101.0, 50.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 90.0, 71.0, 74.0, 69.0, 83.0, 73.0, 71.0, 83.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 99.0, 128.0, 127.0, 142.0, 91.0, 91.0, 91.0, 91.0], "value": 104.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 100.0, 104.0, 100.0, 101.0, 111.0, 113.0, 100.0, 100.0, 131.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 103.0, 149.0, 104.0, 147.0, 163.0, 101.0, 102.0, 156.0, 123.0], "value": 125.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 53.0, 54.0, 53.0, 54.0, 53.0, 54.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 60.0, 78.0, 92.0, 98.0, 62.0, 58.0, 61.0, 59.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 87.0, 87.0, 90.0, 105.0, 88.0, 87.0, 85.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 171.0, 157.0, 160.0, 189.0, 153.0, 148.0, 192.0, 150.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 197.0, 199.0, 200.0, 195.0, 227.0, 261.0, 200.0, 200.0, 203.0], "value": 207.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 60.0, 57.0, 63.0, 61.0, 76.0, 109.0, 106.0, 62.0], "value": 73.9, "unit": "score"}]}]} 16:11:52 INFO - Return code: 0 16:11:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:11:52 ERROR - # TBPL SUCCESS # 16:11:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:11:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:11:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:11:52 INFO - 2017-04-03 16:11:52.513 screenresolution[1653:10711] starting screenresolution argv=screenresolution get 16:11:52 INFO - 2017-04-03 16:11:52.516 screenresolution[1653:10711] Display 0: 1600x1200x32@60 16:11:52 INFO - 2017-04-03 16:11:52.522 screenresolution[1654:10714] starting screenresolution argv=screenresolution list 16:11:52 INFO - Available Modes on Display 0 16:11:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:11:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:11:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:11:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:11:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:11:52 INFO - Intel Iris: 16:11:52 INFO - Chipset Model: Intel Iris 16:11:52 INFO - Type: GPU 16:11:52 INFO - Bus: Built-In 16:11:52 INFO - VRAM (Dynamic, Max): 1536 MB 16:11:52 INFO - Vendor: Intel (0x8086) 16:11:52 INFO - Device ID: 0x0a2e 16:11:52 INFO - Revision ID: 0x0009 16:11:52 INFO - Displays: 16:11:52 INFO - Display: 16:11:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:11:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:11:52 INFO - Display Serial Number: 1600x1200 60 16:11:52 INFO - Main Display: Yes 16:11:52 INFO - Mirror: Off 16:11:52 INFO - Online: Yes 16:11:52 INFO - Rotation: Supported 16:11:52 INFO - Return code: 0 16:11:52 INFO - Running post-action listener: _resource_record_post_action 16:11:52 INFO - [mozharness: 2017-04-03 23:11:52.758974Z] Finished run-tests step (success) 16:11:52 INFO - Running post-run listener: _resource_record_post_run 16:11:52 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 39152128; Write bytes: 518409216; Read time: 246; Write time: 1643 16:11:52 INFO - TinderboxPrint: CPU usage
54.2% 16:11:52 INFO - TinderboxPrint: I/O read bytes / time
39,152,128 / 246 16:11:52 INFO - TinderboxPrint: I/O write bytes / time
518,409,216 / 1,643 16:11:52 INFO - TinderboxPrint: CPU idle
2,202.0 (45.8%) 16:11:52 INFO - TinderboxPrint: CPU system
970.9 (20.2%) 16:11:52 INFO - TinderboxPrint: CPU user
1,632.8 (34.0%) 16:11:52 INFO - TinderboxPrint: Swap in / out
250,851,328 / 0 16:11:52 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203348480; Write bytes: 205359104; Read time: 15585; Write time: 448 16:11:52 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 38189568; Write bytes: 303096832; Read time: 233; Write time: 1159 16:11:53 INFO - Running post-run listener: _upload_blobber_files 16:11:53 INFO - Blob upload gear active. 16:11:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:53 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 16:11:53 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'] 16:11:53 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 16:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:54 INFO - (blobuploader) - INFO - Done attempting. 16:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:55 INFO - (blobuploader) - INFO - Done attempting. 16:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:57 INFO - (blobuploader) - INFO - Done attempting. 16:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:59 INFO - (blobuploader) - INFO - Done attempting. 16:11:59 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:59 INFO - Return code: 0 16:11:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52c9b0f09a3fb4f48da1dac760aa9f129435f8b848990f2f597d1418c7f460709c35213a1f98bb01cb57550edb5a2dfd87196ca15a3c94e436b9cb284c92e5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234fe49cdae63abbcf656b0032c4f3ce1a9863b184d761951428eca7beba5d1e1ba3335f3e025de83c79dfebef505f2b17f8ee62f84d9170e6b326dc55df79ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad895658a0fe226bf7d919cb62effd45d3237a1e8b5bddbde9a27179afd89d18d555c0cd1bea88507d85990ae34cded6dc8bbd31ad1c8e16b23e84abc640ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61479aec46a0f2b9f67d4391c751be3cf5b5220839306452e38557ef4097071e1fc56bcf255ac3fd46f9c9ed0ff48d0f8fe548acdceac9ed64a64ed55d92159"} 16:11:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:59 INFO - Contents: 16:11:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52c9b0f09a3fb4f48da1dac760aa9f129435f8b848990f2f597d1418c7f460709c35213a1f98bb01cb57550edb5a2dfd87196ca15a3c94e436b9cb284c92e5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234fe49cdae63abbcf656b0032c4f3ce1a9863b184d761951428eca7beba5d1e1ba3335f3e025de83c79dfebef505f2b17f8ee62f84d9170e6b326dc55df79ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad895658a0fe226bf7d919cb62effd45d3237a1e8b5bddbde9a27179afd89d18d555c0cd1bea88507d85990ae34cded6dc8bbd31ad1c8e16b23e84abc640ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61479aec46a0f2b9f67d4391c751be3cf5b5220839306452e38557ef4097071e1fc56bcf255ac3fd46f9c9ed0ff48d0f8fe548acdceac9ed64a64ed55d92159"} 16:11:59 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:59 INFO - Copying logs to upload dir... 16:11:59 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.888086 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-03 16:11:59.335333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 16:11:59.338506) ========= 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.JqhDfhh26y/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.v5SFOrhr5n/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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/d52c9b0f09a3fb4f48da1dac760aa9f129435f8b848990f2f597d1418c7f460709c35213a1f98bb01cb57550edb5a2dfd87196ca15a3c94e436b9cb284c92e5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234fe49cdae63abbcf656b0032c4f3ce1a9863b184d761951428eca7beba5d1e1ba3335f3e025de83c79dfebef505f2b17f8ee62f84d9170e6b326dc55df79ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad895658a0fe226bf7d919cb62effd45d3237a1e8b5bddbde9a27179afd89d18d555c0cd1bea88507d85990ae34cded6dc8bbd31ad1c8e16b23e84abc640ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61479aec46a0f2b9f67d4391c751be3cf5b5220839306452e38557ef4097071e1fc56bcf255ac3fd46f9c9ed0ff48d0f8fe548acdceac9ed64a64ed55d92159"} build_url:https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011119 build_url: 'https://queue.taskcluster.net/v1/task/EQ5Ad2whSh21-_94SffKjw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d52c9b0f09a3fb4f48da1dac760aa9f129435f8b848990f2f597d1418c7f460709c35213a1f98bb01cb57550edb5a2dfd87196ca15a3c94e436b9cb284c92e5a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/234fe49cdae63abbcf656b0032c4f3ce1a9863b184d761951428eca7beba5d1e1ba3335f3e025de83c79dfebef505f2b17f8ee62f84d9170e6b326dc55df79ba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad895658a0fe226bf7d919cb62effd45d3237a1e8b5bddbde9a27179afd89d18d555c0cd1bea88507d85990ae34cded6dc8bbd31ad1c8e16b23e84abc640ca1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e61479aec46a0f2b9f67d4391c751be3cf5b5220839306452e38557ef4097071e1fc56bcf255ac3fd46f9c9ed0ff48d0f8fe548acdceac9ed64a64ed55d92159"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 16:11:59.376836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 16:11:59.377188) ========= 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.JqhDfhh26y/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.v5SFOrhr5n/Listeners TMPDIR=/var/folders/hd/dc4krl3j68d6tcd9m8k4vbjh00000w/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.005045 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 16:11:59.425979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 16:11:59.426322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 16:11:59.426679) ========= ========= Total master_lag: 0.29 =========