builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1479153309.47 results: success (0) buildid: 20161114081542 builduid: c0b4dd1356ae41cf97e49288305ed2d3 revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.474003) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.474779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.475326) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.492541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.493157) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 11:55:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 81.2M=0s 2016-11-14 11:55:09 (81.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071820 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.582937) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.583496) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016848 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.634660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:09.635022) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --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 f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 11:55:09,721 truncating revision to first 12 chars 2016-11-14 11:55:09,721 Setting DEBUG logging. 2016-11-14 11:55:09,721 attempt 1/10 2016-11-14 11:55:09,721 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f11ca24b2382?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 11:55:10,036 unpacking tar archive at: mozilla-aurora-f11ca24b2382/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:10.267274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:10.267691) ========= script_repo_revision: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:10.268099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:10.268372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 11:55:10.279004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-14 11:55:10.279351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:55:10 INFO - MultiFileLogger online at 20161114 11:55:10 in /builds/slave/test 11:55:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:55:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:10 INFO - {'append_to_log': False, 11:55:10 INFO - 'base_work_dir': '/builds/slave/test', 11:55:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:55:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:10 INFO - 'branch': 'Mozilla-Aurora', 11:55:10 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:10 INFO - 'config_files': ('talos/linux_config.py',), 11:55:10 INFO - 'default_actions': ('clobber', 11:55:10 INFO - 'read-buildbot-config', 11:55:10 INFO - 'download-and-extract', 11:55:10 INFO - 'populate-webroot', 11:55:10 INFO - 'create-virtualenv', 11:55:10 INFO - 'install', 11:55:10 INFO - 'run-tests'), 11:55:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:10 INFO - 'download_minidump_stackwalk': True, 11:55:10 INFO - 'download_symbols': 'ondemand', 11:55:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:10 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:10 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:10 INFO - 'installer_path': 'installer.exe', 11:55:10 INFO - 'log_level': 'info', 11:55:10 INFO - 'log_name': 'talos', 11:55:10 INFO - 'log_to_console': True, 11:55:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:55:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:55:10 INFO - 'opt_config_files': (), 11:55:10 INFO - 'pip_index': False, 11:55:10 INFO - 'sps_profile': False, 11:55:10 INFO - 'sps_profile_interval': 0, 11:55:10 INFO - 'suite': 'dromaeojs', 11:55:10 INFO - 'system_bits': '32', 11:55:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:10 INFO - 'title': 'talos-linux64-ix-047', 11:55:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:10 INFO - 'use_talos_json': True, 11:55:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:10 INFO - 'work_dir': 'build'} 11:55:10 INFO - [mozharness: 2016-11-14 19:55:10.470804Z] Running clobber step. 11:55:10 INFO - Running pre-action listener: _resource_record_pre_action 11:55:10 INFO - Running main action method: clobber 11:55:10 INFO - rmtree: /builds/slave/test/build 11:55:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:10 INFO - Running post-action listener: _resource_record_post_action 11:55:10 INFO - [mozharness: 2016-11-14 19:55:10.961718Z] Finished clobber step (success) 11:55:10 INFO - [mozharness: 2016-11-14 19:55:10.961819Z] Running read-buildbot-config step. 11:55:10 INFO - Running pre-action listener: _resource_record_pre_action 11:55:10 INFO - Running main action method: read_buildbot_config 11:55:10 INFO - Using buildbot properties: 11:55:10 INFO - { 11:55:10 INFO - "project": "", 11:55:10 INFO - "product": "firefox", 11:55:10 INFO - "script_repo_revision": "production", 11:55:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:55:10 INFO - "repository": "", 11:55:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:55:10 INFO - "buildid": "20161114081542", 11:55:10 INFO - "pgo_build": "True", 11:55:10 INFO - "basedir": "/builds/slave/test", 11:55:10 INFO - "buildnumber": 902, 11:55:10 INFO - "slavename": "talos-linux64-ix-047", 11:55:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:55:10 INFO - "platform": "ubuntu64_hw", 11:55:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:55:10 INFO - "branch": "mozilla-aurora", 11:55:10 INFO - "repo_path": "releases/mozilla-aurora", 11:55:10 INFO - "revision": "f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d", 11:55:10 INFO - "stage_platform": "linux64-pgo", 11:55:10 INFO - "builduid": "c0b4dd1356ae41cf97e49288305ed2d3", 11:55:10 INFO - "slavebuilddir": "test" 11:55:10 INFO - } 11:55:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:55:10 INFO - Running post-action listener: _resource_record_post_action 11:55:10 INFO - [mozharness: 2016-11-14 19:55:10.964229Z] Finished read-buildbot-config step (success) 11:55:10 INFO - [mozharness: 2016-11-14 19:55:10.964315Z] Running download-and-extract step. 11:55:10 INFO - Running pre-action listener: _resource_record_pre_action 11:55:10 INFO - Running main action method: download_and_extract 11:55:10 INFO - mkdir: /builds/slave/test/build/tests 11:55: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')]} 11:55:10 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:10 INFO - Downloading https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:55:11 INFO - Downloaded 1361 bytes. 11:55:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:55:11 INFO - Using the following test package requirements: 11:55:11 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:55:11 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:55:11 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:55:11 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'jsshell-linux-x86_64.zip'], 11:55:11 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:55:11 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:55:11 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:55:11 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:55:11 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:55:11 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:55:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:55:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:55:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:55:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:55:11 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:55:12 INFO - Http code: 200 11:55:12 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 11:55:12 INFO - x-amz-cf-id: tRW3Xwpkczqcx_1O46y92mWLgWfdXs-7RAu_y-yTAtgFjzCa0KLjgg== 11:55:12 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:55:12 INFO - Expected file size: 21998930 11:55:12 INFO - Obtained file size: 21998930 11:55:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:55:16 INFO - Http code: 200 11:55:16 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 11:55:16 INFO - x-amz-cf-id: zPgCblSyIJx-h-5jR6JsumSrKrEpsSIDSYUIQNOMVZMxUVknGjhipQ== 11:55:16 INFO - x-amz-version-id: EYgBEJGJQc1rBPPP1T5gwCWVofHDXC5C 11:55:17 INFO - Expected file size: 21998930 11:55:17 INFO - Obtained file size: 21998930 11:55:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:55:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:55:21 INFO - Fetch https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:55:22 INFO - Http code: 200 11:55:22 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 11:55:22 INFO - x-amz-cf-id: RzOSZZ19XNmkW-1NGX1-7iIEWvGYLMWOgmLKft7ZvCd9e5jD-P7JNQ== 11:55:22 INFO - x-amz-version-id: TSlfhXB2os_hWn6_vAXqk2ibQDA0EcOh 11:55:22 INFO - Expected file size: 14409038 11:55:22 INFO - Obtained file size: 14409038 11:55: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')]} 11:55:22 INFO - trying https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:55:23 INFO - Downloaded 63942402 bytes. 11:55:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:23 INFO - mkdir: /builds/slave/test/properties 11:55:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:23 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:23 INFO - Contents: 11:55:23 INFO - build_url:https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:55:24 INFO - Running post-action listener: _resource_record_post_action 11:55:24 INFO - Running post-action listener: set_extra_try_arguments 11:55:24 INFO - [mozharness: 2016-11-14 19:55:24.322345Z] Finished download-and-extract step (success) 11:55:24 INFO - [mozharness: 2016-11-14 19:55:24.322572Z] Running populate-webroot step. 11:55:24 INFO - Running pre-action listener: _resource_record_pre_action 11:55:24 INFO - Running main action method: populate_webroot 11:55:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:24 INFO - '--tppagecycles', 11:55:24 INFO - '7'], 11:55:24 INFO - 'tests': ['tsvgm']}}, 11:55:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['damp', 'tps']}, 11:55:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'tests': ['damp', 'tps']}, 11:55:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['dromaeo_dom']}, 11:55:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['basic_compositor_video']}, 11:55:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['a11yr', 11:55:24 INFO - 'ts_paint', 11:55:24 INFO - 'tpaint', 11:55:24 INFO - 'sessionrestore', 11:55:24 INFO - 'sessionrestore_no_auto_restore', 11:55:24 INFO - 'tabpaint']}, 11:55:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:24 INFO - 'ts_paint', 11:55:24 INFO - 'tpaint', 11:55:24 INFO - 'sessionrestore', 11:55:24 INFO - 'sessionrestore_no_auto_restore', 11:55:24 INFO - 'tabpaint']}, 11:55:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:24 INFO - 'ts_paint', 11:55:24 INFO - 'tpaint', 11:55:24 INFO - 'sessionrestore', 11:55:24 INFO - 'sessionrestore_no_auto_restore', 11:55:24 INFO - 'tabpaint']}, 11:55:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:24 INFO - 'ts_paint', 11:55:24 INFO - 'tpaint', 11:55:24 INFO - 'sessionrestore', 11:55:24 INFO - 'sessionrestore_no_auto_restore', 11:55:24 INFO - 'tabpaint']}, 11:55:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['a11yr', 11:55:24 INFO - 'ts_paint', 11:55:24 INFO - 'tpaint', 11:55:24 INFO - 'sessionrestore', 11:55:24 INFO - 'sessionrestore_no_auto_restore', 11:55:24 INFO - 'tabpaint']}, 11:55:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['a11yr', 11:55:24 INFO - 'ts_paint', 11:55:24 INFO - 'tpaint', 11:55:24 INFO - 'sessionrestore', 11:55:24 INFO - 'sessionrestore_no_auto_restore', 11:55:24 INFO - 'tabpaint']}, 11:55:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['tsvgx', 11:55:24 INFO - 'tsvgr_opacity', 11:55:24 INFO - 'tart', 11:55:24 INFO - 'tscrollx', 11:55:24 INFO - 'cart']}, 11:55:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:24 INFO - 'tsvgr_opacity', 11:55:24 INFO - 'tart', 11:55:24 INFO - 'tscrollx', 11:55:24 INFO - 'cart']}, 11:55:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'talos_options': ['--disable-e10s'], 11:55:24 INFO - 'tests': ['tp5o']}, 11:55:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'tests': ['tp5o']}, 11:55:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'talos_options': ['--disable-e10s', 11:55:24 INFO - '--xperf_path', 11:55:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:24 INFO - 'tests': ['tp5n']}, 11:55:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:24 INFO - 'talos_options': ['--xperf_path', 11:55:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:24 INFO - 'tests': ['tp5n']}}, 11:55:24 INFO - 'talos.zip': {'path': '', 11:55:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:24 INFO - Running post-action listener: _resource_record_post_action 11:55:24 INFO - [mozharness: 2016-11-14 19:55:24.337701Z] Finished populate-webroot step (success) 11:55:24 INFO - [mozharness: 2016-11-14 19:55:24.337789Z] Running create-virtualenv step. 11:55:24 INFO - Running pre-action listener: _resource_record_pre_action 11:55:24 INFO - Running main action method: create_virtualenv 11:55:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:24 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 11:55:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:24 INFO - Using real prefix '/usr' 11:55:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:26 INFO - Installing pip.................done. 11:55:26 INFO - Return code: 0 11:55:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:55:27 INFO - Reading from file tmpfile_stdout 11:55:27 INFO - Output received: 11:55:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:55:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:55:27 INFO - Using env: {'DISPLAY': ':0', 11:55:27 INFO - 'HOME': '/home/cltbld', 11:55:27 INFO - 'LANG': 'en_US.UTF-8', 11:55:27 INFO - 'LANGUAGE': 'en_US:en', 11:55:27 INFO - 'LOGNAME': 'cltbld', 11:55:27 INFO - 'MAIL': '/var/mail/cltbld', 11:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:27 INFO - 'MOZ_NO_REMOTE': '1', 11:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:27 INFO - 'NO_EM_RESTART': '1', 11:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:27 INFO - 'PWD': '/builds/slave/test', 11:55:27 INFO - 'SHELL': '/bin/bash', 11:55:27 INFO - 'SHLVL': '1', 11:55:27 INFO - 'TERM': 'linux', 11:55:27 INFO - 'TMOUT': '86400', 11:55:27 INFO - 'USER': 'cltbld', 11:55:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:27 INFO - '_': '/tools/buildbot/bin/python'} 11:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:27 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 11:55:27 INFO - Cleaning up... 11:55:27 INFO - Return code: 0 11:55:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:55:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:55:27 INFO - Using env: {'DISPLAY': ':0', 11:55:27 INFO - 'HOME': '/home/cltbld', 11:55:27 INFO - 'LANG': 'en_US.UTF-8', 11:55:27 INFO - 'LANGUAGE': 'en_US:en', 11:55:27 INFO - 'LOGNAME': 'cltbld', 11:55:27 INFO - 'MAIL': '/var/mail/cltbld', 11:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:27 INFO - 'MOZ_NO_REMOTE': '1', 11:55:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:27 INFO - 'NO_EM_RESTART': '1', 11:55:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:27 INFO - 'PWD': '/builds/slave/test', 11:55:27 INFO - 'SHELL': '/bin/bash', 11:55:27 INFO - 'SHLVL': '1', 11:55:27 INFO - 'TERM': 'linux', 11:55:27 INFO - 'TMOUT': '86400', 11:55:27 INFO - 'USER': 'cltbld', 11:55:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:27 INFO - '_': '/tools/buildbot/bin/python'} 11:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:27 INFO - Downloading/unpacking psutil>=3.1.1 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:29 INFO - Installing collected packages: psutil 11:55:29 INFO - Running setup.py install for psutil 11:55:29 INFO - building 'psutil._psutil_linux' extension 11:55:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:55:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:55:29 INFO - building 'psutil._psutil_posix' extension 11:55:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:55:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:55:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:30 INFO - Successfully installed psutil 11:55:30 INFO - Cleaning up... 11:55:30 INFO - Return code: 0 11:55:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:55:30 INFO - Using env: {'DISPLAY': ':0', 11:55:30 INFO - 'HOME': '/home/cltbld', 11:55:30 INFO - 'LANG': 'en_US.UTF-8', 11:55:30 INFO - 'LANGUAGE': 'en_US:en', 11:55:30 INFO - 'LOGNAME': 'cltbld', 11:55:30 INFO - 'MAIL': '/var/mail/cltbld', 11:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:30 INFO - 'MOZ_NO_REMOTE': '1', 11:55:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:30 INFO - 'NO_EM_RESTART': '1', 11:55:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:30 INFO - 'PWD': '/builds/slave/test', 11:55:30 INFO - 'SHELL': '/bin/bash', 11:55:30 INFO - 'SHLVL': '1', 11:55:30 INFO - 'TERM': 'linux', 11:55:30 INFO - 'TMOUT': '86400', 11:55:30 INFO - 'USER': 'cltbld', 11:55:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:30 INFO - '_': '/tools/buildbot/bin/python'} 11:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:32 INFO - Installing collected packages: mozsystemmonitor 11:55:32 INFO - Running setup.py install for mozsystemmonitor 11:55:32 INFO - Successfully installed mozsystemmonitor 11:55:32 INFO - Cleaning up... 11:55:32 INFO - Return code: 0 11:55:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:32 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:32 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 11:55:32 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 11:55:32 INFO - Using env: {'DISPLAY': ':0', 11:55:32 INFO - 'HOME': '/home/cltbld', 11:55:32 INFO - 'LANG': 'en_US.UTF-8', 11:55:32 INFO - 'LANGUAGE': 'en_US:en', 11:55:32 INFO - 'LOGNAME': 'cltbld', 11:55:32 INFO - 'MAIL': '/var/mail/cltbld', 11:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:32 INFO - 'MOZ_NO_REMOTE': '1', 11:55:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:32 INFO - 'NO_EM_RESTART': '1', 11:55:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:32 INFO - 'PWD': '/builds/slave/test', 11:55:32 INFO - 'SHELL': '/bin/bash', 11:55:32 INFO - 'SHLVL': '1', 11:55:32 INFO - 'TERM': 'linux', 11:55:32 INFO - 'TMOUT': '86400', 11:55:32 INFO - 'USER': 'cltbld', 11:55:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:32 INFO - '_': '/tools/buildbot/bin/python'} 11:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:32 INFO - Downloading/unpacking jsonschema==2.5.1 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55: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 11:55:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:34 INFO - warning: no files found matching '*.txt' 11:55:34 INFO - no previously-included directories found matching 'build' 11:55:34 INFO - no previously-included directories found matching 'dist' 11:55:34 INFO - no previously-included directories found matching '.git*' 11:55:34 INFO - Installing collected packages: jsonschema, functools32 11:55:34 INFO - Running setup.py install for functools32 11:55:35 INFO - warning: no files found matching '*.txt' 11:55:35 INFO - no previously-included directories found matching 'build' 11:55:35 INFO - no previously-included directories found matching 'dist' 11:55:35 INFO - no previously-included directories found matching '.git*' 11:55:35 INFO - Successfully installed jsonschema functools32 11:55:35 INFO - Cleaning up... 11:55:35 INFO - Return code: 0 11:55:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:35 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:35 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 11:55:35 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 11:55:35 INFO - Using env: {'DISPLAY': ':0', 11:55:35 INFO - 'HOME': '/home/cltbld', 11:55:35 INFO - 'LANG': 'en_US.UTF-8', 11:55:35 INFO - 'LANGUAGE': 'en_US:en', 11:55:35 INFO - 'LOGNAME': 'cltbld', 11:55:35 INFO - 'MAIL': '/var/mail/cltbld', 11:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:35 INFO - 'MOZ_NO_REMOTE': '1', 11:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:35 INFO - 'NO_EM_RESTART': '1', 11:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:35 INFO - 'PWD': '/builds/slave/test', 11:55:35 INFO - 'SHELL': '/bin/bash', 11:55:35 INFO - 'SHLVL': '1', 11:55:35 INFO - 'TERM': 'linux', 11:55:35 INFO - 'TMOUT': '86400', 11:55:35 INFO - 'USER': 'cltbld', 11:55:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:35 INFO - '_': '/tools/buildbot/bin/python'} 11:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:35 INFO - Cleaning up... 11:55:35 INFO - Return code: 0 11:55:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:35 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:35 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 11:55:35 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 11:55:35 INFO - Using env: {'DISPLAY': ':0', 11:55:35 INFO - 'HOME': '/home/cltbld', 11:55:35 INFO - 'LANG': 'en_US.UTF-8', 11:55:35 INFO - 'LANGUAGE': 'en_US:en', 11:55:35 INFO - 'LOGNAME': 'cltbld', 11:55:35 INFO - 'MAIL': '/var/mail/cltbld', 11:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:35 INFO - 'MOZ_NO_REMOTE': '1', 11:55:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:35 INFO - 'NO_EM_RESTART': '1', 11:55:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:35 INFO - 'PWD': '/builds/slave/test', 11:55:35 INFO - 'SHELL': '/bin/bash', 11:55:35 INFO - 'SHLVL': '1', 11:55:35 INFO - 'TERM': 'linux', 11:55:35 INFO - 'TMOUT': '86400', 11:55:35 INFO - 'USER': 'cltbld', 11:55:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:35 INFO - '_': '/tools/buildbot/bin/python'} 11:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:35 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 11:55:35 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 11:55:35 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 11:55:35 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 11:55:35 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 11:55:35 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 11:55:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:38 INFO - Downloading docopt-0.6.1.tar.gz 11:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:38 INFO - Running setup.py install for blobuploader 11:55:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:38 INFO - Running setup.py install for requests 11:55:38 INFO - Running setup.py install for docopt 11:55:38 INFO - Successfully installed blobuploader requests docopt 11:55:38 INFO - Cleaning up... 11:55:38 INFO - Return code: 0 11:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:38 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:38 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 11:55:38 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 11:55:38 INFO - Using env: {'DISPLAY': ':0', 11:55:38 INFO - 'HOME': '/home/cltbld', 11:55:38 INFO - 'LANG': 'en_US.UTF-8', 11:55:38 INFO - 'LANGUAGE': 'en_US:en', 11:55:38 INFO - 'LOGNAME': 'cltbld', 11:55:38 INFO - 'MAIL': '/var/mail/cltbld', 11:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:38 INFO - 'MOZ_NO_REMOTE': '1', 11:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:38 INFO - 'NO_EM_RESTART': '1', 11:55:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:38 INFO - 'PWD': '/builds/slave/test', 11:55:38 INFO - 'SHELL': '/bin/bash', 11:55:38 INFO - 'SHLVL': '1', 11:55:38 INFO - 'TERM': 'linux', 11:55:38 INFO - 'TMOUT': '86400', 11:55:38 INFO - 'USER': 'cltbld', 11:55:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:38 INFO - '_': '/tools/buildbot/bin/python'} 11:55:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:39 INFO - Running setup.py (path:/tmp/pip-7du1UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:39 INFO - Running setup.py (path:/tmp/pip-evzj_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:39 INFO - Running setup.py (path:/tmp/pip-hMng16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:39 INFO - Running setup.py (path:/tmp/pip-85b6kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:39 INFO - Running setup.py (path:/tmp/pip-vjpsOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:39 INFO - Running setup.py (path:/tmp/pip-RBYMbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:39 INFO - Running setup.py (path:/tmp/pip-8hHcZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:39 INFO - Running setup.py (path:/tmp/pip-dxojpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:39 INFO - Running setup.py (path:/tmp/pip-NF1gBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:39 INFO - Running setup.py (path:/tmp/pip-aKKS4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:39 INFO - Running setup.py (path:/tmp/pip-vEnFwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:39 INFO - Running setup.py (path:/tmp/pip-fOkQWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:39 INFO - Running setup.py (path:/tmp/pip-O1QtO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:40 INFO - Running setup.py (path:/tmp/pip-NFC_J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:40 INFO - Running setup.py (path:/tmp/pip-eo6Fh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:40 INFO - Running setup.py (path:/tmp/pip-dRLGxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:40 INFO - Running setup.py (path:/tmp/pip-p8K2K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:40 INFO - Running setup.py install for manifestparser 11:55:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozcrash 11:55:40 INFO - Running setup.py install for mozdebug 11:55:40 INFO - Running setup.py install for mozdevice 11:55:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozfile 11:55:40 INFO - Running setup.py install for mozhttpd 11:55:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:40 INFO - Running setup.py install for mozinfo 11:55:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozInstall 11:55:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozleak 11:55:41 INFO - Running setup.py install for mozlog 11:55:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for moznetwork 11:55:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozprocess 11:55:41 INFO - Running setup.py install for mozprofile 11:55:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozrunner 11:55:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:41 INFO - Running setup.py install for mozscreenshot 11:55:41 INFO - Running setup.py install for moztest 11:55:42 INFO - Running setup.py install for mozversion 11:55:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:42 INFO - Cleaning up... 11:55:42 INFO - Return code: 0 11:55:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:42 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:42 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 11:55:42 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 11:55:42 INFO - Using env: {'DISPLAY': ':0', 11:55:42 INFO - 'HOME': '/home/cltbld', 11:55:42 INFO - 'LANG': 'en_US.UTF-8', 11:55:42 INFO - 'LANGUAGE': 'en_US:en', 11:55:42 INFO - 'LOGNAME': 'cltbld', 11:55:42 INFO - 'MAIL': '/var/mail/cltbld', 11:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:42 INFO - 'MOZ_NO_REMOTE': '1', 11:55:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:42 INFO - 'NO_EM_RESTART': '1', 11:55:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:42 INFO - 'PWD': '/builds/slave/test', 11:55:42 INFO - 'SHELL': '/bin/bash', 11:55:42 INFO - 'SHLVL': '1', 11:55:42 INFO - 'TERM': 'linux', 11:55:42 INFO - 'TMOUT': '86400', 11:55:42 INFO - 'USER': 'cltbld', 11:55:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:42 INFO - '_': '/tools/buildbot/bin/python'} 11:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:42 INFO - Running setup.py (path:/tmp/pip-yoerjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:42 INFO - Running setup.py (path:/tmp/pip-LmN8uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:42 INFO - Running setup.py (path:/tmp/pip-xZYbvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:42 INFO - Running setup.py (path:/tmp/pip-tDbzYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:42 INFO - Running setup.py (path:/tmp/pip-FL_f5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:42 INFO - Running setup.py (path:/tmp/pip-ii2BPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:42 INFO - Running setup.py (path:/tmp/pip-dAxGxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:42 INFO - Running setup.py (path:/tmp/pip-kPf8f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:42 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)) 11:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:42 INFO - Running setup.py (path:/tmp/pip-kuKVn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:43 INFO - Running setup.py (path:/tmp/pip-jevVhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:43 INFO - Running setup.py (path:/tmp/pip-UMZ1d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:43 INFO - Running setup.py (path:/tmp/pip-Go860S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:43 INFO - Running setup.py (path:/tmp/pip-Wj_1Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:43 INFO - Running setup.py (path:/tmp/pip-HNHLNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:43 INFO - Running setup.py (path:/tmp/pip-29oA_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:43 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)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:43 INFO - Running setup.py (path:/tmp/pip-mZKo6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:43 INFO - Running setup.py (path:/tmp/pip-7VbuwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:43 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)) 11:55:43 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)) 11:55:43 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)) 11:55:43 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)) 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:55:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:45 INFO - Downloading blessings-1.6.tar.gz 11:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:45 INFO - Installing collected packages: blessings 11:55:45 INFO - Running setup.py install for blessings 11:55:45 INFO - Successfully installed blessings 11:55:45 INFO - Cleaning up... 11:55:45 INFO - Return code: 0 11:55:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:46 INFO - Reading from file tmpfile_stdout 11:55:46 INFO - Current package versions: 11:55:46 INFO - argparse == 1.2.1 11:55:46 INFO - blessings == 1.6 11:55:46 INFO - blobuploader == 1.2.4 11:55:46 INFO - docopt == 0.6.1 11:55:46 INFO - functools32 == 3.2.3-2 11:55:46 INFO - jsonschema == 2.5.1 11:55:46 INFO - manifestparser == 1.1 11:55:46 INFO - mozInstall == 1.12 11:55:46 INFO - mozcrash == 1.0 11:55:46 INFO - mozdebug == 0.1 11:55:46 INFO - mozdevice == 0.48 11:55:46 INFO - mozfile == 1.2 11:55:46 INFO - mozhttpd == 0.7 11:55:46 INFO - mozinfo == 0.9 11:55:46 INFO - mozleak == 0.1 11:55:46 INFO - mozlog == 3.4 11:55:46 INFO - moznetwork == 0.27 11:55:46 INFO - mozprocess == 0.23 11:55:46 INFO - mozprofile == 0.28 11:55:46 INFO - mozrunner == 6.13 11:55:46 INFO - mozscreenshot == 0.1 11:55:46 INFO - mozsystemmonitor == 0.3 11:55:46 INFO - moztest == 0.7 11:55:46 INFO - mozversion == 1.4 11:55:46 INFO - psutil == 3.1.1 11:55:46 INFO - requests == 1.2.3 11:55:46 INFO - wsgiref == 0.1.2 11:55:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:55:46 INFO - Using env: {'DISPLAY': ':0', 11:55:46 INFO - 'HOME': '/home/cltbld', 11:55:46 INFO - 'LANG': 'en_US.UTF-8', 11:55:46 INFO - 'LANGUAGE': 'en_US:en', 11:55:46 INFO - 'LOGNAME': 'cltbld', 11:55:46 INFO - 'MAIL': '/var/mail/cltbld', 11:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:46 INFO - 'MOZ_NO_REMOTE': '1', 11:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:46 INFO - 'NO_EM_RESTART': '1', 11:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:46 INFO - 'PWD': '/builds/slave/test', 11:55:46 INFO - 'SHELL': '/bin/bash', 11:55:46 INFO - 'SHLVL': '1', 11:55:46 INFO - 'TERM': 'linux', 11:55:46 INFO - 'TMOUT': '86400', 11:55:46 INFO - 'USER': 'cltbld', 11:55:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:46 INFO - '_': '/tools/buildbot/bin/python'} 11:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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 0x7f90e7135f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bf6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:55:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:55:46 INFO - Using env: {'DISPLAY': ':0', 11:55:46 INFO - 'HOME': '/home/cltbld', 11:55:46 INFO - 'LANG': 'en_US.UTF-8', 11:55:46 INFO - 'LANGUAGE': 'en_US:en', 11:55:46 INFO - 'LOGNAME': 'cltbld', 11:55:46 INFO - 'MAIL': '/var/mail/cltbld', 11:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:46 INFO - 'MOZ_NO_REMOTE': '1', 11:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:55:46 INFO - 'NO_EM_RESTART': '1', 11:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:46 INFO - 'PWD': '/builds/slave/test', 11:55:46 INFO - 'SHELL': '/bin/bash', 11:55:46 INFO - 'SHLVL': '1', 11:55:46 INFO - 'TERM': 'linux', 11:55:46 INFO - 'TMOUT': '86400', 11:55:46 INFO - 'USER': 'cltbld', 11:55:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:46 INFO - '_': '/tools/buildbot/bin/python'} 11:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Running post-action listener: _resource_record_post_action 11:55:46 INFO - Running post-action listener: _start_resource_monitoring 11:55:46 INFO - Starting resource monitoring. 11:55:46 INFO - [mozharness: 2016-11-14 19:55:46.528917Z] Finished create-virtualenv step (success) 11:55:46 INFO - [mozharness: 2016-11-14 19:55:46.529498Z] Running install step. 11:55:46 INFO - Running pre-action listener: _resource_record_pre_action 11:55:46 INFO - Running main action method: install 11:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:46 INFO - Reading from file tmpfile_stdout 11:55:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:46 INFO - Reading from file tmpfile_stdout 11:55:46 INFO - Output received: 11:55:46 INFO - Usage: mozinstall [options] installer 11:55:46 INFO - Options: 11:55:46 INFO - -h, --help show this help message and exit 11:55:46 INFO - -d DEST, --destination=DEST 11:55:46 INFO - Directory to install application into. [default: 11:55:46 INFO - "/builds/slave/test"] 11:55:46 INFO - --app=APP Application being installed. [default: firefox] 11:55:46 INFO - mkdir: /builds/slave/test/build/application 11:55:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:55:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:56:02 INFO - Reading from file tmpfile_stdout 11:56:02 INFO - Output received: 11:56:02 INFO - /builds/slave/test/build/application/firefox/firefox 11:56:02 INFO - Running post-action listener: _resource_record_post_action 11:56:02 INFO - [mozharness: 2016-11-14 19:56:02.752236Z] Finished install step (success) 11:56:02 INFO - [mozharness: 2016-11-14 19:56:02.752479Z] Running run-tests step. 11:56:02 INFO - Running pre-action listener: _resource_record_pre_action 11:56:02 INFO - Running main action method: run_tests 11:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:02 INFO - Python 2.7.3 11:56:02 INFO - Return code: 0 11:56:02 INFO - grabbing minidump binary from tooltool 11:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:56:02 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/linux64/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 0x2bf3f60>, '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 0x2bf4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bf51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:02 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:56:02 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/linux64/releng.manifest -o -c /builds/tooltool_cache 11:56:02 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:56:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:02 INFO - Return code: 0 11:56:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:56:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:56:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:02 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:56:02 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:56:02 INFO - Using env: {'DISPLAY': ':0', 11:56:02 INFO - 'HOME': '/home/cltbld', 11:56:02 INFO - 'LANG': 'en_US.UTF-8', 11:56:02 INFO - 'LANGUAGE': 'en_US:en', 11:56:02 INFO - 'LOGNAME': 'cltbld', 11:56:02 INFO - 'MAIL': '/var/mail/cltbld', 11:56:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:02 INFO - 'MOZ_NO_REMOTE': '1', 11:56:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:56:02 INFO - 'NO_EM_RESTART': '1', 11:56:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:02 INFO - 'PWD': '/builds/slave/test', 11:56:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:02 INFO - 'SHELL': '/bin/bash', 11:56:02 INFO - 'SHLVL': '1', 11:56:02 INFO - 'TERM': 'linux', 11:56:02 INFO - 'TMOUT': '86400', 11:56:02 INFO - 'USER': 'cltbld', 11:56:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962', 11:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:02 INFO - '_': '/tools/buildbot/bin/python'} 11:56:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:56:03 INFO - mozversion application_buildid: 20161114081542 11:56:03 INFO - mozversion application_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:56:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:56:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:03 INFO - mozversion application_name: Firefox 11:56:03 INFO - mozversion application_remotingname: firefox-dev 11:56:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:56:03 INFO - mozversion application_vendor: Mozilla 11:56:03 INFO - mozversion application_version: 52.0a2 11:56:03 INFO - mozversion platform_buildid: 20161114081542 11:56:03 INFO - mozversion platform_changeset: f11ca24b2382ed6c8c7970a82fff53f7f3e0aa6d 11:56:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:56:03 INFO - mozversion platform_version: 52.0a2 11:56:03 INFO - using testdate: 1479153363 11:56:03 INFO - actual date: 1479153363 11:56:03 INFO - starting webserver on 'localhost:51316' 11:56:03 INFO - SUITE-START | Running 2 tests 11:56:03 INFO - TEST-START | dromaeo_css 11:56:03 INFO - operating with platform_type : linux_ 11:56:03 INFO - Initialising browser for dromaeo_css test... 11:56:03 INFO - TEST-INFO | started process 8643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1LhIaK/profile http://localhost:51316/getInfo.html) 11:56:05 ERROR - PROCESS | 8643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:56:06 INFO - PROCESS | 8643 | __metrics Screen width/height:1600/1200 11:56:06 INFO - PROCESS | 8643 | colorDepth:24 11:56:06 INFO - PROCESS | 8643 | Browser inner width/height: 1024/697 11:56:06 INFO - PROCESS | 8643 | __metrics 11:56:07 INFO - PROCESS | 8643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:56:07 INFO - PROCESS | 8643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:56:08 INFO - PROCESS | 8643 | console.error: PushService: 11:56:08 INFO - PROCESS | 8643 | stateChangeProcessEnqueue: Error transitioning state 11:56:08 INFO - PROCESS | 8643 | UnknownError 11:56:08 INFO - TEST-INFO | 8643: exit 0 11:56:08 INFO - Browser initialized. 11:56:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:08 INFO - TEST-INFO | started process 8735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1LhIaK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:20 INFO - PROCESS | 8735 | RSS: Main: 144498688 11:56:20 INFO - PROCESS | 8735 | 11:57:12 INFO - PROCESS | 8735 | 1479153432119 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:59:21 INFO - PROCESS | 8735 | Cycle 1(1): loaded http://localhost:51316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51316/tests/dromaeo/cssquery-ext.html) 11:59:23 INFO - PROCESS | 8735 | RSS: Main: 312315904 11:59:23 INFO - PROCESS | 8735 | 12:02:25 INFO - PROCESS | 8735 | Cycle 1(1): loaded http://localhost:51316/tests/dromaeo/cssquery-ext.html (next: http://localhost:51316/tests/dromaeo/cssquery-jquery.html) 12:02:26 INFO - PROCESS | 8735 | RSS: Main: 223858688 12:02:26 INFO - PROCESS | 8735 | 12:05:28 INFO - PROCESS | 8735 | Cycle 1(1): loaded http://localhost:51316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51316/tests/dromaeo/cssquery-mootools.html) 12:05:29 INFO - PROCESS | 8735 | RSS: Main: 174473216 12:05:29 INFO - PROCESS | 8735 | 12:08:31 INFO - PROCESS | 8735 | Cycle 1(1): loaded http://localhost:51316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51316/tests/dromaeo/cssquery-prototype.html) 12:08:31 INFO - PROCESS | 8735 | RSS: Main: 225239040 12:08:31 INFO - PROCESS | 8735 | 12:11:34 INFO - PROCESS | 8735 | Cycle 1(1): loaded http://localhost:51316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51316/tests/dromaeo/cssquery-yui.html) 12:11:35 INFO - PROCESS | 8735 | RSS: Main: 173957120 12:11:35 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | Cycle 1(1): loaded http://localhost:51316/tests/dromaeo/cssquery-yui.html (next: http://localhost:51316/tests/dromaeo/cssquery-dojo.html) 12:14:37 INFO - PROCESS | 8735 | RSS: Main: 268443648 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | __start_tp_report 12:14:37 INFO - PROCESS | 8735 | _x_x_mozilla_page_load 12:14:37 INFO - PROCESS | 8735 | _x_x_mozilla_page_load_details 12:14:37 INFO - PROCESS | 8735 | |i|pagename|runs| 12:14:37 INFO - PROCESS | 8735 | |0;dojo.html;3149.9370012599747;3190.282186508036;3190.6171259448856;3216.4371235033864;3228.1445416964507;5437.04851650961;5516.062269414199;5519.889602207959;5522.447755224475;5522.834314970557;5577.581681373893;5643;5643.774249030044;5652.886942261162;5661.943380566193;5046.54581087702;5064.113780088488;5099.286099946011;5126.30794842697;5153.81961631343;4860.7326597037145;5126.30794842697;5176.7929282828645;5177.197534382158;5182.870428239286;4857.73282469464;5037.992401519692;5047.747612619372;5050.217216331456;5067.290579318898;5076.543111119999;5109.412417571971;5119.360079990001;5165.096108181053;5191.0656081905245;5011.5489605935645;5083.440821509631;5138.614603904684;5142.665726727751;5145.742712864342;5344;5393.892122157535;5419.701916394597;5435.157550579666;5464.863378415532;5858.179854820329;5872.5889187756875;5932.970335148297;5957.987142185839;5961.284645842483;5945.405459454063;5946.286445626552;5947.167396564484;5955.731992060324;5997.010493268605;5300.575953923715;5331.840044798662;5513.696746678891;5549.833504994856;5567.053600887778;6116.724747386289;6148.600340977822;6154.076888466676;6158.753649853956;6159.3224745277985;5838.824835254949;5855.443732845373;5860.8534786629825;5861.0915308127305;5873.676947767828;5774.88450230993;5815;5883.735231914574;5886.882262354815;5902.4097590240635;5908.852278693067;5912.881742365129;5914.260717410324;5934.376890426443;5980.491658209101;5912.113183022581;5956.047032474783;5960.344362120163;5963.850903727442;5965.433283838029;4512.503624601291;4550.97724511382;4557.863264102082;4579.95420045802;4604.700694454849;4081.9387709184384;4100.6924480664065;4116.670666346685;4138.399932009842;4145.316022856195;5715.8571035724435;5729.0260655688635;5736.082226843685;5738.454846789548;5742.827715168552;5856.443637854397;5904.4095590441475;5968.820935371946;6031.457168854737;6044.153818465418;5693.601447898607;5751.1373294006235;5754.223179870748;5774.393688662714;5790.855228619318;5179.093658609803;5197.376314842168;5209.29674493946;5210.296609957607;5211.218317252366;6017.849553761191;6216.347283535164;6290.056491526308;6296;6296.087067375205;5794.971025144847;5837;5867.589268751147;5883.588148829541;5923.022701254417;6100.816975490742;6102.206713127265;6113.083037544404;6114.357992410733;6118.2658081028785;5785.4214578541805;5787.56593255516;5788.044972579645;5792.739326730223;5804.071348584206;5748.051571490657;5848.590598658223;5865.296164460292;5936.406359364029;5946.851328716817;5764.971175144097;5803.912941305968;5809.070548712186;5811.56413269015;5811.883762324815;5786.276715410574;5793.420657934173;5801.825945221482;5804.390538993345;5804.6807425592;5744.253247077853;5756;5801.854953626024;5812.070068788974;5905.616134951386;5925.555583331181;5933.525317974638;5943.316518600416;5960.642361458326;5961.493273071837;5491.643043202179;5808.854778630399;5820.039693450533;5820.0396934507025;5822.0684690449325 12:14:37 INFO - PROCESS | 8735 | |1;ext.html;559.4545318314644;612.439617749759;633.110479775915;656.019251219427;667.7395815631901;43031.35452968208;44073.77963110184;44190.11619767603;44210;47442.28836567446;45352.546474535244;45849.08301833961;45926.77036614812;45945.54054459454;45964.080718385696;8813.647454101845;8966.417182883091;8970;8973.865392019125;8975.910240897572;8797.956010219972;8881.24509416697;8893.822123557526;8896;8901.19889209971;8896.555172241362;8941.776455588597;8941.95529022354;8951.910480895205;8954.059823718513;8852.203301702846;8914.643414263423;8916.06381329964;8916.687915922945;8925.910740892637;8762.956185219096;8814.735557933273;8836.779080522974;8838.602262898185;8845.867311990325;42036;42211.36682949758;42373.57626423758;42477.78761106206;42542;3718.7025037996896;3723.832427540767;3781.735278530504;3841.692664586826;4225.556316586745;32626.6737332626;32831.179220519676;32871.83564082188;32992.17519562006;33039.3392132156;4423;4508.932131748931;4518.954810451919;4527.117212143633;4530.145416374399;337995;338605;339130;339958;344650;58411.707941460874;58777.70611146917;58833.70583147057;58857.41142588519;58880;38724.41913371302;39658.20683586312;39679;60251.69874150689;60270;18369.346758791773;18439.170237339353;18560.628787424175;18562.72155917662;18646.34737784171;13476.730465390638;13548.254845983369;13554.728905421836;13556.322183890767;13561;19296.677097303047;19436.514087147934;19530.70703939442;19547.902260488892;19558.217671293274;7013.527159296605;7113.110861142357;7139.572085582904;7254.8911766323545;7354.779356619203;975.1808480876098;1012.2104758288547;1039.589362201926;1051.6003918510917;1150.9942450287863;30519;31283.687163128077;31323.373532529222;31752.04743857688;31839.840800795846;975.9609615615437;994.5773046455228;1126.5155982927256;1128.1933417606451;1135.1372956552914;13089.803652945213;16455.588610284598;17227.655446890993;17337.826621733875;17928.103594820208;541560;541737;542495;546354;547253;59524.40475595275;59870.401295986485;60016.99999999913;60060.09909851356;60199.39800601938;1331.5672406467743;1347.8449978252627;1400.3558363153063;1432.3124900047826;1451.8257809062768;29623.259418513848;33043.83478082594;33390.499142512395;33513.664863351056;33694.21100377872;49373;49982.50017499924;50028.24957625566;50043.49956500534;50086.49913500964;309055;309864;312470;312545;313042;27070.593941090505;27434.45131097407;29206.7079329204;29812.46594039531;46540;47391;47700;51027;51170;51258.74370628123;41556.58443415527;42116.578834212494;42419;42472.78763606162;43422.56577434185;35842;36276.63723362733;36401.45397818982;37482;38208.80895595504;35086;35449.46825797667;35563.82218088893;35805.82097089498;36312.818435907655;36352.45471317879;37354.813225934784;37762.62237377701;38470.19457181807;38646.806765965994;25987.090451834094;26015.479690406464;26288.474230515665;26784.33039174036;27015.729842701323 12:14:37 INFO - PROCESS | 8735 | |2;jquery.html;404.27029212271873;405.6288496026138;409.22860408130686;415.69238763315144;415.7588598612805;14452.421903123888;18732.344367947124;19417.70873436896;20256.291029813958;20272.797272027274;19419.805801942013;19537.70693439596;19658.606827863434;19705.70441443376;19731.309404170857;5371.99999999999;5754.482096611304;5790.449907258825;5796.159556864252;5800.9129863052085;5536;5696.6866822324755;5737.196792449061;5739.799107031255;5741.024025915604;5683.801066962657;5711.600187986843;5720.399358067405;5725.398833122525;5727.914081288784;5490.313710786152;5692.658440493542;5697.572682048843;5703.087505999041;5703.629264097841;5177.119889618773;5181.766820493049;5187.429382767892;5188.455212202702;5189.532942035197;21541.246056388107;22002.88998554997;22282.220122295643;23287.76712232873;23323.4169145771;2478.9008439662393;2494.762997515233;2738.6439762830705;2930.926726831825;2951.4244722279163;10474.947625261824;10882.510287037103;10891.07425868802;10891.83662245067;10913.126949843994;1911.5221194701326;1952.8925909074994;1959.9220428764122;1969.7439332886634;2072.4508005378434;79683.60158199172;86588;86672;87616;88141;11125.777484450266;11235.775284494264;11446.713832154262;11553.422328883522;11634.185607007597;14317.35571899267;14807.185604791624;16213.675726485404;16313.83686163147;16326.77549183816;9736.123748862636;10203.438810865326;10344.120749736358;10445.425501597485;10760.623378181726;8248.175182481824;8681.913180868236;8802.823943521222;8834.038317989549;8965.641374344954;8763.518006509703;8975;9083;9149.176574108362;9293.303002274857;3226.306344136022;3229.6447390786993;3376.6285708572036;3429.4169991101076;3554.182538016271;888.3603805260202;989.2728844299434;992.5087081894364;998.5456617239139;1010.6210171185805;18939.90530047341;19386.61226775485;19458.416247512596;20474.078666460045;20597.382078537667;934.845750451168;954.7231302922214;977.3354119199013;1014.5079636376352;1052.936823790575;10257.692269231935;10947.945260273647;10983.176261780398;11046.392448415254;11079.667609971713;344358;345688;347329;472288;477687;99650;101773.49113254386;101977;104513.47743261387;104757;1051.6056478820442;1070.309650275568;1082.9729256768644;1114.6043154679971;1115.4534278203785;17158.39945601898;17468.73796893022;17535.473935781945;17565.209565569836;17812.109394530482;32895.506567401986;42024.80904612744;42032;44693.55306446894;44747.55252447434;56486.717566411906;57166.42833571611;58393.4160658388;58999.41000589939;61080;8752.60613272417;8791.912080879109;8822.426542274732;8891.64433422656;9115.225205857576;10144.594216231268;13661.521846735317;13782.862171378158;13876.028677992444;13955.58133256004;11226.101911846868;11758.470868810753;11790.823137653113;11833.290002599872;11839.28964262147;11424.257423267461;11765.352905589933;11766;11772.499290243319;12318;11485.827712584485;11527.8270825936;11554.364509952033;11625.825612615648;11669.708257293636;8275.337972962268;8501.55473569507;8549.230569248548;8775.07861674515;8793.956030219808;11334.886651133384;11414.600488982845;11488.310701357945;11505.252158609663;11739.706507337385 12:14:37 INFO - PROCESS | 8735 | |3;mootools.html;1409.6053105130568;1484.4878516911665;1524.6340878189235;1661.4351120618994;1795.2532625083627;7573;8534.829303413935;8813.823723525526;8820.91179088209;9116.316276279289;8812.559372031388;8891.42205756627;8899.37704360695;8906.242969347597;8915.554222288876;2521.8991240350365;2545.4654522550286;2546.8726563671744;2548.885300161488;2550.923472295834;2510.598304271317;2556.4759224358963;2556.961645575318;2558.0790915270486;2559.9616005759926;2471.0486462711806;2503.2240005598233;2510.7614776596192;2526.759957804015;2527.0902475108946;2408.397900524869;2451.718052423976;2473.468204336067;2488.9377765555823;2492.3395300245447;2464.864432456214;2505.348609361561;2526.7220605733355;2528.1404322530243;2560.219133164384;8859.335549833788;8898.644054237822;8946.821063578693;8955.37312388133;8958.596863141109;5488.231647569343;5601.495865372095;5614.101743721026;5696.344920334173;5703.74333155009;3598.8200589970397;3606.801625910574;3691.7231207659534;3711.2391959648476;3755.7183211259266;1352.0940969550425;1355.5391167003265;1356.416740801455;1401.4822794785061;1402.5652047865194;11962;11979.221350612183;12083.939580302042;12088.637340879788;12185.329806860707;4569.657275704336;4674.76626168697;4686.414198225222;4691.577758001797;4758.7389341823755;9566.33035687509;9567.952160239154;9577.712668619952;9584.28117891147;9609.231261499064;5498.560115190775;5570;5586.692731899703;5610.298712660918;5614.887702245932;4292.570742925683;4531.320301954733;4595.816167353269;5060.165072763027;5250.1337279349245;3974.2448934702315;4068.4710987571425;4129.215449064728;4170.624643782075;4177.143685544456;1229.1088960503741;1254.3226657604973;1280.2766436963086;1290.9741805163844;1295.8509771376412;930.3394589841289;957.6456711016968;976.8192884316283;978.5254151736402;1005.7535903703639;5913.02435098204;6141.692915354214;6142.170806941095;6203.906941395882;6432.388923052303;464.8187206989277;473.9289106633964;488.3480553461169;522.9712365819917;526.6076772804208;4239.215745087169;4268.146370725867;4290.034742182984;4365.585269399402;4443.37792709021;10942.343459392461;11073.335599864035;11185.608503702495;11192.944035279934;11368.317900925971;11133.332000080021;11147;11159.442027898573;11169.776604467865;11181.329120252649;8105.189481051848;8390.32877369809;8413.15868413166;8595.613197406132;8617.267532259828;5947.791827286024;6084.361142080195;6172.166757487682;6194.566380353332;6286.214223222098;10109.191264698953;10206;10232.23258255619;10253.38479691191;10342.5345859435;8648.43785153963;9533.856992144985;10117.089461948166;10192.745181370525;10317.48412579383;7679.616019199129;7886.72396466121;7968.7609371718945;7986.201379861967;8151.062627797642;8368.581570921551;8407.70573029941;8428.11504791988;8431.578421079044;8453.36599755033;7672.232776722283;7717.768466946;7751.573663448565;7886.960565197137;8062.798430039062;7568;7717.073951125901;7724.227577242231;7734.806629834299;7937.126916039347;7313.597752123472;7353.154387245321;7418.888716669362;7433.516821406592;7521.435892308208;5051.62112841531;5148.819791307286;5193.896122077462;5269.78920843162;5285.894282114413;5272.130098533852;5357.678539287655;5430.83707488776;5457.20870473787;5582.078956972054 12:14:37 INFO - PROCESS | 8735 | |4;prototype.html;333.0836848121724;339.5467051486266;343.87964212525617;344.41793369206056;345.4438354249659;5371.099606212645;5379.81170659027;5380.784768609261;5399.163129714891;5409.756560954756;5044.873878153048;5087.211482220262;5168.250603662476;5211.244369566411;5343.465653434664;4150.3359462486005;4151.709380343377;4156.147989662127;4163.188178305231;4191.455110835587;4141.62725354718;4163.500379954395;4168.124693814302;4193.490343476346;4204.1801848639525;3948.190620922704;3948.986017131255;4048.6558642515274;4125.711200215986;4140.275451795924;4145;4167.499900011988;4168.228877657643;4171;4187.078842654611;3703.9814051136154;3705.184859330943;3710.517632707758;3714.591394946554;3715.8699445519546;5052.46949070346;5067.569256613192;5099.184130539096;5189.714565698885;5239.816606418757;4735.360726301939;4738.549837765407;4740.506740376771;4744.525547445262;4754.120487709784;5521.889562208733;5533.956324021812;5546.334439867202;5551.639143455703;5602.747876345534;3912.471816304791;3996.300647386725;4021.7989100545146;4057.452243947059;4070.5115386153852;5668.376478587352;5694.288213973295;5720.971395143039;5721.970045391828;5725.713714314309;4093.6725061995567;4102.118044620421;4108.322126849096;4137.469136419544;4162.500499940026;3901.122247494291;4030.173814368106;4225.852095176716;4231.746095234295;4234.0050088229245;4669.556392142741;4685.1800934836265;4688.835890743808;4693.577578017995;4696.2486002239475;5562.443755624486;5582.33012038558;5607.4112218217315;5607.8878422432135;5631.63394379364;1319.4260496683974;1358.7974642441313;1378.5726424808342;1384.6123085536067;1388.9513867014607;892.5537231384308;916.8081494057699;990.3562684255147;1012.3571532077184;1024.8770147582188;5163.922541161885;5191.935653191087;5197.532222100029;5218.243354713545;5220.415894132429;5446.400895901447;5455.863603409946;5479.397266300703;5485.725713714299;5540.473655002849;5200.791968321225;5244.76398562058;5406.513413792699;5455.427180146027;5459.508644222039;2938.676745557987;2939.6472423309338;2947.6168098147105;2954.6454425469083;2964.5997790298466;5616.6068375213345;5748.31020277561;5763.740631671585;5776.971115144397;5815.680137592389;5557.916631250535;5610.353270374289;5634.7182640867795;5642.576806739511;5651.773929042793;5744.195812586241;5746.310442746897;5751.712414379264;5754.798582049608;5772.797952071742;5392.218128371443;5457.399686034612;5499.587530935116;5511.641743286674;5577.581681373832;5461.290032295776;5471;5483.259759932517;5484.643498172606;5489.478499542537;5449.754761035842;5714;5726.541876649775;5760.135979603093;5798.651011741194;3947.82234799429;3957.7031722621496;3964.306246406925;3965.1871366369246;3988.501437320335;5526.723663816712;5531.944680553304;5542.224088627515;5560.916586251128;5571.9721401392735;5254.610776049503;5400.675959442446;5426.67439953604;5436.945630543644;5439.184122381675;5582.33012038558;5587;5590.692511911884;5599.356074051536;5621;5337.572994160536;5508.944910551004;5546.500814926676;5550.02973944244;5561.749721262472;5543.695096769717;5587.245721827501;5603.327600687943;5626.381098079126;5629.521490673174;5479;5492.148716948879;5501.449855014466;5510.614257001971;5525.392206857323 12:14:37 INFO - PROCESS | 8735 | |5;yui.html;774.9651265693043;783.9960800195998;830.8130670599115;843.5697794124997;870.5603670146575;14919.47781827635;15248.237588120592;15976;15979.840201597995;16000.83999160008;13104.14823036502;13367.665808354795;14184.148951062944;14200.502982395617;14214.573562793106;814.0434988888062;830.8587540118194;831.2061980808344;831.9209675080888;832.9916700832974;698.2877464985711;709.9325564071405;799.672134424883;813.6989313953845;817.8650522663753;871.4640496094888;884.1865483754929;884.9380543361967;885.5173930208019;885.7032893980492;878.3851304087101;878.8945326560822;879.3404946290283;879.3888247667874;880.3045593980779;533.8371796602034;546.8222827581012;610.6397225636896;629.1506466270544;640.1486023588662;14530.636734081627;14625.341859616343;14635.341409636592;14643.41426342945;14675.559733208021;13386.26375549354;13915.930420347833;13930.233837138954;13988.650283742885;14003.229822359766;12628.81056784149;12668.2399056056;12895.871041289562;12992.610221693365;13044.41300141496;4275.893102672427;4280.892977675552;4283.764392958386;4288.592583704543;4403.757793321366;62410.37589624091;63867;64005.35994640041;65532.344676553104;65639;11304.378259195659;11338;11385.886141138482;11415.771684566262;11508.251963622337;20168.19327226924;20230.089645965967;20390.28633997803;20435.795642043686;20442;8195;8205.671773129008;8215;8248.8350232995;8307.460015098999;4483.103379324149;4530.07133537624;4777.4505931818285;4805.37530121082;4887.706737595756;3420.572428446444;3475.1138459692615;3503.649635036527;3505.1938054247157;3520.5247291615815;667.2060248304502;670.9127813384229;678.640320630057;684.6474065856088;686.2005763285716;704.6159842885639;705.4321271376591;745.4185735126609;751.9987334758177;758.624480881956;9921.603135874484;9979;10012.148967337858;10048.49757512136;10298.485075746183;650;681.7170874087298;693.2166651683666;740.1081696555638;751.8496300739874;4736.218523943511;4837.9032419351415;4841.878953026132;4846.733429661403;4862.07620552094;54526.182107268425;72540.27459725334;88218;88479.11520884708;90670;73411;78358;79406.60296698479;80328.19671803206;80441;44743.776281118386;45945.08109837851;46119.30821037687;68173;70691.64654176799;9321.813563728823;9333.906660933575;9344.15902568772;9354.95322523383;9624.37441566296;46959.53040469551;47298.527014729414;47736;49759.50240497549;50641.74679126581;61030.69484652726;63616.68191659012;66757.33242667705;67619.66190169018;68365.65817170883;10652.360858348524;10795.244332896622;10836.458177090955;12776.552820651232;12823.230606163661;14759.040662356912;15187.772183417037;15200.239988000776;15343.46297879569;16319;13628.86371136276;14288.357023934155;14588.781168282696;14624.85375146235;14677.70644587081;12242.693932651755;12463.189892656948;13387.129836560593;13595.184288942695;13749.725005500035;13146.539871104465;14160.645983850487;14328.785068224193;14734.926325368304;14801.777973330194;10737.355758654505;11727.824082638937;11990.820137697767;12566.685832854251;12736.74526509483;11054.723631909266;11942.641720748392;12060.939695301468;12137.21108127969;12355.135140540076 12:14:37 INFO - PROCESS | 8735 | __end_tp_report 12:14:37 INFO - PROCESS | 8735 | __start_cc_report 12:14:37 INFO - PROCESS | 8735 | _x_x_mozilla_cycle_collect,1679 12:14:37 INFO - PROCESS | 8735 | __end_cc_report 12:14:37 INFO - PROCESS | 8735 | __startTimestamp1479154477806__endTimestamp 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | ------- Summary: start ------- 12:14:37 INFO - PROCESS | 8735 | Number of tests: 6 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | [#0] dojo.html Cycles:165 Average:5531.68 Median:5787.57 stddev:622.06 (10.7%) stddev-sans-first:595.25 12:14:37 INFO - PROCESS | 8735 | Values: 3149.9 3190.3 3190.6 3216.4 3228.1 5437.0 5516.1 5519.9 5522.4 5522.8 5577.6 5643.0 5643.8 5652.9 5661.9 5046.5 5064.1 5099.3 5126.3 5153.8 4860.7 5126.3 5176.8 5177.2 5182.9 4857.7 5038.0 5047.7 5050.2 5067.3 5076.5 5109.4 5119.4 5165.1 5191.1 5011.5 5083.4 5138.6 5142.7 5145.7 5344.0 5393.9 5419.7 5435.2 5464.9 5858.2 5872.6 5933.0 5958.0 5961.3 5945.4 5946.3 5947.2 5955.7 5997.0 5300.6 5331.8 5513.7 5549.8 5567.1 6116.7 6148.6 6154.1 6158.8 6159.3 5838.8 5855.4 5860.9 5861.1 5873.7 5774.9 5815.0 5883.7 5886.9 5902.4 5908.9 5912.9 5914.3 5934.4 5980.5 5912.1 5956.0 5960.3 5963.9 5965.4 4512.5 4551.0 4557.9 4580.0 4604.7 4081.9 4100.7 4116.7 4138.4 4145.3 5715.9 5729.0 5736.1 5738.5 5742.8 5856.4 5904.4 5968.8 6031.5 6044.2 5693.6 5751.1 5754.2 5774.4 5790.9 5179.1 5197.4 5209.3 5210.3 5211.2 6017.8 6216.3 6290.1 6296.0 6296.1 5795.0 5837.0 5867.6 5883.6 5923.0 6100.8 6102.2 6113.1 6114.4 6118.3 5785.4 5787.6 5788.0 5792.7 5804.1 5748.1 5848.6 5865.3 5936.4 5946.9 5765.0 5803.9 5809.1 5811.6 5811.9 5786.3 5793.4 5801.8 5804.4 5804.7 5744.3 5756.0 5801.9 5812.1 5905.6 5925.6 5933.5 5943.3 5960.6 5961.5 5491.6 5808.9 5820.0 5820.0 5822.1 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | [#1] ext.html Cycles:180 Average:56501.90 Median:42163.97 stddev:109109.85 (258.8%) stddev-sans-first:109335.09 12:14:37 INFO - PROCESS | 8735 | Values: 559.5 612.4 633.1 656.0 667.7 43031.4 44073.8 44190.1 44210.0 47442.3 45352.5 45849.1 45926.8 45945.5 45964.1 8813.6 8966.4 8970.0 8973.9 8975.9 8798.0 8881.2 8893.8 8896.0 8901.2 8896.6 8941.8 8942.0 8951.9 8954.1 8852.2 8914.6 8916.1 8916.7 8925.9 8763.0 8814.7 8836.8 8838.6 8845.9 42036.0 42211.4 42373.6 42477.8 42542.0 3718.7 3723.8 3781.7 3841.7 4225.6 32626.7 32831.2 32871.8 32992.2 33039.3 4423.0 4508.9 4519.0 4527.1 4530.1 337995.0 338605.0 339130.0 339958.0 344650.0 58411.7 58777.7 58833.7 58857.4 58880.0 38724.4 39658.2 39679.0 60251.7 60270.0 18369.3 18439.2 18560.6 18562.7 18646.3 13476.7 13548.3 13554.7 13556.3 13561.0 19296.7 19436.5 19530.7 19547.9 19558.2 7013.5 7113.1 7139.6 7254.9 7354.8 975.2 1012.2 1039.6 1051.6 1151.0 30519.0 31283.7 31323.4 31752.0 31839.8 976.0 994.6 1126.5 1128.2 1135.1 13089.8 16455.6 17227.7 17337.8 17928.1 541560.0 541737.0 542495.0 546354.0 547253.0 59524.4 59870.4 60017.0 60060.1 60199.4 1331.6 1347.8 1400.4 1432.3 1451.8 29623.3 33043.8 33390.5 33513.7 33694.2 49373.0 49982.5 50028.2 50043.5 50086.5 309055.0 309864.0 312470.0 312545.0 313042.0 27070.6 27434.5 29206.7 29812.5 46540.0 47391.0 47700.0 51027.0 51170.0 51258.7 41556.6 42116.6 42419.0 42472.8 43422.6 35842.0 36276.6 36401.5 37482.0 38208.8 35086.0 35449.5 35563.8 35805.8 36312.8 36352.5 37354.8 37762.6 38470.2 38646.8 25987.1 26015.5 26288.5 26784.3 27015.7 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | [#2] jquery.html Cycles:180 Average:27131.89 Median:12901.16 stddev:67346.29 (522.0%) stddev-sans-first:67505.31 12:14:37 INFO - PROCESS | 8735 | Values: 404.3 405.6 409.2 415.7 415.8 14452.4 18732.3 19417.7 20256.3 20272.8 19419.8 19537.7 19658.6 19705.7 19731.3 5372.0 5754.5 5790.4 5796.2 5800.9 5536.0 5696.7 5737.2 5739.8 5741.0 5683.8 5711.6 5720.4 5725.4 5727.9 5490.3 5692.7 5697.6 5703.1 5703.6 5177.1 5181.8 5187.4 5188.5 5189.5 21541.2 22002.9 22282.2 23287.8 23323.4 2478.9 2494.8 2738.6 2930.9 2951.4 10474.9 10882.5 10891.1 10891.8 10913.1 1911.5 1952.9 1959.9 1969.7 2072.5 79683.6 86588.0 86672.0 87616.0 88141.0 11125.8 11235.8 11446.7 11553.4 11634.2 14317.4 14807.2 16213.7 16313.8 16326.8 9736.1 10203.4 10344.1 10445.4 10760.6 8248.2 8681.9 8802.8 8834.0 8965.6 8763.5 8975.0 9083.0 9149.2 9293.3 3226.3 3229.6 3376.6 3429.4 3554.2 888.4 989.3 992.5 998.5 1010.6 18939.9 19386.6 19458.4 20474.1 20597.4 934.8 954.7 977.3 1014.5 1052.9 10257.7 10947.9 10983.2 11046.4 11079.7 344358.0 345688.0 347329.0 472288.0 477687.0 99650.0 101773.5 101977.0 104513.5 104757.0 1051.6 1070.3 1083.0 1114.6 1115.5 17158.4 17468.7 17535.5 17565.2 17812.1 32895.5 42024.8 42032.0 44693.6 44747.6 56486.7 57166.4 58393.4 58999.4 61080.0 8752.6 8791.9 8822.4 8891.6 9115.2 10144.6 13661.5 13782.9 13876.0 13955.6 11226.1 11758.5 11790.8 11833.3 11839.3 11424.3 11765.4 11766.0 11772.5 12318.0 11485.8 11527.8 11554.4 11625.8 11669.7 8275.3 8501.6 8549.2 8775.1 8794.0 11334.9 11414.6 11488.3 11505.3 11739.7 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | [#3] mootools.html Cycles:180 Average:5887.66 Median:5055.89 stddev:3252.62 (64.3%) stddev-sans-first:3244.33 12:14:37 INFO - PROCESS | 8735 | Values: 1409.6 1484.5 1524.6 1661.4 1795.3 7573.0 8534.8 8813.8 8820.9 9116.3 8812.6 8891.4 8899.4 8906.2 8915.6 2521.9 2545.5 2546.9 2548.9 2550.9 2510.6 2556.5 2557.0 2558.1 2560.0 2471.0 2503.2 2510.8 2526.8 2527.1 2408.4 2451.7 2473.5 2488.9 2492.3 2464.9 2505.3 2526.7 2528.1 2560.2 8859.3 8898.6 8946.8 8955.4 8958.6 5488.2 5601.5 5614.1 5696.3 5703.7 3598.8 3606.8 3691.7 3711.2 3755.7 1352.1 1355.5 1356.4 1401.5 1402.6 11962.0 11979.2 12083.9 12088.6 12185.3 4569.7 4674.8 4686.4 4691.6 4758.7 9566.3 9568.0 9577.7 9584.3 9609.2 5498.6 5570.0 5586.7 5610.3 5614.9 4292.6 4531.3 4595.8 5060.2 5250.1 3974.2 4068.5 4129.2 4170.6 4177.1 1229.1 1254.3 1280.3 1291.0 1295.9 930.3 957.6 976.8 978.5 1005.8 5913.0 6141.7 6142.2 6203.9 6432.4 464.8 473.9 488.3 523.0 526.6 4239.2 4268.1 4290.0 4365.6 4443.4 10942.3 11073.3 11185.6 11192.9 11368.3 11133.3 11147.0 11159.4 11169.8 11181.3 8105.2 8390.3 8413.2 8595.6 8617.3 5947.8 6084.4 6172.2 6194.6 6286.2 10109.2 10206.0 10232.2 10253.4 10342.5 8648.4 9533.9 10117.1 10192.7 10317.5 7679.6 7886.7 7968.8 7986.2 8151.1 8368.6 8407.7 8428.1 8431.6 8453.4 7672.2 7717.8 7751.6 7887.0 8062.8 7568.0 7717.1 7724.2 7734.8 7937.1 7313.6 7353.2 7418.9 7433.5 7521.4 5051.6 5148.8 5193.9 5269.8 5285.9 5272.1 5357.7 5430.8 5457.2 5582.1 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | [#4] prototype.html Cycles:180 Average:4639.40 Median:5357.28 stddev:1348.28 (25.2%) stddev-sans-first:1312.75 12:14:37 INFO - PROCESS | 8735 | Values: 333.1 339.5 343.9 344.4 345.4 5371.1 5379.8 5380.8 5399.2 5409.8 5044.9 5087.2 5168.3 5211.2 5343.5 4150.3 4151.7 4156.1 4163.2 4191.5 4141.6 4163.5 4168.1 4193.5 4204.2 3948.2 3949.0 4048.7 4125.7 4140.3 4145.0 4167.5 4168.2 4171.0 4187.1 3704.0 3705.2 3710.5 3714.6 3715.9 5052.5 5067.6 5099.2 5189.7 5239.8 4735.4 4738.5 4740.5 4744.5 4754.1 5521.9 5534.0 5546.3 5551.6 5602.7 3912.5 3996.3 4021.8 4057.5 4070.5 5668.4 5694.3 5721.0 5722.0 5725.7 4093.7 4102.1 4108.3 4137.5 4162.5 3901.1 4030.2 4225.9 4231.7 4234.0 4669.6 4685.2 4688.8 4693.6 4696.2 5562.4 5582.3 5607.4 5607.9 5631.6 1319.4 1358.8 1378.6 1384.6 1389.0 892.6 916.8 990.4 1012.4 1024.9 5163.9 5191.9 5197.5 5218.2 5220.4 5446.4 5455.9 5479.4 5485.7 5540.5 5200.8 5244.8 5406.5 5455.4 5459.5 2938.7 2939.6 2947.6 2954.6 2964.6 5616.6 5748.3 5763.7 5777.0 5815.7 5557.9 5610.4 5634.7 5642.6 5651.8 5744.2 5746.3 5751.7 5754.8 5772.8 5392.2 5457.4 5499.6 5511.6 5577.6 5461.3 5471.0 5483.3 5484.6 5489.5 5449.8 5714.0 5726.5 5760.1 5798.7 3947.8 3957.7 3964.3 3965.2 3988.5 5526.7 5531.9 5542.2 5560.9 5572.0 5254.6 5400.7 5426.7 5436.9 5439.2 5582.3 5587.0 5590.7 5599.4 5621.0 5337.6 5508.9 5546.5 5550.0 5561.7 5543.7 5587.2 5603.3 5626.4 5629.5 5479.0 5492.1 5501.4 5510.6 5525.4 12:14:37 INFO - PROCESS | 8735 | 12:14:37 INFO - PROCESS | 8735 | [#5] yui.html Cycles:180 Average:17708.29 Median:26236.11 stddev:22646.47 (86.3%) stddev-sans-first:22674.31 12:14:37 INFO - PROCESS | 8735 | Values: 775.0 784.0 830.8 843.6 870.6 14919.5 15248.2 15976.0 15979.8 16000.8 13104.1 13367.7 14184.1 14200.5 14214.6 814.0 830.9 831.2 831.9 833.0 698.3 709.9 799.7 813.7 817.9 871.5 884.2 884.9 885.5 885.7 878.4 878.9 879.3 879.4 880.3 533.8 546.8 610.6 629.2 640.1 14530.6 14625.3 14635.3 14643.4 14675.6 13386.3 13915.9 13930.2 13988.7 14003.2 12628.8 12668.2 12895.9 12992.6 13044.4 4275.9 4280.9 4283.8 4288.6 4403.8 62410.4 63867.0 64005.4 65532.3 65639.0 11304.4 11338.0 11385.9 11415.8 11508.3 20168.2 20230.1 20390.3 20435.8 20442.0 8195.0 8205.7 8215.0 8248.8 8307.5 4483.1 4530.1 4777.5 4805.4 4887.7 3420.6 3475.1 3503.6 3505.2 3520.5 667.2 670.9 678.6 684.6 686.2 704.6 705.4 745.4 752.0 758.6 9921.6 9979.0 10012.1 10048.5 10298.5 650.0 681.7 693.2 740.1 751.8 4736.2 4837.9 4841.9 4846.7 4862.1 54526.2 72540.3 88218.0 88479.1 90670.0 73411.0 78358.0 79406.6 80328.2 80441.0 44743.8 45945.1 46119.3 68173.0 70691.6 9321.8 9333.9 9344.2 9355.0 9624.4 46959.5 47298.5 47736.0 49759.5 50641.7 61030.7 63616.7 66757.3 67619.7 68365.7 10652.4 10795.2 10836.5 12776.6 12823.2 14759.0 15187.8 15200.2 15343.5 16319.0 13628.9 14288.4 14588.8 14624.9 14677.7 12242.7 12463.2 13387.1 13595.2 13749.7 13146.5 14160.6 14328.8 14734.9 14801.8 10737.4 11727.8 11990.8 12566.7 12736.7 11054.7 11942.6 12060.9 12137.2 12355.1 12:14:37 INFO - PROCESS | 8735 | -------- Summary: end -------- 12:14:37 INFO - PROCESS | 8735 | 12:14:38 INFO - TEST-INFO | 8735: exit 0 12:14:38 INFO - TEST-OK | dromaeo_css | took 1115605ms 12:14:38 INFO - TEST-START | kraken 12:14:38 INFO - operating with platform_type : linux_ 12:14:38 INFO - Initialising browser for kraken test... 12:14:38 INFO - TEST-INFO | started process 9052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PQgr0/profile http://localhost:51316/getInfo.html) 12:14:41 ERROR - PROCESS | 9052 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 12:14:42 INFO - PROCESS | 9052 | __metrics Screen width/height:1600/1200 12:14:42 INFO - PROCESS | 9052 | colorDepth:24 12:14:42 INFO - PROCESS | 9052 | Browser inner width/height: 1024/697 12:14:42 INFO - PROCESS | 9052 | __metrics 12:14:43 INFO - PROCESS | 9052 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:14:43 INFO - PROCESS | 9052 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:43 INFO - PROCESS | 9052 | console.error: PushService: 12:14:43 INFO - PROCESS | 9052 | stateChangeProcessEnqueue: Error transitioning state 12:14:43 INFO - PROCESS | 9052 | UnknownError 12:14:44 INFO - TEST-INFO | 9052: exit 0 12:14:44 INFO - Browser initialized. 12:14:44 INFO - Running cycle 1/1 for kraken test... 12:14:44 INFO - TEST-INFO | started process 9145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4PQgr0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:56 INFO - PROCESS | 9145 | RSS: Main: 144850944 12:14:56 INFO - PROCESS | 9145 | 12:14:58 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51316/tests/kraken/driver.html?testName=audio-beat-detection) 12:14:59 INFO - PROCESS | 9145 | RSS: Main: 186474496 12:14:59 INFO - PROCESS | 9145 | 12:15:02 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51316/tests/kraken/driver.html?testName=audio-dft) 12:15:02 INFO - PROCESS | 9145 | RSS: Main: 175697920 12:15:02 INFO - PROCESS | 9145 | 12:15:05 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51316/tests/kraken/driver.html?testName=audio-fft) 12:15:06 INFO - PROCESS | 9145 | RSS: Main: 267096064 12:15:06 INFO - PROCESS | 9145 | 12:15:08 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51316/tests/kraken/driver.html?testName=audio-oscillator) 12:15:08 INFO - PROCESS | 9145 | RSS: Main: 173764608 12:15:08 INFO - PROCESS | 9145 | 12:15:10 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:11 INFO - PROCESS | 9145 | RSS: Main: 175513600 12:15:11 INFO - PROCESS | 9145 | 12:15:14 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51316/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:15 INFO - PROCESS | 9145 | RSS: Main: 215011328 12:15:15 INFO - PROCESS | 9145 | 12:15:18 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51316/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:18 INFO - PROCESS | 9145 | RSS: Main: 213176320 12:15:18 INFO - PROCESS | 9145 | 12:15:21 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51316/tests/kraken/driver.html?testName=json-parse-financial) 12:15:22 INFO - PROCESS | 9145 | RSS: Main: 211779584 12:15:22 INFO - PROCESS | 9145 | 12:15:23 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:24 INFO - PROCESS | 9145 | RSS: Main: 174608384 12:15:24 INFO - PROCESS | 9145 | 12:15:26 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:26 INFO - PROCESS | 9145 | RSS: Main: 181063680 12:15:26 INFO - PROCESS | 9145 | 12:15:28 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:29 INFO - PROCESS | 9145 | RSS: Main: 190332928 12:15:29 INFO - PROCESS | 9145 | 12:15:31 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:32 INFO - PROCESS | 9145 | RSS: Main: 199954432 12:15:32 INFO - PROCESS | 9145 | 12:15:35 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:15:35 INFO - PROCESS | 9145 | RSS: Main: 195670016 12:15:35 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | Cycle 1(1): loaded http://localhost:51316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51316/tests/kraken/driver.html?testName=ai-astar) 12:15:37 INFO - PROCESS | 9145 | RSS: Main: 246394880 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | __start_tp_report 12:15:37 INFO - PROCESS | 9145 | _x_x_mozilla_page_load 12:15:37 INFO - PROCESS | 9145 | _x_x_mozilla_page_load_details 12:15:37 INFO - PROCESS | 9145 | |i|pagename|runs| 12:15:37 INFO - PROCESS | 9145 | |0;ai-astar;102;111;111;110;110;111;111;111;112;111 12:15:37 INFO - PROCESS | 9145 | |1;audio-beat-detection;148;120;120;156;124;120;122;124;158;121 12:15:37 INFO - PROCESS | 9145 | |2;audio-dft;162;160;161;160;161;160;161;162;161;160 12:15:37 INFO - PROCESS | 9145 | |3;audio-fft;75;75;76;105;76;78;75;75;110;75 12:15:37 INFO - PROCESS | 9145 | |4;audio-oscillator;82;82;129;82;82;81;100;81;81;111 12:15:37 INFO - PROCESS | 9145 | |5;imaging-gaussian-blur;117;119;117;118;117;117;117;117;118;116 12:15:37 INFO - PROCESS | 9145 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;147;147 12:15:37 INFO - PROCESS | 9145 | |7;imaging-desaturate;84;85;84;84;85;84;85;84;84;85 12:15:37 INFO - PROCESS | 9145 | |8;json-parse-financial;49;50;49;50;49;50;51;53;50;51 12:15:37 INFO - PROCESS | 9145 | |9;json-stringify-tinderbox;58;58;59;59;58;59;59;59;58;58 12:15:37 INFO - PROCESS | 9145 | |10;stanford-crypto-aes;75;83;75;75;74;74;74;74;73;74 12:15:37 INFO - PROCESS | 9145 | |11;stanford-crypto-ccm;129;137;136;135;130;136;125;129;173;126 12:15:37 INFO - PROCESS | 9145 | |12;stanford-crypto-pbkdf2;155;160;155;156;156;153;155;153;152;153 12:15:37 INFO - PROCESS | 9145 | |13;stanford-crypto-sha256-iterative;62;62;63;62;64;62;61;60;61;60 12:15:37 INFO - PROCESS | 9145 | __end_tp_report 12:15:37 INFO - PROCESS | 9145 | __start_cc_report 12:15:37 INFO - PROCESS | 9145 | _x_x_mozilla_cycle_collect,1608 12:15:37 INFO - PROCESS | 9145 | __end_cc_report 12:15:37 INFO - PROCESS | 9145 | __startTimestamp1479154537714__endTimestamp 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | ------- Summary: start ------- 12:15:37 INFO - PROCESS | 9145 | Number of tests: 14 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.87 (2.6%) stddev-sans-first:0.60 12:15:37 INFO - PROCESS | 9145 | Values: 102.0 111.0 111.0 110.0 110.0 111.0 111.0 111.0 112.0 111.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:124.00 stddev:15.93 (12.8%) stddev-sans-first:15.71 12:15:37 INFO - PROCESS | 9145 | Values: 148.0 120.0 120.0 156.0 124.0 120.0 122.0 124.0 158.0 121.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 12:15:37 INFO - PROCESS | 9145 | Values: 162.0 160.0 161.0 160.0 161.0 160.0 161.0 162.0 161.0 160.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#3] audio-fft Cycles:10 Average:82.00 Median:75.00 stddev:13.52 (18.0%) stddev-sans-first:14.10 12:15:37 INFO - PROCESS | 9145 | Values: 75.0 75.0 76.0 105.0 76.0 78.0 75.0 75.0 110.0 75.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.50 stddev:16.83 (20.6%) stddev-sans-first:17.52 12:15:37 INFO - PROCESS | 9145 | Values: 82.0 82.0 129.0 82.0 82.0 81.0 100.0 81.0 81.0 111.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 12:15:37 INFO - PROCESS | 9145 | Values: 117.0 119.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 116.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:15:37 INFO - PROCESS | 9145 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 12:15:37 INFO - PROCESS | 9145 | Values: 84.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 84.0 85.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:1.23 (2.5%) stddev-sans-first:1.22 12:15:37 INFO - PROCESS | 9145 | Values: 49.0 50.0 49.0 50.0 49.0 50.0 51.0 53.0 50.0 51.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 12:15:37 INFO - PROCESS | 9145 | Values: 58.0 58.0 59.0 59.0 58.0 59.0 59.0 59.0 58.0 58.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:2.85 (3.8%) stddev-sans-first:3.02 12:15:37 INFO - PROCESS | 9145 | Values: 75.0 83.0 75.0 75.0 74.0 74.0 74.0 74.0 73.0 74.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:135.50 stddev:13.84 (10.2%) stddev-sans-first:14.47 12:15:37 INFO - PROCESS | 9145 | Values: 129.0 137.0 136.0 135.0 130.0 136.0 125.0 129.0 173.0 126.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:2.30 (1.5%) stddev-sans-first:2.44 12:15:37 INFO - PROCESS | 9145 | Values: 155.0 160.0 155.0 156.0 156.0 153.0 155.0 153.0 152.0 153.0 12:15:37 INFO - PROCESS | 9145 | 12:15:37 INFO - PROCESS | 9145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 12:15:37 INFO - PROCESS | 9145 | Values: 62.0 62.0 63.0 62.0 64.0 62.0 61.0 60.0 61.0 60.0 12:15:37 INFO - PROCESS | 9145 | -------- Summary: end -------- 12:15:37 INFO - PROCESS | 9145 | 12:15:38 INFO - TEST-INFO | 9145: exit 0 12:15:38 INFO - TEST-OK | kraken | took 60104ms 12:15:38 INFO - SUITE-END | took 1175s 12:15:38 INFO - Completed test suite (00:19:35) 12:15:38 INFO - javascript benchmark 12:15:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.9370012599747, 3190.282186508036, 3190.6171259448856, 3216.4371235033864, 3228.1445416964507, 5437.04851650961, 5516.062269414199, 5519.889602207959, 5522.447755224475, 5522.834314970557, 5577.581681373893, 5643.0, 5643.774249030044, 5652.886942261162, 5661.943380566193, 5046.54581087702, 5064.113780088488, 5099.286099946011, 5126.30794842697, 5153.81961631343, 4860.7326597037145, 5126.30794842697, 5176.7929282828645, 5177.197534382158, 5182.870428239286, 4857.73282469464, 5037.992401519692, 5047.747612619372, 5050.217216331456, 5067.290579318898, 5076.543111119999, 5109.412417571971, 5119.360079990001, 5165.096108181053, 5191.0656081905245, 5011.5489605935645, 5083.440821509631, 5138.614603904684, 5142.665726727751, 5145.742712864342, 5344.0, 5393.892122157535, 5419.701916394597, 5435.157550579666, 5464.863378415532, 5858.179854820329, 5872.5889187756875, 5932.970335148297, 5957.987142185839, 5961.284645842483, 5945.405459454063, 5946.286445626552, 5947.167396564484, 5955.731992060324, 5997.010493268605, 5300.575953923715, 5331.840044798662, 5513.696746678891, 5549.833504994856, 5567.053600887778, 6116.724747386289, 6148.600340977822, 6154.076888466676, 6158.753649853956, 6159.3224745277985, 5838.824835254949, 5855.443732845373, 5860.8534786629825, 5861.0915308127305, 5873.676947767828, 5774.88450230993, 5815.0, 5883.735231914574, 5886.882262354815, 5902.4097590240635, 5908.852278693067, 5912.881742365129, 5914.260717410324, 5934.376890426443, 5980.491658209101, 5912.113183022581, 5956.047032474783, 5960.344362120163, 5963.850903727442, 5965.433283838029, 4512.503624601291, 4550.97724511382, 4557.863264102082, 4579.95420045802, 4604.700694454849, 4081.9387709184384, 4100.6924480664065, 4116.670666346685, 4138.399932009842, 4145.316022856195, 5715.8571035724435, 5729.0260655688635, 5736.082226843685, 5738.454846789548, 5742.827715168552, 5856.443637854397, 5904.4095590441475, 5968.820935371946, 6031.457168854737, 6044.153818465418, 5693.601447898607, 5751.1373294006235, 5754.223179870748, 5774.393688662714, 5790.855228619318, 5179.093658609803, 5197.376314842168, 5209.29674493946, 5210.296609957607, 5211.218317252366, 6017.849553761191, 6216.347283535164, 6290.056491526308, 6296.0, 6296.087067375205, 5794.971025144847, 5837.0, 5867.589268751147, 5883.588148829541, 5923.022701254417, 6100.816975490742, 6102.206713127265, 6113.083037544404, 6114.357992410733, 6118.2658081028785, 5785.4214578541805, 5787.56593255516, 5788.044972579645, 5792.739326730223, 5804.071348584206, 5748.051571490657, 5848.590598658223, 5865.296164460292, 5936.406359364029, 5946.851328716817, 5764.971175144097, 5803.912941305968, 5809.070548712186, 5811.56413269015, 5811.883762324815, 5786.276715410574, 5793.420657934173, 5801.825945221482, 5804.390538993345, 5804.6807425592, 5744.253247077853, 5756.0, 5801.854953626024, 5812.070068788974, 5905.616134951386, 5925.555583331181, 5933.525317974638, 5943.316518600416, 5960.642361458326, 5961.493273071837, 5491.643043202179, 5808.854778630399, 5820.039693450533, 5820.0396934507025, 5822.0684690449325], "value": 5489.866053060744, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.4545318314644, 612.439617749759, 633.110479775915, 656.019251219427, 667.7395815631901, 43031.35452968208, 44073.77963110184, 44190.11619767603, 44210.0, 47442.28836567446, 45352.546474535244, 45849.08301833961, 45926.77036614812, 45945.54054459454, 45964.080718385696, 8813.647454101845, 8966.417182883091, 8970.0, 8973.865392019125, 8975.910240897572, 8797.956010219972, 8881.24509416697, 8893.822123557526, 8896.0, 8901.19889209971, 8896.555172241362, 8941.776455588597, 8941.95529022354, 8951.910480895205, 8954.059823718513, 8852.203301702846, 8914.643414263423, 8916.06381329964, 8916.687915922945, 8925.910740892637, 8762.956185219096, 8814.735557933273, 8836.779080522974, 8838.602262898185, 8845.867311990325, 42036.0, 42211.36682949758, 42373.57626423758, 42477.78761106206, 42542.0, 3718.7025037996896, 3723.832427540767, 3781.735278530504, 3841.692664586826, 4225.556316586745, 32626.6737332626, 32831.179220519676, 32871.83564082188, 32992.17519562006, 33039.3392132156, 4423.0, 4508.932131748931, 4518.954810451919, 4527.117212143633, 4530.145416374399, 337995.0, 338605.0, 339130.0, 339958.0, 344650.0, 58411.707941460874, 58777.70611146917, 58833.70583147057, 58857.41142588519, 58880.0, 38724.41913371302, 39658.20683586312, 39679.0, 60251.69874150689, 60270.0, 18369.346758791773, 18439.170237339353, 18560.628787424175, 18562.72155917662, 18646.34737784171, 13476.730465390638, 13548.254845983369, 13554.728905421836, 13556.322183890767, 13561.0, 19296.677097303047, 19436.514087147934, 19530.70703939442, 19547.902260488892, 19558.217671293274, 7013.527159296605, 7113.110861142357, 7139.572085582904, 7254.8911766323545, 7354.779356619203, 975.1808480876098, 1012.2104758288547, 1039.589362201926, 1051.6003918510917, 1150.9942450287863, 30519.0, 31283.687163128077, 31323.373532529222, 31752.04743857688, 31839.840800795846, 975.9609615615437, 994.5773046455228, 1126.5155982927256, 1128.1933417606451, 1135.1372956552914, 13089.803652945213, 16455.588610284598, 17227.655446890993, 17337.826621733875, 17928.103594820208, 541560.0, 541737.0, 542495.0, 546354.0, 547253.0, 59524.40475595275, 59870.401295986485, 60016.99999999913, 60060.09909851356, 60199.39800601938, 1331.5672406467743, 1347.8449978252627, 1400.3558363153063, 1432.3124900047826, 1451.8257809062768, 29623.259418513848, 33043.83478082594, 33390.499142512395, 33513.664863351056, 33694.21100377872, 49373.0, 49982.50017499924, 50028.24957625566, 50043.49956500534, 50086.49913500964, 309055.0, 309864.0, 312470.0, 312545.0, 313042.0, 27070.593941090505, 27434.45131097407, 29206.7079329204, 29812.46594039531, 46540.0, 47391.0, 47700.0, 51027.0, 51170.0, 51258.74370628123, 41556.58443415527, 42116.578834212494, 42419.0, 42472.78763606162, 43422.56577434185, 35842.0, 36276.63723362733, 36401.45397818982, 37482.0, 38208.80895595504, 35086.0, 35449.46825797667, 35563.82218088893, 35805.82097089498, 36312.818435907655, 36352.45471317879, 37354.813225934784, 37762.62237377701, 38470.19457181807, 38646.806765965994, 25987.090451834094, 26015.479690406464, 26288.474230515665, 26784.33039174036, 27015.729842701323], "value": 19991.341882388926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.27029212271873, 405.6288496026138, 409.22860408130686, 415.69238763315144, 415.7588598612805, 14452.421903123888, 18732.344367947124, 19417.70873436896, 20256.291029813958, 20272.797272027274, 19419.805801942013, 19537.70693439596, 19658.606827863434, 19705.70441443376, 19731.309404170857, 5371.99999999999, 5754.482096611304, 5790.449907258825, 5796.159556864252, 5800.9129863052085, 5536.0, 5696.6866822324755, 5737.196792449061, 5739.799107031255, 5741.024025915604, 5683.801066962657, 5711.600187986843, 5720.399358067405, 5725.398833122525, 5727.914081288784, 5490.313710786152, 5692.658440493542, 5697.572682048843, 5703.087505999041, 5703.629264097841, 5177.119889618773, 5181.766820493049, 5187.429382767892, 5188.455212202702, 5189.532942035197, 21541.246056388107, 22002.88998554997, 22282.220122295643, 23287.76712232873, 23323.4169145771, 2478.9008439662393, 2494.762997515233, 2738.6439762830705, 2930.926726831825, 2951.4244722279163, 10474.947625261824, 10882.510287037103, 10891.07425868802, 10891.83662245067, 10913.126949843994, 1911.5221194701326, 1952.8925909074994, 1959.9220428764122, 1969.7439332886634, 2072.4508005378434, 79683.60158199172, 86588.0, 86672.0, 87616.0, 88141.0, 11125.777484450266, 11235.775284494264, 11446.713832154262, 11553.422328883522, 11634.185607007597, 14317.35571899267, 14807.185604791624, 16213.675726485404, 16313.83686163147, 16326.77549183816, 9736.123748862636, 10203.438810865326, 10344.120749736358, 10445.425501597485, 10760.623378181726, 8248.175182481824, 8681.913180868236, 8802.823943521222, 8834.038317989549, 8965.641374344954, 8763.518006509703, 8975.0, 9083.0, 9149.176574108362, 9293.303002274857, 3226.306344136022, 3229.6447390786993, 3376.6285708572036, 3429.4169991101076, 3554.182538016271, 888.3603805260202, 989.2728844299434, 992.5087081894364, 998.5456617239139, 1010.6210171185805, 18939.90530047341, 19386.61226775485, 19458.416247512596, 20474.078666460045, 20597.382078537667, 934.845750451168, 954.7231302922214, 977.3354119199013, 1014.5079636376352, 1052.936823790575, 10257.692269231935, 10947.945260273647, 10983.176261780398, 11046.392448415254, 11079.667609971713, 344358.0, 345688.0, 347329.0, 472288.0, 477687.0, 99650.0, 101773.49113254386, 101977.0, 104513.47743261387, 104757.0, 1051.6056478820442, 1070.309650275568, 1082.9729256768644, 1114.6043154679971, 1115.4534278203785, 17158.39945601898, 17468.73796893022, 17535.473935781945, 17565.209565569836, 17812.109394530482, 32895.506567401986, 42024.80904612744, 42032.0, 44693.55306446894, 44747.55252447434, 56486.717566411906, 57166.42833571611, 58393.4160658388, 58999.41000589939, 61080.0, 8752.60613272417, 8791.912080879109, 8822.426542274732, 8891.64433422656, 9115.225205857576, 10144.594216231268, 13661.521846735317, 13782.862171378158, 13876.028677992444, 13955.58133256004, 11226.101911846868, 11758.470868810753, 11790.823137653113, 11833.290002599872, 11839.28964262147, 11424.257423267461, 11765.352905589933, 11766.0, 11772.499290243319, 12318.0, 11485.827712584485, 11527.8270825936, 11554.364509952033, 11625.825612615648, 11669.708257293636, 8275.337972962268, 8501.55473569507, 8549.230569248548, 8775.07861674515, 8793.956030219808, 11334.886651133384, 11414.600488982845, 11488.310701357945, 11505.252158609663, 11739.706507337385], "value": 9683.953209828474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.6053105130568, 1484.4878516911665, 1524.6340878189235, 1661.4351120618994, 1795.2532625083627, 7573.0, 8534.829303413935, 8813.823723525526, 8820.91179088209, 9116.316276279289, 8812.559372031388, 8891.42205756627, 8899.37704360695, 8906.242969347597, 8915.554222288876, 2521.8991240350365, 2545.4654522550286, 2546.8726563671744, 2548.885300161488, 2550.923472295834, 2510.598304271317, 2556.4759224358963, 2556.961645575318, 2558.0790915270486, 2559.9616005759926, 2471.0486462711806, 2503.2240005598233, 2510.7614776596192, 2526.759957804015, 2527.0902475108946, 2408.397900524869, 2451.718052423976, 2473.468204336067, 2488.9377765555823, 2492.3395300245447, 2464.864432456214, 2505.348609361561, 2526.7220605733355, 2528.1404322530243, 2560.219133164384, 8859.335549833788, 8898.644054237822, 8946.821063578693, 8955.37312388133, 8958.596863141109, 5488.231647569343, 5601.495865372095, 5614.101743721026, 5696.344920334173, 5703.74333155009, 3598.8200589970397, 3606.801625910574, 3691.7231207659534, 3711.2391959648476, 3755.7183211259266, 1352.0940969550425, 1355.5391167003265, 1356.416740801455, 1401.4822794785061, 1402.5652047865194, 11962.0, 11979.221350612183, 12083.939580302042, 12088.637340879788, 12185.329806860707, 4569.657275704336, 4674.76626168697, 4686.414198225222, 4691.577758001797, 4758.7389341823755, 9566.33035687509, 9567.952160239154, 9577.712668619952, 9584.28117891147, 9609.231261499064, 5498.560115190775, 5570.0, 5586.692731899703, 5610.298712660918, 5614.887702245932, 4292.570742925683, 4531.320301954733, 4595.816167353269, 5060.165072763027, 5250.1337279349245, 3974.2448934702315, 4068.4710987571425, 4129.215449064728, 4170.624643782075, 4177.143685544456, 1229.1088960503741, 1254.3226657604973, 1280.2766436963086, 1290.9741805163844, 1295.8509771376412, 930.3394589841289, 957.6456711016968, 976.8192884316283, 978.5254151736402, 1005.7535903703639, 5913.02435098204, 6141.692915354214, 6142.170806941095, 6203.906941395882, 6432.388923052303, 464.8187206989277, 473.9289106633964, 488.3480553461169, 522.9712365819917, 526.6076772804208, 4239.215745087169, 4268.146370725867, 4290.034742182984, 4365.585269399402, 4443.37792709021, 10942.343459392461, 11073.335599864035, 11185.608503702495, 11192.944035279934, 11368.317900925971, 11133.332000080021, 11147.0, 11159.442027898573, 11169.776604467865, 11181.329120252649, 8105.189481051848, 8390.32877369809, 8413.15868413166, 8595.613197406132, 8617.267532259828, 5947.791827286024, 6084.361142080195, 6172.166757487682, 6194.566380353332, 6286.214223222098, 10109.191264698953, 10206.0, 10232.23258255619, 10253.38479691191, 10342.5345859435, 8648.43785153963, 9533.856992144985, 10117.089461948166, 10192.745181370525, 10317.48412579383, 7679.616019199129, 7886.72396466121, 7968.7609371718945, 7986.201379861967, 8151.062627797642, 8368.581570921551, 8407.70573029941, 8428.11504791988, 8431.578421079044, 8453.36599755033, 7672.232776722283, 7717.768466946, 7751.573663448565, 7886.960565197137, 8062.798430039062, 7568.0, 7717.073951125901, 7724.227577242231, 7734.806629834299, 7937.126916039347, 7313.597752123472, 7353.154387245321, 7418.888716669362, 7433.516821406592, 7521.435892308208, 5051.62112841531, 5148.819791307286, 5193.896122077462, 5269.78920843162, 5285.894282114413, 5272.130098533852, 5357.678539287655, 5430.83707488776, 5457.20870473787, 5582.078956972054], "value": 4701.228047816761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.0836848121724, 339.5467051486266, 343.87964212525617, 344.41793369206056, 345.4438354249659, 5371.099606212645, 5379.81170659027, 5380.784768609261, 5399.163129714891, 5409.756560954756, 5044.873878153048, 5087.211482220262, 5168.250603662476, 5211.244369566411, 5343.465653434664, 4150.3359462486005, 4151.709380343377, 4156.147989662127, 4163.188178305231, 4191.455110835587, 4141.62725354718, 4163.500379954395, 4168.124693814302, 4193.490343476346, 4204.1801848639525, 3948.190620922704, 3948.986017131255, 4048.6558642515274, 4125.711200215986, 4140.275451795924, 4145.0, 4167.499900011988, 4168.228877657643, 4171.0, 4187.078842654611, 3703.9814051136154, 3705.184859330943, 3710.517632707758, 3714.591394946554, 3715.8699445519546, 5052.46949070346, 5067.569256613192, 5099.184130539096, 5189.714565698885, 5239.816606418757, 4735.360726301939, 4738.549837765407, 4740.506740376771, 4744.525547445262, 4754.120487709784, 5521.889562208733, 5533.956324021812, 5546.334439867202, 5551.639143455703, 5602.747876345534, 3912.471816304791, 3996.300647386725, 4021.7989100545146, 4057.452243947059, 4070.5115386153852, 5668.376478587352, 5694.288213973295, 5720.971395143039, 5721.970045391828, 5725.713714314309, 4093.6725061995567, 4102.118044620421, 4108.322126849096, 4137.469136419544, 4162.500499940026, 3901.122247494291, 4030.173814368106, 4225.852095176716, 4231.746095234295, 4234.0050088229245, 4669.556392142741, 4685.1800934836265, 4688.835890743808, 4693.577578017995, 4696.2486002239475, 5562.443755624486, 5582.33012038558, 5607.4112218217315, 5607.8878422432135, 5631.63394379364, 1319.4260496683974, 1358.7974642441313, 1378.5726424808342, 1384.6123085536067, 1388.9513867014607, 892.5537231384308, 916.8081494057699, 990.3562684255147, 1012.3571532077184, 1024.8770147582188, 5163.922541161885, 5191.935653191087, 5197.532222100029, 5218.243354713545, 5220.415894132429, 5446.400895901447, 5455.863603409946, 5479.397266300703, 5485.725713714299, 5540.473655002849, 5200.791968321225, 5244.76398562058, 5406.513413792699, 5455.427180146027, 5459.508644222039, 2938.676745557987, 2939.6472423309338, 2947.6168098147105, 2954.6454425469083, 2964.5997790298466, 5616.6068375213345, 5748.31020277561, 5763.740631671585, 5776.971115144397, 5815.680137592389, 5557.916631250535, 5610.353270374289, 5634.7182640867795, 5642.576806739511, 5651.773929042793, 5744.195812586241, 5746.310442746897, 5751.712414379264, 5754.798582049608, 5772.797952071742, 5392.218128371443, 5457.399686034612, 5499.587530935116, 5511.641743286674, 5577.581681373832, 5461.290032295776, 5471.0, 5483.259759932517, 5484.643498172606, 5489.478499542537, 5449.754761035842, 5714.0, 5726.541876649775, 5760.135979603093, 5798.651011741194, 3947.82234799429, 3957.7031722621496, 3964.306246406925, 3965.1871366369246, 3988.501437320335, 5526.723663816712, 5531.944680553304, 5542.224088627515, 5560.916586251128, 5571.9721401392735, 5254.610776049503, 5400.675959442446, 5426.67439953604, 5436.945630543644, 5439.184122381675, 5582.33012038558, 5587.0, 5590.692511911884, 5599.356074051536, 5621.0, 5337.572994160536, 5508.944910551004, 5546.500814926676, 5550.02973944244, 5561.749721262472, 5543.695096769717, 5587.245721827501, 5603.327600687943, 5626.381098079126, 5629.521490673174, 5479.0, 5492.148716948879, 5501.449855014466, 5510.614257001971, 5525.392206857323], "value": 4212.035545864855, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.9651265693043, 783.9960800195998, 830.8130670599115, 843.5697794124997, 870.5603670146575, 14919.47781827635, 15248.237588120592, 15976.0, 15979.840201597995, 16000.83999160008, 13104.14823036502, 13367.665808354795, 14184.148951062944, 14200.502982395617, 14214.573562793106, 814.0434988888062, 830.8587540118194, 831.2061980808344, 831.9209675080888, 832.9916700832974, 698.2877464985711, 709.9325564071405, 799.672134424883, 813.6989313953845, 817.8650522663753, 871.4640496094888, 884.1865483754929, 884.9380543361967, 885.5173930208019, 885.7032893980492, 878.3851304087101, 878.8945326560822, 879.3404946290283, 879.3888247667874, 880.3045593980779, 533.8371796602034, 546.8222827581012, 610.6397225636896, 629.1506466270544, 640.1486023588662, 14530.636734081627, 14625.341859616343, 14635.341409636592, 14643.41426342945, 14675.559733208021, 13386.26375549354, 13915.930420347833, 13930.233837138954, 13988.650283742885, 14003.229822359766, 12628.81056784149, 12668.2399056056, 12895.871041289562, 12992.610221693365, 13044.41300141496, 4275.893102672427, 4280.892977675552, 4283.764392958386, 4288.592583704543, 4403.757793321366, 62410.37589624091, 63867.0, 64005.35994640041, 65532.344676553104, 65639.0, 11304.378259195659, 11338.0, 11385.886141138482, 11415.771684566262, 11508.251963622337, 20168.19327226924, 20230.089645965967, 20390.28633997803, 20435.795642043686, 20442.0, 8195.0, 8205.671773129008, 8215.0, 8248.8350232995, 8307.460015098999, 4483.103379324149, 4530.07133537624, 4777.4505931818285, 4805.37530121082, 4887.706737595756, 3420.572428446444, 3475.1138459692615, 3503.649635036527, 3505.1938054247157, 3520.5247291615815, 667.2060248304502, 670.9127813384229, 678.640320630057, 684.6474065856088, 686.2005763285716, 704.6159842885639, 705.4321271376591, 745.4185735126609, 751.9987334758177, 758.624480881956, 9921.603135874484, 9979.0, 10012.148967337858, 10048.49757512136, 10298.485075746183, 650.0, 681.7170874087298, 693.2166651683666, 740.1081696555638, 751.8496300739874, 4736.218523943511, 4837.9032419351415, 4841.878953026132, 4846.733429661403, 4862.07620552094, 54526.182107268425, 72540.27459725334, 88218.0, 88479.11520884708, 90670.0, 73411.0, 78358.0, 79406.60296698479, 80328.19671803206, 80441.0, 44743.776281118386, 45945.08109837851, 46119.30821037687, 68173.0, 70691.64654176799, 9321.813563728823, 9333.906660933575, 9344.15902568772, 9354.95322523383, 9624.37441566296, 46959.53040469551, 47298.527014729414, 47736.0, 49759.50240497549, 50641.74679126581, 61030.69484652726, 63616.68191659012, 66757.33242667705, 67619.66190169018, 68365.65817170883, 10652.360858348524, 10795.244332896622, 10836.458177090955, 12776.552820651232, 12823.230606163661, 14759.040662356912, 15187.772183417037, 15200.239988000776, 15343.46297879569, 16319.0, 13628.86371136276, 14288.357023934155, 14588.781168282696, 14624.85375146235, 14677.70644587081, 12242.693932651755, 12463.189892656948, 13387.129836560593, 13595.184288942695, 13749.725005500035, 13146.539871104465, 14160.645983850487, 14328.785068224193, 14734.926325368304, 14801.777973330194, 10737.355758654505, 11727.824082638937, 11990.820137697767, 12566.685832854251, 12736.74526509483, 11054.723631909266, 11942.641720748392, 12060.939695301468, 12137.21108127969, 12355.135140540076], "value": 7326.815960349237, "unit": "score"}], "name": "dromaeo_css", "value": 7322.958955138628, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 120.0, 156.0, 124.0, 120.0, 122.0, 124.0, 158.0, 121.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 160.0, 161.0, 160.0, 161.0, 162.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 76.0, 78.0, 75.0, 75.0, 110.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 129.0, 82.0, 82.0, 81.0, 100.0, 81.0, 81.0, 111.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 50.0, 49.0, 50.0, 51.0, 53.0, 50.0, 51.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 75.0, 75.0, 74.0, 74.0, 74.0, 74.0, 73.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 137.0, 136.0, 135.0, 130.0, 136.0, 125.0, 129.0, 173.0, 126.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 160.0, 155.0, 156.0, 156.0, 153.0, 155.0, 153.0, 152.0, 153.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 61.0, 60.0, 61.0, 60.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1459.1, "alertThreshold": 2.0}]} 12:15:38 INFO - Return code: 0 12:15:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:15:39 ERROR - # TBPL SUCCESS # 12:15:39 INFO - Running post-action listener: _resource_record_post_action 12:15:39 INFO - [mozharness: 2016-11-14 20:15:39.044479Z] Finished run-tests step (success) 12:15:39 INFO - Running post-run listener: _resource_record_post_run 12:15:39 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355090432; Read time: 12; Write time: 255144 12:15:39 INFO - TinderboxPrint: CPU usage
13.0% 12:15:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:15:39 INFO - TinderboxPrint: I/O write bytes / time
355,090,432 / 255,144 12:15:39 INFO - TinderboxPrint: CPU idle
8,276.2 (87.0%) 12:15:39 INFO - TinderboxPrint: CPU user
1,192.2 (12.5%) 12:15:39 INFO - TinderboxPrint: Swap in / out
0 / 0 12:15:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107491328; Read time: 0; Write time: 81804 12:15:39 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 247590912; Read time: 0; Write time: 173336 12:15:39 INFO - Running post-run listener: _upload_blobber_files 12:15:39 INFO - Blob upload gear active. 12:15:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:15:39 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 12:15:39 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'] 12:15:39 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 12:15:40 INFO - (blobuploader) - INFO - Open directory for files ... 12:15:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:15:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:15:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:43 INFO - (blobuploader) - INFO - Done attempting. 12:15:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:15:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:15:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:43 INFO - (blobuploader) - INFO - Done attempting. 12:15:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:15:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:15:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:15:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:15:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:15:44 INFO - (blobuploader) - INFO - Done attempting. 12:15:44 INFO - (blobuploader) - INFO - Iteration through files over. 12:15:44 INFO - Return code: 0 12:15:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:15:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:15:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0593315330f8b5fb1156ad662d86bc2b572ca20203cd76305d0c662890f2da15b20b582b5d499d25249b5bea2014e46e929ab3cfb585781f09beb202b2b21d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0ece84b1b624c449412915adb624175e94619b5013960f25238629052b2306b5d5d2c0df59fcdb23deaf52539dcbc811afe72ddc402019b529cd56af4f7eac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/716e1632fc679f64e85ded7f30fb085b9aee2cec0e76445324c30344328daa394dae8a1b753aa7b1d9b9dcb07779b9d622f2c78123860bf661ee4297e22c1553"} 12:15:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:15:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:15:44 INFO - Contents: 12:15:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0593315330f8b5fb1156ad662d86bc2b572ca20203cd76305d0c662890f2da15b20b582b5d499d25249b5bea2014e46e929ab3cfb585781f09beb202b2b21d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0ece84b1b624c449412915adb624175e94619b5013960f25238629052b2306b5d5d2c0df59fcdb23deaf52539dcbc811afe72ddc402019b529cd56af4f7eac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/716e1632fc679f64e85ded7f30fb085b9aee2cec0e76445324c30344328daa394dae8a1b753aa7b1d9b9dcb07779b9d622f2c78123860bf661ee4297e22c1553"} 12:15:44 INFO - Running post-run listener: copy_logs_to_upload_dir 12:15:44 INFO - Copying logs to upload dir... 12:15:44 INFO - mkdir: /builds/slave/test/build/upload/logs 12:15:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.340505 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-11-14 12:15:44.649323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:44.653107) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0593315330f8b5fb1156ad662d86bc2b572ca20203cd76305d0c662890f2da15b20b582b5d499d25249b5bea2014e46e929ab3cfb585781f09beb202b2b21d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0ece84b1b624c449412915adb624175e94619b5013960f25238629052b2306b5d5d2c0df59fcdb23deaf52539dcbc811afe72ddc402019b529cd56af4f7eac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/716e1632fc679f64e85ded7f30fb085b9aee2cec0e76445324c30344328daa394dae8a1b753aa7b1d9b9dcb07779b9d622f2c78123860bf661ee4297e22c1553"} build_url:https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/MHL-UbIzRBK2VdjKkIZRSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0593315330f8b5fb1156ad662d86bc2b572ca20203cd76305d0c662890f2da15b20b582b5d499d25249b5bea2014e46e929ab3cfb585781f09beb202b2b21d64", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e0ece84b1b624c449412915adb624175e94619b5013960f25238629052b2306b5d5d2c0df59fcdb23deaf52539dcbc811afe72ddc402019b529cd56af4f7eac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/716e1632fc679f64e85ded7f30fb085b9aee2cec0e76445324c30344328daa394dae8a1b753aa7b1d9b9dcb07779b9d622f2c78123860bf661ee4297e22c1553"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:44.678323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:44.678665) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1479153308.735554-244547962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:15:44.762169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:15:44.762524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:15:44.762937) ========= ========= Total master_lag: 0.19 =========