builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0123 starttime: 1486032350.23 results: success (0) buildid: 20170202015108 builduid: 7f938b69f9c04f6986f4380187aa5839 revision: 6ad72b5a43e15125e1baf4a88183b467c042894e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.226303) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.226943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.227271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.248588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.248952) ========= 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.a4apB3jfpf/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.MvO1v3F0mS/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-02 02:45:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.93M=0.001s 2017-02-02 02:45:50 (7.93 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.384290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.384600) ========= 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.a4apB3jfpf/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.MvO1v3F0mS/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.022634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:50.433183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 02:45:50.433553) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6ad72b5a43e15125e1baf4a88183b467c042894e --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 6ad72b5a43e15125e1baf4a88183b467c042894e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a4apB3jfpf/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.MvO1v3F0mS/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-02 02:45:50,519 truncating revision to first 12 chars 2017-02-02 02:45:50,519 Setting DEBUG logging. 2017-02-02 02:45:50,519 attempt 1/10 2017-02-02 02:45:50,519 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6ad72b5a43e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 02:45:51,292 unpacking tar archive at: mozilla-aurora-6ad72b5a43e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.041893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 02:45:51.498704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:51.499121) ========= script_repo_revision: 6ad72b5a43e15125e1baf4a88183b467c042894e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:51.499515) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:51.499775) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 02:45:51.519828) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-02 02:45:51.520135) ========= /tools/buildbot/bin/python -u 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', '-u', '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:45:51 INFO - MultiFileLogger online at 20170202 02:45:51 in /builds/slave/test 02:45:51 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 02:45:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:51 INFO - {'append_to_log': False, 02:45:51 INFO - 'base_work_dir': '/builds/slave/test', 02:45:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:45:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:51 INFO - 'branch': 'Mozilla-Aurora', 02:45:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:51 INFO - 'config_files': ('talos/mac_config.py',), 02:45:51 INFO - 'default_actions': ('clobber', 02:45:51 INFO - 'read-buildbot-config', 02:45:51 INFO - 'download-and-extract', 02:45:51 INFO - 'populate-webroot', 02:45:51 INFO - 'create-virtualenv', 02:45:51 INFO - 'install', 02:45:51 INFO - 'run-tests'), 02:45:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:51 INFO - 'download_minidump_stackwalk': True, 02:45:51 INFO - 'download_symbols': 'ondemand', 02:45:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:51 INFO - 'installer_path': 'installer.exe', 02:45:51 INFO - 'log_level': 'info', 02:45:51 INFO - 'log_name': 'talos', 02:45:51 INFO - 'log_to_console': True, 02:45:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:45:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:45:51 INFO - 'opt_config_files': (), 02:45:51 INFO - 'pip_index': False, 02:45:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:51 INFO - 'cmd': ('bash', 02:45:51 INFO - '-c', 02:45:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:51 INFO - 'enabled': True, 02:45:51 INFO - 'halt_on_failure': False, 02:45:51 INFO - 'name': 'check_screen_resolution'},), 02:45:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:45:51 INFO - 'cmd': ('bash', 02:45:51 INFO - '-c', 02:45:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:45:51 INFO - 'enabled': True, 02:45:51 INFO - 'halt_on_failure': False, 02:45:51 INFO - 'name': 'check_screen_resolution'},), 02:45:51 INFO - 'run_cmd_checks_enabled': True, 02:45:51 INFO - 'sps_profile': False, 02:45:51 INFO - 'sps_profile_interval': 0, 02:45:51 INFO - 'suite': 'dromaeojs-e10s', 02:45:51 INFO - 'system_bits': '32', 02:45:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:51 INFO - 'title': 't-yosemite-r7-0123', 02:45:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:51 INFO - 'use_talos_json': True, 02:45:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:51 INFO - 'work_dir': 'build'} 02:45:51 INFO - [mozharness: 2017-02-02 10:45:51.727579Z] Running clobber step. 02:45:51 INFO - Running pre-action listener: _resource_record_pre_action 02:45:51 INFO - Running main action method: clobber 02:45:51 INFO - rmtree: /builds/slave/test/build 02:45:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:52 INFO - Running post-action listener: _resource_record_post_action 02:45:52 INFO - [mozharness: 2017-02-02 10:45:52.660706Z] Finished clobber step (success) 02:45:52 INFO - [mozharness: 2017-02-02 10:45:52.660905Z] Running read-buildbot-config step. 02:45:52 INFO - Running pre-action listener: _resource_record_pre_action 02:45:52 INFO - Running main action method: read_buildbot_config 02:45:52 INFO - Using buildbot properties: 02:45:52 INFO - { 02:45:52 INFO - "project": "", 02:45:52 INFO - "product": "firefox", 02:45:52 INFO - "script_repo_revision": "production", 02:45:52 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:45:52 INFO - "repository": "", 02:45:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:45:52 INFO - "buildid": "20170202015108", 02:45:52 INFO - "pgo_build": "False", 02:45:52 INFO - "basedir": "/builds/slave/test", 02:45:52 INFO - "buildnumber": 32, 02:45:52 INFO - "slavename": "t-yosemite-r7-0123", 02:45:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:45:52 INFO - "platform": "yosemite_r7", 02:45:52 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:45:52 INFO - "branch": "mozilla-aurora", 02:45:52 INFO - "repo_path": "releases/mozilla-aurora", 02:45:52 INFO - "revision": "6ad72b5a43e15125e1baf4a88183b467c042894e", 02:45:52 INFO - "stage_platform": "macosx64", 02:45:52 INFO - "builduid": "7f938b69f9c04f6986f4380187aa5839", 02:45:52 INFO - "slavebuilddir": "test" 02:45:52 INFO - } 02:45:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:45:52 INFO - Running post-action listener: _resource_record_post_action 02:45:52 INFO - [mozharness: 2017-02-02 10:45:52.664594Z] Finished read-buildbot-config step (success) 02:45:52 INFO - [mozharness: 2017-02-02 10:45:52.664850Z] Running download-and-extract step. 02:45:52 INFO - Running pre-action listener: _resource_record_pre_action 02:45:52 INFO - Running main action method: download_and_extract 02:45:52 INFO - mkdir: /builds/slave/test/build/tests 02:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:52 INFO - trying https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:45:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:45:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:45:54 INFO - Downloaded 1199 bytes. 02:45:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:45:54 INFO - Using the following test package requirements: 02:45:54 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:45:54 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:45:54 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:45:54 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'jsshell-mac.zip'], 02:45:54 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:45:54 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:45:54 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:45:54 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:45:54 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:45:54 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:45:54 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:45:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:45:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:45:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:45:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:45:55 INFO - Expected file size: 16355929 02:45:55 INFO - Obtained file size: 16355929 02:46:01 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:46:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:46:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:46:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:46:02 INFO - Expected file size: 16355929 02:46:02 INFO - Obtained file size: 16355929 02:46:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:46:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:46:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:46:10 INFO - Expected file size: 14403485 02:46:10 INFO - Obtained file size: 14403485 02:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:10 INFO - trying https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:46:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:46:12 INFO - Downloaded 73824061 bytes. 02:46:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:46:12 INFO - mkdir: /builds/slave/test/properties 02:46:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:46:12 INFO - Writing to file /builds/slave/test/properties/build_url 02:46:12 INFO - Contents: 02:46:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:46:13 INFO - Running post-action listener: _resource_record_post_action 02:46:13 INFO - Running post-action listener: set_extra_try_arguments 02:46:13 INFO - [mozharness: 2017-02-02 10:46:13.567311Z] Finished download-and-extract step (success) 02:46:13 INFO - [mozharness: 2017-02-02 10:46:13.567458Z] Running populate-webroot step. 02:46:13 INFO - Running pre-action listener: _resource_record_pre_action 02:46:13 INFO - Running main action method: populate_webroot 02:46:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:46:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:46:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:46:13 INFO - '--tppagecycles', 02:46:13 INFO - '7'], 02:46:13 INFO - 'tests': ['tsvgm']}}, 02:46:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:46:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:46:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:46:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:46:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:46:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['damp', 'tps']}, 02:46:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'tests': ['damp', 'tps']}, 02:46:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['dromaeo_dom']}, 02:46:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:46:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['basic_compositor_video']}, 02:46:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:46:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['a11yr', 02:46:13 INFO - 'ts_paint', 02:46:13 INFO - 'tpaint', 02:46:13 INFO - 'sessionrestore', 02:46:13 INFO - 'sessionrestore_no_auto_restore', 02:46:13 INFO - 'tabpaint']}, 02:46:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:46:13 INFO - 'ts_paint', 02:46:13 INFO - 'tpaint', 02:46:13 INFO - 'sessionrestore', 02:46:13 INFO - 'sessionrestore_no_auto_restore', 02:46:13 INFO - 'tabpaint']}, 02:46:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:46:13 INFO - 'ts_paint', 02:46:13 INFO - 'tpaint', 02:46:13 INFO - 'sessionrestore', 02:46:13 INFO - 'sessionrestore_no_auto_restore', 02:46:13 INFO - 'tabpaint']}, 02:46:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:46:13 INFO - 'ts_paint', 02:46:13 INFO - 'tpaint', 02:46:13 INFO - 'sessionrestore', 02:46:13 INFO - 'sessionrestore_no_auto_restore', 02:46:13 INFO - 'tabpaint']}, 02:46:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['a11yr', 02:46:13 INFO - 'ts_paint', 02:46:13 INFO - 'tpaint', 02:46:13 INFO - 'sessionrestore', 02:46:13 INFO - 'sessionrestore_no_auto_restore', 02:46:13 INFO - 'tabpaint']}, 02:46:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['a11yr', 02:46:13 INFO - 'ts_paint', 02:46:13 INFO - 'tpaint', 02:46:13 INFO - 'sessionrestore', 02:46:13 INFO - 'sessionrestore_no_auto_restore', 02:46:13 INFO - 'tabpaint']}, 02:46:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['tsvgx', 02:46:13 INFO - 'tsvgr_opacity', 02:46:13 INFO - 'tart', 02:46:13 INFO - 'tscrollx', 02:46:13 INFO - 'cart', 02:46:13 INFO - 'tsvg_static']}, 02:46:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:46:13 INFO - 'tsvgr_opacity', 02:46:13 INFO - 'tart', 02:46:13 INFO - 'tscrollx', 02:46:13 INFO - 'cart', 02:46:13 INFO - 'tsvg_static']}, 02:46:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'talos_options': ['--disable-e10s'], 02:46:13 INFO - 'tests': ['tp5o']}, 02:46:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:46:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'talos_options': ['--disable-e10s', 02:46:13 INFO - '--xperf_path', 02:46:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:13 INFO - 'tests': ['tp5n']}, 02:46:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:46:13 INFO - 'talos_options': ['--xperf_path', 02:46:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:46:13 INFO - 'tests': ['tp5n']}}, 02:46:13 INFO - 'talos.zip': {'path': '', 02:46:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:46:13 INFO - Running post-action listener: _resource_record_post_action 02:46:13 INFO - [mozharness: 2017-02-02 10:46:13.586005Z] Finished populate-webroot step (success) 02:46:13 INFO - [mozharness: 2017-02-02 10:46:13.586138Z] Running create-virtualenv step. 02:46:13 INFO - Running pre-action listener: _resource_record_pre_action 02:46:13 INFO - Running main action method: create_virtualenv 02:46:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:46:13 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 02:46:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:46:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:46:13 INFO - Using real prefix '/tools/python27' 02:46:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:46:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:46:17 INFO - Installing pip.................done. 02:46:17 INFO - Return code: 0 02:46:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:46:17 INFO - Reading from file tmpfile_stdout 02:46:17 INFO - Output received: 02:46:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:46:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:17 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:17 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 02:46:17 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 02:46:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:17 INFO - 'HOME': '/Users/cltbld', 02:46:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:17 INFO - 'LOGNAME': 'cltbld', 02:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:17 INFO - 'MOZ_NO_REMOTE': '1', 02:46:17 INFO - 'NO_EM_RESTART': '1', 02:46:17 INFO - 'PAGER': '/bin/cat', 02:46:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:17 INFO - 'PWD': '/builds/slave/test', 02:46:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:17 INFO - 'SHELL': '/bin/bash', 02:46:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:17 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:17 INFO - 'USER': 'cltbld', 02:46:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:17 INFO - 'XPC_FLAGS': '0x0', 02:46:17 INFO - 'XPC_SERVICE_NAME': '0', 02:46:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:17 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 02:46:17 INFO - Cleaning up... 02:46:17 INFO - Return code: 0 02:46:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:17 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:17 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 02:46:17 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 02:46:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:17 INFO - 'HOME': '/Users/cltbld', 02:46:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:17 INFO - 'LOGNAME': 'cltbld', 02:46:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:17 INFO - 'MOZ_NO_REMOTE': '1', 02:46:17 INFO - 'NO_EM_RESTART': '1', 02:46:17 INFO - 'PAGER': '/bin/cat', 02:46:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:17 INFO - 'PWD': '/builds/slave/test', 02:46:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:17 INFO - 'SHELL': '/bin/bash', 02:46:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:17 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:17 INFO - 'USER': 'cltbld', 02:46:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:17 INFO - 'XPC_FLAGS': '0x0', 02:46:17 INFO - 'XPC_SERVICE_NAME': '0', 02:46:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:18 INFO - Downloading/unpacking psutil>=3.1.1 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:18 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 02:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:46:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:21 INFO - Installing collected packages: psutil 02:46:21 INFO - Running setup.py install for psutil 02:46:22 INFO - building 'psutil._psutil_osx' extension 02:46:22 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 02:46:22 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 02:46:22 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 02:46:22 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 02:46:22 INFO - building 'psutil._psutil_posix' extension 02:46:22 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 02:46:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:46:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:46:22 INFO - ^ 02:46:22 INFO - 1 warning generated. 02:46:22 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 02:46:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:46:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:46:22 INFO - Successfully installed psutil 02:46:22 INFO - Cleaning up... 02:46:22 INFO - Return code: 0 02:46:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:46: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')]} 02:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46: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')]} 02:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:46:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:22 INFO - 'HOME': '/Users/cltbld', 02:46:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:22 INFO - 'LOGNAME': 'cltbld', 02:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:22 INFO - 'MOZ_NO_REMOTE': '1', 02:46:22 INFO - 'NO_EM_RESTART': '1', 02:46:22 INFO - 'PAGER': '/bin/cat', 02:46:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:22 INFO - 'PWD': '/builds/slave/test', 02:46:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:22 INFO - 'SHELL': '/bin/bash', 02:46:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:22 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:22 INFO - 'USER': 'cltbld', 02:46:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:22 INFO - 'XPC_FLAGS': '0x0', 02:46:22 INFO - 'XPC_SERVICE_NAME': '0', 02:46:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:46:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:46:25 INFO - Installing collected packages: mozsystemmonitor 02:46:25 INFO - Running setup.py install for mozsystemmonitor 02:46:26 INFO - Successfully installed mozsystemmonitor 02:46:26 INFO - Cleaning up... 02:46:26 INFO - Return code: 0 02:46:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:26 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:26 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 02:46:26 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 02:46:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:26 INFO - 'HOME': '/Users/cltbld', 02:46:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:26 INFO - 'LOGNAME': 'cltbld', 02:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:26 INFO - 'MOZ_NO_REMOTE': '1', 02:46:26 INFO - 'NO_EM_RESTART': '1', 02:46:26 INFO - 'PAGER': '/bin/cat', 02:46:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:26 INFO - 'PWD': '/builds/slave/test', 02:46:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:26 INFO - 'SHELL': '/bin/bash', 02:46:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:26 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:26 INFO - 'USER': 'cltbld', 02:46:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:26 INFO - 'XPC_FLAGS': '0x0', 02:46:26 INFO - 'XPC_SERVICE_NAME': '0', 02:46:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:26 INFO - Downloading/unpacking jsonschema==2.5.1 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:46:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:46:28 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 02:46:28 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 02:46:28 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 02:46:28 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 02:46:28 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 02:46:28 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 02:46:29 INFO - Downloading functools32-3.2.3-2.tar.gz 02:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:46:29 INFO - warning: no files found matching '*.txt' 02:46:29 INFO - no previously-included directories found matching 'build' 02:46:29 INFO - no previously-included directories found matching 'dist' 02:46:29 INFO - no previously-included directories found matching '.git*' 02:46:29 INFO - Installing collected packages: jsonschema, functools32 02:46:29 INFO - Running setup.py install for functools32 02:46:29 INFO - warning: no files found matching '*.txt' 02:46:29 INFO - no previously-included directories found matching 'build' 02:46:29 INFO - no previously-included directories found matching 'dist' 02:46:29 INFO - no previously-included directories found matching '.git*' 02:46:29 INFO - Successfully installed jsonschema functools32 02:46:29 INFO - Cleaning up... 02:46:29 INFO - Return code: 0 02:46:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:46:29 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')]} 02:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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')]} 02:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:29 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 02:46:29 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 02:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:29 INFO - 'HOME': '/Users/cltbld', 02:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:29 INFO - 'LOGNAME': 'cltbld', 02:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:29 INFO - 'MOZ_NO_REMOTE': '1', 02:46:29 INFO - 'NO_EM_RESTART': '1', 02:46:29 INFO - 'PAGER': '/bin/cat', 02:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:29 INFO - 'PWD': '/builds/slave/test', 02:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:29 INFO - 'SHELL': '/bin/bash', 02:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:29 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:29 INFO - 'USER': 'cltbld', 02:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:29 INFO - 'XPC_FLAGS': '0x0', 02:46:29 INFO - 'XPC_SERVICE_NAME': '0', 02:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:46:29 INFO - Cleaning up... 02:46:29 INFO - Return code: 0 02:46:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:46:29 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')]} 02:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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')]} 02:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:29 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:29 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 02:46:29 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 02:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:29 INFO - 'HOME': '/Users/cltbld', 02:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:29 INFO - 'LOGNAME': 'cltbld', 02:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:29 INFO - 'MOZ_NO_REMOTE': '1', 02:46:29 INFO - 'NO_EM_RESTART': '1', 02:46:29 INFO - 'PAGER': '/bin/cat', 02:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:29 INFO - 'PWD': '/builds/slave/test', 02:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:29 INFO - 'SHELL': '/bin/bash', 02:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:29 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:29 INFO - 'USER': 'cltbld', 02:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:29 INFO - 'XPC_FLAGS': '0x0', 02:46:29 INFO - 'XPC_SERVICE_NAME': '0', 02:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:30 INFO - Downloading/unpacking blobuploader==1.2.4 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:46:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:46:32 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 02:46:32 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 02:46:32 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 02:46:32 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 02:46:32 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 02:46:32 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 02:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:46:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:34 INFO - Downloading docopt-0.6.1.tar.gz 02:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:46:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:46:34 INFO - Running setup.py install for blobuploader 02:46:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:46:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:46:34 INFO - Running setup.py install for requests 02:46:34 INFO - Running setup.py install for docopt 02:46:34 INFO - Successfully installed blobuploader requests docopt 02:46:34 INFO - Cleaning up... 02:46:35 INFO - Return code: 0 02:46:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:35 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')]} 02:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:35 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')]} 02:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:35 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:35 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 02:46:35 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 02:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:35 INFO - 'HOME': '/Users/cltbld', 02:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:35 INFO - 'LOGNAME': 'cltbld', 02:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:35 INFO - 'MOZ_NO_REMOTE': '1', 02:46:35 INFO - 'NO_EM_RESTART': '1', 02:46:35 INFO - 'PAGER': '/bin/cat', 02:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:35 INFO - 'PWD': '/builds/slave/test', 02:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:35 INFO - 'SHELL': '/bin/bash', 02:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:35 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:35 INFO - 'USER': 'cltbld', 02:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:35 INFO - 'XPC_FLAGS': '0x0', 02:46:35 INFO - 'XPC_SERVICE_NAME': '0', 02:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ikAoNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-PkdR94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-sM_YIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-iSFrTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-oyms28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-z1HlDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:35 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-JaUEvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-HHrLcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-HSK3hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-Ghfeq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-xXRgZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-7ztp6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-4R17ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-m1eSnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-cEB9MI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-5zvTOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:36 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-YbqM9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:46:37 INFO - Running setup.py install for manifestparser 02:46:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:46:37 INFO - Running setup.py install for mozcrash 02:46:37 INFO - Running setup.py install for mozdebug 02:46:37 INFO - Running setup.py install for mozdevice 02:46:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:46:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:46:37 INFO - Running setup.py install for mozfile 02:46:37 INFO - Running setup.py install for mozhttpd 02:46:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:46:37 INFO - Running setup.py install for mozinfo 02:46:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Running setup.py install for mozInstall 02:46:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Running setup.py install for mozleak 02:46:38 INFO - Running setup.py install for mozlog 02:46:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Running setup.py install for moznetwork 02:46:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:46:38 INFO - Running setup.py install for mozprocess 02:46:38 INFO - Running setup.py install for mozprofile 02:46:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Running setup.py install for mozrunner 02:46:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Running setup.py install for mozscreenshot 02:46:39 INFO - Running setup.py install for moztest 02:46:39 INFO - Running setup.py install for mozversion 02:46:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:46:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:46:39 INFO - Cleaning up... 02:46:39 INFO - Return code: 0 02:46:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:39 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:39 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 02:46:39 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 02:46:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:39 INFO - 'HOME': '/Users/cltbld', 02:46:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:39 INFO - 'LOGNAME': 'cltbld', 02:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:39 INFO - 'MOZ_NO_REMOTE': '1', 02:46:39 INFO - 'NO_EM_RESTART': '1', 02:46:39 INFO - 'PAGER': '/bin/cat', 02:46:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:39 INFO - 'PWD': '/builds/slave/test', 02:46:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:39 INFO - 'SHELL': '/bin/bash', 02:46:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:39 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:39 INFO - 'USER': 'cltbld', 02:46:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:39 INFO - 'XPC_FLAGS': '0x0', 02:46:39 INFO - 'XPC_SERVICE_NAME': '0', 02:46:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:46:39 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-aMy0mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-MC7IGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-LqHIap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-a9NSZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-ZE34Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-1sv42G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-0Sf2Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-tEaNYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-CNpjuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-QXdQO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:46:40 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)) 02:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:46:40 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-NvuDag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:46:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-pVDTS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:46:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-A9RUze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:46:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-BDVXIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-jUTK0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:46:41 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)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:46:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-qL3wH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:46:41 INFO - Running setup.py (path:/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/pip-7_drSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:46:41 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)) 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:46:41 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)) 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:46:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:46:44 INFO - Downloading blessings-1.6.tar.gz 02:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:46:44 INFO - Installing collected packages: blessings 02:46:44 INFO - Running setup.py install for blessings 02:46:44 INFO - Successfully installed blessings 02:46:44 INFO - Cleaning up... 02:46:44 INFO - Return code: 0 02:46:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:46:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:45 INFO - Reading from file tmpfile_stdout 02:46:45 INFO - Current package versions: 02:46:45 INFO - blessings == 1.6 02:46:45 INFO - blobuploader == 1.2.4 02:46:45 INFO - docopt == 0.6.1 02:46:45 INFO - functools32 == 3.2.3-2 02:46:45 INFO - jsonschema == 2.5.1 02:46:45 INFO - manifestparser == 1.1 02:46:45 INFO - mozInstall == 1.12 02:46:45 INFO - mozcrash == 1.0 02:46:45 INFO - mozdebug == 0.1 02:46:45 INFO - mozdevice == 0.49 02:46:45 INFO - mozfile == 1.2 02:46:45 INFO - mozhttpd == 0.7 02:46:45 INFO - mozinfo == 0.9 02:46:45 INFO - mozleak == 0.1 02:46:45 INFO - mozlog == 3.4 02:46:45 INFO - moznetwork == 0.27 02:46:45 INFO - mozprocess == 0.24 02:46:45 INFO - mozprofile == 0.28 02:46:45 INFO - mozrunner == 6.13 02:46:45 INFO - mozscreenshot == 0.1 02:46:45 INFO - mozsystemmonitor == 0.3 02:46:45 INFO - moztest == 0.8 02:46:45 INFO - mozversion == 1.4 02:46:45 INFO - psutil == 3.1.1 02:46:45 INFO - requests == 1.2.3 02:46:45 INFO - wsgiref == 0.1.2 02:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:46:45 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')]} 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:45 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')]} 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:45 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:45 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 02:46:45 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 02:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:45 INFO - 'HOME': '/Users/cltbld', 02:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:45 INFO - 'LOGNAME': 'cltbld', 02:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:45 INFO - 'MOZ_NO_REMOTE': '1', 02:46:45 INFO - 'NO_EM_RESTART': '1', 02:46:45 INFO - 'PAGER': '/bin/cat', 02:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:45 INFO - 'PWD': '/builds/slave/test', 02:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:45 INFO - 'SHELL': '/bin/bash', 02:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:45 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:45 INFO - 'USER': 'cltbld', 02:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:45 INFO - 'XPC_FLAGS': '0x0', 02:46:45 INFO - 'XPC_SERVICE_NAME': '0', 02:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 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)) 02:46:45 INFO - Cleaning up... 02:46:45 INFO - Return code: 0 02:46:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:46:45 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')]} 02:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:45 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')]} 02:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:46:45 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 0x10482bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10482e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdd5ad94370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, '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.a4apB3jfpf/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.MvO1v3F0mS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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 02:46:45 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 02:46:45 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 02:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:46:45 INFO - 'HOME': '/Users/cltbld', 02:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:46:45 INFO - 'LOGNAME': 'cltbld', 02:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:45 INFO - 'MOZ_NO_REMOTE': '1', 02:46:45 INFO - 'NO_EM_RESTART': '1', 02:46:45 INFO - 'PAGER': '/bin/cat', 02:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:45 INFO - 'PWD': '/builds/slave/test', 02:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:46:45 INFO - 'SHELL': '/bin/bash', 02:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:46:45 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:46:45 INFO - 'USER': 'cltbld', 02:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:45 INFO - 'XPC_FLAGS': '0x0', 02:46:45 INFO - 'XPC_SERVICE_NAME': '0', 02:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:46:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:46:45 INFO - Cleaning up... 02:46:45 INFO - Return code: 0 02:46:45 INFO - Running post-action listener: _resource_record_post_action 02:46:45 INFO - Running post-action listener: _start_resource_monitoring 02:46:45 INFO - Starting resource monitoring. 02:46:45 INFO - [mozharness: 2017-02-02 10:46:45.608879Z] Finished create-virtualenv step (success) 02:46:45 INFO - [mozharness: 2017-02-02 10:46:45.609868Z] Running install step. 02:46:45 INFO - Running pre-action listener: _resource_record_pre_action 02:46:45 INFO - Running main action method: install 02:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:46:45 INFO - Reading from file tmpfile_stdout 02:46:45 INFO - Detecting whether we're running mozinstall >=1.0... 02:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:46:45 INFO - Reading from file tmpfile_stdout 02:46:45 INFO - Output received: 02:46:45 INFO - Usage: mozinstall [options] installer 02:46:45 INFO - Options: 02:46:45 INFO - -h, --help show this help message and exit 02:46:45 INFO - -d DEST, --destination=DEST 02:46:45 INFO - Directory to install application into. [default: 02:46:45 INFO - "/builds/slave/test"] 02:46:45 INFO - --app=APP Application being installed. [default: firefox] 02:46:45 INFO - mkdir: /builds/slave/test/build/application 02:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:47:05 INFO - Reading from file tmpfile_stdout 02:47:05 INFO - Output received: 02:47:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:47:05 INFO - Running post-action listener: _resource_record_post_action 02:47:05 INFO - [mozharness: 2017-02-02 10:47:05.947829Z] Finished install step (success) 02:47:05 INFO - [mozharness: 2017-02-02 10:47:05.948052Z] Running run-tests step. 02:47:05 INFO - Running pre-action listener: _resource_record_pre_action 02:47:05 INFO - Running main action method: run_tests 02:47:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:47:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:47:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:47:05 INFO - 2017-02-02 02:47:05.962 screenresolution[2162:20802] starting screenresolution argv=screenresolution get 02:47:05 INFO - 2017-02-02 02:47:05.965 screenresolution[2162:20802] Display 0: 1600x1200x32@60 02:47:05 INFO - 2017-02-02 02:47:05.971 screenresolution[2163:20804] starting screenresolution argv=screenresolution list 02:47:05 INFO - Available Modes on Display 0 02:47:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:47:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:47:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:47:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:47:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:47:06 INFO - Intel Iris: 02:47:06 INFO - Chipset Model: Intel Iris 02:47:06 INFO - Type: GPU 02:47:06 INFO - Bus: Built-In 02:47:06 INFO - VRAM (Dynamic, Max): 1536 MB 02:47:06 INFO - Vendor: Intel (0x8086) 02:47:06 INFO - Device ID: 0x0a2e 02:47:06 INFO - Revision ID: 0x0009 02:47:06 INFO - Displays: 02:47:06 INFO - Display: 02:47:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:47:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:47:06 INFO - Display Serial Number: 1600x1200 60 02:47:06 INFO - Main Display: Yes 02:47:06 INFO - Mirror: Off 02:47:06 INFO - Online: Yes 02:47:06 INFO - Rotation: Supported 02:47:06 INFO - Return code: 0 02:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:47:06 INFO - Python 2.7.3 02:47:06 INFO - Return code: 0 02:47:06 INFO - grabbing minidump binary from tooltool 02:47:06 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')]} 02:47:06 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 0x104609d30>, '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 0x104530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1045febe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:47:06 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 02:47:06 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 02:47:06 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 02:47:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:47:06 INFO - Return code: 0 02:47:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:47:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:47:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:47:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:47:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:47:06 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/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 02:47:06 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/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0123 --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 02:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a4apB3jfpf/Render', 02:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:47:06 INFO - 'HOME': '/Users/cltbld', 02:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:47:06 INFO - 'LOGNAME': 'cltbld', 02:47:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:47:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:47:06 INFO - 'MOZ_NO_REMOTE': '1', 02:47:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:47:06 INFO - 'NO_EM_RESTART': '1', 02:47:06 INFO - 'PAGER': '/bin/cat', 02:47:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:47:06 INFO - 'PWD': '/builds/slave/test', 02:47:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:47:06 INFO - 'SHELL': '/bin/bash', 02:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MvO1v3F0mS/Listeners', 02:47:06 INFO - 'TMPDIR': '/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/', 02:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:47:06 INFO - 'USER': 'cltbld', 02:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:47:06 INFO - 'XPC_FLAGS': '0x0', 02:47:06 INFO - 'XPC_SERVICE_NAME': '0', 02:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:47:06 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/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0123', '--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 02:47:06 INFO - mozversion application_buildid: 20170202015108 02:47:06 INFO - mozversion application_changeset: 6ad72b5a43e15125e1baf4a88183b467c042894e 02:47:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:47:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:47:06 INFO - mozversion application_name: Firefox 02:47:06 INFO - mozversion application_remotingname: firefox-dev 02:47:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:47:06 INFO - mozversion application_vendor: Mozilla 02:47:06 INFO - mozversion application_version: 53.0a2 02:47:06 INFO - mozversion platform_buildid: 20170202015108 02:47:06 INFO - mozversion platform_changeset: 6ad72b5a43e15125e1baf4a88183b467c042894e 02:47:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:47:06 INFO - mozversion platform_version: 53.0a2 02:47:06 INFO - using testdate: 1486032426 02:47:06 INFO - actual date: 1486032426 02:47:06 INFO - starting webserver on 'localhost:54780' 02:47:06 INFO - SUITE-START | Running 2 tests 02:47:06 INFO - TEST-START | dromaeo_css 02:47:06 INFO - operating with platform_type : mac_ 02:47:06 INFO - Initialising browser for dromaeo_css test... 02:47:06 INFO - TEST-INFO | started process 2173 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpRavEWb/profile http://localhost:54780/getInfo.html) 02:47:09 INFO - PROCESS | 2173 | 2017-02-02 02:47:09.453 plugin-container[2175:20942] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f2f, name = 'com.apple.tsm.portname' 02:47:09 INFO - PROCESS | 2173 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:09 INFO - PROCESS | 2173 | 2017-02-02 02:47:09.457 plugin-container[2175:20942] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960f, name = 'com.apple.CFPasteboardClient' 02:47:09 INFO - PROCESS | 2173 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:09 INFO - PROCESS | 2173 | 2017-02-02 02:47:09.457 plugin-container[2175:20942] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:47:09 INFO - PROCESS | 2173 | __metrics Screen width/height:1600/1200 02:47:09 INFO - PROCESS | 2173 | colorDepth:24 02:47:09 INFO - PROCESS | 2173 | Browser inner width/height: 1024/689 02:47:09 INFO - PROCESS | 2173 | __metrics 02:47:09 ERROR - PROCESS | 2173 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 02:47:10 INFO - TEST-INFO | 2173: exit 0 02:47:10 INFO - Browser initialized. 02:47:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:47:10 INFO - TEST-INFO | started process 2176 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpRavEWb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:12 INFO - PROCESS | 2176 | 2017-02-02 02:47:12.576 plugin-container[2177:21069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4637, name = 'com.apple.tsm.portname' 02:47:12 INFO - PROCESS | 2176 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:12 INFO - PROCESS | 2176 | 2017-02-02 02:47:12.576 plugin-container[2177:21069] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 02:47:12 INFO - PROCESS | 2176 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:47:12 INFO - PROCESS | 2176 | 2017-02-02 02:47:12.576 plugin-container[2177:21069] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:47:22 INFO - PROCESS | 2176 | RSS: Main: 218787840 02:47:22 INFO - PROCESS | 2176 | 02:50:24 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54780/tests/dromaeo/cssquery-ext.html) 02:50:26 INFO - PROCESS | 2176 | RSS: Main: 239411200 02:50:26 INFO - PROCESS | 2176 | 02:52:10 INFO - PROCESS | 2176 | ************************* 02:52:10 INFO - PROCESS | 2176 | A coding exception was thrown and uncaught in a Task. 02:52:10 INFO - PROCESS | 2176 | 02:52:10 ERROR - PROCESS | 2176 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:52:10 INFO - PROCESS | 2176 | Full stack: 02:52:10 INFO - PROCESS | 2176 | ************************* 02:53:28 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-ext.html (next: http://localhost:54780/tests/dromaeo/cssquery-jquery.html) 02:53:29 INFO - PROCESS | 2176 | RSS: Main: 250732544 02:53:29 INFO - PROCESS | 2176 | 02:56:31 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54780/tests/dromaeo/cssquery-mootools.html) 02:56:31 INFO - PROCESS | 2176 | RSS: Main: 256507904 02:56:31 INFO - PROCESS | 2176 | 02:59:33 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54780/tests/dromaeo/cssquery-prototype.html) 02:59:34 INFO - PROCESS | 2176 | RSS: Main: 252870656 02:59:34 INFO - PROCESS | 2176 | 03:02:37 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54780/tests/dromaeo/cssquery-yui.html) 03:02:37 INFO - PROCESS | 2176 | RSS: Main: 256892928 03:02:37 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | Cycle 1(1): loaded http://localhost:54780/tests/dromaeo/cssquery-yui.html (next: http://localhost:54780/tests/dromaeo/cssquery-dojo.html) 03:05:40 INFO - PROCESS | 2176 | RSS: Main: 259121152 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | __start_tp_report 03:05:40 INFO - PROCESS | 2176 | _x_x_mozilla_page_load 03:05:40 INFO - PROCESS | 2176 | _x_x_mozilla_page_load_details 03:05:40 INFO - PROCESS | 2176 | |i|pagename|runs| 03:05:40 INFO - PROCESS | 2176 | |0;dojo.html;3359.0930448778845;3365.7475689323305;3371;3408.7102596279315;3416.1801167719755;5685.1756495308155;5704.344000439951;5761.308642962845;5761.567882408825;5769.682667453289;5728.68492232928;5780.5664575156825;5828;5832.825015249538;5840.065589505669;5250.842474725755;5254.789808407659;5280.709560974145;5291.074062039147;5320.388155362125;3928.9410658839997;4376.168527979674;5334.91997620036;5351.063563876306;5371.113766228587;4292.763897985626;5164.457731938149;5196.610254230929;5321.680699158062;5336.8132115375965;4543.432070991126;5281.18141688037;5303;5333.519983201491;5368.570514358842;4717.174494463455;4829.010052939139;5184.774428644963;5293;5372.301600791872;5607;5810.767569297223;5829.883402331972;5915.112733090071;5941.376155503696;6174.043023331391;6210.068489726577;6214.720337584819;6264.561480696353;6307.558470907038;6264;6273.654948977804;6276.278228003793;6283.403076707706;6284.685765711696;5979.581429299951;5985.820425387245;5991.610545314541;6002.339742628264;6006.489448396936;6206.782762603378;6238.407351301619;6239.282482514569;6267.874642507124;6282.057691346335;5838.4745372915795;6189.938100618936;6202.627842329474;6249.500039996789;6255.155554000243;6239.906401403982;6304.117423560705;6310.5267104967315;6311.810645680637;6313.873722525524;6152.815415537541;6212.316645169119;6237;6268;6302.653354065479;6293.087502312139;6321.1150438938585;6325.620462772248;6342.460890824239;6346.2067241594805;5085.186370180827;5088.135017047037;5088.338515992898;5090.618203634742;5121.28302037715;3477.2697733476252;4369.9730563318235;4407.647388208936;4426.712263702849;4490.199209549255;4862.927056094161;6058.212432383762;6118.4668989547035;6140.416660417253;6143.815685529441;6260.780872669435;6287.46556542699;6294.716737746812;6300.716467758962;6321.683915804191;5857.736401861841;5905.261842269716;5986.73059712314;6009.2188015557695;6032.065029920369;5559.916601250984;5563.693996830132;5563.888722225533;5581.944180558143;5609.663420194802;6419.839504012437;6436.388543088399;6436.645984470805;6449.7097630605795;6461.418472337512;6216.502679785516;6217.222847144107;6218.595791273553;6219.751209951552;6284.811455656338;6406.743730250924;6408.29508754046;6419.550631455753;6442.259140198749;6482.384173503509;6287.654179020198;6299.149614801943;6315.96842015787;6321.241451025722;6322.36776322364;6204.162438070984;6239.75040998355;6243.250809902841;6260.373962603703;6302.212223472066;4906.607471402351;6144.709610981744;6242.188515492957;6253.405926436982;6273.811785646438;6222.28443728977;6259.280182779039;6260.40526150015;6270.122182894307;6274.529410294337;5589.301337332833;5866.442687944638;5900.7049647518315;5907.734151963258;6087.269527656709;6111.348653136637;6128.533679014772;6154.169187159855;6265.530085243716;6287.2140982377205;6096.1465394845645;6103.938960610337;6119.020956646915;6122.7244773984385;6139.785107521216 03:05:40 INFO - PROCESS | 2176 | |1;ext.html;405.3878643248694;443.28409618466173;471.76647559458075;494.6290282288285;508.8498892826616;30479;40938.18123637529;41010.97472563187;41177.970550736245;41228.58771412285;41267;41347.17305653885;41860.790696046475;42062.527811526605;42251;9279.675211367603;9521.71434856952;9556.856647150298;10718.303310284806;11170.888291117106;10888.67333979982;11008.724781880437;11012.889871101266;11050.944745276303;11053.115750739922;11022.834657480103;11073.944630276837;11073.944630276837;11080.279781814157;11113.110951123932;10983.725406864813;10984;11000.22998390113;11021.118310535177;11022.889771102347;10915.890841091566;10957.726056848564;11005.449727513593;11008.39453830039;11025.062869656089;36381.81809090964;36624.81687591572;36657.63342366569;36702.63297367019;36722;3818.4654148419245;3844.530827239359;3905.8828235152705;3912.921741565153;3946.664533514626;27193;27760.583591246148;27952.720472795216;28779.704913278954;29077.854610727023;2535;2832.56095305228;2971.9851400743073;3162.57305263791;3213;488259;489303;489559;491380.5430972858;492928;56195.43804561902;56385;56431.87136257252;56442;56552.43447565554;57482.13776793351;57654.42345576575;58079.8384032317;58099.70950145222;58138.709306454046;12762.80855787164;12897.935510322575;14201.502947396999;14917.254137293092;15221.467248646244;9149.954250228706;10890.237683362247;11992;12163.087768417405;12316.199447035913;15341.463048793239;16016;17323.826761732475;17401.65196696059;17436.041017743893;8105.189481051848;8152.184781521919;8166.510009399455;8167.183281671785;8217.917820821714;876.5792419638482;880.9515476648846;890.5013192612158;892.5537231384308;929.9070092990647;23906;29067.41865162685;29495.410091798043;29866;30948.845255773576;987.950602469888;1030.1810061001522;1042.4631314872847;1059.994700026495;1077.8706555213269;13789.586312410644;14425.855741442661;14547.927260363631;14609.050411723203;14697.191654459108;588832;750123;763835;765441;956242;52834;53442.465575344526;53482.73258633682;53653.7317313411;53875;1412.2726795700223;1418.4326269492285;1442.4590778458078;1449.7752848308528;1450.514077783933;27815.721842781313;28134;28647.57028644614;29033.419331612826;29051.983180588577;48063.279050813566;50649.49350506448;51028;51032;51130;623746;630809.8459507857;631515;631786;632747;24866.75133248717;25725.228243152735;25753.484930301664;26542.336441589116;38271.80864095662;41770.37344439775;41852.37221441742;42251.67615781161;42684.14631707286;43263.56736432721;34995.47506787451;35201.64798351983;35466.64533354736;35538;35659.64340356667;34829;34928.82535587306;35413;35629;35855.64144358523;33583.66416335903;33631.15922101967;33679.83160084184;34565.30869382648;34781.13047173841;27044.59433108544;29570.704292956794;30636.080917572508;31421.528677069404;31515.684843151274;23380.649290261;23914.760852391948;23931.641025384284;24056.39859003539;24140.275791726275 03:05:40 INFO - PROCESS | 2176 | |2;jquery.html;364.30236097872574;394.27453485586534;395.7447446397072;402.9053172504461;426.3519450435338;19928.70106948397;21142.788572114274;21147.259845905395;21397.465063373424;21657.35027949162;17625.91187044066;18243.45269641913;20130.49673758157;20607.896960515212;20849.895750521264;5770.221020162277;5802.825915222529;5905.409459054082;5968.253968253968;5990.790322338719;5675;5898.587098903078;5942.762289508414;5947.286325640929;5947.821565353025;5792.304923409197;5877.500412464946;5878.000739874232;5895.025166569205;5896.587238893279;5666.575006874501;5865.706714664249;5870.412958704138;5896.97051514744;5900.409959004087;5232.790688372461;5236.423993360727;5236.947630523684;5244.39689435716;5251.842444726664;22365.776342236695;23447.593144411218;25377.746222537724;25589.720513974415;25928.22215333543;2782.401783616532;2852.5721141828685;2855.328997685542;2855.4431885782283;2859.628248327704;15378.461753838563;15419.306131224123;15668.216589170495;15733.527994160193;15939.920300398424;1793.5426466251154;1828.1042289278291;1828.1864570266237;1857.3870622694612;1867.3370953311514;122349.38825305905;123326.38336808259;128189.35905320507;129169;131396;11650.126240531825;11719;12036.939815301042;12039.518419263131;12057.879421205851;12992.415341309475;15441.841861860405;15542.766858497132;15554.06675599445;15595.688086238211;8629.741107766777;8779.20987111163;8803.955980220186;8805.647774089093;8849.557522123869;8552.230299273095;8553.272971797342;8658.696945607;8663.610137543825;8694.869576956351;4066.2274167908004;4618.284165954283;4692.296155576622;4712.269598212282;4715.104130215248;1872.4663470910725;2008.126464987735;2022.6561484547663;2025.6657651487635;2047.98976005122;935.6725146198776;1042.987035022414;1051.3271506236015;1053.3048188195753;1063.8191507443753;20768.376948691563;21206.893965530075;21222;21280.78719212819;21427.250046248308;1049.3127001813825;1065.2702898514387;1068.9518971646294;1098.4946924414699;1104.1608377633056;10761.892381076246;11030.558777648965;11034.84134165917;11040.668779936615;11060.557577696964;717664;721525;727515;740685;745500;129142;139946.90079648813;140989;141207.88188177184;154063;995.5271246158162;997.4065431068502;1042.05693847067;1044.5247412427327;1061.4321338084087;19161.137748801615;19595.412137635893;19776.703349450057;19831.60336793285;19890;49502.01991920283;54767.178492323445;54873.35379938608;60132.699336503036;60326;82816;85147.5742621283;86046.2790744169;86894.56552717449;87264;7971.920280797118;7992.760217193493;8102.825090361983;8342.374321925758;8344.707935222237;10132.240081993732;10959.945200273947;12729.045321600732;13016.13644998099;13052.15161014569;9425.575849086945;9694.660686875926;10787.892121079003;10811.243212975016;11246.325220486797;10642.095421888916;10791.460426978776;10974.067204287725;11020.44897755125;11249.043831274434;9449.527523623654;10489.213309001703;11029.503672334924;11439.59961401347;11514.94242528782;8050.798730031796;8168.570500162329;8255.25702686761;8505.277051450696;8555.31557475388;8160.551169685724;9906.910239873465;9939.801203975736;10641;11176.27354221973 03:05:40 INFO - PROCESS | 2176 | |3;mootools.html;1429.0825250437274;1435.4043072125069;1450.9419623215072;1455.9563213103606;1462.108114050429;7489.588072656002;7713.92286077139;7983.520988740673;8449.49303041818;8461.026981897083;6614.239362473317;8116.107228204893;8123.3907456940815;8236.382271329645;8239.711610093647;2281.247188427819;2324.837261391703;2324.93025209244;2327.674125622414;2333.673285739998;2320.8143348532076;2342.1334106380664;2368.7394386617457;2368.881555922197;2373.4066483379156;2295.024614538823;2298.402415371999;2311.849729767568;2313.9421514462106;2319.420144963759;1969.6553103206882;2087.2903212907686;2127.8190604214656;2273.1362082408746;2312.398776318161;2293.8050265727434;2322.2336628912417;2326.5114325991563;2329.033451117784;2353.294011796454;8324;8370.958145209295;8388.993320801483;8397.916020839775;8406.369522285853;5068.771905264235;5187.870303242411;5190.299309593194;5195.766190521435;5220.451852555465;3302.339532093567;3396.371671240828;3529.347070791886;3548.6806187442994;3579.83890724918;1008.3143462445535;1058.8094143054248;1204.897583705386;1224.8591411987647;1243.757467293878;10618.097461715763;10662.040416362486;10758.0855627271;10772.892271077268;10789.946050269777;4455.131249406335;4639.072185562901;4714.6464015199;4719.811207551659;4721.976390118028;9448.055194480497;9468.958414574392;9488.288378371511;9521.952390238004;9522.90477095234;5230.293910322058;5236.371635403776;5240.816571419982;5241.816536421207;5244.501772331622;4222.556631553643;4231.196072746168;4650.139724150975;4697.436307643105;4765.904681906342;3817.3892177251505;3875.4380614810693;3901;3935.2719746846924;3981.024648961023;1267.765463389276;1275.9744805103846;1280.4558062823262;1288.3815768431205;1289.7549465601694;860.165639329849;907.1065000974036;914.2959920861033;919.4253591505309;931.6040682709821;4624.791884365211;5338.786448542015;5591.524720398812;5720.771169153188;5725.914111288334;924.5654542365078;939.8825146856643;999.7850462150673;1022.897710228986;1029.917606591471;3636.909077273089;3724.7951362675312;3734.141147536028;3789.621037896188;3823.5411750590106;9464.290178236522;9568.808623827623;9625.422474651543;9710.75723106928;9714.951425242829;9252.028537003653;9626.181774549243;9653.517324133765;9657.420554766737;9741.707748767549;7688.461807673521;7852.84294314122;7859.72490962825;7870.803229919184;7896;5557.9995600792245;5589.357223919302;5626.127950167731;5654.123610840326;5809.680467574324;8891.333150013645;9080.818383632422;9124.771880703036;9147.359684822264;9156.633734650539;8825.514596697243;9125.95051569078;9154.038825923448;9160.770980725536;9281;5845.678487683048;6543.1821022372205;6757.560758550679;7109.21798602143;7228.168760592389;7668.923310767044;7946.086200087064;7954.801129971797;7965.800854978672;7968.0039995000625;6993.4055605274125;7118.608476533634;7144.214136445091;7166.856662866818;7228.31331023552;6980.162380514168;6986.9650651746415;6999.230084690578;7025.367716905503;7116.323949224816;6381.776637817654;6405.135306733718;6457.967710161419;6498.317676643885;6505.902411463927;5006.574441172395;5028.84913452597;5054.444011158696;5082.6950382975665;5086.898262034812;4799.904001920012;4830.7826147824135;4868.269759536098;4958.404991401055;4986.750662466789 03:05:40 INFO - PROCESS | 2176 | |4;prototype.html;343.3579206883129;353.9769914955528;359.28322995623734;361.99095022624437;362.9691476224522;5413.781899072706;5423.810166644168;5442.15646574781;5448.6185966982275;5521.668699878011;4523.117991991563;5380.865478363033;5394.946050539494;5437.6465529740635;5439.456054394568;3725.105974566098;3909.2181563687236;4265.573442655733;4274.786260686953;4350.456192975878;3437.4843773433936;4088.5911408859024;4193.622573968342;4274.807633656477;4281.507626622947;3342.665733426662;3367.602444985328;4202;4204.600562946515;4226.746395216282;3334.3831391192707;3632.9827648258397;4219.303814870543;4271.594198551133;4285.635720963722;3306.57014588102;3577.964220357789;3683.6684698377007;3742.9625703742886;3750.7374483786148;5153;5277.522293757754;5281.70950597717;5292.179712144623;5305.814296499604;4705.435347758256;4900.534449227318;4921.8523444296725;4963.851084467472;4998.650094493387;5043.924341134886;5624;5636.830895073154;5692.430756924316;5789.768409263625;4013.8795836124964;4127.29835927893;4162.583741625844;4166.604172603597;4179.874603761892;5146.922796158024;5375.22059301403;5525.640833345819;6009.909851352233;6068.605540639888;3921.509811273591;4203.591796748063;4207.558206388347;4217.8523751668545;4230.725002874865;3684.5394325709285;4312.331588603772;4326.567343265649;4349.608535231844;4353.69524133314;4144.373673036093;4951.851444456672;4952.232403977389;4954.925676114789;4993.975030124826;4651.651126165483;5362.597805164628;5496.31296087989;5610.326760788732;5756.366799652035;1336.9799453008213;1382.8271466066742;1383.6540864783803;1393.5749596373;1396.6927275999467;877.3156937588691;924.6209054287709;977.2165797419595;979.8334283171878;984.3945973226414;4519.593236608721;5131.461196574306;5139.398056118848;5173.611979101583;5183.45573714762;5086.669366491166;5677.574181936371;5716.74188695463;5839.532837373085;6033.215681961317;4794.496577859344;5524.696141712164;5532.7786888524815;5535.8339249821765;5545.3622833374675;2417.8428402153804;2500.524900268943;2680.9731902681115;2724.4198364948284;2730.8322346078453;4883.02339532095;5619.8876022480135;5645.294338207724;5822.505087067562;5884;4883.804647814048;5633.521250649701;5760.279965004374;5791.160281759121;5822.301323841166;5042.495750424928;5055.620828437882;5579.884023195296;5755.510781583528;5847.649141051465;4538.909221815611;4670.252759558454;5118.744062796771;5229.084910140787;5591.4214902461645;4625.583697467244;5091.643584949018;5335.413104558573;5367.060764366299;5598.10430331145;4654.86035418938;5454.754536045967;5815.005272284861;5843.357230704534;5900.403822318166;3620.49313096172;3956.6834653227097;3973.092915400566;4004.8398064078274;4027.295223335846;5238.3022743288;5263.578913686819;5453.1334246805045;5637.577181711306;5641.351244606759;5133.793558513672;5202.557782588522;5690.857728556819;5698;5810.576408779876;5700.771969121189;5742.626729262584;5789.56578256624;5798.739056742373;5842;4682.601978831837;4790.353302304145;5224.425313215619;5555.111501878321;5607.971960140173;5499.230107784833;5765.192872997867;5765.538756899354;5799.3040835100055;5822.5633077518505;4073.8205060292603;4554.908901821878;5482.013237617267;5684.175794509855;5707.68607726579 03:05:40 INFO - PROCESS | 2176 | |5;yui.html;702.8559145375199;703.5919166883205;764.8279137194129;822.3421262989609;835.2232423845821;14639.634009149764;15695.21523923805;15698.293576789043;15736.370545178179;15745.60635984101;14494.927525362385;14564.854351456483;14628.268586570655;14632.707345853076;14644.121352718817;673.3367632881608;696.853660731247;843.4601854812925;848.0967769325679;863.3611127765471;864.844328020956;869.2046777198856;881.9470831750116;882.1927935938609;882.8808110905042;917.7843206846386;937.0442149008007;938.488523754552;938.549496241801;940.4169414962698;929.0523665860784;931.6459745296812;932.9813403731955;933.3979583168853;937.723371605378;678.2979616097365;691.7025678958046;695.7425752471568;697.104221075915;699.0911814640997;15207.923960380127;15260.618484537976;15546.144962027083;15590.922045389814;15786.368545258176;12063.577774777928;14511.1293322401;14633;14884.925575372163;15052.021618594756;10710.143188544977;10997.505112269968;11707.882921170765;11849.822252666218;11858.881411185865;3634.5275114235246;3696.31618150643;3705.4441833724886;3743.5507739071213;3873.2834425631067;106037.40943885848;106678.99999999923;109067;109621.45189274082;110569.34145987817;10438.478076096164;10614.787704245871;10652.68041958727;10663.626773062906;10784.352938823695;21428.78571214299;22236.221732239293;22239.55520889573;22794.974226159862;22853.657195142085;7740.690372385042;7789.80525486856;7827.178146294671;7967.721129760431;8070.556119413372;4219.451471308772;4253.97904502917;4352.325389564622;4411.889702757392;4506.639468842484;3430.4168291390524;3508.8421021054114;3509.175343794206;3511.0169152637304;3517.067976986101;649.5875119299185;653.4119292636665;657.4378906035366;660.3363619562405;677.7831094049956;678.7590405406108;691.2361840166644;696.9721211151599;702.125853312629;745.7613563659685;9966.352187107816;11048.779024419466;11212.12722081219;11250.156238282161;11373.94313028446;580.4833698008775;586.8738221282445;590.4154886662174;642.2485691740582;701.5895701014862;4494.023108981519;4891.679246603398;4933.407991041026;4941.2835138905375;5398.217258497574;70979.64510177416;94163;94410.52794735982;95765.04234957701;97710;65713;82370;85307;85650;85871;56812.43187568154;71840;73659;74127.77616671509;76600.85098723523;10810.729731756768;10928.781424371628;10933.726656833644;11122.499487522919;11181.273217240854;39885;48936.26595600998;49219.50780492293;49812.75093624509;50374;52180.95638087141;63201;65809;66092.98613189548;66569;10753.946230268799;12759.362031898183;12896.935515322364;13218.801717974431;13250.536231231861;14365.569032929028;14505.202213877916;14513.637159071108;14954.25228738537;15078.170700611572;10889.509972051119;13374.799378009533;13877.05901983928;13963.022588418713;14314.713705726035;14083.507077252247;14122.858771412566;14137.929310353382;14439.639009024439;14617.561473155822;13064.21614703121;13479.460821567027;13691.246981416118;13708.93145534266;14347.856521434653;10970.890291096986;11162.497687603915;11289.37908415045;11369;11973.580924667594;10944.94527527389;10979.1216702662;11078.335299882034;11085.113190944543;11094.611688590861 03:05:40 INFO - PROCESS | 2176 | __end_tp_report 03:05:40 INFO - PROCESS | 2176 | __start_cc_report 03:05:40 INFO - PROCESS | 2176 | _x_x_mozilla_cycle_collect,380 03:05:40 INFO - PROCESS | 2176 | __end_cc_report 03:05:40 INFO - PROCESS | 2176 | __startTimestamp1486033540659__endTimestamp 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | ------- Summary: start ------- 03:05:40 INFO - PROCESS | 2176 | Number of tests: 6 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | [#0] dojo.html Cycles:165 Average:5789.05 Median:6118.47 stddev:711.19 (11.6%) stddev-sans-first:687.35 03:05:40 INFO - PROCESS | 2176 | Values: 3359.1 3365.7 3371.0 3408.7 3416.2 5685.2 5704.3 5761.3 5761.6 5769.7 5728.7 5780.6 5828.0 5832.8 5840.1 5250.8 5254.8 5280.7 5291.1 5320.4 3928.9 4376.2 5334.9 5351.1 5371.1 4292.8 5164.5 5196.6 5321.7 5336.8 4543.4 5281.2 5303.0 5333.5 5368.6 4717.2 4829.0 5184.8 5293.0 5372.3 5607.0 5810.8 5829.9 5915.1 5941.4 6174.0 6210.1 6214.7 6264.6 6307.6 6264.0 6273.7 6276.3 6283.4 6284.7 5979.6 5985.8 5991.6 6002.3 6006.5 6206.8 6238.4 6239.3 6267.9 6282.1 5838.5 6189.9 6202.6 6249.5 6255.2 6239.9 6304.1 6310.5 6311.8 6313.9 6152.8 6212.3 6237.0 6268.0 6302.7 6293.1 6321.1 6325.6 6342.5 6346.2 5085.2 5088.1 5088.3 5090.6 5121.3 3477.3 4370.0 4407.6 4426.7 4490.2 4862.9 6058.2 6118.5 6140.4 6143.8 6260.8 6287.5 6294.7 6300.7 6321.7 5857.7 5905.3 5986.7 6009.2 6032.1 5559.9 5563.7 5563.9 5581.9 5609.7 6419.8 6436.4 6436.6 6449.7 6461.4 6216.5 6217.2 6218.6 6219.8 6284.8 6406.7 6408.3 6419.6 6442.3 6482.4 6287.7 6299.1 6316.0 6321.2 6322.4 6204.2 6239.8 6243.3 6260.4 6302.2 4906.6 6144.7 6242.2 6253.4 6273.8 6222.3 6259.3 6260.4 6270.1 6274.5 5589.3 5866.4 5900.7 5907.7 6087.3 6111.3 6128.5 6154.2 6265.5 6287.2 6096.1 6103.9 6119.0 6122.7 6139.8 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | [#1] ext.html Cycles:180 Average:74020.69 Median:34878.91 stddev:172644.83 (495.0%) stddev-sans-first:173040.67 03:05:40 INFO - PROCESS | 2176 | Values: 405.4 443.3 471.8 494.6 508.8 30479.0 40938.2 41011.0 41178.0 41228.6 41267.0 41347.2 41860.8 42062.5 42251.0 9279.7 9521.7 9556.9 10718.3 11170.9 10888.7 11008.7 11012.9 11050.9 11053.1 11022.8 11073.9 11073.9 11080.3 11113.1 10983.7 10984.0 11000.2 11021.1 11022.9 10915.9 10957.7 11005.4 11008.4 11025.1 36381.8 36624.8 36657.6 36702.6 36722.0 3818.5 3844.5 3905.9 3912.9 3946.7 27193.0 27760.6 27952.7 28779.7 29077.9 2535.0 2832.6 2972.0 3162.6 3213.0 488259.0 489303.0 489559.0 491380.5 492928.0 56195.4 56385.0 56431.9 56442.0 56552.4 57482.1 57654.4 58079.8 58099.7 58138.7 12762.8 12897.9 14201.5 14917.3 15221.5 9150.0 10890.2 11992.0 12163.1 12316.2 15341.5 16016.0 17323.8 17401.7 17436.0 8105.2 8152.2 8166.5 8167.2 8217.9 876.6 881.0 890.5 892.6 929.9 23906.0 29067.4 29495.4 29866.0 30948.8 988.0 1030.2 1042.5 1060.0 1077.9 13789.6 14425.9 14547.9 14609.1 14697.2 588832.0 750123.0 763835.0 765441.0 956242.0 52834.0 53442.5 53482.7 53653.7 53875.0 1412.3 1418.4 1442.5 1449.8 1450.5 27815.7 28134.0 28647.6 29033.4 29052.0 48063.3 50649.5 51028.0 51032.0 51130.0 623746.0 630809.8 631515.0 631786.0 632747.0 24866.8 25725.2 25753.5 26542.3 38271.8 41770.4 41852.4 42251.7 42684.1 43263.6 34995.5 35201.6 35466.6 35538.0 35659.6 34829.0 34928.8 35413.0 35629.0 35855.6 33583.7 33631.2 33679.8 34565.3 34781.1 27044.6 29570.7 30636.1 31421.5 31515.7 23380.6 23914.8 23931.6 24056.4 24140.3 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | [#2] jquery.html Cycles:180 Average:39748.37 Median:22011.56 stddev:121399.79 (551.5%) stddev-sans-first:121704.33 03:05:40 INFO - PROCESS | 2176 | Values: 364.3 394.3 395.7 402.9 426.4 19928.7 21142.8 21147.3 21397.5 21657.4 17625.9 18243.5 20130.5 20607.9 20849.9 5770.2 5802.8 5905.4 5968.3 5990.8 5675.0 5898.6 5942.8 5947.3 5947.8 5792.3 5877.5 5878.0 5895.0 5896.6 5666.6 5865.7 5870.4 5897.0 5900.4 5232.8 5236.4 5236.9 5244.4 5251.8 22365.8 23447.6 25377.7 25589.7 25928.2 2782.4 2852.6 2855.3 2855.4 2859.6 15378.5 15419.3 15668.2 15733.5 15939.9 1793.5 1828.1 1828.2 1857.4 1867.3 122349.4 123326.4 128189.4 129169.0 131396.0 11650.1 11719.0 12036.9 12039.5 12057.9 12992.4 15441.8 15542.8 15554.1 15595.7 8629.7 8779.2 8804.0 8805.6 8849.6 8552.2 8553.3 8658.7 8663.6 8694.9 4066.2 4618.3 4692.3 4712.3 4715.1 1872.5 2008.1 2022.7 2025.7 2048.0 935.7 1043.0 1051.3 1053.3 1063.8 20768.4 21206.9 21222.0 21280.8 21427.3 1049.3 1065.3 1069.0 1098.5 1104.2 10761.9 11030.6 11034.8 11040.7 11060.6 717664.0 721525.0 727515.0 740685.0 745500.0 129142.0 139946.9 140989.0 141207.9 154063.0 995.5 997.4 1042.1 1044.5 1061.4 19161.1 19595.4 19776.7 19831.6 19890.0 49502.0 54767.2 54873.4 60132.7 60326.0 82816.0 85147.6 86046.3 86894.6 87264.0 7971.9 7992.8 8102.8 8342.4 8344.7 10132.2 10959.9 12729.0 13016.1 13052.2 9425.6 9694.7 10787.9 10811.2 11246.3 10642.1 10791.5 10974.1 11020.4 11249.0 9449.5 10489.2 11029.5 11439.6 11514.9 8050.8 8168.6 8255.3 8505.3 8555.3 8160.6 9906.9 9939.8 10641.0 11176.3 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | [#3] mootools.html Cycles:180 Average:5383.41 Median:5241.32 stddev:2897.22 (55.3%) stddev-sans-first:2890.10 03:05:40 INFO - PROCESS | 2176 | Values: 1429.1 1435.4 1450.9 1456.0 1462.1 7489.6 7713.9 7983.5 8449.5 8461.0 6614.2 8116.1 8123.4 8236.4 8239.7 2281.2 2324.8 2324.9 2327.7 2333.7 2320.8 2342.1 2368.7 2368.9 2373.4 2295.0 2298.4 2311.8 2313.9 2319.4 1969.7 2087.3 2127.8 2273.1 2312.4 2293.8 2322.2 2326.5 2329.0 2353.3 8324.0 8371.0 8389.0 8397.9 8406.4 5068.8 5187.9 5190.3 5195.8 5220.5 3302.3 3396.4 3529.3 3548.7 3579.8 1008.3 1058.8 1204.9 1224.9 1243.8 10618.1 10662.0 10758.1 10772.9 10789.9 4455.1 4639.1 4714.6 4719.8 4722.0 9448.1 9469.0 9488.3 9522.0 9522.9 5230.3 5236.4 5240.8 5241.8 5244.5 4222.6 4231.2 4650.1 4697.4 4765.9 3817.4 3875.4 3901.0 3935.3 3981.0 1267.8 1276.0 1280.5 1288.4 1289.8 860.2 907.1 914.3 919.4 931.6 4624.8 5338.8 5591.5 5720.8 5725.9 924.6 939.9 999.8 1022.9 1029.9 3636.9 3724.8 3734.1 3789.6 3823.5 9464.3 9568.8 9625.4 9710.8 9715.0 9252.0 9626.2 9653.5 9657.4 9741.7 7688.5 7852.8 7859.7 7870.8 7896.0 5558.0 5589.4 5626.1 5654.1 5809.7 8891.3 9080.8 9124.8 9147.4 9156.6 8825.5 9126.0 9154.0 9160.8 9281.0 5845.7 6543.2 6757.6 7109.2 7228.2 7668.9 7946.1 7954.8 7965.8 7968.0 6993.4 7118.6 7144.2 7166.9 7228.3 6980.2 6987.0 6999.2 7025.4 7116.3 6381.8 6405.1 6458.0 6498.3 6505.9 5006.6 5028.8 5054.4 5082.7 5086.9 4799.9 4830.8 4868.3 4958.4 4986.8 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | [#4] prototype.html Cycles:180 Average:4574.63 Median:5132.63 stddev:1370.66 (26.7%) stddev-sans-first:1337.20 03:05:40 INFO - PROCESS | 2176 | Values: 343.4 354.0 359.3 362.0 363.0 5413.8 5423.8 5442.2 5448.6 5521.7 4523.1 5380.9 5394.9 5437.6 5439.5 3725.1 3909.2 4265.6 4274.8 4350.5 3437.5 4088.6 4193.6 4274.8 4281.5 3342.7 3367.6 4202.0 4204.6 4226.7 3334.4 3633.0 4219.3 4271.6 4285.6 3306.6 3578.0 3683.7 3743.0 3750.7 5153.0 5277.5 5281.7 5292.2 5305.8 4705.4 4900.5 4921.9 4963.9 4998.7 5043.9 5624.0 5636.8 5692.4 5789.8 4013.9 4127.3 4162.6 4166.6 4179.9 5146.9 5375.2 5525.6 6009.9 6068.6 3921.5 4203.6 4207.6 4217.9 4230.7 3684.5 4312.3 4326.6 4349.6 4353.7 4144.4 4951.9 4952.2 4954.9 4994.0 4651.7 5362.6 5496.3 5610.3 5756.4 1337.0 1382.8 1383.7 1393.6 1396.7 877.3 924.6 977.2 979.8 984.4 4519.6 5131.5 5139.4 5173.6 5183.5 5086.7 5677.6 5716.7 5839.5 6033.2 4794.5 5524.7 5532.8 5535.8 5545.4 2417.8 2500.5 2681.0 2724.4 2730.8 4883.0 5619.9 5645.3 5822.5 5884.0 4883.8 5633.5 5760.3 5791.2 5822.3 5042.5 5055.6 5579.9 5755.5 5847.6 4538.9 4670.3 5118.7 5229.1 5591.4 4625.6 5091.6 5335.4 5367.1 5598.1 4654.9 5454.8 5815.0 5843.4 5900.4 3620.5 3956.7 3973.1 4004.8 4027.3 5238.3 5263.6 5453.1 5637.6 5641.4 5133.8 5202.6 5690.9 5698.0 5810.6 5700.8 5742.6 5789.6 5798.7 5842.0 4682.6 4790.4 5224.4 5555.1 5608.0 5499.2 5765.2 5765.5 5799.3 5822.6 4073.8 4554.9 5482.0 5684.2 5707.7 03:05:40 INFO - PROCESS | 2176 | 03:05:40 INFO - PROCESS | 2176 | [#5] yui.html Cycles:180 Average:19704.69 Median:3700.88 stddev:27564.85 (744.8%) stddev-sans-first:27605.25 03:05:40 INFO - PROCESS | 2176 | Values: 702.9 703.6 764.8 822.3 835.2 14639.6 15695.2 15698.3 15736.4 15745.6 14494.9 14564.9 14628.3 14632.7 14644.1 673.3 696.9 843.5 848.1 863.4 864.8 869.2 881.9 882.2 882.9 917.8 937.0 938.5 938.5 940.4 929.1 931.6 933.0 933.4 937.7 678.3 691.7 695.7 697.1 699.1 15207.9 15260.6 15546.1 15590.9 15786.4 12063.6 14511.1 14633.0 14884.9 15052.0 10710.1 10997.5 11707.9 11849.8 11858.9 3634.5 3696.3 3705.4 3743.6 3873.3 106037.4 106679.0 109067.0 109621.5 110569.3 10438.5 10614.8 10652.7 10663.6 10784.4 21428.8 22236.2 22239.6 22795.0 22853.7 7740.7 7789.8 7827.2 7967.7 8070.6 4219.5 4254.0 4352.3 4411.9 4506.6 3430.4 3508.8 3509.2 3511.0 3517.1 649.6 653.4 657.4 660.3 677.8 678.8 691.2 697.0 702.1 745.8 9966.4 11048.8 11212.1 11250.2 11373.9 580.5 586.9 590.4 642.2 701.6 4494.0 4891.7 4933.4 4941.3 5398.2 70979.6 94163.0 94410.5 95765.0 97710.0 65713.0 82370.0 85307.0 85650.0 85871.0 56812.4 71840.0 73659.0 74127.8 76600.9 10810.7 10928.8 10933.7 11122.5 11181.3 39885.0 48936.3 49219.5 49812.8 50374.0 52181.0 63201.0 65809.0 66093.0 66569.0 10753.9 12759.4 12896.9 13218.8 13250.5 14365.6 14505.2 14513.6 14954.3 15078.2 10889.5 13374.8 13877.1 13963.0 14314.7 14083.5 14122.9 14137.9 14439.6 14617.6 13064.2 13479.5 13691.2 13708.9 14347.9 10970.9 11162.5 11289.4 11369.0 11973.6 10944.9 10979.1 11078.3 11085.1 11094.6 03:05:40 INFO - PROCESS | 2176 | -------- Summary: end -------- 03:05:40 INFO - PROCESS | 2176 | 03:05:41 INFO - TEST-INFO | 2176: exit 0 03:05:41 INFO - TEST-OK | dromaeo_css | took 1114732ms 03:05:41 INFO - TEST-START | kraken 03:05:41 INFO - operating with platform_type : mac_ 03:05:41 INFO - Initialising browser for kraken test... 03:05:41 INFO - TEST-INFO | started process 2183 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpDKdnUz/profile http://localhost:54780/getInfo.html) 03:05:44 INFO - PROCESS | 2183 | 2017-02-02 03:05:44.022 plugin-container[2184:23262] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 03:05:44 INFO - PROCESS | 2183 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:44 INFO - PROCESS | 2183 | 2017-02-02 03:05:44.025 plugin-container[2184:23262] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:05:44 INFO - PROCESS | 2183 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:44 INFO - PROCESS | 2183 | 2017-02-02 03:05:44.025 plugin-container[2184:23262] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:44 INFO - PROCESS | 2183 | __metrics Screen width/height:1600/1200 03:05:44 INFO - PROCESS | 2183 | colorDepth:24 03:05:44 INFO - PROCESS | 2183 | Browser inner width/height: 1024/689 03:05:44 INFO - PROCESS | 2183 | __metrics 03:05:44 ERROR - PROCESS | 2183 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 03:05:44 INFO - TEST-INFO | 2183: exit 0 03:05:44 INFO - Browser initialized. 03:05:44 INFO - Running cycle 1/1 for kraken test... 03:05:44 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/T/tmpDKdnUz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:05:47 INFO - PROCESS | 2185 | 2017-02-02 03:05:47.424 plugin-container[2186:23390] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 03:05:47 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:47 INFO - PROCESS | 2185 | 2017-02-02 03:05:47.425 plugin-container[2186:23390] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 03:05:47 INFO - PROCESS | 2185 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:05:47 INFO - PROCESS | 2185 | 2017-02-02 03:05:47.425 plugin-container[2186:23390] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:05:57 INFO - PROCESS | 2185 | RSS: Main: 219209728 03:05:57 INFO - PROCESS | 2185 | 03:06:00 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:01 INFO - PROCESS | 2185 | RSS: Main: 234287104 03:06:01 INFO - PROCESS | 2185 | 03:06:03 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-dft) 03:06:04 INFO - PROCESS | 2185 | RSS: Main: 242974720 03:06:04 INFO - PROCESS | 2185 | 03:06:07 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-fft) 03:06:08 INFO - PROCESS | 2185 | RSS: Main: 245313536 03:06:08 INFO - PROCESS | 2185 | 03:06:10 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54780/tests/kraken/driver.html?testName=audio-oscillator) 03:06:10 INFO - PROCESS | 2185 | RSS: Main: 246587392 03:06:10 INFO - PROCESS | 2185 | 03:06:12 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:13 INFO - PROCESS | 2185 | RSS: Main: 246697984 03:06:13 INFO - PROCESS | 2185 | 03:06:16 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54780/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:17 INFO - PROCESS | 2185 | RSS: Main: 250273792 03:06:17 INFO - PROCESS | 2185 | 03:06:20 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54780/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:20 INFO - PROCESS | 2185 | RSS: Main: 249671680 03:06:20 INFO - PROCESS | 2185 | 03:06:23 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54780/tests/kraken/driver.html?testName=json-parse-financial) 03:06:24 INFO - PROCESS | 2185 | RSS: Main: 249741312 03:06:24 INFO - PROCESS | 2185 | 03:06:25 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:26 INFO - PROCESS | 2185 | RSS: Main: 248979456 03:06:26 INFO - PROCESS | 2185 | 03:06:28 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:29 INFO - PROCESS | 2185 | RSS: Main: 249024512 03:06:29 INFO - PROCESS | 2185 | 03:06:31 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:31 INFO - PROCESS | 2185 | RSS: Main: 249073664 03:06:31 INFO - PROCESS | 2185 | 03:06:34 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:35 INFO - PROCESS | 2185 | RSS: Main: 249401344 03:06:35 INFO - PROCESS | 2185 | 03:06:38 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:39 INFO - PROCESS | 2185 | RSS: Main: 249491456 03:06:39 INFO - PROCESS | 2185 | 03:06:40 INFO - PROCESS | 2185 | Cycle 1(1): loaded http://localhost:54780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54780/tests/kraken/driver.html?testName=ai-astar) 03:06:41 INFO - PROCESS | 2185 | RSS: Main: 251510784 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | __start_tp_report 03:06:41 INFO - PROCESS | 2185 | _x_x_mozilla_page_load 03:06:41 INFO - PROCESS | 2185 | _x_x_mozilla_page_load_details 03:06:41 INFO - PROCESS | 2185 | |i|pagename|runs| 03:06:41 INFO - PROCESS | 2185 | |0;ai-astar;120;115;99;107;98;143;123;160;174;178 03:06:41 INFO - PROCESS | 2185 | |1;audio-beat-detection;165;136;110;143;110;111;113;130;134;97 03:06:41 INFO - PROCESS | 2185 | |2;audio-dft;202;196;201;201;195;238;275;203;200;200 03:06:41 INFO - PROCESS | 2185 | |3;audio-fft;78;59;58;88;61;62;59;62;88;84 03:06:41 INFO - PROCESS | 2185 | |4;audio-oscillator;91;71;85;74;70;73;82;72;75;83 03:06:41 INFO - PROCESS | 2185 | |5;imaging-gaussian-blur;91;87;89;88;90;86;99;103;135;126 03:06:41 INFO - PROCESS | 2185 | |6;imaging-darkroom;100;101;99;100;100;138;101;99;100;100 03:06:41 INFO - PROCESS | 2185 | |7;imaging-desaturate;92;96;144;91;91;90;94;92;92;92 03:06:41 INFO - PROCESS | 2185 | |8;json-parse-financial;58;59;61;63;63;65;63;62;65;65 03:06:41 INFO - PROCESS | 2185 | |9;json-stringify-tinderbox;58;82;106;117;102;70;71;62;101;106 03:06:41 INFO - PROCESS | 2185 | |10;stanford-crypto-aes;105;103;81;83;87;85;93;84;88;75 03:06:41 INFO - PROCESS | 2185 | |11;stanford-crypto-ccm;168;161;133;149;137;153;159;145;190;140 03:06:41 INFO - PROCESS | 2185 | |12;stanford-crypto-pbkdf2;211;173;172;166;172;170;169;173;170;169 03:06:41 INFO - PROCESS | 2185 | |13;stanford-crypto-sha256-iterative;66;66;66;65;68;69;68;68;69;67 03:06:41 INFO - PROCESS | 2185 | __end_tp_report 03:06:41 INFO - PROCESS | 2185 | __start_cc_report 03:06:41 INFO - PROCESS | 2185 | _x_x_mozilla_cycle_collect,946 03:06:41 INFO - PROCESS | 2185 | __end_cc_report 03:06:41 INFO - PROCESS | 2185 | __startTimestamp1486033601061__endTimestamp 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | ------- Summary: start ------- 03:06:41 INFO - PROCESS | 2185 | Number of tests: 14 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#0] ai-astar Cycles:10 Average:131.70 Median:167.00 stddev:30.13 (18.0%) stddev-sans-first:31.65 03:06:41 INFO - PROCESS | 2185 | Values: 120.0 115.0 99.0 107.0 98.0 143.0 123.0 160.0 174.0 178.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#1] audio-beat-detection Cycles:10 Average:124.90 Median:135.00 stddev:20.34 (15.1%) stddev-sans-first:15.57 03:06:41 INFO - PROCESS | 2185 | Values: 165.0 136.0 110.0 143.0 110.0 111.0 113.0 130.0 134.0 97.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#2] audio-dft Cycles:10 Average:211.10 Median:201.50 stddev:25.59 (12.7%) stddev-sans-first:26.93 03:06:41 INFO - PROCESS | 2185 | Values: 202.0 196.0 201.0 201.0 195.0 238.0 275.0 203.0 200.0 200.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#3] audio-fft Cycles:10 Average:69.90 Median:70.00 stddev:12.92 (18.5%) stddev-sans-first:13.37 03:06:41 INFO - PROCESS | 2185 | Values: 78.0 59.0 58.0 88.0 61.0 62.0 59.0 62.0 88.0 84.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:7.12 (9.1%) stddev-sans-first:5.67 03:06:41 INFO - PROCESS | 2185 | Values: 91.0 71.0 85.0 74.0 70.0 73.0 82.0 72.0 75.0 83.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:88.50 stddev:17.38 (19.6%) stddev-sans-first:18.17 03:06:41 INFO - PROCESS | 2185 | Values: 91.0 87.0 89.0 88.0 90.0 86.0 99.0 103.0 135.0 126.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:101.00 stddev:12.04 (11.9%) stddev-sans-first:12.69 03:06:41 INFO - PROCESS | 2185 | Values: 100.0 101.0 99.0 100.0 100.0 138.0 101.0 99.0 100.0 100.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#7] imaging-desaturate Cycles:10 Average:97.40 Median:92.00 stddev:16.46 (17.9%) stddev-sans-first:17.34 03:06:41 INFO - PROCESS | 2185 | Values: 92.0 96.0 144.0 91.0 91.0 90.0 94.0 92.0 92.0 92.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:2.46 (3.9%) stddev-sans-first:2.03 03:06:41 INFO - PROCESS | 2185 | Values: 58.0 59.0 61.0 63.0 63.0 65.0 63.0 62.0 65.0 65.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#9] json-stringify-tinderbox Cycles:10 Average:87.50 Median:60.00 stddev:21.28 (35.5%) stddev-sans-first:19.72 03:06:41 INFO - PROCESS | 2185 | Values: 58.0 82.0 106.0 117.0 102.0 70.0 71.0 62.0 101.0 106.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:84.50 stddev:9.47 (11.2%) stddev-sans-first:7.91 03:06:41 INFO - PROCESS | 2185 | Values: 105.0 103.0 81.0 83.0 87.0 85.0 93.0 84.0 88.0 75.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:156.00 stddev:16.99 (10.9%) stddev-sans-first:17.19 03:06:41 INFO - PROCESS | 2185 | Values: 168.0 161.0 133.0 149.0 137.0 153.0 159.0 145.0 190.0 140.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:172.00 stddev:13.01 (7.6%) stddev-sans-first:2.30 03:06:41 INFO - PROCESS | 2185 | Values: 211.0 173.0 172.0 166.0 172.0 170.0 169.0 173.0 170.0 169.0 03:06:41 INFO - PROCESS | 2185 | 03:06:41 INFO - PROCESS | 2185 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 03:06:41 INFO - PROCESS | 2185 | Values: 66.0 66.0 66.0 65.0 68.0 69.0 68.0 68.0 69.0 67.0 03:06:41 INFO - PROCESS | 2185 | -------- Summary: end -------- 03:06:41 INFO - PROCESS | 2185 | 03:06:42 INFO - TEST-INFO | 2185: exit 0 03:06:42 INFO - TEST-OK | kraken | took 60763ms 03:06:42 INFO - SUITE-END | took 1175s 03:06:42 INFO - Completed test suite (00:19:35) 03:06:42 INFO - javascript benchmark 03:06:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7318.610013162735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.0930448778845, 3365.7475689323305, 3371.0, 3408.7102596279315, 3416.1801167719755, 5685.1756495308155, 5704.344000439951, 5761.308642962845, 5761.567882408825, 5769.682667453289, 5728.68492232928, 5780.5664575156825, 5828.0, 5832.825015249538, 5840.065589505669, 5250.842474725755, 5254.789808407659, 5280.709560974145, 5291.074062039147, 5320.388155362125, 3928.9410658839997, 4376.168527979674, 5334.91997620036, 5351.063563876306, 5371.113766228587, 4292.763897985626, 5164.457731938149, 5196.610254230929, 5321.680699158062, 5336.8132115375965, 4543.432070991126, 5281.18141688037, 5303.0, 5333.519983201491, 5368.570514358842, 4717.174494463455, 4829.010052939139, 5184.774428644963, 5293.0, 5372.301600791872, 5607.0, 5810.767569297223, 5829.883402331972, 5915.112733090071, 5941.376155503696, 6174.043023331391, 6210.068489726577, 6214.720337584819, 6264.561480696353, 6307.558470907038, 6264.0, 6273.654948977804, 6276.278228003793, 6283.403076707706, 6284.685765711696, 5979.581429299951, 5985.820425387245, 5991.610545314541, 6002.339742628264, 6006.489448396936, 6206.782762603378, 6238.407351301619, 6239.282482514569, 6267.874642507124, 6282.057691346335, 5838.4745372915795, 6189.938100618936, 6202.627842329474, 6249.500039996789, 6255.155554000243, 6239.906401403982, 6304.117423560705, 6310.5267104967315, 6311.810645680637, 6313.873722525524, 6152.815415537541, 6212.316645169119, 6237.0, 6268.0, 6302.653354065479, 6293.087502312139, 6321.1150438938585, 6325.620462772248, 6342.460890824239, 6346.2067241594805, 5085.186370180827, 5088.135017047037, 5088.338515992898, 5090.618203634742, 5121.28302037715, 3477.2697733476252, 4369.9730563318235, 4407.647388208936, 4426.712263702849, 4490.199209549255, 4862.927056094161, 6058.212432383762, 6118.4668989547035, 6140.416660417253, 6143.815685529441, 6260.780872669435, 6287.46556542699, 6294.716737746812, 6300.716467758962, 6321.683915804191, 5857.736401861841, 5905.261842269716, 5986.73059712314, 6009.2188015557695, 6032.065029920369, 5559.916601250984, 5563.693996830132, 5563.888722225533, 5581.944180558143, 5609.663420194802, 6419.839504012437, 6436.388543088399, 6436.645984470805, 6449.7097630605795, 6461.418472337512, 6216.502679785516, 6217.222847144107, 6218.595791273553, 6219.751209951552, 6284.811455656338, 6406.743730250924, 6408.29508754046, 6419.550631455753, 6442.259140198749, 6482.384173503509, 6287.654179020198, 6299.149614801943, 6315.96842015787, 6321.241451025722, 6322.36776322364, 6204.162438070984, 6239.75040998355, 6243.250809902841, 6260.373962603703, 6302.212223472066, 4906.607471402351, 6144.709610981744, 6242.188515492957, 6253.405926436982, 6273.811785646438, 6222.28443728977, 6259.280182779039, 6260.40526150015, 6270.122182894307, 6274.529410294337, 5589.301337332833, 5866.442687944638, 5900.7049647518315, 5907.734151963258, 6087.269527656709, 6111.348653136637, 6128.533679014772, 6154.169187159855, 6265.530085243716, 6287.2140982377205, 6096.1465394845645, 6103.938960610337, 6119.020956646915, 6122.7244773984385, 6139.785107521216], "value": 5741.843305961342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.3878643248694, 443.28409618466173, 471.76647559458075, 494.6290282288285, 508.8498892826616, 30479.0, 40938.18123637529, 41010.97472563187, 41177.970550736245, 41228.58771412285, 41267.0, 41347.17305653885, 41860.790696046475, 42062.527811526605, 42251.0, 9279.675211367603, 9521.71434856952, 9556.856647150298, 10718.303310284806, 11170.888291117106, 10888.67333979982, 11008.724781880437, 11012.889871101266, 11050.944745276303, 11053.115750739922, 11022.834657480103, 11073.944630276837, 11073.944630276837, 11080.279781814157, 11113.110951123932, 10983.725406864813, 10984.0, 11000.22998390113, 11021.118310535177, 11022.889771102347, 10915.890841091566, 10957.726056848564, 11005.449727513593, 11008.39453830039, 11025.062869656089, 36381.81809090964, 36624.81687591572, 36657.63342366569, 36702.63297367019, 36722.0, 3818.4654148419245, 3844.530827239359, 3905.8828235152705, 3912.921741565153, 3946.664533514626, 27193.0, 27760.583591246148, 27952.720472795216, 28779.704913278954, 29077.854610727023, 2535.0, 2832.56095305228, 2971.9851400743073, 3162.57305263791, 3213.0, 488259.0, 489303.0, 489559.0, 491380.5430972858, 492928.0, 56195.43804561902, 56385.0, 56431.87136257252, 56442.0, 56552.43447565554, 57482.13776793351, 57654.42345576575, 58079.8384032317, 58099.70950145222, 58138.709306454046, 12762.80855787164, 12897.935510322575, 14201.502947396999, 14917.254137293092, 15221.467248646244, 9149.954250228706, 10890.237683362247, 11992.0, 12163.087768417405, 12316.199447035913, 15341.463048793239, 16016.0, 17323.826761732475, 17401.65196696059, 17436.041017743893, 8105.189481051848, 8152.184781521919, 8166.510009399455, 8167.183281671785, 8217.917820821714, 876.5792419638482, 880.9515476648846, 890.5013192612158, 892.5537231384308, 929.9070092990647, 23906.0, 29067.41865162685, 29495.410091798043, 29866.0, 30948.845255773576, 987.950602469888, 1030.1810061001522, 1042.4631314872847, 1059.994700026495, 1077.8706555213269, 13789.586312410644, 14425.855741442661, 14547.927260363631, 14609.050411723203, 14697.191654459108, 588832.0, 750123.0, 763835.0, 765441.0, 956242.0, 52834.0, 53442.465575344526, 53482.73258633682, 53653.7317313411, 53875.0, 1412.2726795700223, 1418.4326269492285, 1442.4590778458078, 1449.7752848308528, 1450.514077783933, 27815.721842781313, 28134.0, 28647.57028644614, 29033.419331612826, 29051.983180588577, 48063.279050813566, 50649.49350506448, 51028.0, 51032.0, 51130.0, 623746.0, 630809.8459507857, 631515.0, 631786.0, 632747.0, 24866.75133248717, 25725.228243152735, 25753.484930301664, 26542.336441589116, 38271.80864095662, 41770.37344439775, 41852.37221441742, 42251.67615781161, 42684.14631707286, 43263.56736432721, 34995.47506787451, 35201.64798351983, 35466.64533354736, 35538.0, 35659.64340356667, 34829.0, 34928.82535587306, 35413.0, 35629.0, 35855.64144358523, 33583.66416335903, 33631.15922101967, 33679.83160084184, 34565.30869382648, 34781.13047173841, 27044.59433108544, 29570.704292956794, 30636.080917572508, 31421.528677069404, 31515.684843151274, 23380.649290261, 23914.760852391948, 23931.641025384284, 24056.39859003539, 24140.275791726275], "value": 19614.64606999622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.30236097872574, 394.27453485586534, 395.7447446397072, 402.9053172504461, 426.3519450435338, 19928.70106948397, 21142.788572114274, 21147.259845905395, 21397.465063373424, 21657.35027949162, 17625.91187044066, 18243.45269641913, 20130.49673758157, 20607.896960515212, 20849.895750521264, 5770.221020162277, 5802.825915222529, 5905.409459054082, 5968.253968253968, 5990.790322338719, 5675.0, 5898.587098903078, 5942.762289508414, 5947.286325640929, 5947.821565353025, 5792.304923409197, 5877.500412464946, 5878.000739874232, 5895.025166569205, 5896.587238893279, 5666.575006874501, 5865.706714664249, 5870.412958704138, 5896.97051514744, 5900.409959004087, 5232.790688372461, 5236.423993360727, 5236.947630523684, 5244.39689435716, 5251.842444726664, 22365.776342236695, 23447.593144411218, 25377.746222537724, 25589.720513974415, 25928.22215333543, 2782.401783616532, 2852.5721141828685, 2855.328997685542, 2855.4431885782283, 2859.628248327704, 15378.461753838563, 15419.306131224123, 15668.216589170495, 15733.527994160193, 15939.920300398424, 1793.5426466251154, 1828.1042289278291, 1828.1864570266237, 1857.3870622694612, 1867.3370953311514, 122349.38825305905, 123326.38336808259, 128189.35905320507, 129169.0, 131396.0, 11650.126240531825, 11719.0, 12036.939815301042, 12039.518419263131, 12057.879421205851, 12992.415341309475, 15441.841861860405, 15542.766858497132, 15554.06675599445, 15595.688086238211, 8629.741107766777, 8779.20987111163, 8803.955980220186, 8805.647774089093, 8849.557522123869, 8552.230299273095, 8553.272971797342, 8658.696945607, 8663.610137543825, 8694.869576956351, 4066.2274167908004, 4618.284165954283, 4692.296155576622, 4712.269598212282, 4715.104130215248, 1872.4663470910725, 2008.126464987735, 2022.6561484547663, 2025.6657651487635, 2047.98976005122, 935.6725146198776, 1042.987035022414, 1051.3271506236015, 1053.3048188195753, 1063.8191507443753, 20768.376948691563, 21206.893965530075, 21222.0, 21280.78719212819, 21427.250046248308, 1049.3127001813825, 1065.2702898514387, 1068.9518971646294, 1098.4946924414699, 1104.1608377633056, 10761.892381076246, 11030.558777648965, 11034.84134165917, 11040.668779936615, 11060.557577696964, 717664.0, 721525.0, 727515.0, 740685.0, 745500.0, 129142.0, 139946.90079648813, 140989.0, 141207.88188177184, 154063.0, 995.5271246158162, 997.4065431068502, 1042.05693847067, 1044.5247412427327, 1061.4321338084087, 19161.137748801615, 19595.412137635893, 19776.703349450057, 19831.60336793285, 19890.0, 49502.01991920283, 54767.178492323445, 54873.35379938608, 60132.699336503036, 60326.0, 82816.0, 85147.5742621283, 86046.2790744169, 86894.56552717449, 87264.0, 7971.920280797118, 7992.760217193493, 8102.825090361983, 8342.374321925758, 8344.707935222237, 10132.240081993732, 10959.945200273947, 12729.045321600732, 13016.13644998099, 13052.15161014569, 9425.575849086945, 9694.660686875926, 10787.892121079003, 10811.243212975016, 11246.325220486797, 10642.095421888916, 10791.460426978776, 10974.067204287725, 11020.44897755125, 11249.043831274434, 9449.527523623654, 10489.213309001703, 11029.503672334924, 11439.59961401347, 11514.94242528782, 8050.798730031796, 8168.570500162329, 8255.25702686761, 8505.277051450696, 8555.31557475388, 8160.551169685724, 9906.910239873465, 9939.801203975736, 10641.0, 11176.27354221973], "value": 9941.948730450087, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.0825250437274, 1435.4043072125069, 1450.9419623215072, 1455.9563213103606, 1462.108114050429, 7489.588072656002, 7713.92286077139, 7983.520988740673, 8449.49303041818, 8461.026981897083, 6614.239362473317, 8116.107228204893, 8123.3907456940815, 8236.382271329645, 8239.711610093647, 2281.247188427819, 2324.837261391703, 2324.93025209244, 2327.674125622414, 2333.673285739998, 2320.8143348532076, 2342.1334106380664, 2368.7394386617457, 2368.881555922197, 2373.4066483379156, 2295.024614538823, 2298.402415371999, 2311.849729767568, 2313.9421514462106, 2319.420144963759, 1969.6553103206882, 2087.2903212907686, 2127.8190604214656, 2273.1362082408746, 2312.398776318161, 2293.8050265727434, 2322.2336628912417, 2326.5114325991563, 2329.033451117784, 2353.294011796454, 8324.0, 8370.958145209295, 8388.993320801483, 8397.916020839775, 8406.369522285853, 5068.771905264235, 5187.870303242411, 5190.299309593194, 5195.766190521435, 5220.451852555465, 3302.339532093567, 3396.371671240828, 3529.347070791886, 3548.6806187442994, 3579.83890724918, 1008.3143462445535, 1058.8094143054248, 1204.897583705386, 1224.8591411987647, 1243.757467293878, 10618.097461715763, 10662.040416362486, 10758.0855627271, 10772.892271077268, 10789.946050269777, 4455.131249406335, 4639.072185562901, 4714.6464015199, 4719.811207551659, 4721.976390118028, 9448.055194480497, 9468.958414574392, 9488.288378371511, 9521.952390238004, 9522.90477095234, 5230.293910322058, 5236.371635403776, 5240.816571419982, 5241.816536421207, 5244.501772331622, 4222.556631553643, 4231.196072746168, 4650.139724150975, 4697.436307643105, 4765.904681906342, 3817.3892177251505, 3875.4380614810693, 3901.0, 3935.2719746846924, 3981.024648961023, 1267.765463389276, 1275.9744805103846, 1280.4558062823262, 1288.3815768431205, 1289.7549465601694, 860.165639329849, 907.1065000974036, 914.2959920861033, 919.4253591505309, 931.6040682709821, 4624.791884365211, 5338.786448542015, 5591.524720398812, 5720.771169153188, 5725.914111288334, 924.5654542365078, 939.8825146856643, 999.7850462150673, 1022.897710228986, 1029.917606591471, 3636.909077273089, 3724.7951362675312, 3734.141147536028, 3789.621037896188, 3823.5411750590106, 9464.290178236522, 9568.808623827623, 9625.422474651543, 9710.75723106928, 9714.951425242829, 9252.028537003653, 9626.181774549243, 9653.517324133765, 9657.420554766737, 9741.707748767549, 7688.461807673521, 7852.84294314122, 7859.72490962825, 7870.803229919184, 7896.0, 5557.9995600792245, 5589.357223919302, 5626.127950167731, 5654.123610840326, 5809.680467574324, 8891.333150013645, 9080.818383632422, 9124.771880703036, 9147.359684822264, 9156.633734650539, 8825.514596697243, 9125.95051569078, 9154.038825923448, 9160.770980725536, 9281.0, 5845.678487683048, 6543.1821022372205, 6757.560758550679, 7109.21798602143, 7228.168760592389, 7668.923310767044, 7946.086200087064, 7954.801129971797, 7965.800854978672, 7968.0039995000625, 6993.4055605274125, 7118.608476533634, 7144.214136445091, 7166.856662866818, 7228.31331023552, 6980.162380514168, 6986.9650651746415, 6999.230084690578, 7025.367716905503, 7116.323949224816, 6381.776637817654, 6405.135306733718, 6457.967710161419, 6498.317676643885, 6505.902411463927, 5006.574441172395, 5028.84913452597, 5054.444011158696, 5082.6950382975665, 5086.898262034812, 4799.904001920012, 4830.7826147824135, 4868.269759536098, 4958.404991401055, 4986.750662466789], "value": 4397.408754089958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.3579206883129, 353.9769914955528, 359.28322995623734, 361.99095022624437, 362.9691476224522, 5413.781899072706, 5423.810166644168, 5442.15646574781, 5448.6185966982275, 5521.668699878011, 4523.117991991563, 5380.865478363033, 5394.946050539494, 5437.6465529740635, 5439.456054394568, 3725.105974566098, 3909.2181563687236, 4265.573442655733, 4274.786260686953, 4350.456192975878, 3437.4843773433936, 4088.5911408859024, 4193.622573968342, 4274.807633656477, 4281.507626622947, 3342.665733426662, 3367.602444985328, 4202.0, 4204.600562946515, 4226.746395216282, 3334.3831391192707, 3632.9827648258397, 4219.303814870543, 4271.594198551133, 4285.635720963722, 3306.57014588102, 3577.964220357789, 3683.6684698377007, 3742.9625703742886, 3750.7374483786148, 5153.0, 5277.522293757754, 5281.70950597717, 5292.179712144623, 5305.814296499604, 4705.435347758256, 4900.534449227318, 4921.8523444296725, 4963.851084467472, 4998.650094493387, 5043.924341134886, 5624.0, 5636.830895073154, 5692.430756924316, 5789.768409263625, 4013.8795836124964, 4127.29835927893, 4162.583741625844, 4166.604172603597, 4179.874603761892, 5146.922796158024, 5375.22059301403, 5525.640833345819, 6009.909851352233, 6068.605540639888, 3921.509811273591, 4203.591796748063, 4207.558206388347, 4217.8523751668545, 4230.725002874865, 3684.5394325709285, 4312.331588603772, 4326.567343265649, 4349.608535231844, 4353.69524133314, 4144.373673036093, 4951.851444456672, 4952.232403977389, 4954.925676114789, 4993.975030124826, 4651.651126165483, 5362.597805164628, 5496.31296087989, 5610.326760788732, 5756.366799652035, 1336.9799453008213, 1382.8271466066742, 1383.6540864783803, 1393.5749596373, 1396.6927275999467, 877.3156937588691, 924.6209054287709, 977.2165797419595, 979.8334283171878, 984.3945973226414, 4519.593236608721, 5131.461196574306, 5139.398056118848, 5173.611979101583, 5183.45573714762, 5086.669366491166, 5677.574181936371, 5716.74188695463, 5839.532837373085, 6033.215681961317, 4794.496577859344, 5524.696141712164, 5532.7786888524815, 5535.8339249821765, 5545.3622833374675, 2417.8428402153804, 2500.524900268943, 2680.9731902681115, 2724.4198364948284, 2730.8322346078453, 4883.02339532095, 5619.8876022480135, 5645.294338207724, 5822.505087067562, 5884.0, 4883.804647814048, 5633.521250649701, 5760.279965004374, 5791.160281759121, 5822.301323841166, 5042.495750424928, 5055.620828437882, 5579.884023195296, 5755.510781583528, 5847.649141051465, 4538.909221815611, 4670.252759558454, 5118.744062796771, 5229.084910140787, 5591.4214902461645, 4625.583697467244, 5091.643584949018, 5335.413104558573, 5367.060764366299, 5598.10430331145, 4654.86035418938, 5454.754536045967, 5815.005272284861, 5843.357230704534, 5900.403822318166, 3620.49313096172, 3956.6834653227097, 3973.092915400566, 4004.8398064078274, 4027.295223335846, 5238.3022743288, 5263.578913686819, 5453.1334246805045, 5637.577181711306, 5641.351244606759, 5133.793558513672, 5202.557782588522, 5690.857728556819, 5698.0, 5810.576408779876, 5700.771969121189, 5742.626729262584, 5789.56578256624, 5798.739056742373, 5842.0, 4682.601978831837, 4790.353302304145, 5224.425313215619, 5555.111501878321, 5607.971960140173, 5499.230107784833, 5765.192872997867, 5765.538756899354, 5799.3040835100055, 5822.5633077518505, 4073.8205060292603, 4554.908901821878, 5482.013237617267, 5684.175794509855, 5707.68607726579], "value": 4155.071620004556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8559145375199, 703.5919166883205, 764.8279137194129, 822.3421262989609, 835.2232423845821, 14639.634009149764, 15695.21523923805, 15698.293576789043, 15736.370545178179, 15745.60635984101, 14494.927525362385, 14564.854351456483, 14628.268586570655, 14632.707345853076, 14644.121352718817, 673.3367632881608, 696.853660731247, 843.4601854812925, 848.0967769325679, 863.3611127765471, 864.844328020956, 869.2046777198856, 881.9470831750116, 882.1927935938609, 882.8808110905042, 917.7843206846386, 937.0442149008007, 938.488523754552, 938.549496241801, 940.4169414962698, 929.0523665860784, 931.6459745296812, 932.9813403731955, 933.3979583168853, 937.723371605378, 678.2979616097365, 691.7025678958046, 695.7425752471568, 697.104221075915, 699.0911814640997, 15207.923960380127, 15260.618484537976, 15546.144962027083, 15590.922045389814, 15786.368545258176, 12063.577774777928, 14511.1293322401, 14633.0, 14884.925575372163, 15052.021618594756, 10710.143188544977, 10997.505112269968, 11707.882921170765, 11849.822252666218, 11858.881411185865, 3634.5275114235246, 3696.31618150643, 3705.4441833724886, 3743.5507739071213, 3873.2834425631067, 106037.40943885848, 106678.99999999923, 109067.0, 109621.45189274082, 110569.34145987817, 10438.478076096164, 10614.787704245871, 10652.68041958727, 10663.626773062906, 10784.352938823695, 21428.78571214299, 22236.221732239293, 22239.55520889573, 22794.974226159862, 22853.657195142085, 7740.690372385042, 7789.80525486856, 7827.178146294671, 7967.721129760431, 8070.556119413372, 4219.451471308772, 4253.97904502917, 4352.325389564622, 4411.889702757392, 4506.639468842484, 3430.4168291390524, 3508.8421021054114, 3509.175343794206, 3511.0169152637304, 3517.067976986101, 649.5875119299185, 653.4119292636665, 657.4378906035366, 660.3363619562405, 677.7831094049956, 678.7590405406108, 691.2361840166644, 696.9721211151599, 702.125853312629, 745.7613563659685, 9966.352187107816, 11048.779024419466, 11212.12722081219, 11250.156238282161, 11373.94313028446, 580.4833698008775, 586.8738221282445, 590.4154886662174, 642.2485691740582, 701.5895701014862, 4494.023108981519, 4891.679246603398, 4933.407991041026, 4941.2835138905375, 5398.217258497574, 70979.64510177416, 94163.0, 94410.52794735982, 95765.04234957701, 97710.0, 65713.0, 82370.0, 85307.0, 85650.0, 85871.0, 56812.43187568154, 71840.0, 73659.0, 74127.77616671509, 76600.85098723523, 10810.729731756768, 10928.781424371628, 10933.726656833644, 11122.499487522919, 11181.273217240854, 39885.0, 48936.26595600998, 49219.50780492293, 49812.75093624509, 50374.0, 52180.95638087141, 63201.0, 65809.0, 66092.98613189548, 66569.0, 10753.946230268799, 12759.362031898183, 12896.935515322364, 13218.801717974431, 13250.536231231861, 14365.569032929028, 14505.202213877916, 14513.637159071108, 14954.25228738537, 15078.170700611572, 10889.509972051119, 13374.799378009533, 13877.05901983928, 13963.022588418713, 14314.713705726035, 14083.507077252247, 14122.858771412566, 14137.929310353382, 14439.639009024439, 14617.561473155822, 13064.21614703121, 13479.460821567027, 13691.246981416118, 13708.93145534266, 14347.856521434653, 10970.890291096986, 11162.497687603915, 11289.37908415045, 11369.0, 11973.580924667594, 10944.94527527389, 10979.1216702662, 11078.335299882034, 11085.113190944543, 11094.611688590861], "value": 7510.112418678825, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 115.0, 99.0, 107.0, 98.0, 143.0, 123.0, 160.0, 174.0, 178.0], "value": 131.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 136.0, 110.0, 143.0, 110.0, 111.0, 113.0, 130.0, 134.0, 97.0], "value": 124.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 196.0, 201.0, 201.0, 195.0, 238.0, 275.0, 203.0, 200.0, 200.0], "value": 211.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 58.0, 88.0, 61.0, 62.0, 59.0, 62.0, 88.0, 84.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 85.0, 74.0, 70.0, 73.0, 82.0, 72.0, 75.0, 83.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 89.0, 88.0, 90.0, 86.0, 99.0, 103.0, 135.0, 126.0], "value": 99.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 99.0, 100.0, 100.0, 138.0, 101.0, 99.0, 100.0, 100.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 144.0, 91.0, 91.0, 90.0, 94.0, 92.0, 92.0, 92.0], "value": 97.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 61.0, 63.0, 63.0, 65.0, 63.0, 62.0, 65.0, 65.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 82.0, 106.0, 117.0, 102.0, 70.0, 71.0, 62.0, 101.0, 106.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 103.0, 81.0, 83.0, 87.0, 85.0, 93.0, 84.0, 88.0, 75.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 161.0, 133.0, 149.0, 137.0, 153.0, 159.0, 145.0, 190.0, 140.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 173.0, 172.0, 166.0, 172.0, 170.0, 169.0, 173.0, 170.0, 169.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 68.0, 69.0, 68.0, 68.0, 69.0, 67.0], "value": 67.2, "unit": "score"}]}]} 03:06:42 INFO - Return code: 0 03:06:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:42 ERROR - # TBPL SUCCESS # 03:06:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:06:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:06:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:06:42 INFO - 2017-02-02 03:06:42.386 screenresolution[2190:23774] starting screenresolution argv=screenresolution get 03:06:42 INFO - 2017-02-02 03:06:42.388 screenresolution[2190:23774] Display 0: 1600x1200x32@60 03:06:42 INFO - 2017-02-02 03:06:42.394 screenresolution[2191:23777] starting screenresolution argv=screenresolution list 03:06:42 INFO - Available Modes on Display 0 03:06:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:06:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:06:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:06:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:06:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:06:42 INFO - Intel Iris: 03:06:42 INFO - Chipset Model: Intel Iris 03:06:42 INFO - Type: GPU 03:06:42 INFO - Bus: Built-In 03:06:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:06:42 INFO - Vendor: Intel (0x8086) 03:06:42 INFO - Device ID: 0x0a2e 03:06:42 INFO - Revision ID: 0x0009 03:06:42 INFO - Displays: 03:06:42 INFO - Display: 03:06:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:06:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:06:42 INFO - Display Serial Number: 1600x1200 60 03:06:42 INFO - Main Display: Yes 03:06:42 INFO - Mirror: Off 03:06:42 INFO - Online: Yes 03:06:42 INFO - Rotation: Supported 03:06:42 INFO - Return code: 0 03:06:42 INFO - Running post-action listener: _resource_record_post_action 03:06:42 INFO - [mozharness: 2017-02-02 11:06:42.637382Z] Finished run-tests step (success) 03:06:42 INFO - Running post-run listener: _resource_record_post_run 03:06:42 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 663552; Write bytes: 510834688; Read time: 7; Write time: 1995 03:06:42 INFO - TinderboxPrint: CPU usage
54.2% 03:06:42 INFO - TinderboxPrint: I/O read bytes / time
663,552 / 7 03:06:42 INFO - TinderboxPrint: I/O write bytes / time
510,834,688 / 1,995 03:06:42 INFO - TinderboxPrint: CPU idle
2,189.8 (45.8%) 03:06:42 INFO - TinderboxPrint: CPU system
965.1 (20.2%) 03:06:42 INFO - TinderboxPrint: CPU user
1,630.8 (34.1%) 03:06:42 INFO - TinderboxPrint: Swap in / out
207,781,888 / 0 03:06:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205081088; Write bytes: 200328704; Read time: 15687; Write time: 415 03:06:42 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 663552; Write bytes: 299549184; Read time: 7; Write time: 1547 03:06:43 INFO - Running post-run listener: _upload_blobber_files 03:06:43 INFO - Blob upload gear active. 03:06:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:43 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 03:06:43 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'] 03:06:43 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 03:06:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:44 INFO - (blobuploader) - INFO - Done attempting. 03:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:45 INFO - (blobuploader) - INFO - Done attempting. 03:06:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:46 INFO - (blobuploader) - INFO - Done attempting. 03:06:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:48 INFO - (blobuploader) - INFO - Done attempting. 03:06:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:48 INFO - Return code: 0 03:06:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ae90a9bbb1ccc6d9720c0c6758dc60b99fce36138c814586df7661655f1eafcab765eb28474373ca7a4c7157c0ef67b73f8be20d60385137682fb74247e25b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3abd8fb86c240e347c77e7e8ec58deb02e4b11c6f8159ce37be2e1fdda36d1fe6f262d5de046fc2fcd090a3556e28b8e99e394bc0e982f73517be16e7285d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd5af6978897affb81a547792f0bdf089c77c2bedd566f813d8dcc4e8c1bd049c63690522a11921e4661b9286f8eff475b26544a9eb38c43e24864c10fbe4306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/760e75d13705b7d6ed72379238830cd415f6b1e87059be430028b2cab3c44830b40d346401e6749a84cac948f6161e3e71f39123789ffefcb739888e565f870c"} 03:06:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:48 INFO - Contents: 03:06:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ae90a9bbb1ccc6d9720c0c6758dc60b99fce36138c814586df7661655f1eafcab765eb28474373ca7a4c7157c0ef67b73f8be20d60385137682fb74247e25b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3abd8fb86c240e347c77e7e8ec58deb02e4b11c6f8159ce37be2e1fdda36d1fe6f262d5de046fc2fcd090a3556e28b8e99e394bc0e982f73517be16e7285d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd5af6978897affb81a547792f0bdf089c77c2bedd566f813d8dcc4e8c1bd049c63690522a11921e4661b9286f8eff475b26544a9eb38c43e24864c10fbe4306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/760e75d13705b7d6ed72379238830cd415f6b1e87059be430028b2cab3c44830b40d346401e6749a84cac948f6161e3e71f39123789ffefcb739888e565f870c"} 03:06:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:48 INFO - Copying logs to upload dir... 03:06:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.732090 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-02 03:06:48.294761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 03:06:48.298767) ========= 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.a4apB3jfpf/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.MvO1v3F0mS/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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/61ae90a9bbb1ccc6d9720c0c6758dc60b99fce36138c814586df7661655f1eafcab765eb28474373ca7a4c7157c0ef67b73f8be20d60385137682fb74247e25b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3abd8fb86c240e347c77e7e8ec58deb02e4b11c6f8159ce37be2e1fdda36d1fe6f262d5de046fc2fcd090a3556e28b8e99e394bc0e982f73517be16e7285d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd5af6978897affb81a547792f0bdf089c77c2bedd566f813d8dcc4e8c1bd049c63690522a11921e4661b9286f8eff475b26544a9eb38c43e24864c10fbe4306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/760e75d13705b7d6ed72379238830cd415f6b1e87059be430028b2cab3c44830b40d346401e6749a84cac948f6161e3e71f39123789ffefcb739888e565f870c"} build_url:https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/Ich611VWQkedgYAkhIHR6g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61ae90a9bbb1ccc6d9720c0c6758dc60b99fce36138c814586df7661655f1eafcab765eb28474373ca7a4c7157c0ef67b73f8be20d60385137682fb74247e25b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bf3abd8fb86c240e347c77e7e8ec58deb02e4b11c6f8159ce37be2e1fdda36d1fe6f262d5de046fc2fcd090a3556e28b8e99e394bc0e982f73517be16e7285d8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd5af6978897affb81a547792f0bdf089c77c2bedd566f813d8dcc4e8c1bd049c63690522a11921e4661b9286f8eff475b26544a9eb38c43e24864c10fbe4306", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/760e75d13705b7d6ed72379238830cd415f6b1e87059be430028b2cab3c44830b40d346401e6749a84cac948f6161e3e71f39123789ffefcb739888e565f870c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 03:06:48.334954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 03:06:48.335361) ========= 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.a4apB3jfpf/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.MvO1v3F0mS/Listeners TMPDIR=/var/folders/hn/0wf8m37s2nbfv1c2zw6h8k5m00000w/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.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 03:06:48.384589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 03:06:48.384949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 03:06:48.385334) ========= ========= Total master_lag: 0.18 =========