builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0022 starttime: 1475105429.66 results: success (0) buildid: 20160928141021 builduid: c7d9d40b63cb44d8b5dc5d1c7f3aefb5 revision: 72f6089e120d83a4437e94b00e2c7cd425a3d4e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.656033) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.656493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.656800) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.682520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.683186) ========= 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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-28 16:30:29-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-09-28 16:30:29 (20.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.889174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.889522) ========= 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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.021945 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.938439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:29.938793) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 72f6089e120d83a4437e94b00e2c7cd425a3d4e6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 72f6089e120d83a4437e94b00e2c7cd425a3d4e6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DX2kfQQlyl/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.yRB8fBdBGE/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-28 16:30:30,019 truncating revision to first 12 chars 2016-09-28 16:30:30,019 Setting DEBUG logging. 2016-09-28 16:30:30,019 attempt 1/10 2016-09-28 16:30:30,019 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/72f6089e120d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 16:30:30,305 unpacking tar archive at: mozilla-aurora-72f6089e120d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.564905 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:30.525975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:30.526323) ========= script_repo_revision: 72f6089e120d83a4437e94b00e2c7cd425a3d4e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:30.526764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:30.527035) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 16:30:30.544896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-28 16:30:30.545393) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DX2kfQQlyl/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.yRB8fBdBGE/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:30:30 INFO - MultiFileLogger online at 20160928 16:30:30 in /builds/slave/test 16:30:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:30:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:30 INFO - {'append_to_log': False, 16:30:30 INFO - 'base_work_dir': '/builds/slave/test', 16:30:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:30:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:30 INFO - 'branch': 'Mozilla-Aurora', 16:30:30 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:30 INFO - 'config_files': ('talos/mac_config.py',), 16:30:30 INFO - 'default_actions': ('clobber', 16:30:30 INFO - 'read-buildbot-config', 16:30:30 INFO - 'download-and-extract', 16:30:30 INFO - 'populate-webroot', 16:30:30 INFO - 'create-virtualenv', 16:30:30 INFO - 'install', 16:30:30 INFO - 'run-tests'), 16:30:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:30 INFO - 'download_minidump_stackwalk': True, 16:30:30 INFO - 'download_symbols': 'ondemand', 16:30:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:30 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:30 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:30 INFO - 'installer_path': 'installer.exe', 16:30:30 INFO - 'log_level': 'info', 16:30:30 INFO - 'log_name': 'talos', 16:30:30 INFO - 'log_to_console': True, 16:30:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:30:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:30:30 INFO - 'opt_config_files': (), 16:30:30 INFO - 'pip_index': False, 16:30:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:30:30 INFO - 'cmd': ('bash', 16:30:30 INFO - '-c', 16:30:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:30:30 INFO - 'enabled': True, 16:30:30 INFO - 'halt_on_failure': False, 16:30:30 INFO - 'name': 'check_screen_resolution'},), 16:30:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:30:30 INFO - 'cmd': ('bash', 16:30:30 INFO - '-c', 16:30:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:30:30 INFO - 'enabled': True, 16:30:30 INFO - 'halt_on_failure': False, 16:30:30 INFO - 'name': 'check_screen_resolution'},), 16:30:30 INFO - 'run_cmd_checks_enabled': True, 16:30:30 INFO - 'sps_profile': False, 16:30:30 INFO - 'sps_profile_interval': 0, 16:30:30 INFO - 'suite': 'dromaeojs-e10s', 16:30:30 INFO - 'system_bits': '32', 16:30:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:30 INFO - 'title': 't-yosemite-r7-0022', 16:30:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:30 INFO - 'use_talos_json': True, 16:30:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:30 INFO - 'work_dir': 'build'} 16:30:30 INFO - [mozharness: 2016-09-28 23:30:30.736118Z] Running clobber step. 16:30:30 INFO - Running pre-action listener: _resource_record_pre_action 16:30:30 INFO - Running main action method: clobber 16:30:30 INFO - rmtree: /builds/slave/test/build 16:30:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:32 INFO - Running post-action listener: _resource_record_post_action 16:30:32 INFO - [mozharness: 2016-09-28 23:30:32.258210Z] Finished clobber step (success) 16:30:32 INFO - [mozharness: 2016-09-28 23:30:32.258417Z] Running read-buildbot-config step. 16:30:32 INFO - Running pre-action listener: _resource_record_pre_action 16:30:32 INFO - Running main action method: read_buildbot_config 16:30:32 INFO - Using buildbot properties: 16:30:32 INFO - { 16:30:32 INFO - "project": "", 16:30:32 INFO - "product": "firefox", 16:30:32 INFO - "script_repo_revision": "production", 16:30:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:30:32 INFO - "repository": "", 16:30:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:30:32 INFO - "buildid": "20160928141021", 16:30:32 INFO - "pgo_build": "False", 16:30:32 INFO - "basedir": "/builds/slave/test", 16:30:32 INFO - "buildnumber": 411, 16:30:32 INFO - "slavename": "t-yosemite-r7-0022", 16:30:32 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:30:32 INFO - "platform": "yosemite_r7", 16:30:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:30:32 INFO - "branch": "mozilla-aurora", 16:30:32 INFO - "repo_path": "releases/mozilla-aurora", 16:30:32 INFO - "revision": "72f6089e120d83a4437e94b00e2c7cd425a3d4e6", 16:30:32 INFO - "stage_platform": "macosx64", 16:30:32 INFO - "builduid": "c7d9d40b63cb44d8b5dc5d1c7f3aefb5", 16:30:32 INFO - "slavebuilddir": "test" 16:30:32 INFO - } 16:30:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:30:32 INFO - Running post-action listener: _resource_record_post_action 16:30:32 INFO - [mozharness: 2016-09-28 23:30:32.264228Z] Finished read-buildbot-config step (success) 16:30:32 INFO - [mozharness: 2016-09-28 23:30:32.264450Z] Running download-and-extract step. 16:30:32 INFO - Running pre-action listener: _resource_record_pre_action 16:30:32 INFO - Running main action method: download_and_extract 16:30:32 INFO - mkdir: /builds/slave/test/build/tests 16:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:30:32 INFO - trying https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:30:32 INFO - Downloading https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:30:33 INFO - Downloaded 1199 bytes. 16:30:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:30:33 INFO - Using the following test package requirements: 16:30:33 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:30:33 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:30:33 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:30:33 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'jsshell-mac.zip'], 16:30:33 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:30:33 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:30:33 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:30:33 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:30:33 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:30:33 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:30:33 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:30:33 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:30:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:30:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:30:33 INFO - Fetch https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:30:34 INFO - Expected file size: 16432459 16:30:40 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:30:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:30:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:30:40 INFO - Fetch https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:30:41 INFO - Expected file size: 16432459 16:30:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:30:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:30:47 INFO - Fetch https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:30:48 INFO - Expected file size: 14414059 16:30: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')]} 16:30:49 INFO - trying https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:30:49 INFO - Downloading https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:30:51 INFO - Downloaded 115265231 bytes. 16:30:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:30:51 INFO - mkdir: /builds/slave/test/properties 16:30:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:30:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:30:51 INFO - Contents: 16:30:51 INFO - build_url:https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:30:52 INFO - Running post-action listener: _resource_record_post_action 16:30:52 INFO - Running post-action listener: set_extra_try_arguments 16:30:52 INFO - [mozharness: 2016-09-28 23:30:52.600130Z] Finished download-and-extract step (success) 16:30:52 INFO - [mozharness: 2016-09-28 23:30:52.600252Z] Running populate-webroot step. 16:30:52 INFO - Running pre-action listener: _resource_record_pre_action 16:30:52 INFO - Running main action method: populate_webroot 16:30:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:30:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:30:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:30:52 INFO - '--tppagecycles', 16:30:52 INFO - '7'], 16:30:52 INFO - 'tests': ['tsvgm']}}, 16:30:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:30:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:30:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:30:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:30:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:30:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['damp', 'tps']}, 16:30:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'tests': ['damp', 'tps']}, 16:30:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['dromaeo_dom']}, 16:30:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:30:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['basic_compositor_video']}, 16:30:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:30:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other-e10s': {'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['a11yr', 16:30:52 INFO - 'ts_paint', 16:30:52 INFO - 'tpaint', 16:30:52 INFO - 'sessionrestore', 16:30:52 INFO - 'sessionrestore_no_auto_restore', 16:30:52 INFO - 'tabpaint']}, 16:30:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['tsvgx', 16:30:52 INFO - 'tsvgr_opacity', 16:30:52 INFO - 'tart', 16:30:52 INFO - 'tscrollx', 16:30:52 INFO - 'cart']}, 16:30:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:30:52 INFO - 'tsvgr_opacity', 16:30:52 INFO - 'tart', 16:30:52 INFO - 'tscrollx', 16:30:52 INFO - 'cart']}, 16:30:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--disable-e10s'], 16:30:52 INFO - 'tests': ['tp5o']}, 16:30:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'tests': ['tp5o']}, 16:30:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--disable-e10s', 16:30:52 INFO - '--xperf_path', 16:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:52 INFO - 'tests': ['tp5n']}, 16:30:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:30:52 INFO - 'talos_options': ['--xperf_path', 16:30:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:30:52 INFO - 'tests': ['tp5n']}}, 16:30:52 INFO - 'talos.zip': {'path': '', 16:30:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:30:52 INFO - Running post-action listener: _resource_record_post_action 16:30:52 INFO - [mozharness: 2016-09-28 23:30:52.619137Z] Finished populate-webroot step (success) 16:30:52 INFO - [mozharness: 2016-09-28 23:30:52.619281Z] Running create-virtualenv step. 16:30:52 INFO - Running pre-action listener: _resource_record_pre_action 16:30:52 INFO - Running main action method: create_virtualenv 16:30:52 INFO - Creating virtualenv /builds/slave/test/build/venv 16:30:52 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 16:30:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:30:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:30:52 INFO - Using real prefix '/tools/python27' 16:30:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:30:53 INFO - Installing distribute.............................................................................................................................................................................................done. 16:30:56 INFO - Installing pip.................done. 16:30:56 INFO - Return code: 0 16:30:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:30:56 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')]} 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 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')]} 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:30:56 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 16:30:56 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 16:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:56 INFO - 'HOME': '/Users/cltbld', 16:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:56 INFO - 'LOGNAME': 'cltbld', 16:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:56 INFO - 'MOZ_NO_REMOTE': '1', 16:30:56 INFO - 'NO_EM_RESTART': '1', 16:30:56 INFO - 'PAGER': '/bin/cat', 16:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:56 INFO - 'PWD': '/builds/slave/test', 16:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:56 INFO - 'SHELL': '/bin/bash', 16:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:30:56 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:56 INFO - 'USER': 'cltbld', 16:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:56 INFO - 'XPC_FLAGS': '0x0', 16:30:56 INFO - 'XPC_SERVICE_NAME': '0', 16:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:56 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 16:30:56 INFO - Cleaning up... 16:30:56 INFO - Return code: 0 16:30:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:30:56 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')]} 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 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')]} 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:30:56 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:30:56 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 16:30:56 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 16:30:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:30:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:30:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:30:56 INFO - 'HOME': '/Users/cltbld', 16:30:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:30:56 INFO - 'LOGNAME': 'cltbld', 16:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:30:56 INFO - 'MOZ_NO_REMOTE': '1', 16:30:56 INFO - 'NO_EM_RESTART': '1', 16:30:56 INFO - 'PAGER': '/bin/cat', 16:30:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:30:56 INFO - 'PWD': '/builds/slave/test', 16:30:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:30:56 INFO - 'SHELL': '/bin/bash', 16:30:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:30:56 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:30:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:30:56 INFO - 'USER': 'cltbld', 16:30:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:30:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:30:56 INFO - 'XPC_FLAGS': '0x0', 16:30:56 INFO - 'XPC_SERVICE_NAME': '0', 16:30:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:30:56 INFO - Downloading/unpacking psutil>=3.1.1 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:00 INFO - Installing collected packages: psutil 16:31:00 INFO - Running setup.py install for psutil 16:31:00 INFO - building 'psutil._psutil_osx' extension 16:31:00 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 16:31:00 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 16:31:00 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 16:31:00 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 16:31:00 INFO - building 'psutil._psutil_posix' extension 16:31:00 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 16:31:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:31:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:31:00 INFO - ^ 16:31:00 INFO - 1 warning generated. 16:31:00 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 16:31:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:01 INFO - Successfully installed psutil 16:31:01 INFO - Cleaning up... 16:31:01 INFO - Return code: 0 16:31:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:01 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:01 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 16:31:01 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 16:31:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:01 INFO - 'HOME': '/Users/cltbld', 16:31:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:01 INFO - 'LOGNAME': 'cltbld', 16:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:01 INFO - 'MOZ_NO_REMOTE': '1', 16:31:01 INFO - 'NO_EM_RESTART': '1', 16:31:01 INFO - 'PAGER': '/bin/cat', 16:31:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:01 INFO - 'PWD': '/builds/slave/test', 16:31:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:01 INFO - 'SHELL': '/bin/bash', 16:31:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:01 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:01 INFO - 'USER': 'cltbld', 16:31:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:01 INFO - 'XPC_FLAGS': '0x0', 16:31:01 INFO - 'XPC_SERVICE_NAME': '0', 16:31:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:01 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 16:31:01 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 16:31:01 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 16:31:01 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 16:31:01 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 16:31:01 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 16:31:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:04 INFO - Installing collected packages: mozsystemmonitor 16:31:04 INFO - Running setup.py install for mozsystemmonitor 16:31:04 INFO - Successfully installed mozsystemmonitor 16:31:04 INFO - Cleaning up... 16:31:04 INFO - Return code: 0 16:31:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:04 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:04 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 16:31:04 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 16:31:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:04 INFO - 'HOME': '/Users/cltbld', 16:31:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:04 INFO - 'LOGNAME': 'cltbld', 16:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:04 INFO - 'MOZ_NO_REMOTE': '1', 16:31:04 INFO - 'NO_EM_RESTART': '1', 16:31:04 INFO - 'PAGER': '/bin/cat', 16:31:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:04 INFO - 'PWD': '/builds/slave/test', 16:31:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:04 INFO - 'SHELL': '/bin/bash', 16:31:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:04 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:04 INFO - 'USER': 'cltbld', 16:31:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:04 INFO - 'XPC_FLAGS': '0x0', 16:31:04 INFO - 'XPC_SERVICE_NAME': '0', 16:31:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:04 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 16:31:04 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 16:31:04 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 16:31:04 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 16:31:04 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 16:31:04 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 16:31:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:06 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 16:31:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:07 INFO - warning: no files found matching '*.txt' 16:31:07 INFO - no previously-included directories found matching 'build' 16:31:07 INFO - no previously-included directories found matching 'dist' 16:31:07 INFO - no previously-included directories found matching '.git*' 16:31:07 INFO - Installing collected packages: jsonschema, functools32 16:31:07 INFO - Running setup.py install for functools32 16:31:07 INFO - warning: no files found matching '*.txt' 16:31:07 INFO - no previously-included directories found matching 'build' 16:31:07 INFO - no previously-included directories found matching 'dist' 16:31:07 INFO - no previously-included directories found matching '.git*' 16:31:07 INFO - Successfully installed jsonschema functools32 16:31:07 INFO - Cleaning up... 16:31:07 INFO - Return code: 0 16:31:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:31:07 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')]} 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 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')]} 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:07 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 16:31:07 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 16:31:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:07 INFO - 'HOME': '/Users/cltbld', 16:31:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:07 INFO - 'LOGNAME': 'cltbld', 16:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:07 INFO - 'MOZ_NO_REMOTE': '1', 16:31:07 INFO - 'NO_EM_RESTART': '1', 16:31:07 INFO - 'PAGER': '/bin/cat', 16:31:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:07 INFO - 'PWD': '/builds/slave/test', 16:31:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:07 INFO - 'SHELL': '/bin/bash', 16:31:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:07 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:07 INFO - 'USER': 'cltbld', 16:31:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:07 INFO - 'XPC_FLAGS': '0x0', 16:31:07 INFO - 'XPC_SERVICE_NAME': '0', 16:31:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:31:07 INFO - Cleaning up... 16:31:08 INFO - Return code: 0 16:31:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:08 INFO - 'HOME': '/Users/cltbld', 16:31:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:08 INFO - 'LOGNAME': 'cltbld', 16:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:08 INFO - 'MOZ_NO_REMOTE': '1', 16:31:08 INFO - 'NO_EM_RESTART': '1', 16:31:08 INFO - 'PAGER': '/bin/cat', 16:31:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:08 INFO - 'PWD': '/builds/slave/test', 16:31:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:08 INFO - 'SHELL': '/bin/bash', 16:31:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:08 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:08 INFO - 'USER': 'cltbld', 16:31:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:08 INFO - 'XPC_FLAGS': '0x0', 16:31:08 INFO - 'XPC_SERVICE_NAME': '0', 16:31:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:10 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:10 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 16:31:10 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 16:31:10 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 16:31:10 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 16:31:10 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 16:31:10 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 16:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:11 INFO - Downloading docopt-0.6.1.tar.gz 16:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:12 INFO - Running setup.py install for blobuploader 16:31:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:12 INFO - Running setup.py install for requests 16:31:12 INFO - Running setup.py install for docopt 16:31:12 INFO - Successfully installed blobuploader requests docopt 16:31:12 INFO - Cleaning up... 16:31:13 INFO - Return code: 0 16:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:13 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:13 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 16:31:13 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 16:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:13 INFO - 'HOME': '/Users/cltbld', 16:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:13 INFO - 'LOGNAME': 'cltbld', 16:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:13 INFO - 'MOZ_NO_REMOTE': '1', 16:31:13 INFO - 'NO_EM_RESTART': '1', 16:31:13 INFO - 'PAGER': '/bin/cat', 16:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:13 INFO - 'PWD': '/builds/slave/test', 16:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:13 INFO - 'SHELL': '/bin/bash', 16:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:13 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:13 INFO - 'USER': 'cltbld', 16:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:13 INFO - 'XPC_FLAGS': '0x0', 16:31:13 INFO - 'XPC_SERVICE_NAME': '0', 16:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-D8N8IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-29gxt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-GnV1z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Wh1CSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-iyUMVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-_Nehxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-YZkZ8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:13 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-UxNYPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-WjwmAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-u0yCRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-2dkvMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-XKvbhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-Y8nUp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-agTSc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-kIqyFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-PvZm40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:14 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-18TvYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:15 INFO - Running setup.py install for manifestparser 16:31:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:15 INFO - Running setup.py install for mozcrash 16:31:15 INFO - Running setup.py install for mozdebug 16:31:15 INFO - Running setup.py install for mozdevice 16:31:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:15 INFO - Running setup.py install for mozfile 16:31:15 INFO - Running setup.py install for mozhttpd 16:31:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:15 INFO - Running setup.py install for mozinfo 16:31:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Running setup.py install for mozInstall 16:31:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Running setup.py install for mozleak 16:31:16 INFO - Running setup.py install for mozlog 16:31:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Running setup.py install for moznetwork 16:31:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Running setup.py install for mozprocess 16:31:16 INFO - Running setup.py install for mozprofile 16:31:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:16 INFO - Running setup.py install for mozrunner 16:31:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:17 INFO - Running setup.py install for mozscreenshot 16:31:17 INFO - Running setup.py install for moztest 16:31:17 INFO - Running setup.py install for mozversion 16:31:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:17 INFO - Cleaning up... 16:31:17 INFO - Return code: 0 16:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:17 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')]} 16:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:17 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')]} 16:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:17 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:17 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 16:31:17 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 16:31:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:17 INFO - 'HOME': '/Users/cltbld', 16:31:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:17 INFO - 'LOGNAME': 'cltbld', 16:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:17 INFO - 'MOZ_NO_REMOTE': '1', 16:31:17 INFO - 'NO_EM_RESTART': '1', 16:31:17 INFO - 'PAGER': '/bin/cat', 16:31:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:17 INFO - 'PWD': '/builds/slave/test', 16:31:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:17 INFO - 'SHELL': '/bin/bash', 16:31:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:17 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:17 INFO - 'USER': 'cltbld', 16:31:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:17 INFO - 'XPC_FLAGS': '0x0', 16:31:17 INFO - 'XPC_SERVICE_NAME': '0', 16:31:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:17 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-5KCqYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:17 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)) 16:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:17 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-YGIOzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-8tqV7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-YYyBmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-V5ydqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-1Ls0Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-onx_QF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-SD6lg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-0MW5Qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-R5EyNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:18 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)) 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:18 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-uIKj5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:19 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)) 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-JuDAnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-XeBaij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:19 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)) 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-SY8rWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-cSFs8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:19 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)) 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-X5RqSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:19 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-KM5D3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:19 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)) 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:31:19 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)) 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:31:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:22 INFO - Downloading blessings-1.6.tar.gz 16:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:22 INFO - Installing collected packages: blessings 16:31:22 INFO - Running setup.py install for blessings 16:31:22 INFO - Successfully installed blessings 16:31:22 INFO - Cleaning up... 16:31:22 INFO - Return code: 0 16:31:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:22 INFO - Reading from file tmpfile_stdout 16:31:22 INFO - Current package versions: 16:31:22 INFO - blessings == 1.6 16:31:22 INFO - blobuploader == 1.2.4 16:31:22 INFO - docopt == 0.6.1 16:31:22 INFO - functools32 == 3.2.3-2 16:31:22 INFO - jsonschema == 2.5.1 16:31:22 INFO - manifestparser == 1.1 16:31:22 INFO - mozInstall == 1.12 16:31:22 INFO - mozcrash == 0.17 16:31:22 INFO - mozdebug == 0.1 16:31:22 INFO - mozdevice == 0.48 16:31:22 INFO - mozfile == 1.2 16:31:22 INFO - mozhttpd == 0.7 16:31:22 INFO - mozinfo == 0.9 16:31:22 INFO - mozleak == 0.1 16:31:22 INFO - mozlog == 3.4 16:31:22 INFO - moznetwork == 0.27 16:31:22 INFO - mozprocess == 0.23 16:31:22 INFO - mozprofile == 0.28 16:31:22 INFO - mozrunner == 6.12 16:31:22 INFO - mozscreenshot == 0.1 16:31:22 INFO - mozsystemmonitor == 0.3 16:31:22 INFO - moztest == 0.7 16:31:22 INFO - mozversion == 1.4 16:31:22 INFO - psutil == 3.1.1 16:31:22 INFO - requests == 1.2.3 16:31:22 INFO - wsgiref == 0.1.2 16:31:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:22 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 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:22 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 16:31:22 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 16:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:22 INFO - 'HOME': '/Users/cltbld', 16:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:22 INFO - 'LOGNAME': 'cltbld', 16:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:22 INFO - 'MOZ_NO_REMOTE': '1', 16:31:22 INFO - 'NO_EM_RESTART': '1', 16:31:22 INFO - 'PAGER': '/bin/cat', 16:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:22 INFO - 'PWD': '/builds/slave/test', 16:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:22 INFO - 'SHELL': '/bin/bash', 16:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:22 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:22 INFO - 'USER': 'cltbld', 16:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:22 INFO - 'XPC_FLAGS': '0x0', 16:31:22 INFO - 'XPC_SERVICE_NAME': '0', 16:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 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)) 16:31:22 INFO - Cleaning up... 16:31:23 INFO - Return code: 0 16:31:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10874f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6ba474870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, '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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 16:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:23 INFO - 'HOME': '/Users/cltbld', 16:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:23 INFO - 'LOGNAME': 'cltbld', 16:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:23 INFO - 'MOZ_NO_REMOTE': '1', 16:31:23 INFO - 'NO_EM_RESTART': '1', 16:31:23 INFO - 'PAGER': '/bin/cat', 16:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:23 INFO - 'PWD': '/builds/slave/test', 16:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:23 INFO - 'SHELL': '/bin/bash', 16:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:23 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:23 INFO - 'USER': 'cltbld', 16:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:23 INFO - 'XPC_FLAGS': '0x0', 16:31:23 INFO - 'XPC_SERVICE_NAME': '0', 16:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:23 INFO - Cleaning up... 16:31:23 INFO - Return code: 0 16:31:23 INFO - Running post-action listener: _resource_record_post_action 16:31:23 INFO - Running post-action listener: _start_resource_monitoring 16:31:23 INFO - Starting resource monitoring. 16:31:23 INFO - [mozharness: 2016-09-28 23:31:23.301258Z] Finished create-virtualenv step (success) 16:31:23 INFO - [mozharness: 2016-09-28 23:31:23.302237Z] Running install step. 16:31:23 INFO - Running pre-action listener: _resource_record_pre_action 16:31:23 INFO - Running main action method: install 16:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:23 INFO - Reading from file tmpfile_stdout 16:31:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:23 INFO - Reading from file tmpfile_stdout 16:31:23 INFO - Output received: 16:31:23 INFO - Usage: mozinstall [options] installer 16:31:23 INFO - Options: 16:31:23 INFO - -h, --help show this help message and exit 16:31:23 INFO - -d DEST, --destination=DEST 16:31:23 INFO - Directory to install application into. [default: 16:31:23 INFO - "/builds/slave/test"] 16:31:23 INFO - --app=APP Application being installed. [default: firefox] 16:31:23 INFO - mkdir: /builds/slave/test/build/application 16:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:31:56 INFO - Reading from file tmpfile_stdout 16:31:56 INFO - Output received: 16:31:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:31:56 INFO - Running post-action listener: _resource_record_post_action 16:31:56 INFO - [mozharness: 2016-09-28 23:31:56.498350Z] Finished install step (success) 16:31:56 INFO - [mozharness: 2016-09-28 23:31:56.498501Z] Running run-tests step. 16:31:56 INFO - Running pre-action listener: _resource_record_pre_action 16:31:56 INFO - Running main action method: run_tests 16:31:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:31:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:31:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:31:56 INFO - 2016-09-28 16:31:56.513 screenresolution[1928:23131] starting screenresolution argv=screenresolution get 16:31:56 INFO - 2016-09-28 16:31:56.515 screenresolution[1928:23131] Display 0: 1600x1200x32@60 16:31:56 INFO - 2016-09-28 16:31:56.521 screenresolution[1929:23134] starting screenresolution argv=screenresolution list 16:31:56 INFO - Available Modes on Display 0 16:31:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:31:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:31:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:31:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:31:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:31:56 INFO - Intel Iris: 16:31:56 INFO - Chipset Model: Intel Iris 16:31:56 INFO - Type: GPU 16:31:56 INFO - Bus: Built-In 16:31:56 INFO - VRAM (Dynamic, Max): 1536 MB 16:31:56 INFO - Vendor: Intel (0x8086) 16:31:56 INFO - Device ID: 0x0a2e 16:31:56 INFO - Revision ID: 0x0009 16:31:56 INFO - Displays: 16:31:56 INFO - Display: 16:31:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:31:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:31:56 INFO - Display Serial Number: 1600x1200 60 16:31:56 INFO - Main Display: Yes 16:31:56 INFO - Mirror: Off 16:31:56 INFO - Online: Yes 16:31:56 INFO - Rotation: Supported 16:31:56 INFO - Return code: 0 16:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:56 INFO - Python 2.7.3 16:31:56 INFO - Return code: 0 16:31:56 INFO - grabbing minidump binary from tooltool 16:31:56 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')]} 16:31:56 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 0x108563d30>, '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 0x1083c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10855bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:56 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 16:31:56 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 16:31:56 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 16:31:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:56 INFO - Return code: 0 16:31:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:31:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:31:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 16:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 16:31:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DX2kfQQlyl/Render', 16:31:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:31:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:31:56 INFO - 'HOME': '/Users/cltbld', 16:31:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:31:56 INFO - 'LOGNAME': 'cltbld', 16:31:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:56 INFO - 'MOZ_NO_REMOTE': '1', 16:31:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:56 INFO - 'NO_EM_RESTART': '1', 16:31:56 INFO - 'PAGER': '/bin/cat', 16:31:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:56 INFO - 'PWD': '/builds/slave/test', 16:31:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:31:56 INFO - 'SHELL': '/bin/bash', 16:31:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yRB8fBdBGE/Listeners', 16:31:56 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 16:31:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:31:56 INFO - 'USER': 'cltbld', 16:31:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:31:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:56 INFO - 'XPC_FLAGS': '0x0', 16:31:56 INFO - 'XPC_SERVICE_NAME': '0', 16:31:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:31:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 16:31:57 INFO - mozversion application_buildid: 20160928141021 16:31:57 INFO - mozversion application_changeset: 72f6089e120d83a4437e94b00e2c7cd425a3d4e6 16:31:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:31:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:57 INFO - mozversion application_name: Firefox 16:31:57 INFO - mozversion application_remotingname: firefox-dev 16:31:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:31:57 INFO - mozversion application_vendor: Mozilla 16:31:57 INFO - mozversion application_version: 51.0a2 16:31:57 INFO - mozversion platform_buildid: 20160928141021 16:31:57 INFO - mozversion platform_changeset: 72f6089e120d83a4437e94b00e2c7cd425a3d4e6 16:31:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:31:57 INFO - mozversion platform_version: 51.0a2 16:31:57 INFO - using testdate: 1475105517 16:31:57 INFO - actual date: 1475105517 16:31:57 INFO - starting webserver on 'localhost:56581' 16:31:57 INFO - SUITE-START | Running 2 tests 16:31:57 INFO - TEST-START | dromaeo_css 16:31:57 INFO - operating with platform_type : mac_ 16:31:57 INFO - Initialising browser for dromaeo_css test... 16:31:57 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpDHkKiq/profile http://localhost:56581/getInfo.html) 16:31:59 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 16:31:59 INFO - PROCESS | 1939 | colorDepth:24 16:31:59 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 16:31:59 INFO - PROCESS | 1939 | __metrics 16:31:59 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:32:00 INFO - TEST-INFO | 1939: exit 0 16:32:00 INFO - Browser initialized. 16:32:00 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:00 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpDHkKiq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:12 INFO - PROCESS | 1942 | RSS: Main: 224378880 16:32:12 INFO - PROCESS | 1942 | 16:33:02 INFO - PROCESS | 1942 | 1475105582022 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:35:14 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56581/tests/dromaeo/cssquery-ext.html) 16:35:15 INFO - PROCESS | 1942 | RSS: Main: 236998656 16:35:15 INFO - PROCESS | 1942 | 16:38:17 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-ext.html (next: http://localhost:56581/tests/dromaeo/cssquery-jquery.html) 16:38:18 INFO - PROCESS | 1942 | RSS: Main: 248770560 16:38:18 INFO - PROCESS | 1942 | 16:41:20 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56581/tests/dromaeo/cssquery-mootools.html) 16:41:20 INFO - PROCESS | 1942 | RSS: Main: 251924480 16:41:20 INFO - PROCESS | 1942 | 16:44:22 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56581/tests/dromaeo/cssquery-prototype.html) 16:44:23 INFO - PROCESS | 1942 | RSS: Main: 252805120 16:44:23 INFO - PROCESS | 1942 | 16:47:26 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56581/tests/dromaeo/cssquery-yui.html) 16:47:26 INFO - PROCESS | 1942 | RSS: Main: 257335296 16:47:26 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:56581/tests/dromaeo/cssquery-yui.html (next: http://localhost:56581/tests/dromaeo/cssquery-dojo.html) 16:50:29 INFO - PROCESS | 1942 | RSS: Main: 260272128 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | __start_tp_report 16:50:29 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 16:50:29 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 16:50:29 INFO - PROCESS | 1942 | |i|pagename|runs| 16:50:29 INFO - PROCESS | 1942 | |0;dojo.html;3046.6648668646444;3390.4405773047433;3392.406328892445;3404.965950340499;3437.003269051975;5782.710864456776;5850.88298234035;5862.2379090718205;5873.2658417697785;5883.646981181132;5822.534197264219;5851.268591426072;5858.091995740657;5893.793717219898;5944.256967879015;5273.367195936484;5338.759755810978;5378;5381.300430943991;5393.973030134844;5367.812126575571;5368.91946620801;5384.973075134619;5398.190271459273;5453.563714902798;5238.580913526927;5266.447023062581;5387.0841956867425;5390.948764990829;5394.244805727201;5249.658772179815;5285.365756109272;5322.600804939645;5335.226392173152;5402.270693456372;5156.252343410222;5283.101872681615;5293.100172970604;5311.575073994071;5345.1447768356875;5663.2637757091725;5795.855103622401;5826.417358264182;5928.199693041471;5983.940160598382;5227.26818245446;5928.940710592882;6206.565540412173;6207.162033125561;6212.565120441571;6264.248290205159;6282.623042617458;6284.622922624611;6288.465480434169;6291.087792270141;5924.4667979882015;5952.642841429528;5965.4115586690505;5973.641581505123;6013.1581578579035;6136.243373036893;6241.7191226394925;6254.21822272216;6311.589746666452;6336.112944187817;5165.096108181128;5387.757550910218;5830.41695830422;6237.625742455467;6264.9976003839165;5283.682979021271;6220.2314296379245;6254.124422580842;6279.403456671609;6281.8743625127245;6124.289394097934;6190.288116866528;6239.625622462667;6243.37566243372;6319.6208227506495;6187.3503282155625;6195.411435913581;6228.128062071313;6232.439080482778;6308.558400911984;4991.101601711727;5002.949970500248;5007;5010.498950105033;5012.899742005139;4338.501072376717;4423.1153769246275;4449.466064072268;4460.8661740147845;4470.6870519064005;5729.713514324267;5770.798022069207;5849.94150058494;5914.940850591439;5988.730507127189;6194;6250.312465628777;6255.968720156461;6267.7806276781;6279.529035322369;4607.884802879955;4812.542808433193;5616.943830561724;5902.8819423611285;5957.553183511254;4207.84284321814;5497.752601132958;5503.807366742145;5534.08687566547;5547.528460080938;6393.6163830170335;6456.192975878015;6466.997615369719;6481.287058423475;6489.286178520359;6103.6032657877095;6143.634700640197;6249.906251406142;6288;6294.15028971083;6381.170447841937;6413.935860641521;6430.710618022294;6503.02454631809;6519.511036672174;6190.226221722285;6193.916064688751;6194.4115309045565;6195.2255968004;6202.224721909762;5544.085225937675;5847.7368518417625;6123.862238009652;6185.938140618537;6297.559170857996;6100.267967843887;6104.145419641342;6140.964409184605;6145.446909778141;6167.938320616737;6107.929031871887;6135.815925522242;6143.784967526115;6146.293176284785;6159.384061593805;5903.645781253139;5991.6405015697455;6148.262208535004;6166.982447896226;6175;6141.293751218667;6177.166082578794;6181.320054794059;6183.752649893954;6300.180976473029;6131;6135.815925522242;6143.262808462834;6152.78465253714;6169.290531588746 16:50:29 INFO - PROCESS | 1942 | |1;ext.html;450.5629539346833;461.73911739866975;464.23864861626936;522.2740390856708;533.8772082421042;39997.60002399975;41776.37335439971;41874;41908.790456047755;41915.37126943098;42329.7883510582;42800.35799463003;42804;42810.35784463236;42862;9662.613495460173;9863.901360986405;9872.950635246814;9899.15857152143;9902.158316543102;9737.026297370241;9847.950760246189;9855.605775768961;9870.259730520203;9890.653827116052;9884.258680598949;9911.752206194868;9922.851157232648;9924.851127233098;9949.552270147824;9848;9878.901210987942;9880.061394167542;9884.703458896209;9931.255155863339;9751.90248097524;9754.0733630305;9774.071463210983;9774.462404567746;9889.307748457612;39707.60292397097;39737;39798.80603581897;39969.80015099935;39990.600093998975;3317.2370354818527;3455.4125798614295;3501.7023552998025;3669;4109.8972525686795;30296.54555181674;30299.848500757354;30312.393752125055;30871.684623653317;30995.535066974015;3170.461021626329;3242.4974129010043;3278.639349671534;3294.1764558860286;3381.2730262993327;520002;524635;525926.9999999962;529545;532503;59400;60355;60912;60952.085718714254;61051;28528.144155675363;35315.823420882734;36661.81669091638;55024.72487637536;64105.03842442274;16614.00315981045;16756.581085472717;16784.992900426012;16790.74813877793;16812.411565595146;10875.945620272007;12782.552610658582;12883.677908052374;12963.481460741465;13005.21968681882;18664.533386665444;18884.43346699601;19200.8079919199;19230.423087307405;19245.711314330296;7924.960375198202;7952.008231727077;7979.321757650665;8034;8078.596070196467;869.4044579462961;1015.7765291635828;1053.7207639975413;1057.164839776568;1089.8910108989037;30053.699463005527;30159.246018849266;30165.245868853453;30305.545416818764;30679.69320306813;1046.3094357723867;1082.1991726122612;1104.939228342433;1114.8606424196976;1150.5972909481613;15271.923640381727;15579.298931548108;15604.21978901073;15620.921895390678;15782;658393;671059;671701;672540;674114;57111.428885711444;57415.71292143512;57427;57639.423605763404;57812;1372.9244891530861;1392.7353802777643;1403.0459287684473;1416.7379034878375;1426.4650755966513;26071.348216294744;28755.13734587966;29840.22908660227;29905.551416728333;30110.84944575351;49462.29032822625;50078.998420030664;50097.998040039725;50106.498935011645;50329.74835125801;569539;571101;572470;572629;574674.1266293642;26537.60193597059;26798;26849.731502685503;26894.462110758068;26907.730922690524;46335.76832115953;46436;46945.765271173426;47393;47946.76026619845;37895.43156852594;38104.428433574074;38977.41533877051;39062.023449413995;40140.79929600333;38712.64505742286;38807.41788873113;39792.403113952736;39923;40215.396769049075;37331.81334093312;37386.252274953804;37723.43414848725;38174.23651526898;38225.808870955465;32629.673703263612;34244.82877585596;34566.48150277697;34667.826660866536;34677;25807.354816128995;25824.741752582235;25838;25856.095036673625;26068.34829129287 16:50:29 INFO - PROCESS | 1942 | |2;jquery.html;376.3752171395484;377.8431950740443;381.1652481066464;384.07246499703217;400.02194634119587;18842.81157188428;20480.69278960817;21003.57992840142;21035.789642103573;21212.15151393946;20198.485113616465;20329.983500824936;20372;20536.075876585553;20797.96010199488;5785.305763308409;5855.4144585541535;6064.787732429366;6110.8777824443705;6165.445109940105;3890.824912878927;4097.815598298083;6109.602875813058;6152.5693201475915;6163.167972323724;5838.124281357809;6089.725962331706;6129.019356902896;6173.228346456693;6175.382461753811;6129.693515324238;6170.475509581691;6671.899921501182;6845.657717114124;6857.759978400732;5941.3761555036535;6001.339852616209;6030.849228769316;6052;6055.27336719592;11064.944675276653;13338.599842004756;13353.532626358128;13429.395677194452;13436.932815335958;2269.0016392787284;2330.8251881108986;2421.9273421797197;2470.7529247075327;2758.517259479603;9906.07850363031;9914.305998580103;9944.801103977952;10023.54894029763;10144.391336519759;1519.8252200996917;1927.7012063130237;1990.7810140884492;1997.3808119483008;2004.2784597544871;117261;120172;120920.1861972071;124863.3756831219;125584;9656.22750179984;11389.829152562717;11399.829002564968;11640.301581905112;11730.237534560398;14287.928560357132;14630.049046811922;14694.044887082306;14707.632309192355;14739.484118055816;8357.331413487029;8592.226699596942;8622.698205562901;8715.738527844174;8750.606222719993;7109.289071092952;8616.569171541398;8682.479051256945;8688.348373871984;8735.170158835028;4493.865184044484;4515.367848501212;4571.839985600488;4613.169629466661;4659.138059459011;1595.6010997250687;1953.5604488989864;1958.285225892539;1984.4245168900857;2024.6861736430876;702.5679207287482;899.5068186809864;945.8723072385278;980.3284749946309;1015.2284263959444;20541.691874621894;21061.052252648667;21158.047887845085;21174.941252937293;21280.36158915235;941.2987324443196;945.1021529546958;948.8481842905102;976.1019861727228;979.2802290316612;8930.508822014852;10715.35707857531;10923;10944.288621239593;11002.669919902415;628099;633652;639745;651174;652572;100675;100982;117417;129717.35141324233;136646.63353366338;848.749618862437;966.9806603867884;984.015984015984;994.4828689081781;996.2776986684596;14412.927935360256;17520.38678646241;18249.726254106463;18570.350037748613;18726.063696815378;55108.897822042534;57100;57235.713821430625;57713.13430298633;57857.84284314206;68455;68517.65741171263;71989.84030479094;82188.17811821806;82928;6967.930320696728;7054.823629409306;7357.374623157091;7371.3734332582335;7451.552906825608;6897.413719833669;10383.650125483638;10667.986541278566;10967.50646220906;13499.86500134986;10120.392776433437;10850.177472434516;10861.456927153453;11479.311241325548;11606.825897611374;11049.944750276198;11077.72305692332;11150.498227579941;11151.888481115086;11452.656420307405;8413.621387037476;11287.097032237565;11405.372704501333;11678.357690327113;11683.065354771768;8127.959360203397;8151.225633564802;8181.550014749246;8316.62575184106;8348.123447037973;8191.549464779256;10201.489925503844;10832.566697332333;11170.218084733991;11248.325100493996 16:50:29 INFO - PROCESS | 1942 | |3;mootools.html;1506.7363211437996;1543.6449616588184;1732.4023211991866;1794.8294911983373;1870.1210431097388;7872.29149376556;8524.403291769579;8758.91241087589;8760.824783504335;9332.953335233322;8748.431351962117;9033.322500812432;9037.096290370959;9140.360174787767;9142.314326425529;2371.3597328721235;2410.9758902410927;2414.6740190074293;2418.117387153685;2424.4666173441815;2392.425817803732;2398.640203969401;2424.4544977380124;2424.599941009731;2435.5737745894485;2373.1575290771784;2404.95190096198;2415.6618073469726;2427.4416884116663;2431.0761910473993;2367.490989437279;2375.5961486547244;2381.773731495505;2383.9284821455385;2394.892229849661;2007.5181956330375;2353.5410594933996;2361.846479978813;2363.078399424226;2364.0898254172093;9023.503707296097;9097.81804363909;9155.313351498664;9169.724908252763;9175.449473031573;5315.096433606296;5459.3994660587305;5479.150731636602;5483.067878460672;5489.478499542537;3171.5876935998403;3308.470644696861;3598.604153543108;3631.9455208171635;3685.1708365617787;1016.6630880392261;1054.9977521354745;1056.2025670618712;1056.2764506313124;1113.7995160871121;11764.999975002049;11843.111766617538;11882.465289062013;11909.285442873455;11970.40147992597;3703.4629978652943;4645.628349732014;4774.904501909942;4882.926756098661;4899.485554016848;8607.440516366416;10188.541515631814;10268.486575671186;10302.793944121076;10345.689629311133;5346.4386239445075;5404.162354835007;5433.157860531624;5449.373322068013;5450.236966824647;4442.333649952533;4586.3579098926175;4803.871090293778;4919.827806026843;4932.55606995365;3994.7416563782317;4049.655779258796;4116.835326586963;4149.564295748964;4150.315197992298;1308.7055412532104;1311.4885194774047;1315.302889468583;1321.3195204469705;1328.5018118205674;735.2647352647352;780.6292011294589;918.4948278446827;939.8825146856643;951.9143277105094;5371.462853714597;5943.781524787408;5981.252343457068;6121.693915304306;6277.654728989949;423.8495334156392;428.45158197507243;444.100696090413;451.1540860885839;452.70800333784524;4093.8976525586504;4122.237386083584;4128.876133715993;4144.626983571433;4169.770662613585;10764.3541387517;11058.557657693764;11156.832647510293;11177.888221117684;11191.104711623051;11107.38909359993;11120.777584448266;11125.499352529156;11126.443677816076;11128.721781955515;6913.274106218875;7898.644560994769;8262.42163048581;8266.8346633067;8445.704400346081;6129.172561704113;6152.446279834837;6182.783602573888;6200.193974783429;6234.908890943976;9944.552495137592;10311.948440257751;10374.948125259325;10416.375017498975;10466.372017678963;10594.523246454082;10634.09610183143;10650.467476626292;10651.680449586525;10676.14590832716;7184.389326907062;7442.995195648518;7634.694612215671;7779.222077792176;7923.524588524707;8497.2777313929;8596.269317108116;8770.605322760619;8782.209601135928;8789.648414063622;7677.692892284246;7767.766966990999;7815.609219539114;7843.254890785366;7915.366770658218;7525.3227209551405;7632.771016869503;7642.847143056996;7644.847103058019;7649.847003060019;7170.103737032871;7287.1984081752025;7293.671784769592;7300.926990730025;7301.415886729155;5052.191649336089;5098.515641014098;5129.538341549279;5204.557612602971;5317.813876514303;4964.528369804862;5124.410692770379;5222.529972302511;5328.307320048369;5340.359156901197 16:50:29 INFO - PROCESS | 1942 | |4;prototype.html;299.43855271366186;303.6902359593215;308.64197530864186;312.9295908420607;316.4509575885838;5413.702246376448;5594.992901277768;5713.857378441856;5729.255196824412;5789.942100578993;4864.781084851182;5419.566434685225;5588.888222235563;5599.7600959616175;5623.297087864017;3606.9098272543133;4240.151969606076;4278.636315913143;4291.648130838791;4317.201317756209;3568.750937171995;4154.6676265898805;4251.341042138473;4287.292596721537;4298.226319262531;4250.744955302692;4252.914941701164;4269.743815371072;4274.922056119604;4293.806778694966;3619.9095022624383;3912.1784425270725;3987.381955796842;4050.4531888195306;4311.439512863339;3695.4456831475227;3711.2763011212824;3736.5702944161226;3737.1404576947184;3743.794091324976;5210.7915683373;5431.456854314537;5449.618526703132;5456.427075157131;5471.863203419906;3826.6747326477284;4112.773797441139;4888.560029597318;4890.315355850184;4956.925646115311;5543.861403464905;5897.083447879456;5906.763729450817;5922.239377994961;5954.464098231137;3484.233468636896;4054.655354294859;4104.302268614343;4127.855525056609;4152.397902304179;5317.787288508455;6334.954732469137;6372.872542549169;6386.2975072741965;6390.4248617624635;3547.598698514124;3907.4529565860803;4172.645325147336;4227.408162857202;4246.426732391149;3814.703000979625;4040.252553277653;4270.679699022586;4276.337167739005;4282.336237883133;4387.670924680661;4907.08623636782;4919.434265059493;4936.531029552187;5003.74981250936;5687.971560142173;5989.431004054608;5996.490298324604;6001.5798894077;6066.696665166724;1139.32779660001;1361.515947617102;1377.5522955039653;1380.2339701465783;1469.544441223224;812.4515951732557;856.0241324889631;911.148076548416;913.9908600913906;915.3683958068912;3835.6547910688173;4373.715708478939;4473.6868419211;4724.669273150916;4775.498572649822;4618.722876627413;4679.525949325952;4781.665283430196;4981.452040275567;5272.762725677354;4325.351197320427;4365.301551751768;4419.602495516981;4424.566488431415;4439.62263207631;2722.564389697639;2772.5702516110036;2966.1546459259007;3180.3480286541203;3271.3479692755004;5451.836444906659;6001.849953751103;6412.454941330039;6452.322506136788;6456.611828456905;5516.9448305516435;5795.420457954171;5975.282966044016;6375.330590288046;6395.880720873828;5412.756425960842;5783.681897495594;6106.694665266719;6499;6511.609303441809;6027.60820546663;6046.767262915889;6192.969035154795;6220.533459990609;6225.501959843111;5138.332016837787;5344.663834041489;6046.334903160561;6120.877582448237;6123;6037.69811509414;6070.817875463743;6252.5935814171935;6412.807615771534;6464.191976003;3291.555639988571;3796.9430458543698;3995.5405128410603;4032.1330913853662;4063.7358571692744;5040.57155141817;5166.844994650167;6110.388961103854;6132.386761323832;6151.723172457339;5280.524752772269;5481.917771233514;5532.778688852401;5705.343885453226;5950.256217972754;5856.5739042660525;5860.706964651836;5916.408359164049;5948.315943666534;5970.850728731816;4680.438347398198;5088.923666145085;5849.502792262535;5874.123078767992;5906.586538942232;4991.302882685471;5087.364079490064;5372.597055220952;5723.599348045764;5876.6180198286975;5776.671365586023;5822.243108395882;5865.208196893535;5885.440883116097;5931.851703707442 16:50:29 INFO - PROCESS | 1942 | |5;yui.html;550.6998685716284;709.131314140178;720.27972027972;778.9532628042318;788.7476007677544;14776;14838.55484335469;15061.397544098236;15070.924645376757;15083.547493575183;11928.522859085626;14296.571102866905;14430.278486075707;14446;14452.132872027685;657.9144711187539;675.6891829758317;813.8535063688533;815.8449894520022;845.2730651639584;836.6109758962082;845.602566793606;849.235687880909;849.9915000850006;852.9445586036887;851.8083431227955;868.8045189832301;892.4333048514208;894.7360528644033;895.7312806158159;879.7844528090595;883.3419102768446;885.6457417033238;890.585877566928;893.70954439807;659.960402375859;662.3376623376623;664.4086762781129;665.1286814273318;665.5873358517701;14867.628309292355;14940.850591494163;15111.54665360041;15161.09033457996;15188.924055379763;14545.709085818331;14602.34289456977;14645.926770366186;14656.047356921767;14801.777973330409;11405.31568105908;11743.354115523643;11755.941965223086;11818.704532386759;12155.574554890536;3846.76919384835;3860.8455661773496;3863.3625451800417;3895.2793733159174;3909.042284640281;105191;107557.46221268922;118025.40987295094;119092;123346;11276.097912167006;11311.547538098548;11383.373914434786;11474.311541307548;11514.078873690085;22952.19667311636;22959.655605165935;23613.763862361156;23754.049838006285;23885.880570597037;7805.41459390548;7962.522248665098;8355.832883342298;8393.496390216484;8404.957975210207;4482.910341793146;4507.5267096955;4567.474740404896;4572.862814115582;4610.05493873755;3490.5636795400574;3629.854805807738;3646.197836475971;3650.799206043693;3650.8904732858055;626.7179769103831;630.7287866217571;642.8617847162883;656.6322859198864;681.3322943515383;530.8407477756657;582.8892510423007;606.75123199488;619.9380061993854;636.3477435628517;8625.223729864343;9075.635249862373;9184.908150918405;9188.494632795127;9283.11810378013;534.3747815056394;534.8154886564129;590.306389991758;610.1823556434399;628.6322501336678;4321.827126914888;4444.555544445594;4470.754108523997;4493.213687604656;4497.550244975541;137865;140926;157193;166682;167758;139199.30400348135;139428.30285848505;141376.2931185358;144463;145438.54561454462;118706.40646796883;119750;122260;124189.37905310416;124240;7289.380402665833;8736.825263494822;8757;8809.559522024001;8856.380053396459;51480.48519514907;67423;67957;68927.65536172286;69584.6520767393;101704;103514.96485035354;103785;106266;106784;10208.438535880598;10502.212334074822;11169.553217871195;11668.649940501798;11865.644030678748;12211.412516372815;12258.570950016707;12292.50829966827;12330.260184388966;12523.311217883103;9901.950490247502;11770.293782373084;11801.29192248468;12020;12136.878631213574;11264.94367528157;11803.409829508662;11804.40977951082;11889.167758256839;12033.518659253881;10980.286281391684;11511.712207194552;11557.364344960772;11736.002439792372;11875;9032.45805251687;9878;10310.07209351162;10368.481575921325;10452.895471045193;8676.045634980273;10182.134518566005;10238.873723890516;10288.434136122585;10373.68878933603 16:50:29 INFO - PROCESS | 1942 | __end_tp_report 16:50:29 INFO - PROCESS | 1942 | __start_cc_report 16:50:29 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,374 16:50:29 INFO - PROCESS | 1942 | __end_cc_report 16:50:29 INFO - PROCESS | 1942 | __startTimestamp1475106629376__endTimestamp 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | ------- Summary: start ------- 16:50:29 INFO - PROCESS | 1942 | Number of tests: 6 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | [#0] dojo.html Cycles:165 Average:5773.15 Median:5988.73 stddev:660.91 (11.0%) stddev-sans-first:627.37 16:50:29 INFO - PROCESS | 1942 | Values: 3046.7 3390.4 3392.4 3405.0 3437.0 5782.7 5850.9 5862.2 5873.3 5883.6 5822.5 5851.3 5858.1 5893.8 5944.3 5273.4 5338.8 5378.0 5381.3 5394.0 5367.8 5368.9 5385.0 5398.2 5453.6 5238.6 5266.4 5387.1 5390.9 5394.2 5249.7 5285.4 5322.6 5335.2 5402.3 5156.3 5283.1 5293.1 5311.6 5345.1 5663.3 5795.9 5826.4 5928.2 5983.9 5227.3 5928.9 6206.6 6207.2 6212.6 6264.2 6282.6 6284.6 6288.5 6291.1 5924.5 5952.6 5965.4 5973.6 6013.2 6136.2 6241.7 6254.2 6311.6 6336.1 5165.1 5387.8 5830.4 6237.6 6265.0 5283.7 6220.2 6254.1 6279.4 6281.9 6124.3 6190.3 6239.6 6243.4 6319.6 6187.4 6195.4 6228.1 6232.4 6308.6 4991.1 5002.9 5007.0 5010.5 5012.9 4338.5 4423.1 4449.5 4460.9 4470.7 5729.7 5770.8 5849.9 5914.9 5988.7 6194.0 6250.3 6256.0 6267.8 6279.5 4607.9 4812.5 5616.9 5902.9 5957.6 4207.8 5497.8 5503.8 5534.1 5547.5 6393.6 6456.2 6467.0 6481.3 6489.3 6103.6 6143.6 6249.9 6288.0 6294.2 6381.2 6413.9 6430.7 6503.0 6519.5 6190.2 6193.9 6194.4 6195.2 6202.2 5544.1 5847.7 6123.9 6185.9 6297.6 6100.3 6104.1 6141.0 6145.4 6167.9 6107.9 6135.8 6143.8 6146.3 6159.4 5903.6 5991.6 6148.3 6167.0 6175.0 6141.3 6177.2 6181.3 6183.8 6300.2 6131.0 6135.8 6143.3 6152.8 6169.3 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | [#1] ext.html Cycles:180 Average:71553.09 Median:39860.90 stddev:158452.80 (397.5%) stddev-sans-first:158807.37 16:50:29 INFO - PROCESS | 1942 | Values: 450.6 461.7 464.2 522.3 533.9 39997.6 41776.4 41874.0 41908.8 41915.4 42329.8 42800.4 42804.0 42810.4 42862.0 9662.6 9863.9 9873.0 9899.2 9902.2 9737.0 9848.0 9855.6 9870.3 9890.7 9884.3 9911.8 9922.9 9924.9 9949.6 9848.0 9878.9 9880.1 9884.7 9931.3 9751.9 9754.1 9774.1 9774.5 9889.3 39707.6 39737.0 39798.8 39969.8 39990.6 3317.2 3455.4 3501.7 3669.0 4109.9 30296.5 30299.8 30312.4 30871.7 30995.5 3170.5 3242.5 3278.6 3294.2 3381.3 520002.0 524635.0 525927.0 529545.0 532503.0 59400.0 60355.0 60912.0 60952.1 61051.0 28528.1 35315.8 36661.8 55024.7 64105.0 16614.0 16756.6 16785.0 16790.7 16812.4 10875.9 12782.6 12883.7 12963.5 13005.2 18664.5 18884.4 19200.8 19230.4 19245.7 7925.0 7952.0 7979.3 8034.0 8078.6 869.4 1015.8 1053.7 1057.2 1089.9 30053.7 30159.2 30165.2 30305.5 30679.7 1046.3 1082.2 1104.9 1114.9 1150.6 15271.9 15579.3 15604.2 15620.9 15782.0 658393.0 671059.0 671701.0 672540.0 674114.0 57111.4 57415.7 57427.0 57639.4 57812.0 1372.9 1392.7 1403.0 1416.7 1426.5 26071.3 28755.1 29840.2 29905.6 30110.8 49462.3 50079.0 50098.0 50106.5 50329.7 569539.0 571101.0 572470.0 572629.0 574674.1 26537.6 26798.0 26849.7 26894.5 26907.7 46335.8 46436.0 46945.8 47393.0 47946.8 37895.4 38104.4 38977.4 39062.0 40140.8 38712.6 38807.4 39792.4 39923.0 40215.4 37331.8 37386.3 37723.4 38174.2 38225.8 32629.7 34244.8 34566.5 34667.8 34677.0 25807.4 25824.7 25838.0 25856.1 26068.3 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | [#2] jquery.html Cycles:180 Average:35573.44 Median:382.62 stddev:106559.43 (27850.0%) stddev-sans-first:106825.58 16:50:29 INFO - PROCESS | 1942 | Values: 376.4 377.8 381.2 384.1 400.0 18842.8 20480.7 21003.6 21035.8 21212.2 20198.5 20330.0 20372.0 20536.1 20798.0 5785.3 5855.4 6064.8 6110.9 6165.4 3890.8 4097.8 6109.6 6152.6 6163.2 5838.1 6089.7 6129.0 6173.2 6175.4 6129.7 6170.5 6671.9 6845.7 6857.8 5941.4 6001.3 6030.8 6052.0 6055.3 11064.9 13338.6 13353.5 13429.4 13436.9 2269.0 2330.8 2421.9 2470.8 2758.5 9906.1 9914.3 9944.8 10023.5 10144.4 1519.8 1927.7 1990.8 1997.4 2004.3 117261.0 120172.0 120920.2 124863.4 125584.0 9656.2 11389.8 11399.8 11640.3 11730.2 14287.9 14630.0 14694.0 14707.6 14739.5 8357.3 8592.2 8622.7 8715.7 8750.6 7109.3 8616.6 8682.5 8688.3 8735.2 4493.9 4515.4 4571.8 4613.2 4659.1 1595.6 1953.6 1958.3 1984.4 2024.7 702.6 899.5 945.9 980.3 1015.2 20541.7 21061.1 21158.0 21174.9 21280.4 941.3 945.1 948.8 976.1 979.3 8930.5 10715.4 10923.0 10944.3 11002.7 628099.0 633652.0 639745.0 651174.0 652572.0 100675.0 100982.0 117417.0 129717.4 136646.6 848.7 967.0 984.0 994.5 996.3 14412.9 17520.4 18249.7 18570.4 18726.1 55108.9 57100.0 57235.7 57713.1 57857.8 68455.0 68517.7 71989.8 82188.2 82928.0 6967.9 7054.8 7357.4 7371.4 7451.6 6897.4 10383.7 10668.0 10967.5 13499.9 10120.4 10850.2 10861.5 11479.3 11606.8 11049.9 11077.7 11150.5 11151.9 11452.7 8413.6 11287.1 11405.4 11678.4 11683.1 8128.0 8151.2 8181.6 8316.6 8348.1 8191.5 10201.5 10832.6 11170.2 11248.3 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | [#3] mootools.html Cycles:180 Average:5842.03 Median:4615.99 stddev:3328.28 (72.1%) stddev-sans-first:3321.68 16:50:29 INFO - PROCESS | 1942 | Values: 1506.7 1543.6 1732.4 1794.8 1870.1 7872.3 8524.4 8758.9 8760.8 9333.0 8748.4 9033.3 9037.1 9140.4 9142.3 2371.4 2411.0 2414.7 2418.1 2424.5 2392.4 2398.6 2424.5 2424.6 2435.6 2373.2 2405.0 2415.7 2427.4 2431.1 2367.5 2375.6 2381.8 2383.9 2394.9 2007.5 2353.5 2361.8 2363.1 2364.1 9023.5 9097.8 9155.3 9169.7 9175.4 5315.1 5459.4 5479.2 5483.1 5489.5 3171.6 3308.5 3598.6 3631.9 3685.2 1016.7 1055.0 1056.2 1056.3 1113.8 11765.0 11843.1 11882.5 11909.3 11970.4 3703.5 4645.6 4774.9 4882.9 4899.5 8607.4 10188.5 10268.5 10302.8 10345.7 5346.4 5404.2 5433.2 5449.4 5450.2 4442.3 4586.4 4803.9 4919.8 4932.6 3994.7 4049.7 4116.8 4149.6 4150.3 1308.7 1311.5 1315.3 1321.3 1328.5 735.3 780.6 918.5 939.9 951.9 5371.5 5943.8 5981.3 6121.7 6277.7 423.8 428.5 444.1 451.2 452.7 4093.9 4122.2 4128.9 4144.6 4169.8 10764.4 11058.6 11156.8 11177.9 11191.1 11107.4 11120.8 11125.5 11126.4 11128.7 6913.3 7898.6 8262.4 8266.8 8445.7 6129.2 6152.4 6182.8 6200.2 6234.9 9944.6 10311.9 10374.9 10416.4 10466.4 10594.5 10634.1 10650.5 10651.7 10676.1 7184.4 7443.0 7634.7 7779.2 7923.5 8497.3 8596.3 8770.6 8782.2 8789.6 7677.7 7767.8 7815.6 7843.3 7915.4 7525.3 7632.8 7642.8 7644.8 7649.8 7170.1 7287.2 7293.7 7300.9 7301.4 5052.2 5098.5 5129.5 5204.6 5317.8 4964.5 5124.4 5222.5 5328.3 5340.4 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | [#4] prototype.html Cycles:180 Average:4709.90 Median:5152.59 stddev:1487.63 (28.9%) stddev-sans-first:1454.50 16:50:29 INFO - PROCESS | 1942 | Values: 299.4 303.7 308.6 312.9 316.5 5413.7 5595.0 5713.9 5729.3 5789.9 4864.8 5419.6 5588.9 5599.8 5623.3 3606.9 4240.2 4278.6 4291.6 4317.2 3568.8 4154.7 4251.3 4287.3 4298.2 4250.7 4252.9 4269.7 4274.9 4293.8 3619.9 3912.2 3987.4 4050.5 4311.4 3695.4 3711.3 3736.6 3737.1 3743.8 5210.8 5431.5 5449.6 5456.4 5471.9 3826.7 4112.8 4888.6 4890.3 4956.9 5543.9 5897.1 5906.8 5922.2 5954.5 3484.2 4054.7 4104.3 4127.9 4152.4 5317.8 6335.0 6372.9 6386.3 6390.4 3547.6 3907.5 4172.6 4227.4 4246.4 3814.7 4040.3 4270.7 4276.3 4282.3 4387.7 4907.1 4919.4 4936.5 5003.7 5688.0 5989.4 5996.5 6001.6 6066.7 1139.3 1361.5 1377.6 1380.2 1469.5 812.5 856.0 911.1 914.0 915.4 3835.7 4373.7 4473.7 4724.7 4775.5 4618.7 4679.5 4781.7 4981.5 5272.8 4325.4 4365.3 4419.6 4424.6 4439.6 2722.6 2772.6 2966.2 3180.3 3271.3 5451.8 6001.8 6412.5 6452.3 6456.6 5516.9 5795.4 5975.3 6375.3 6395.9 5412.8 5783.7 6106.7 6499.0 6511.6 6027.6 6046.8 6193.0 6220.5 6225.5 5138.3 5344.7 6046.3 6120.9 6123.0 6037.7 6070.8 6252.6 6412.8 6464.2 3291.6 3796.9 3995.5 4032.1 4063.7 5040.6 5166.8 6110.4 6132.4 6151.7 5280.5 5481.9 5532.8 5705.3 5950.3 5856.6 5860.7 5916.4 5948.3 5970.9 4680.4 5088.9 5849.5 5874.1 5906.6 4991.3 5087.4 5372.6 5723.6 5876.6 5776.7 5822.2 5865.2 5885.4 5931.9 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - PROCESS | 1942 | [#5] yui.html Cycles:180 Average:25949.67 Median:13688.22 stddev:42905.25 (313.4%) stddev-sans-first:42983.23 16:50:29 INFO - PROCESS | 1942 | Values: 550.7 709.1 720.3 779.0 788.7 14776.0 14838.6 15061.4 15070.9 15083.5 11928.5 14296.6 14430.3 14446.0 14452.1 657.9 675.7 813.9 815.8 845.3 836.6 845.6 849.2 850.0 852.9 851.8 868.8 892.4 894.7 895.7 879.8 883.3 885.6 890.6 893.7 660.0 662.3 664.4 665.1 665.6 14867.6 14940.9 15111.5 15161.1 15188.9 14545.7 14602.3 14645.9 14656.0 14801.8 11405.3 11743.4 11755.9 11818.7 12155.6 3846.8 3860.8 3863.4 3895.3 3909.0 105191.0 107557.5 118025.4 119092.0 123346.0 11276.1 11311.5 11383.4 11474.3 11514.1 22952.2 22959.7 23613.8 23754.0 23885.9 7805.4 7962.5 8355.8 8393.5 8405.0 4482.9 4507.5 4567.5 4572.9 4610.1 3490.6 3629.9 3646.2 3650.8 3650.9 626.7 630.7 642.9 656.6 681.3 530.8 582.9 606.8 619.9 636.3 8625.2 9075.6 9184.9 9188.5 9283.1 534.4 534.8 590.3 610.2 628.6 4321.8 4444.6 4470.8 4493.2 4497.6 137865.0 140926.0 157193.0 166682.0 167758.0 139199.3 139428.3 141376.3 144463.0 145438.5 118706.4 119750.0 122260.0 124189.4 124240.0 7289.4 8736.8 8757.0 8809.6 8856.4 51480.5 67423.0 67957.0 68927.7 69584.7 101704.0 103515.0 103785.0 106266.0 106784.0 10208.4 10502.2 11169.6 11668.6 11865.6 12211.4 12258.6 12292.5 12330.3 12523.3 9902.0 11770.3 11801.3 12020.0 12136.9 11264.9 11803.4 11804.4 11889.2 12033.5 10980.3 11511.7 11557.4 11736.0 11875.0 9032.5 9878.0 10310.1 10368.5 10452.9 8676.0 10182.1 10238.9 10288.4 10373.7 16:50:29 INFO - PROCESS | 1942 | -------- Summary: end -------- 16:50:29 INFO - PROCESS | 1942 | 16:50:29 INFO - TEST-INFO | 1942: exit 0 16:50:29 INFO - TEST-OK | dromaeo_css | took 1112853ms 16:50:29 INFO - TEST-START | kraken 16:50:29 INFO - operating with platform_type : mac_ 16:50:29 INFO - Initialising browser for kraken test... 16:50:29 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpm4TPim/profile http://localhost:56581/getInfo.html) 16:50:32 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 16:50:32 INFO - PROCESS | 1947 | colorDepth:24 16:50:32 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 16:50:32 INFO - PROCESS | 1947 | __metrics 16:50:32 ERROR - PROCESS | 1947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:50:33 INFO - TEST-INFO | 1947: exit 0 16:50:33 INFO - Browser initialized. 16:50:33 INFO - Running cycle 1/1 for kraken test... 16:50:33 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmpm4TPim/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:45 INFO - PROCESS | 1949 | RSS: Main: 224559104 16:50:45 INFO - PROCESS | 1949 | 16:50:48 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:49 INFO - PROCESS | 1949 | RSS: Main: 237137920 16:50:49 INFO - PROCESS | 1949 | 16:50:51 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-dft) 16:50:52 INFO - PROCESS | 1949 | RSS: Main: 244527104 16:50:52 INFO - PROCESS | 1949 | 16:50:55 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-fft) 16:50:56 INFO - PROCESS | 1949 | RSS: Main: 248356864 16:50:56 INFO - PROCESS | 1949 | 16:50:58 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56581/tests/kraken/driver.html?testName=audio-oscillator) 16:50:58 INFO - PROCESS | 1949 | RSS: Main: 249942016 16:50:58 INFO - PROCESS | 1949 | 16:51:01 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:01 INFO - PROCESS | 1949 | RSS: Main: 250077184 16:51:01 INFO - PROCESS | 1949 | 16:51:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56581/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:05 INFO - PROCESS | 1949 | RSS: Main: 250621952 16:51:05 INFO - PROCESS | 1949 | 16:51:08 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56581/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:08 INFO - PROCESS | 1949 | RSS: Main: 250580992 16:51:08 INFO - PROCESS | 1949 | 16:51:11 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56581/tests/kraken/driver.html?testName=json-parse-financial) 16:51:12 INFO - PROCESS | 1949 | RSS: Main: 251056128 16:51:12 INFO - PROCESS | 1949 | 16:51:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:14 INFO - PROCESS | 1949 | RSS: Main: 250511360 16:51:14 INFO - PROCESS | 1949 | 16:51:16 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:16 INFO - PROCESS | 1949 | RSS: Main: 250646528 16:51:16 INFO - PROCESS | 1949 | 16:51:19 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:19 INFO - PROCESS | 1949 | RSS: Main: 250646528 16:51:19 INFO - PROCESS | 1949 | 16:51:22 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:23 INFO - PROCESS | 1949 | RSS: Main: 250679296 16:51:23 INFO - PROCESS | 1949 | 16:51:26 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:26 INFO - PROCESS | 1949 | RSS: Main: 251031552 16:51:26 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56581/tests/kraken/driver.html?testName=ai-astar) 16:51:28 INFO - PROCESS | 1949 | RSS: Main: 252665856 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | __start_tp_report 16:51:28 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 16:51:28 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 16:51:28 INFO - PROCESS | 1949 | |i|pagename|runs| 16:51:28 INFO - PROCESS | 1949 | |0;ai-astar;105;118;119;116;118;120;117;122;118;129 16:51:28 INFO - PROCESS | 1949 | |1;audio-beat-detection;143;114;116;155;112;115;111;110;137;112 16:51:28 INFO - PROCESS | 1949 | |2;audio-dft;196;204;196;198;194;196;195;195;199;198 16:51:28 INFO - PROCESS | 1949 | |3;audio-fft;81;60;60;84;60;75;79;85;68;52 16:51:28 INFO - PROCESS | 1949 | |4;audio-oscillator;92;97;120;102;98;65;125;101;101;97 16:51:28 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;91;89;92;103;93;87;92;93;92;128 16:51:28 INFO - PROCESS | 1949 | |6;imaging-darkroom;133;97;96;97;97;96;95;97;96;118 16:51:28 INFO - PROCESS | 1949 | |7;imaging-desaturate;92;95;91;93;113;123;92;91;93;92 16:51:28 INFO - PROCESS | 1949 | |8;json-parse-financial;56;57;56;56;59;61;58;60;60;59 16:51:28 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;68;76;70;103;81;74;71;70;73;72 16:51:28 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;86;87;81;87;83;85;87;88;92;129 16:51:28 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;136;138;139;136;153;144;169;163;172;149 16:51:28 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;168;165;167;164;166;233;232;175;162;169 16:51:28 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;67;68;70;68;71;67;64;67;78;77 16:51:28 INFO - PROCESS | 1949 | __end_tp_report 16:51:28 INFO - PROCESS | 1949 | __start_cc_report 16:51:28 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,960 16:51:28 INFO - PROCESS | 1949 | __end_cc_report 16:51:28 INFO - PROCESS | 1949 | __startTimestamp1475106688899__endTimestamp 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | ------- Summary: start ------- 16:51:28 INFO - PROCESS | 1949 | Number of tests: 14 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:118.20 Median:118.50 stddev:5.92 (5.0%) stddev-sans-first:3.91 16:51:28 INFO - PROCESS | 1949 | Values: 105.0 118.0 119.0 116.0 118.0 120.0 117.0 122.0 118.0 129.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:115.50 stddev:16.22 (14.0%) stddev-sans-first:15.41 16:51:28 INFO - PROCESS | 1949 | Values: 143.0 114.0 116.0 155.0 112.0 115.0 111.0 110.0 137.0 112.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:197.10 Median:197.00 stddev:2.88 (1.5%) stddev-sans-first:3.03 16:51:28 INFO - PROCESS | 1949 | Values: 196.0 204.0 196.0 198.0 194.0 196.0 195.0 195.0 199.0 198.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:70.40 Median:77.00 stddev:11.90 (15.5%) stddev-sans-first:11.99 16:51:28 INFO - PROCESS | 1949 | Values: 81.0 60.0 60.0 84.0 60.0 75.0 79.0 85.0 68.0 52.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:78.50 stddev:16.13 (20.5%) stddev-sans-first:16.86 16:51:28 INFO - PROCESS | 1949 | Values: 92.0 97.0 120.0 102.0 98.0 65.0 125.0 101.0 101.0 97.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:92.00 stddev:11.99 (13.0%) stddev-sans-first:12.58 16:51:28 INFO - PROCESS | 1949 | Values: 91.0 89.0 92.0 103.0 93.0 87.0 92.0 93.0 92.0 128.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:96.50 stddev:12.80 (13.3%) stddev-sans-first:7.24 16:51:28 INFO - PROCESS | 1949 | Values: 133.0 97.0 96.0 97.0 97.0 96.0 95.0 97.0 96.0 118.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:92.00 stddev:11.12 (12.1%) stddev-sans-first:11.61 16:51:28 INFO - PROCESS | 1949 | Values: 92.0 95.0 91.0 93.0 113.0 123.0 92.0 91.0 93.0 92.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:1.87 (3.2%) stddev-sans-first:1.81 16:51:28 INFO - PROCESS | 1949 | Values: 56.0 57.0 56.0 56.0 59.0 61.0 58.0 60.0 60.0 59.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:75.80 Median:72.50 stddev:10.24 (14.1%) stddev-sans-first:10.46 16:51:28 INFO - PROCESS | 1949 | Values: 68.0 76.0 70.0 103.0 81.0 74.0 71.0 70.0 73.0 72.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:87.00 stddev:13.84 (15.9%) stddev-sans-first:14.59 16:51:28 INFO - PROCESS | 1949 | Values: 86.0 87.0 81.0 87.0 83.0 85.0 87.0 88.0 92.0 129.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:151.00 stddev:13.81 (9.1%) stddev-sans-first:13.70 16:51:28 INFO - PROCESS | 1949 | Values: 136.0 138.0 139.0 136.0 153.0 144.0 169.0 163.0 172.0 149.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:168.50 stddev:27.83 (16.5%) stddev-sans-first:29.18 16:51:28 INFO - PROCESS | 1949 | Values: 168.0 165.0 167.0 164.0 166.0 233.0 232.0 175.0 162.0 169.0 16:51:28 INFO - PROCESS | 1949 | 16:51:28 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:4.52 (6.6%) stddev-sans-first:4.69 16:51:28 INFO - PROCESS | 1949 | Values: 67.0 68.0 70.0 68.0 71.0 67.0 64.0 67.0 78.0 77.0 16:51:28 INFO - PROCESS | 1949 | -------- Summary: end -------- 16:51:28 INFO - PROCESS | 1949 | 16:51:29 INFO - TEST-INFO | 1949: exit 0 16:51:29 INFO - TEST-OK | kraken | took 59928ms 16:51:29 INFO - SUITE-END | took 1172s 16:51:30 INFO - Completed test suite (00:19:32) 16:51:30 INFO - javascript benchmark 16:51:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.320380138565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.6648668646444, 3390.4405773047433, 3392.406328892445, 3404.965950340499, 3437.003269051975, 5782.710864456776, 5850.88298234035, 5862.2379090718205, 5873.2658417697785, 5883.646981181132, 5822.534197264219, 5851.268591426072, 5858.091995740657, 5893.793717219898, 5944.256967879015, 5273.367195936484, 5338.759755810978, 5378.0, 5381.300430943991, 5393.973030134844, 5367.812126575571, 5368.91946620801, 5384.973075134619, 5398.190271459273, 5453.563714902798, 5238.580913526927, 5266.447023062581, 5387.0841956867425, 5390.948764990829, 5394.244805727201, 5249.658772179815, 5285.365756109272, 5322.600804939645, 5335.226392173152, 5402.270693456372, 5156.252343410222, 5283.101872681615, 5293.100172970604, 5311.575073994071, 5345.1447768356875, 5663.2637757091725, 5795.855103622401, 5826.417358264182, 5928.199693041471, 5983.940160598382, 5227.26818245446, 5928.940710592882, 6206.565540412173, 6207.162033125561, 6212.565120441571, 6264.248290205159, 6282.623042617458, 6284.622922624611, 6288.465480434169, 6291.087792270141, 5924.4667979882015, 5952.642841429528, 5965.4115586690505, 5973.641581505123, 6013.1581578579035, 6136.243373036893, 6241.7191226394925, 6254.21822272216, 6311.589746666452, 6336.112944187817, 5165.096108181128, 5387.757550910218, 5830.41695830422, 6237.625742455467, 6264.9976003839165, 5283.682979021271, 6220.2314296379245, 6254.124422580842, 6279.403456671609, 6281.8743625127245, 6124.289394097934, 6190.288116866528, 6239.625622462667, 6243.37566243372, 6319.6208227506495, 6187.3503282155625, 6195.411435913581, 6228.128062071313, 6232.439080482778, 6308.558400911984, 4991.101601711727, 5002.949970500248, 5007.0, 5010.498950105033, 5012.899742005139, 4338.501072376717, 4423.1153769246275, 4449.466064072268, 4460.8661740147845, 4470.6870519064005, 5729.713514324267, 5770.798022069207, 5849.94150058494, 5914.940850591439, 5988.730507127189, 6194.0, 6250.312465628777, 6255.968720156461, 6267.7806276781, 6279.529035322369, 4607.884802879955, 4812.542808433193, 5616.943830561724, 5902.8819423611285, 5957.553183511254, 4207.84284321814, 5497.752601132958, 5503.807366742145, 5534.08687566547, 5547.528460080938, 6393.6163830170335, 6456.192975878015, 6466.997615369719, 6481.287058423475, 6489.286178520359, 6103.6032657877095, 6143.634700640197, 6249.906251406142, 6288.0, 6294.15028971083, 6381.170447841937, 6413.935860641521, 6430.710618022294, 6503.02454631809, 6519.511036672174, 6190.226221722285, 6193.916064688751, 6194.4115309045565, 6195.2255968004, 6202.224721909762, 5544.085225937675, 5847.7368518417625, 6123.862238009652, 6185.938140618537, 6297.559170857996, 6100.267967843887, 6104.145419641342, 6140.964409184605, 6145.446909778141, 6167.938320616737, 6107.929031871887, 6135.815925522242, 6143.784967526115, 6146.293176284785, 6159.384061593805, 5903.645781253139, 5991.6405015697455, 6148.262208535004, 6166.982447896226, 6175.0, 6141.293751218667, 6177.166082578794, 6181.320054794059, 6183.752649893954, 6300.180976473029, 6131.0, 6135.815925522242, 6143.262808462834, 6152.78465253714, 6169.290531588746], "value": 5731.71250110856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.5629539346833, 461.73911739866975, 464.23864861626936, 522.2740390856708, 533.8772082421042, 39997.60002399975, 41776.37335439971, 41874.0, 41908.790456047755, 41915.37126943098, 42329.7883510582, 42800.35799463003, 42804.0, 42810.35784463236, 42862.0, 9662.613495460173, 9863.901360986405, 9872.950635246814, 9899.15857152143, 9902.158316543102, 9737.026297370241, 9847.950760246189, 9855.605775768961, 9870.259730520203, 9890.653827116052, 9884.258680598949, 9911.752206194868, 9922.851157232648, 9924.851127233098, 9949.552270147824, 9848.0, 9878.901210987942, 9880.061394167542, 9884.703458896209, 9931.255155863339, 9751.90248097524, 9754.0733630305, 9774.071463210983, 9774.462404567746, 9889.307748457612, 39707.60292397097, 39737.0, 39798.80603581897, 39969.80015099935, 39990.600093998975, 3317.2370354818527, 3455.4125798614295, 3501.7023552998025, 3669.0, 4109.8972525686795, 30296.54555181674, 30299.848500757354, 30312.393752125055, 30871.684623653317, 30995.535066974015, 3170.461021626329, 3242.4974129010043, 3278.639349671534, 3294.1764558860286, 3381.2730262993327, 520002.0, 524635.0, 525926.9999999962, 529545.0, 532503.0, 59400.0, 60355.0, 60912.0, 60952.085718714254, 61051.0, 28528.144155675363, 35315.823420882734, 36661.81669091638, 55024.72487637536, 64105.03842442274, 16614.00315981045, 16756.581085472717, 16784.992900426012, 16790.74813877793, 16812.411565595146, 10875.945620272007, 12782.552610658582, 12883.677908052374, 12963.481460741465, 13005.21968681882, 18664.533386665444, 18884.43346699601, 19200.8079919199, 19230.423087307405, 19245.711314330296, 7924.960375198202, 7952.008231727077, 7979.321757650665, 8034.0, 8078.596070196467, 869.4044579462961, 1015.7765291635828, 1053.7207639975413, 1057.164839776568, 1089.8910108989037, 30053.699463005527, 30159.246018849266, 30165.245868853453, 30305.545416818764, 30679.69320306813, 1046.3094357723867, 1082.1991726122612, 1104.939228342433, 1114.8606424196976, 1150.5972909481613, 15271.923640381727, 15579.298931548108, 15604.21978901073, 15620.921895390678, 15782.0, 658393.0, 671059.0, 671701.0, 672540.0, 674114.0, 57111.428885711444, 57415.71292143512, 57427.0, 57639.423605763404, 57812.0, 1372.9244891530861, 1392.7353802777643, 1403.0459287684473, 1416.7379034878375, 1426.4650755966513, 26071.348216294744, 28755.13734587966, 29840.22908660227, 29905.551416728333, 30110.84944575351, 49462.29032822625, 50078.998420030664, 50097.998040039725, 50106.498935011645, 50329.74835125801, 569539.0, 571101.0, 572470.0, 572629.0, 574674.1266293642, 26537.60193597059, 26798.0, 26849.731502685503, 26894.462110758068, 26907.730922690524, 46335.76832115953, 46436.0, 46945.765271173426, 47393.0, 47946.76026619845, 37895.43156852594, 38104.428433574074, 38977.41533877051, 39062.023449413995, 40140.79929600333, 38712.64505742286, 38807.41788873113, 39792.403113952736, 39923.0, 40215.396769049075, 37331.81334093312, 37386.252274953804, 37723.43414848725, 38174.23651526898, 38225.808870955465, 32629.673703263612, 34244.82877585596, 34566.48150277697, 34667.826660866536, 34677.0, 25807.354816128995, 25824.741752582235, 25838.0, 25856.095036673625, 26068.34829129287], "value": 20074.96805439702, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.3752171395484, 377.8431950740443, 381.1652481066464, 384.07246499703217, 400.02194634119587, 18842.81157188428, 20480.69278960817, 21003.57992840142, 21035.789642103573, 21212.15151393946, 20198.485113616465, 20329.983500824936, 20372.0, 20536.075876585553, 20797.96010199488, 5785.305763308409, 5855.4144585541535, 6064.787732429366, 6110.8777824443705, 6165.445109940105, 3890.824912878927, 4097.815598298083, 6109.602875813058, 6152.5693201475915, 6163.167972323724, 5838.124281357809, 6089.725962331706, 6129.019356902896, 6173.228346456693, 6175.382461753811, 6129.693515324238, 6170.475509581691, 6671.899921501182, 6845.657717114124, 6857.759978400732, 5941.3761555036535, 6001.339852616209, 6030.849228769316, 6052.0, 6055.27336719592, 11064.944675276653, 13338.599842004756, 13353.532626358128, 13429.395677194452, 13436.932815335958, 2269.0016392787284, 2330.8251881108986, 2421.9273421797197, 2470.7529247075327, 2758.517259479603, 9906.07850363031, 9914.305998580103, 9944.801103977952, 10023.54894029763, 10144.391336519759, 1519.8252200996917, 1927.7012063130237, 1990.7810140884492, 1997.3808119483008, 2004.2784597544871, 117261.0, 120172.0, 120920.1861972071, 124863.3756831219, 125584.0, 9656.22750179984, 11389.829152562717, 11399.829002564968, 11640.301581905112, 11730.237534560398, 14287.928560357132, 14630.049046811922, 14694.044887082306, 14707.632309192355, 14739.484118055816, 8357.331413487029, 8592.226699596942, 8622.698205562901, 8715.738527844174, 8750.606222719993, 7109.289071092952, 8616.569171541398, 8682.479051256945, 8688.348373871984, 8735.170158835028, 4493.865184044484, 4515.367848501212, 4571.839985600488, 4613.169629466661, 4659.138059459011, 1595.6010997250687, 1953.5604488989864, 1958.285225892539, 1984.4245168900857, 2024.6861736430876, 702.5679207287482, 899.5068186809864, 945.8723072385278, 980.3284749946309, 1015.2284263959444, 20541.691874621894, 21061.052252648667, 21158.047887845085, 21174.941252937293, 21280.36158915235, 941.2987324443196, 945.1021529546958, 948.8481842905102, 976.1019861727228, 979.2802290316612, 8930.508822014852, 10715.35707857531, 10923.0, 10944.288621239593, 11002.669919902415, 628099.0, 633652.0, 639745.0, 651174.0, 652572.0, 100675.0, 100982.0, 117417.0, 129717.35141324233, 136646.63353366338, 848.749618862437, 966.9806603867884, 984.015984015984, 994.4828689081781, 996.2776986684596, 14412.927935360256, 17520.38678646241, 18249.726254106463, 18570.350037748613, 18726.063696815378, 55108.897822042534, 57100.0, 57235.713821430625, 57713.13430298633, 57857.84284314206, 68455.0, 68517.65741171263, 71989.84030479094, 82188.17811821806, 82928.0, 6967.930320696728, 7054.823629409306, 7357.374623157091, 7371.3734332582335, 7451.552906825608, 6897.413719833669, 10383.650125483638, 10667.986541278566, 10967.50646220906, 13499.86500134986, 10120.392776433437, 10850.177472434516, 10861.456927153453, 11479.311241325548, 11606.825897611374, 11049.944750276198, 11077.72305692332, 11150.498227579941, 11151.888481115086, 11452.656420307405, 8413.621387037476, 11287.097032237565, 11405.372704501333, 11678.357690327113, 11683.065354771768, 8127.959360203397, 8151.225633564802, 8181.550014749246, 8316.62575184106, 8348.123447037973, 8191.549464779256, 10201.489925503844, 10832.566697332333, 11170.218084733991, 11248.325100493996], "value": 9326.232567731082, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.7363211437996, 1543.6449616588184, 1732.4023211991866, 1794.8294911983373, 1870.1210431097388, 7872.29149376556, 8524.403291769579, 8758.91241087589, 8760.824783504335, 9332.953335233322, 8748.431351962117, 9033.322500812432, 9037.096290370959, 9140.360174787767, 9142.314326425529, 2371.3597328721235, 2410.9758902410927, 2414.6740190074293, 2418.117387153685, 2424.4666173441815, 2392.425817803732, 2398.640203969401, 2424.4544977380124, 2424.599941009731, 2435.5737745894485, 2373.1575290771784, 2404.95190096198, 2415.6618073469726, 2427.4416884116663, 2431.0761910473993, 2367.490989437279, 2375.5961486547244, 2381.773731495505, 2383.9284821455385, 2394.892229849661, 2007.5181956330375, 2353.5410594933996, 2361.846479978813, 2363.078399424226, 2364.0898254172093, 9023.503707296097, 9097.81804363909, 9155.313351498664, 9169.724908252763, 9175.449473031573, 5315.096433606296, 5459.3994660587305, 5479.150731636602, 5483.067878460672, 5489.478499542537, 3171.5876935998403, 3308.470644696861, 3598.604153543108, 3631.9455208171635, 3685.1708365617787, 1016.6630880392261, 1054.9977521354745, 1056.2025670618712, 1056.2764506313124, 1113.7995160871121, 11764.999975002049, 11843.111766617538, 11882.465289062013, 11909.285442873455, 11970.40147992597, 3703.4629978652943, 4645.628349732014, 4774.904501909942, 4882.926756098661, 4899.485554016848, 8607.440516366416, 10188.541515631814, 10268.486575671186, 10302.793944121076, 10345.689629311133, 5346.4386239445075, 5404.162354835007, 5433.157860531624, 5449.373322068013, 5450.236966824647, 4442.333649952533, 4586.3579098926175, 4803.871090293778, 4919.827806026843, 4932.55606995365, 3994.7416563782317, 4049.655779258796, 4116.835326586963, 4149.564295748964, 4150.315197992298, 1308.7055412532104, 1311.4885194774047, 1315.302889468583, 1321.3195204469705, 1328.5018118205674, 735.2647352647352, 780.6292011294589, 918.4948278446827, 939.8825146856643, 951.9143277105094, 5371.462853714597, 5943.781524787408, 5981.252343457068, 6121.693915304306, 6277.654728989949, 423.8495334156392, 428.45158197507243, 444.100696090413, 451.1540860885839, 452.70800333784524, 4093.8976525586504, 4122.237386083584, 4128.876133715993, 4144.626983571433, 4169.770662613585, 10764.3541387517, 11058.557657693764, 11156.832647510293, 11177.888221117684, 11191.104711623051, 11107.38909359993, 11120.777584448266, 11125.499352529156, 11126.443677816076, 11128.721781955515, 6913.274106218875, 7898.644560994769, 8262.42163048581, 8266.8346633067, 8445.704400346081, 6129.172561704113, 6152.446279834837, 6182.783602573888, 6200.193974783429, 6234.908890943976, 9944.552495137592, 10311.948440257751, 10374.948125259325, 10416.375017498975, 10466.372017678963, 10594.523246454082, 10634.09610183143, 10650.467476626292, 10651.680449586525, 10676.14590832716, 7184.389326907062, 7442.995195648518, 7634.694612215671, 7779.222077792176, 7923.524588524707, 8497.2777313929, 8596.269317108116, 8770.605322760619, 8782.209601135928, 8789.648414063622, 7677.692892284246, 7767.766966990999, 7815.609219539114, 7843.254890785366, 7915.366770658218, 7525.3227209551405, 7632.771016869503, 7642.847143056996, 7644.847103058019, 7649.847003060019, 7170.103737032871, 7287.1984081752025, 7293.671784769592, 7300.926990730025, 7301.415886729155, 5052.191649336089, 5098.515641014098, 5129.538341549279, 5204.557612602971, 5317.813876514303, 4964.528369804862, 5124.410692770379, 5222.529972302511, 5328.307320048369, 5340.359156901197], "value": 4587.763182698538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.43855271366186, 303.6902359593215, 308.64197530864186, 312.9295908420607, 316.4509575885838, 5413.702246376448, 5594.992901277768, 5713.857378441856, 5729.255196824412, 5789.942100578993, 4864.781084851182, 5419.566434685225, 5588.888222235563, 5599.7600959616175, 5623.297087864017, 3606.9098272543133, 4240.151969606076, 4278.636315913143, 4291.648130838791, 4317.201317756209, 3568.750937171995, 4154.6676265898805, 4251.341042138473, 4287.292596721537, 4298.226319262531, 4250.744955302692, 4252.914941701164, 4269.743815371072, 4274.922056119604, 4293.806778694966, 3619.9095022624383, 3912.1784425270725, 3987.381955796842, 4050.4531888195306, 4311.439512863339, 3695.4456831475227, 3711.2763011212824, 3736.5702944161226, 3737.1404576947184, 3743.794091324976, 5210.7915683373, 5431.456854314537, 5449.618526703132, 5456.427075157131, 5471.863203419906, 3826.6747326477284, 4112.773797441139, 4888.560029597318, 4890.315355850184, 4956.925646115311, 5543.861403464905, 5897.083447879456, 5906.763729450817, 5922.239377994961, 5954.464098231137, 3484.233468636896, 4054.655354294859, 4104.302268614343, 4127.855525056609, 4152.397902304179, 5317.787288508455, 6334.954732469137, 6372.872542549169, 6386.2975072741965, 6390.4248617624635, 3547.598698514124, 3907.4529565860803, 4172.645325147336, 4227.408162857202, 4246.426732391149, 3814.703000979625, 4040.252553277653, 4270.679699022586, 4276.337167739005, 4282.336237883133, 4387.670924680661, 4907.08623636782, 4919.434265059493, 4936.531029552187, 5003.74981250936, 5687.971560142173, 5989.431004054608, 5996.490298324604, 6001.5798894077, 6066.696665166724, 1139.32779660001, 1361.515947617102, 1377.5522955039653, 1380.2339701465783, 1469.544441223224, 812.4515951732557, 856.0241324889631, 911.148076548416, 913.9908600913906, 915.3683958068912, 3835.6547910688173, 4373.715708478939, 4473.6868419211, 4724.669273150916, 4775.498572649822, 4618.722876627413, 4679.525949325952, 4781.665283430196, 4981.452040275567, 5272.762725677354, 4325.351197320427, 4365.301551751768, 4419.602495516981, 4424.566488431415, 4439.62263207631, 2722.564389697639, 2772.5702516110036, 2966.1546459259007, 3180.3480286541203, 3271.3479692755004, 5451.836444906659, 6001.849953751103, 6412.454941330039, 6452.322506136788, 6456.611828456905, 5516.9448305516435, 5795.420457954171, 5975.282966044016, 6375.330590288046, 6395.880720873828, 5412.756425960842, 5783.681897495594, 6106.694665266719, 6499.0, 6511.609303441809, 6027.60820546663, 6046.767262915889, 6192.969035154795, 6220.533459990609, 6225.501959843111, 5138.332016837787, 5344.663834041489, 6046.334903160561, 6120.877582448237, 6123.0, 6037.69811509414, 6070.817875463743, 6252.5935814171935, 6412.807615771534, 6464.191976003, 3291.555639988571, 3796.9430458543698, 3995.5405128410603, 4032.1330913853662, 4063.7358571692744, 5040.57155141817, 5166.844994650167, 6110.388961103854, 6132.386761323832, 6151.723172457339, 5280.524752772269, 5481.917771233514, 5532.778688852401, 5705.343885453226, 5950.256217972754, 5856.5739042660525, 5860.706964651836, 5916.408359164049, 5948.315943666534, 5970.850728731816, 4680.438347398198, 5088.923666145085, 5849.502792262535, 5874.123078767992, 5906.586538942232, 4991.302882685471, 5087.364079490064, 5372.597055220952, 5723.599348045764, 5876.6180198286975, 5776.671365586023, 5822.243108395882, 5865.208196893535, 5885.440883116097, 5931.851703707442], "value": 4231.929512820307, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.6998685716284, 709.131314140178, 720.27972027972, 778.9532628042318, 788.7476007677544, 14776.0, 14838.55484335469, 15061.397544098236, 15070.924645376757, 15083.547493575183, 11928.522859085626, 14296.571102866905, 14430.278486075707, 14446.0, 14452.132872027685, 657.9144711187539, 675.6891829758317, 813.8535063688533, 815.8449894520022, 845.2730651639584, 836.6109758962082, 845.602566793606, 849.235687880909, 849.9915000850006, 852.9445586036887, 851.8083431227955, 868.8045189832301, 892.4333048514208, 894.7360528644033, 895.7312806158159, 879.7844528090595, 883.3419102768446, 885.6457417033238, 890.585877566928, 893.70954439807, 659.960402375859, 662.3376623376623, 664.4086762781129, 665.1286814273318, 665.5873358517701, 14867.628309292355, 14940.850591494163, 15111.54665360041, 15161.09033457996, 15188.924055379763, 14545.709085818331, 14602.34289456977, 14645.926770366186, 14656.047356921767, 14801.777973330409, 11405.31568105908, 11743.354115523643, 11755.941965223086, 11818.704532386759, 12155.574554890536, 3846.76919384835, 3860.8455661773496, 3863.3625451800417, 3895.2793733159174, 3909.042284640281, 105191.0, 107557.46221268922, 118025.40987295094, 119092.0, 123346.0, 11276.097912167006, 11311.547538098548, 11383.373914434786, 11474.311541307548, 11514.078873690085, 22952.19667311636, 22959.655605165935, 23613.763862361156, 23754.049838006285, 23885.880570597037, 7805.41459390548, 7962.522248665098, 8355.832883342298, 8393.496390216484, 8404.957975210207, 4482.910341793146, 4507.5267096955, 4567.474740404896, 4572.862814115582, 4610.05493873755, 3490.5636795400574, 3629.854805807738, 3646.197836475971, 3650.799206043693, 3650.8904732858055, 626.7179769103831, 630.7287866217571, 642.8617847162883, 656.6322859198864, 681.3322943515383, 530.8407477756657, 582.8892510423007, 606.75123199488, 619.9380061993854, 636.3477435628517, 8625.223729864343, 9075.635249862373, 9184.908150918405, 9188.494632795127, 9283.11810378013, 534.3747815056394, 534.8154886564129, 590.306389991758, 610.1823556434399, 628.6322501336678, 4321.827126914888, 4444.555544445594, 4470.754108523997, 4493.213687604656, 4497.550244975541, 137865.0, 140926.0, 157193.0, 166682.0, 167758.0, 139199.30400348135, 139428.30285848505, 141376.2931185358, 144463.0, 145438.54561454462, 118706.40646796883, 119750.0, 122260.0, 124189.37905310416, 124240.0, 7289.380402665833, 8736.825263494822, 8757.0, 8809.559522024001, 8856.380053396459, 51480.48519514907, 67423.0, 67957.0, 68927.65536172286, 69584.6520767393, 101704.0, 103514.96485035354, 103785.0, 106266.0, 106784.0, 10208.438535880598, 10502.212334074822, 11169.553217871195, 11668.649940501798, 11865.644030678748, 12211.412516372815, 12258.570950016707, 12292.50829966827, 12330.260184388966, 12523.311217883103, 9901.950490247502, 11770.293782373084, 11801.29192248468, 12020.0, 12136.878631213574, 11264.94367528157, 11803.409829508662, 11804.40977951082, 11889.167758256839, 12033.518659253881, 10980.286281391684, 11511.712207194552, 11557.364344960772, 11736.002439792372, 11875.0, 9032.45805251687, 9878.0, 10310.07209351162, 10368.481575921325, 10452.895471045193, 8676.045634980273, 10182.134518566005, 10238.873723890516, 10288.434136122585, 10373.68878933603], "value": 7636.691782779941, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 119.0, 116.0, 118.0, 120.0, 117.0, 122.0, 118.0, 129.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 116.0, 155.0, 112.0, 115.0, 111.0, 110.0, 137.0, 112.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 204.0, 196.0, 198.0, 194.0, 196.0, 195.0, 195.0, 199.0, 198.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 84.0, 60.0, 75.0, 79.0, 85.0, 68.0, 52.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 120.0, 102.0, 98.0, 65.0, 125.0, 101.0, 101.0, 97.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 92.0, 103.0, 93.0, 87.0, 92.0, 93.0, 92.0, 128.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 97.0, 96.0, 97.0, 97.0, 96.0, 95.0, 97.0, 96.0, 118.0], "value": 102.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 91.0, 93.0, 113.0, 123.0, 92.0, 91.0, 93.0, 92.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 59.0, 61.0, 58.0, 60.0, 60.0, 59.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 70.0, 103.0, 81.0, 74.0, 71.0, 70.0, 73.0, 72.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 81.0, 87.0, 83.0, 85.0, 87.0, 88.0, 92.0, 129.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 139.0, 136.0, 153.0, 144.0, 169.0, 163.0, 172.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 167.0, 164.0, 166.0, 233.0, 232.0, 175.0, 162.0, 169.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 68.0, 71.0, 67.0, 64.0, 67.0, 78.0, 77.0], "value": 69.7, "unit": "score"}]}]} 16:51:30 INFO - Return code: 0 16:51:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:30 ERROR - # TBPL SUCCESS # 16:51:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:51:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:51:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:51:30 INFO - 2016-09-28 16:51:30.196 screenresolution[1954:25859] starting screenresolution argv=screenresolution get 16:51:30 INFO - 2016-09-28 16:51:30.200 screenresolution[1954:25859] Display 0: 1600x1200x32@60 16:51:30 INFO - 2016-09-28 16:51:30.207 screenresolution[1955:25862] starting screenresolution argv=screenresolution list 16:51:30 INFO - Available Modes on Display 0 16:51:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:51:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:51:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:51:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:51:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:51:30 INFO - Intel Iris: 16:51:30 INFO - Chipset Model: Intel Iris 16:51:30 INFO - Type: GPU 16:51:30 INFO - Bus: Built-In 16:51:30 INFO - VRAM (Dynamic, Max): 1536 MB 16:51:30 INFO - Vendor: Intel (0x8086) 16:51:30 INFO - Device ID: 0x0a2e 16:51:30 INFO - Revision ID: 0x0009 16:51:30 INFO - Displays: 16:51:30 INFO - Display: 16:51:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:51:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:51:30 INFO - Display Serial Number: 1600x1200 60 16:51:30 INFO - Main Display: Yes 16:51:30 INFO - Mirror: Off 16:51:30 INFO - Online: Yes 16:51:30 INFO - Rotation: Supported 16:51:30 INFO - Return code: 0 16:51:30 INFO - Running post-action listener: _resource_record_post_action 16:51:30 INFO - [mozharness: 2016-09-28 23:51:30.453297Z] Finished run-tests step (success) 16:51:30 INFO - Running post-run listener: _resource_record_post_run 16:51:30 INFO - Total resource usage - Wall time: 1206s; CPU: 55.0%; Read bytes: 716800; Write bytes: 661934080; Read time: 7; Write time: 2147 16:51:30 INFO - TinderboxPrint: CPU usage
54.6% 16:51:30 INFO - TinderboxPrint: I/O read bytes / time
716,800 / 7 16:51:30 INFO - TinderboxPrint: I/O write bytes / time
661,934,080 / 2,147 16:51:30 INFO - TinderboxPrint: CPU idle
2,192.2 (45.4%) 16:51:30 INFO - TinderboxPrint: CPU system
982.6 (20.4%) 16:51:30 INFO - TinderboxPrint: CPU user
1,650.9 (34.2%) 16:51:30 INFO - TinderboxPrint: Swap in / out
363,368,448 / 0 16:51:30 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 362045952; Write bytes: 357316096; Read time: 28769; Write time: 679 16:51:30 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 679936; Write bytes: 294271488; Read time: 6; Write time: 1430 16:51:30 INFO - Running post-run listener: _upload_blobber_files 16:51:30 INFO - Blob upload gear active. 16:51:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:51:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:51:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:51:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:33 INFO - (blobuploader) - INFO - Done attempting. 16:51:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:51:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:51:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:34 INFO - (blobuploader) - INFO - Done attempting. 16:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:38 INFO - (blobuploader) - INFO - Done attempting. 16:51:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:38 INFO - Return code: 0 16:51:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9412aef68a6753e628a333622912d99f6ee7023663f2dfe6f7522a849d2ae5be51b30c6778536f24528cf95a41b808d4915309294b25001693b01f6027674687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca894d06e11b771217421968ab278cdcca14f8850a21ab63478584bbd9b099d0d608ac12321754817620ff23d7a34a0c634a096dec3cc1b4fa2ee67aed8dbe6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7770f51fbd75140f3659e2e78f34a1f327c1ea2e5836e10c259eabb3e10724dfdd348f2562c7f4b9673e68b9f2e7807fb897d81b0394f2e4094bd2f423f79908"} 16:51:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:38 INFO - Contents: 16:51:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9412aef68a6753e628a333622912d99f6ee7023663f2dfe6f7522a849d2ae5be51b30c6778536f24528cf95a41b808d4915309294b25001693b01f6027674687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca894d06e11b771217421968ab278cdcca14f8850a21ab63478584bbd9b099d0d608ac12321754817620ff23d7a34a0c634a096dec3cc1b4fa2ee67aed8dbe6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7770f51fbd75140f3659e2e78f34a1f327c1ea2e5836e10c259eabb3e10724dfdd348f2562c7f4b9673e68b9f2e7807fb897d81b0394f2e4094bd2f423f79908"} 16:51:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:38 INFO - Copying logs to upload dir... 16:51:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.270008 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-09-28 16:51:38.852949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 16:51:38.858616) ========= 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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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/Mozilla-Aurora/sha512/9412aef68a6753e628a333622912d99f6ee7023663f2dfe6f7522a849d2ae5be51b30c6778536f24528cf95a41b808d4915309294b25001693b01f6027674687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca894d06e11b771217421968ab278cdcca14f8850a21ab63478584bbd9b099d0d608ac12321754817620ff23d7a34a0c634a096dec3cc1b4fa2ee67aed8dbe6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7770f51fbd75140f3659e2e78f34a1f327c1ea2e5836e10c259eabb3e10724dfdd348f2562c7f4b9673e68b9f2e7807fb897d81b0394f2e4094bd2f423f79908"} build_url:https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/PesIZ8SSQLa3gyn0yl2n_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9412aef68a6753e628a333622912d99f6ee7023663f2dfe6f7522a849d2ae5be51b30c6778536f24528cf95a41b808d4915309294b25001693b01f6027674687", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ca894d06e11b771217421968ab278cdcca14f8850a21ab63478584bbd9b099d0d608ac12321754817620ff23d7a34a0c634a096dec3cc1b4fa2ee67aed8dbe6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7770f51fbd75140f3659e2e78f34a1f327c1ea2e5836e10c259eabb3e10724dfdd348f2562c7f4b9673e68b9f2e7807fb897d81b0394f2e4094bd2f423f79908"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 16:51:38.891055) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:51:38.891431) ========= 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.DX2kfQQlyl/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.yRB8fBdBGE/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.004940 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:51:38.940077) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 16:51:38.943432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 16:51:38.943764) ========= ========= Total master_lag: 0.17 =========