builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1479408043.3 results: success (0) buildid: 20161117083828 builduid: 6100fd72ae7a4785b797dccc5157c8dc revision: 4465d90d1d21cdff02858a87b6e883c7b456b73f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.296728) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.297178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.297456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.313814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.314196) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 10:40:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-11-17 10:40:43 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088272 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.416636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.416970) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.466503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:43.466934) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 4465d90d1d21cdff02858a87b6e883c7b456b73f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 4465d90d1d21cdff02858a87b6e883c7b456b73f --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=a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 10:40:44,015 truncating revision to first 12 chars 2016-11-17 10:40:44,015 Setting DEBUG logging. 2016-11-17 10:40:44,016 attempt 1/10 2016-11-17 10:40:44,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/4465d90d1d21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 10:40:44,322 unpacking tar archive at: graphics-4465d90d1d21/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686132 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:44.166548) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:44.166913) ========= script_repo_revision: 4465d90d1d21cdff02858a87b6e883c7b456b73f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:44.167297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:44.167561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 10:40:44.176177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-17 10:40:44.176501) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:40:44 INFO - MultiFileLogger online at 20161117 10:40:44 in /builds/slave/test 10:40:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 10:40:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:40:44 INFO - {'append_to_log': False, 10:40:44 INFO - 'base_work_dir': '/builds/slave/test', 10:40:44 INFO - 'blob_upload_branch': 'Graphics', 10:40:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:40:44 INFO - 'branch': 'Graphics', 10:40:44 INFO - 'buildbot_json_path': 'buildprops.json', 10:40:44 INFO - 'config_files': ('talos/linux_config.py',), 10:40:44 INFO - 'default_actions': ('clobber', 10:40:44 INFO - 'read-buildbot-config', 10:40:44 INFO - 'download-and-extract', 10:40:44 INFO - 'populate-webroot', 10:40:44 INFO - 'create-virtualenv', 10:40:44 INFO - 'install', 10:40:44 INFO - 'run-tests'), 10:40:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:40:44 INFO - 'download_minidump_stackwalk': True, 10:40:44 INFO - 'download_symbols': 'ondemand', 10:40:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:40:44 INFO - 'tooltool.py': '/tools/tooltool.py', 10:40:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:40:44 INFO - '/tools/misc-python/virtualenv.py')}, 10:40:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:40:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:40:44 INFO - 'installer_path': 'installer.exe', 10:40:44 INFO - 'log_level': 'info', 10:40:44 INFO - 'log_name': 'talos', 10:40:44 INFO - 'log_to_console': True, 10:40:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:40:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:40:44 INFO - 'opt_config_files': (), 10:40:44 INFO - 'pip_index': False, 10:40:44 INFO - 'sps_profile': False, 10:40:44 INFO - 'sps_profile_interval': 0, 10:40:44 INFO - 'suite': 'dromaeojs', 10:40:44 INFO - 'system_bits': '32', 10:40:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:40:44 INFO - 'title': 'talos-linux64-ix-002', 10:40:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:40:44 INFO - 'use_talos_json': True, 10:40:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:40:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:40:44 INFO - 'work_dir': 'build'} 10:40:44 INFO - [mozharness: 2016-11-17 18:40:44.830257Z] Running clobber step. 10:40:44 INFO - Running pre-action listener: _resource_record_pre_action 10:40:44 INFO - Running main action method: clobber 10:40:44 INFO - rmtree: /builds/slave/test/build 10:40:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:40:45 INFO - Running post-action listener: _resource_record_post_action 10:40:45 INFO - [mozharness: 2016-11-17 18:40:45.291692Z] Finished clobber step (success) 10:40:45 INFO - [mozharness: 2016-11-17 18:40:45.291789Z] Running read-buildbot-config step. 10:40:45 INFO - Running pre-action listener: _resource_record_pre_action 10:40:45 INFO - Running main action method: read_buildbot_config 10:40:45 INFO - Using buildbot properties: 10:40:45 INFO - { 10:40:45 INFO - "project": "", 10:40:45 INFO - "product": "firefox", 10:40:45 INFO - "script_repo_revision": "default", 10:40:45 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 10:40:45 INFO - "repository": "", 10:40:45 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 10:40:45 INFO - "buildid": "20161117083828", 10:40:45 INFO - "pgo_build": "False", 10:40:45 INFO - "basedir": "/builds/slave/test", 10:40:45 INFO - "buildnumber": 2, 10:40:45 INFO - "slavename": "talos-linux64-ix-002", 10:40:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:40:45 INFO - "platform": "ubuntu64_hw", 10:40:45 INFO - "scheduler": "tests-graphics-linux64-talos", 10:40:45 INFO - "branch": "graphics", 10:40:45 INFO - "repo_path": "projects/graphics", 10:40:45 INFO - "revision": "4465d90d1d21cdff02858a87b6e883c7b456b73f", 10:40:45 INFO - "stage_platform": "linux64", 10:40:45 INFO - "builduid": "6100fd72ae7a4785b797dccc5157c8dc", 10:40:45 INFO - "slavebuilddir": "test" 10:40:45 INFO - } 10:40:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:40:45 INFO - Running post-action listener: _resource_record_post_action 10:40:45 INFO - [mozharness: 2016-11-17 18:40:45.294214Z] Finished read-buildbot-config step (success) 10:40:45 INFO - [mozharness: 2016-11-17 18:40:45.294302Z] Running download-and-extract step. 10:40:45 INFO - Running pre-action listener: _resource_record_pre_action 10:40:45 INFO - Running main action method: download_and_extract 10:40:45 INFO - mkdir: /builds/slave/test/build/tests 10:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:45 INFO - trying https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:40:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:40:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:40:45 INFO - Downloaded 1361 bytes. 10:40:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:40:45 INFO - Using the following test package requirements: 10:40:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:40:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:40:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'jsshell-linux-x86_64.zip'], 10:40:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:40:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:40:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:40:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:40:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:40:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:40:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:40:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:40:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:40:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:40:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:40:46 INFO - Http code: 200 10:40:46 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 10:40:46 INFO - x-amz-cf-id: oN13DYLXU-5FIDwM7RaN6G3zEF7M97Y9WL-Mvtmdi5DXH2HIGqni-Q== 10:40:46 INFO - x-amz-version-id: 5kacVxYtVBRq1AdPYMAPmnJhyXxudUV_ 10:40:46 INFO - Expected file size: 20361480 10:40:46 INFO - Obtained file size: 20361480 10:40:50 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:40:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:40:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:40:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:40:51 INFO - Http code: 200 10:40:51 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 10:40:51 INFO - x-amz-cf-id: 43P8eeUi3n5iSXna_daaNaf0ITATlcmKdtZSUPL9xPZD2iBAdFGjnA== 10:40:51 INFO - x-amz-version-id: 5kacVxYtVBRq1AdPYMAPmnJhyXxudUV_ 10:40:51 INFO - Expected file size: 20361480 10:40:51 INFO - Obtained file size: 20361480 10:40:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:40:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:40:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:40:56 INFO - Http code: 200 10:40:56 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 10:40:56 INFO - x-amz-cf-id: ss3CMNQWt3a5Xlgzj44YNesbpeqkuDLinWubYcG5BuXJhpRyOjlNYg== 10:40:56 INFO - x-amz-version-id: 82KV7n3S2vmf0Vnz3Ntg9HXvjkG46oy5 10:40:56 INFO - Expected file size: 14409392 10:40:56 INFO - Obtained file size: 14409392 10:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:40:56 INFO - trying https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:40:56 INFO - Downloading https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:40:58 INFO - Downloaded 55729230 bytes. 10:40:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:40:58 INFO - mkdir: /builds/slave/test/properties 10:40:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:40:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:40:58 INFO - Contents: 10:40:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:40:58 INFO - Running post-action listener: _resource_record_post_action 10:40:58 INFO - Running post-action listener: set_extra_try_arguments 10:40:58 INFO - [mozharness: 2016-11-17 18:40:58.784585Z] Finished download-and-extract step (success) 10:40:58 INFO - [mozharness: 2016-11-17 18:40:58.784809Z] Running populate-webroot step. 10:40:58 INFO - Running pre-action listener: _resource_record_pre_action 10:40:58 INFO - Running main action method: populate_webroot 10:40:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:40:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:40:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:40:58 INFO - '--tppagecycles', 10:40:58 INFO - '7'], 10:40:58 INFO - 'tests': ['tsvgm']}}, 10:40:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:40:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:40:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:40:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:40:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:40:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['damp', 'tps']}, 10:40:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'tests': ['damp', 'tps']}, 10:40:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['dromaeo_dom']}, 10:40:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:40:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['basic_compositor_video']}, 10:40:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:40:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['a11yr', 10:40:58 INFO - 'ts_paint', 10:40:58 INFO - 'tpaint', 10:40:58 INFO - 'sessionrestore', 10:40:58 INFO - 'sessionrestore_no_auto_restore', 10:40:58 INFO - 'tabpaint']}, 10:40:58 INFO - 'other-e10s': {'tests': ['a11yr', 10:40:58 INFO - 'ts_paint', 10:40:58 INFO - 'tpaint', 10:40:58 INFO - 'sessionrestore', 10:40:58 INFO - 'sessionrestore_no_auto_restore', 10:40:58 INFO - 'tabpaint']}, 10:40:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:40:58 INFO - 'ts_paint', 10:40:58 INFO - 'tpaint', 10:40:58 INFO - 'sessionrestore', 10:40:58 INFO - 'sessionrestore_no_auto_restore', 10:40:58 INFO - 'tabpaint']}, 10:40:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:40:58 INFO - 'ts_paint', 10:40:58 INFO - 'tpaint', 10:40:58 INFO - 'sessionrestore', 10:40:58 INFO - 'sessionrestore_no_auto_restore', 10:40:58 INFO - 'tabpaint']}, 10:40:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['a11yr', 10:40:58 INFO - 'ts_paint', 10:40:58 INFO - 'tpaint', 10:40:58 INFO - 'sessionrestore', 10:40:58 INFO - 'sessionrestore_no_auto_restore', 10:40:58 INFO - 'tabpaint']}, 10:40:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['a11yr', 10:40:58 INFO - 'ts_paint', 10:40:58 INFO - 'tpaint', 10:40:58 INFO - 'sessionrestore', 10:40:58 INFO - 'sessionrestore_no_auto_restore', 10:40:58 INFO - 'tabpaint']}, 10:40:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['tsvgx', 10:40:58 INFO - 'tsvgr_opacity', 10:40:58 INFO - 'tart', 10:40:58 INFO - 'tscrollx', 10:40:58 INFO - 'cart']}, 10:40:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:40:58 INFO - 'tsvgr_opacity', 10:40:58 INFO - 'tart', 10:40:58 INFO - 'tscrollx', 10:40:58 INFO - 'cart']}, 10:40:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'talos_options': ['--disable-e10s'], 10:40:58 INFO - 'tests': ['tp5o']}, 10:40:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:40:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'talos_options': ['--disable-e10s', 10:40:58 INFO - '--xperf_path', 10:40:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:58 INFO - 'tests': ['tp5n']}, 10:40:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:40:58 INFO - 'talos_options': ['--xperf_path', 10:40:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:40:58 INFO - 'tests': ['tp5n']}}, 10:40:58 INFO - 'talos.zip': {'path': '', 10:40:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:40:58 INFO - Running post-action listener: _resource_record_post_action 10:40:58 INFO - [mozharness: 2016-11-17 18:40:58.806164Z] Finished populate-webroot step (success) 10:40:58 INFO - [mozharness: 2016-11-17 18:40:58.806252Z] Running create-virtualenv step. 10:40:58 INFO - Running pre-action listener: _resource_record_pre_action 10:40:58 INFO - Running main action method: create_virtualenv 10:40:58 INFO - Creating virtualenv /builds/slave/test/build/venv 10:40:58 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 10:40:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:40:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:40:58 INFO - Using real prefix '/usr' 10:40:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:40:59 INFO - Installing distribute.............................................................................................................................................................................................done. 10:41:01 INFO - Installing pip.................done. 10:41:01 INFO - Return code: 0 10:41:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:41:01 INFO - Reading from file tmpfile_stdout 10:41:01 INFO - Output received: 10:41:01 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) 10:41:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:41:01 INFO - Using env: {'DISPLAY': ':0', 10:41:01 INFO - 'HOME': '/home/cltbld', 10:41:01 INFO - 'LANG': 'en_US.UTF-8', 10:41:01 INFO - 'LANGUAGE': 'en_US:en', 10:41:01 INFO - 'LOGNAME': 'cltbld', 10:41:01 INFO - 'MAIL': '/var/mail/cltbld', 10:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:01 INFO - 'MOZ_NO_REMOTE': '1', 10:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:01 INFO - 'NO_EM_RESTART': '1', 10:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:01 INFO - 'PWD': '/builds/slave/test', 10:41:01 INFO - 'SHELL': '/bin/bash', 10:41:01 INFO - 'SHLVL': '1', 10:41:01 INFO - 'TERM': 'linux', 10:41:01 INFO - 'TMOUT': '86400', 10:41:01 INFO - 'USER': 'cltbld', 10:41:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:01 INFO - '_': '/tools/buildbot/bin/python'} 10:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:01 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 10:41:01 INFO - Cleaning up... 10:41:01 INFO - Return code: 0 10:41:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:41:01 INFO - Using env: {'DISPLAY': ':0', 10:41:01 INFO - 'HOME': '/home/cltbld', 10:41:01 INFO - 'LANG': 'en_US.UTF-8', 10:41:01 INFO - 'LANGUAGE': 'en_US:en', 10:41:01 INFO - 'LOGNAME': 'cltbld', 10:41:01 INFO - 'MAIL': '/var/mail/cltbld', 10:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:01 INFO - 'MOZ_NO_REMOTE': '1', 10:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:01 INFO - 'NO_EM_RESTART': '1', 10:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:01 INFO - 'PWD': '/builds/slave/test', 10:41:01 INFO - 'SHELL': '/bin/bash', 10:41:01 INFO - 'SHLVL': '1', 10:41:01 INFO - 'TERM': 'linux', 10:41:01 INFO - 'TMOUT': '86400', 10:41:01 INFO - 'USER': 'cltbld', 10:41:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:01 INFO - '_': '/tools/buildbot/bin/python'} 10:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:02 INFO - Downloading/unpacking psutil>=3.1.1 10:41:02 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 10:41:02 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 10:41:02 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 10:41:02 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 10:41:02 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 10:41:02 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 10:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:04 INFO - Installing collected packages: psutil 10:41:04 INFO - Running setup.py install for psutil 10:41:04 INFO - building 'psutil._psutil_linux' extension 10:41:04 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 10:41:04 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 10:41:04 INFO - building 'psutil._psutil_posix' extension 10:41:04 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 10:41:04 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 10:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:41:04 INFO - Successfully installed psutil 10:41:04 INFO - Cleaning up... 10:41:04 INFO - Return code: 0 10:41:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:41:04 INFO - Using env: {'DISPLAY': ':0', 10:41:04 INFO - 'HOME': '/home/cltbld', 10:41:04 INFO - 'LANG': 'en_US.UTF-8', 10:41:04 INFO - 'LANGUAGE': 'en_US:en', 10:41:04 INFO - 'LOGNAME': 'cltbld', 10:41:04 INFO - 'MAIL': '/var/mail/cltbld', 10:41:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:04 INFO - 'MOZ_NO_REMOTE': '1', 10:41:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:04 INFO - 'NO_EM_RESTART': '1', 10:41:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:04 INFO - 'PWD': '/builds/slave/test', 10:41:04 INFO - 'SHELL': '/bin/bash', 10:41:04 INFO - 'SHLVL': '1', 10:41:04 INFO - 'TERM': 'linux', 10:41:04 INFO - 'TMOUT': '86400', 10:41:04 INFO - 'USER': 'cltbld', 10:41:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:04 INFO - '_': '/tools/buildbot/bin/python'} 10:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:41:06 INFO - Installing collected packages: mozsystemmonitor 10:41:06 INFO - Running setup.py install for mozsystemmonitor 10:41:07 INFO - Successfully installed mozsystemmonitor 10:41:07 INFO - Cleaning up... 10:41:07 INFO - Return code: 0 10:41:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:41:07 INFO - Using env: {'DISPLAY': ':0', 10:41:07 INFO - 'HOME': '/home/cltbld', 10:41:07 INFO - 'LANG': 'en_US.UTF-8', 10:41:07 INFO - 'LANGUAGE': 'en_US:en', 10:41:07 INFO - 'LOGNAME': 'cltbld', 10:41:07 INFO - 'MAIL': '/var/mail/cltbld', 10:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:07 INFO - 'MOZ_NO_REMOTE': '1', 10:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:07 INFO - 'NO_EM_RESTART': '1', 10:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:07 INFO - 'PWD': '/builds/slave/test', 10:41:07 INFO - 'SHELL': '/bin/bash', 10:41:07 INFO - 'SHLVL': '1', 10:41:07 INFO - 'TERM': 'linux', 10:41:07 INFO - 'TMOUT': '86400', 10:41:07 INFO - 'USER': 'cltbld', 10:41:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:07 INFO - '_': '/tools/buildbot/bin/python'} 10:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:07 INFO - Downloading/unpacking jsonschema==2.5.1 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 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 10:41:07 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 10:41:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:41:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:41:09 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 10:41:09 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 10:41:09 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 10:41:09 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 10:41:09 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 10:41:09 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 10:41:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:41:09 INFO - warning: no files found matching '*.txt' 10:41:09 INFO - no previously-included directories found matching 'build' 10:41:09 INFO - no previously-included directories found matching 'dist' 10:41:09 INFO - no previously-included directories found matching '.git*' 10:41:09 INFO - Installing collected packages: jsonschema, functools32 10:41:09 INFO - Running setup.py install for functools32 10:41:09 INFO - warning: no files found matching '*.txt' 10:41:09 INFO - no previously-included directories found matching 'build' 10:41:09 INFO - no previously-included directories found matching 'dist' 10:41:09 INFO - no previously-included directories found matching '.git*' 10:41:09 INFO - Successfully installed jsonschema functools32 10:41:09 INFO - Cleaning up... 10:41:09 INFO - Return code: 0 10:41:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:41:09 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')]} 10:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:09 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')]} 10:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:09 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 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:09 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 10:41:09 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 10:41:09 INFO - Using env: {'DISPLAY': ':0', 10:41:09 INFO - 'HOME': '/home/cltbld', 10:41:09 INFO - 'LANG': 'en_US.UTF-8', 10:41:09 INFO - 'LANGUAGE': 'en_US:en', 10:41:09 INFO - 'LOGNAME': 'cltbld', 10:41:09 INFO - 'MAIL': '/var/mail/cltbld', 10:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:09 INFO - 'MOZ_NO_REMOTE': '1', 10:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:09 INFO - 'NO_EM_RESTART': '1', 10:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:09 INFO - 'PWD': '/builds/slave/test', 10:41:09 INFO - 'SHELL': '/bin/bash', 10:41:09 INFO - 'SHLVL': '1', 10:41:09 INFO - 'TERM': 'linux', 10:41:09 INFO - 'TMOUT': '86400', 10:41:09 INFO - 'USER': 'cltbld', 10:41:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:09 INFO - '_': '/tools/buildbot/bin/python'} 10:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:41:09 INFO - Cleaning up... 10:41:09 INFO - Return code: 0 10:41:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:41:09 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')]} 10:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:09 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')]} 10:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:09 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 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:09 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 10:41:09 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 10:41:09 INFO - Using env: {'DISPLAY': ':0', 10:41:09 INFO - 'HOME': '/home/cltbld', 10:41:09 INFO - 'LANG': 'en_US.UTF-8', 10:41:09 INFO - 'LANGUAGE': 'en_US:en', 10:41:09 INFO - 'LOGNAME': 'cltbld', 10:41:09 INFO - 'MAIL': '/var/mail/cltbld', 10:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:09 INFO - 'MOZ_NO_REMOTE': '1', 10:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:09 INFO - 'NO_EM_RESTART': '1', 10:41:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:09 INFO - 'PWD': '/builds/slave/test', 10:41:09 INFO - 'SHELL': '/bin/bash', 10:41:09 INFO - 'SHLVL': '1', 10:41:09 INFO - 'TERM': 'linux', 10:41:09 INFO - 'TMOUT': '86400', 10:41:09 INFO - 'USER': 'cltbld', 10:41:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:09 INFO - '_': '/tools/buildbot/bin/python'} 10:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:12 INFO - Downloading blobuploader-1.2.4.tar.gz 10:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:41:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:41:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 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 10:41:12 INFO - Downloading docopt-0.6.1.tar.gz 10:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:41:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:41:12 INFO - Running setup.py install for blobuploader 10:41:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:41:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:41:12 INFO - Running setup.py install for requests 10:41:13 INFO - Running setup.py install for docopt 10:41:13 INFO - Successfully installed blobuploader requests docopt 10:41:13 INFO - Cleaning up... 10:41:13 INFO - Return code: 0 10:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:41:13 INFO - Using env: {'DISPLAY': ':0', 10:41:13 INFO - 'HOME': '/home/cltbld', 10:41:13 INFO - 'LANG': 'en_US.UTF-8', 10:41:13 INFO - 'LANGUAGE': 'en_US:en', 10:41:13 INFO - 'LOGNAME': 'cltbld', 10:41:13 INFO - 'MAIL': '/var/mail/cltbld', 10:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:13 INFO - 'MOZ_NO_REMOTE': '1', 10:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:13 INFO - 'NO_EM_RESTART': '1', 10:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:13 INFO - 'PWD': '/builds/slave/test', 10:41:13 INFO - 'SHELL': '/bin/bash', 10:41:13 INFO - 'SHLVL': '1', 10:41:13 INFO - 'TERM': 'linux', 10:41:13 INFO - 'TMOUT': '86400', 10:41:13 INFO - 'USER': 'cltbld', 10:41:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:13 INFO - '_': '/tools/buildbot/bin/python'} 10:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:41:13 INFO - Running setup.py (path:/tmp/pip-k2Jb1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:41:13 INFO - Running setup.py (path:/tmp/pip-G2jvsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:41:13 INFO - Running setup.py (path:/tmp/pip-LS1OE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:41:13 INFO - Running setup.py (path:/tmp/pip-b_cl8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:41:13 INFO - Running setup.py (path:/tmp/pip-hoS1KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:41:14 INFO - Running setup.py (path:/tmp/pip-Y4ykMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:41:14 INFO - Running setup.py (path:/tmp/pip-FpI1kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:41:14 INFO - Running setup.py (path:/tmp/pip-hn6mIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:41:14 INFO - Running setup.py (path:/tmp/pip-XoWjzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:41:14 INFO - Running setup.py (path:/tmp/pip-Cn2BMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:41:14 INFO - Running setup.py (path:/tmp/pip-uXW3nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:41:14 INFO - Running setup.py (path:/tmp/pip-EfQn7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:41:14 INFO - Running setup.py (path:/tmp/pip-aRVgt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:41:14 INFO - Running setup.py (path:/tmp/pip-O3px2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:14 INFO - Running setup.py (path:/tmp/pip-lxrNt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:41:14 INFO - Running setup.py (path:/tmp/pip-1EioER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:41:14 INFO - Running setup.py (path:/tmp/pip-nmLFXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:41:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:41:14 INFO - Running setup.py install for manifestparser 10:41:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Running setup.py install for mozcrash 10:41:15 INFO - Running setup.py install for mozdebug 10:41:15 INFO - Running setup.py install for mozdevice 10:41:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Running setup.py install for mozfile 10:41:15 INFO - Running setup.py install for mozhttpd 10:41:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Running setup.py install for mozinfo 10:41:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Running setup.py install for mozInstall 10:41:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Running setup.py install for mozleak 10:41:15 INFO - Running setup.py install for mozlog 10:41:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:41:15 INFO - Running setup.py install for moznetwork 10:41:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:41:16 INFO - Running setup.py install for mozprocess 10:41:16 INFO - Running setup.py install for mozprofile 10:41:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:41:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:41:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:41:16 INFO - Running setup.py install for mozrunner 10:41:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:41:16 INFO - Running setup.py install for mozscreenshot 10:41:16 INFO - Running setup.py install for moztest 10:41:16 INFO - Running setup.py install for mozversion 10:41:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:41:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:41:16 INFO - Cleaning up... 10:41:16 INFO - Return code: 0 10:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:16 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 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:16 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 10:41:16 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 10:41:16 INFO - Using env: {'DISPLAY': ':0', 10:41:16 INFO - 'HOME': '/home/cltbld', 10:41:16 INFO - 'LANG': 'en_US.UTF-8', 10:41:16 INFO - 'LANGUAGE': 'en_US:en', 10:41:16 INFO - 'LOGNAME': 'cltbld', 10:41:16 INFO - 'MAIL': '/var/mail/cltbld', 10:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:16 INFO - 'MOZ_NO_REMOTE': '1', 10:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:16 INFO - 'NO_EM_RESTART': '1', 10:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:16 INFO - 'PWD': '/builds/slave/test', 10:41:16 INFO - 'SHELL': '/bin/bash', 10:41:16 INFO - 'SHLVL': '1', 10:41:16 INFO - 'TERM': 'linux', 10:41:16 INFO - 'TMOUT': '86400', 10:41:16 INFO - 'USER': 'cltbld', 10:41:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:16 INFO - '_': '/tools/buildbot/bin/python'} 10:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:41:16 INFO - Running setup.py (path:/tmp/pip-u60BvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:41:17 INFO - Running setup.py (path:/tmp/pip-mAmCJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:41:17 INFO - Running setup.py (path:/tmp/pip-FAwzQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:41:17 INFO - Running setup.py (path:/tmp/pip-bfmXDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:41:17 INFO - Running setup.py (path:/tmp/pip-smoj7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:41:17 INFO - Running setup.py (path:/tmp/pip-saXff3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:41:17 INFO - Running setup.py (path:/tmp/pip-pU0y6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:41:17 INFO - Running setup.py (path:/tmp/pip-zyhOPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:41:17 INFO - Running setup.py (path:/tmp/pip-0aU6V9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:41:17 INFO - Running setup.py (path:/tmp/pip-GIkR8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:41:17 INFO - Running setup.py (path:/tmp/pip-EinXKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:41:17 INFO - Running setup.py (path:/tmp/pip-HIrp1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:41:17 INFO - Running setup.py (path:/tmp/pip-IopUrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:41:17 INFO - Running setup.py (path:/tmp/pip-lq0zPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:41:17 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)) 10:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:17 INFO - Running setup.py (path:/tmp/pip-WzWOHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:41:18 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)) 10:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:41:18 INFO - Running setup.py (path:/tmp/pip-ht8jA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:41:18 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)) 10:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:41:18 INFO - Running setup.py (path:/tmp/pip-r5Gfsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:41:18 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)) 10:41:18 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)) 10:41:18 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)) 10:41:18 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)) 10:41:18 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)) 10:41:18 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)) 10:41:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:41:20 INFO - Downloading blessings-1.6.tar.gz 10:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:41:20 INFO - Installing collected packages: blessings 10:41:20 INFO - Running setup.py install for blessings 10:41:20 INFO - Successfully installed blessings 10:41:20 INFO - Cleaning up... 10:41:20 INFO - Return code: 0 10:41:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:41:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:41:20 INFO - Reading from file tmpfile_stdout 10:41:20 INFO - Current package versions: 10:41:20 INFO - argparse == 1.2.1 10:41:20 INFO - blessings == 1.6 10:41:20 INFO - blobuploader == 1.2.4 10:41:20 INFO - docopt == 0.6.1 10:41:20 INFO - functools32 == 3.2.3-2 10:41:20 INFO - jsonschema == 2.5.1 10:41:20 INFO - manifestparser == 1.1 10:41:20 INFO - mozInstall == 1.12 10:41:20 INFO - mozcrash == 1.0 10:41:20 INFO - mozdebug == 0.1 10:41:20 INFO - mozdevice == 0.48 10:41:20 INFO - mozfile == 1.2 10:41:20 INFO - mozhttpd == 0.7 10:41:20 INFO - mozinfo == 0.9 10:41:20 INFO - mozleak == 0.1 10:41:20 INFO - mozlog == 3.4 10:41:20 INFO - moznetwork == 0.27 10:41:20 INFO - mozprocess == 0.23 10:41:20 INFO - mozprofile == 0.28 10:41:20 INFO - mozrunner == 6.13 10:41:20 INFO - mozscreenshot == 0.1 10:41:20 INFO - mozsystemmonitor == 0.3 10:41:20 INFO - moztest == 0.7 10:41:20 INFO - mozversion == 1.4 10:41:20 INFO - psutil == 3.1.1 10:41:20 INFO - requests == 1.2.3 10:41:20 INFO - wsgiref == 0.1.2 10:41:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:20 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 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:20 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 10:41:20 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 10:41:20 INFO - Using env: {'DISPLAY': ':0', 10:41:20 INFO - 'HOME': '/home/cltbld', 10:41:20 INFO - 'LANG': 'en_US.UTF-8', 10:41:20 INFO - 'LANGUAGE': 'en_US:en', 10:41:20 INFO - 'LOGNAME': 'cltbld', 10:41:20 INFO - 'MAIL': '/var/mail/cltbld', 10:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:20 INFO - 'MOZ_NO_REMOTE': '1', 10:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:20 INFO - 'NO_EM_RESTART': '1', 10:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:20 INFO - 'PWD': '/builds/slave/test', 10:41:20 INFO - 'SHELL': '/bin/bash', 10:41:20 INFO - 'SHLVL': '1', 10:41:20 INFO - 'TERM': 'linux', 10:41:20 INFO - 'TMOUT': '86400', 10:41:20 INFO - 'USER': 'cltbld', 10:41:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:20 INFO - '_': '/tools/buildbot/bin/python'} 10:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 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)) 10:41:20 INFO - Cleaning up... 10:41:20 INFO - Return code: 0 10:41:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffda8814e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1464b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1600130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, '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': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', '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 10:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:41:20 INFO - Using env: {'DISPLAY': ':0', 10:41:20 INFO - 'HOME': '/home/cltbld', 10:41:20 INFO - 'LANG': 'en_US.UTF-8', 10:41:20 INFO - 'LANGUAGE': 'en_US:en', 10:41:20 INFO - 'LOGNAME': 'cltbld', 10:41:20 INFO - 'MAIL': '/var/mail/cltbld', 10:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:20 INFO - 'MOZ_NO_REMOTE': '1', 10:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:20 INFO - 'NO_EM_RESTART': '1', 10:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:20 INFO - 'PWD': '/builds/slave/test', 10:41:20 INFO - 'SHELL': '/bin/bash', 10:41:20 INFO - 'SHLVL': '1', 10:41:20 INFO - 'TERM': 'linux', 10:41:20 INFO - 'TMOUT': '86400', 10:41:20 INFO - 'USER': 'cltbld', 10:41:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:20 INFO - '_': '/tools/buildbot/bin/python'} 10:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:41:21 INFO - Cleaning up... 10:41:21 INFO - Return code: 0 10:41:21 INFO - Running post-action listener: _resource_record_post_action 10:41:21 INFO - Running post-action listener: _start_resource_monitoring 10:41:21 INFO - Starting resource monitoring. 10:41:21 INFO - [mozharness: 2016-11-17 18:41:21.076354Z] Finished create-virtualenv step (success) 10:41:21 INFO - [mozharness: 2016-11-17 18:41:21.076863Z] Running install step. 10:41:21 INFO - Running pre-action listener: _resource_record_pre_action 10:41:21 INFO - Running main action method: install 10:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:41:21 INFO - Reading from file tmpfile_stdout 10:41:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:41:21 INFO - Reading from file tmpfile_stdout 10:41:21 INFO - Output received: 10:41:21 INFO - Usage: mozinstall [options] installer 10:41:21 INFO - Options: 10:41:21 INFO - -h, --help show this help message and exit 10:41:21 INFO - -d DEST, --destination=DEST 10:41:21 INFO - Directory to install application into. [default: 10:41:21 INFO - "/builds/slave/test"] 10:41:21 INFO - --app=APP Application being installed. [default: firefox] 10:41:21 INFO - mkdir: /builds/slave/test/build/application 10:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:41:37 INFO - Reading from file tmpfile_stdout 10:41:37 INFO - Output received: 10:41:37 INFO - /builds/slave/test/build/application/firefox/firefox 10:41:37 INFO - Running post-action listener: _resource_record_post_action 10:41:37 INFO - [mozharness: 2016-11-17 18:41:37.426437Z] Finished install step (success) 10:41:37 INFO - [mozharness: 2016-11-17 18:41:37.426697Z] Running run-tests step. 10:41:37 INFO - Running pre-action listener: _resource_record_pre_action 10:41:37 INFO - Running main action method: run_tests 10:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:41:37 INFO - Python 2.7.3 10:41:37 INFO - Return code: 0 10:41:37 INFO - grabbing minidump binary from tooltool 10:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:41:37 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 0x168efc0>, '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 0x168fec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1690350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:41:37 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 10:41:37 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 10:41:37 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 10:41:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:41:37 INFO - Return code: 0 10:41:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:41:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:41:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:41:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:41:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:41:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 10:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 10:41:37 INFO - Using env: {'DISPLAY': ':0', 10:41:37 INFO - 'HOME': '/home/cltbld', 10:41:37 INFO - 'LANG': 'en_US.UTF-8', 10:41:37 INFO - 'LANGUAGE': 'en_US:en', 10:41:37 INFO - 'LOGNAME': 'cltbld', 10:41:37 INFO - 'MAIL': '/var/mail/cltbld', 10:41:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:41:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:41:37 INFO - 'MOZ_NO_REMOTE': '1', 10:41:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:41:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:41:37 INFO - 'NO_EM_RESTART': '1', 10:41:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:41:37 INFO - 'PWD': '/builds/slave/test', 10:41:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:41:37 INFO - 'SHELL': '/bin/bash', 10:41:37 INFO - 'SHLVL': '1', 10:41:37 INFO - 'TERM': 'linux', 10:41:37 INFO - 'TMOUT': '86400', 10:41:37 INFO - 'USER': 'cltbld', 10:41:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516', 10:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:41:37 INFO - '_': '/tools/buildbot/bin/python'} 10:41:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 10:41:37 INFO - mozversion application_buildid: 20161117083828 10:41:37 INFO - mozversion application_changeset: 4465d90d1d21cdff02858a87b6e883c7b456b73f 10:41:37 INFO - mozversion application_display_name: Nightly 10:41:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:41:37 INFO - mozversion application_name: Firefox 10:41:37 INFO - mozversion application_remotingname: firefox 10:41:37 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 10:41:37 INFO - mozversion application_vendor: Mozilla 10:41:37 INFO - mozversion application_version: 53.0a1 10:41:37 INFO - mozversion platform_buildid: 20161117083828 10:41:37 INFO - mozversion platform_changeset: 4465d90d1d21cdff02858a87b6e883c7b456b73f 10:41:37 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 10:41:37 INFO - mozversion platform_version: 53.0a1 10:41:37 INFO - using testdate: 1479408097 10:41:37 INFO - actual date: 1479408097 10:41:37 INFO - starting webserver on 'localhost:46462' 10:41:37 INFO - SUITE-START | Running 2 tests 10:41:37 INFO - TEST-START | dromaeo_css 10:41:37 INFO - operating with platform_type : linux_ 10:41:37 INFO - Initialising browser for dromaeo_css test... 10:41:37 INFO - TEST-INFO | started process 13380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybljXb/profile http://localhost:46462/getInfo.html) 10:41:42 INFO - PROCESS | 13380 | __metrics Screen width/height:1600/1200 10:41:42 INFO - PROCESS | 13380 | colorDepth:24 10:41:42 INFO - PROCESS | 13380 | Browser inner width/height: 1024/697 10:41:42 INFO - PROCESS | 13380 | __metrics 10:41:42 INFO - PROCESS | 13380 | 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" 10:41:42 INFO - PROCESS | 13380 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:41:43 INFO - PROCESS | 13380 | console.error: PushService: 10:41:43 INFO - PROCESS | 13380 | stateChangeProcessEnqueue: Error transitioning state 10:41:43 INFO - PROCESS | 13380 | UnknownError 10:41:44 INFO - TEST-INFO | 13380: exit 0 10:41:44 INFO - Browser initialized. 10:41:44 INFO - Running cycle 1/1 for dromaeo_css test... 10:41:44 INFO - TEST-INFO | started process 13460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybljXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:41:56 INFO - PROCESS | 13460 | RSS: Main: 174718976 10:41:56 INFO - PROCESS | 13460 | 10:42:48 INFO - PROCESS | 13460 | 1479408168130 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] 10:45:00 INFO - PROCESS | 13460 | Cycle 1(1): loaded http://localhost:46462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46462/tests/dromaeo/cssquery-ext.html) 10:45:02 INFO - PROCESS | 13460 | RSS: Main: 309743616 10:45:02 INFO - PROCESS | 13460 | 10:48:05 INFO - PROCESS | 13460 | Cycle 1(1): loaded http://localhost:46462/tests/dromaeo/cssquery-ext.html (next: http://localhost:46462/tests/dromaeo/cssquery-jquery.html) 10:48:05 INFO - PROCESS | 13460 | RSS: Main: 276537344 10:48:05 INFO - PROCESS | 13460 | 10:51:08 INFO - PROCESS | 13460 | Cycle 1(1): loaded http://localhost:46462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46462/tests/dromaeo/cssquery-mootools.html) 10:51:08 INFO - PROCESS | 13460 | RSS: Main: 219447296 10:51:08 INFO - PROCESS | 13460 | 10:54:11 INFO - PROCESS | 13460 | Cycle 1(1): loaded http://localhost:46462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46462/tests/dromaeo/cssquery-prototype.html) 10:54:11 INFO - PROCESS | 13460 | RSS: Main: 220053504 10:54:11 INFO - PROCESS | 13460 | 10:57:14 INFO - PROCESS | 13460 | Cycle 1(1): loaded http://localhost:46462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46462/tests/dromaeo/cssquery-yui.html) 10:57:15 INFO - PROCESS | 13460 | RSS: Main: 220368896 10:57:15 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | Cycle 1(1): loaded http://localhost:46462/tests/dromaeo/cssquery-yui.html (next: http://localhost:46462/tests/dromaeo/cssquery-dojo.html) 11:00:18 INFO - PROCESS | 13460 | RSS: Main: 297332736 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | __start_tp_report 11:00:18 INFO - PROCESS | 13460 | _x_x_mozilla_page_load 11:00:18 INFO - PROCESS | 13460 | _x_x_mozilla_page_load_details 11:00:18 INFO - PROCESS | 13460 | |i|pagename|runs| 11:00:18 INFO - PROCESS | 13460 | |0;dojo.html;2463.7043554773422;2515.8616276104813;2522.7351128131545;2527.1028784781415;2541.0471073347494;4316.54676258993;4329.242382583043;4364.345348197768;4418.1384629997165;4434.201843668143;4397.890052748675;4399.736015839044;4445.555444455553;4468.597826195642;4540.636749060075;4084.1831633673237;4127.071408932996;4138.08962028354;4160.292750232453;4160.791960401968;4126.5667104954;4157.230912281222;4161.25097482453;4174.415581818533;4177.97911010446;4169.14532520834;4185.142045880602;4199.538050814408;4218.135282267128;4228.02755366266;3959.4456776051375;3993.920121597581;3995.62041606047;4125.278076336629;4135.048938744106;4022.6982976276895;4048.271311163989;4084.775337356444;4087.6116768906904;4149.771762553059;4426.933595996063;4455.131249406367;4459.420275364214;4499.055198408339;4512.368268442421;4544.045750392422;4706.22347312693;4756.762161891927;4765.880852978668;4768.403949506312;4577.771111444415;4643.651726120521;4656.604188643969;4658.1848176568965;4674.813007479696;4364.345348197796;4364.759938203398;4368.912621747547;4369.497507786582;4379.496357918816;4746.833860814924;4748;4756.167670657621;4758.881027974328;4764.118638051971;4636.466806317249;4656.278276867091;4676.649251306166;4725.40932383452;4727.2436410174205;4690;4740.028294199681;4751.976240118777;4761.666683332133;4797.160496913027;4530.433695788027;4571.245744452194;4655;4673.836415725501;4674.158651442773;4591.150637132075;4591.931121033187;4592.471865735483;4598.26427771555;4620.376249206314;3952.24907267624;3966.3257246268204;3995.84016639337;4043.8180281887385;4059.4519739834745;3563.340781955295;3595.8741444049856;3600.369935261319;3629.201575653352;3644.1800594865945;4098.856540021085;4108.055147316134;4111.342185250345;4111.465509483748;4156.937645935313;4647.419072615923;4700.647451441156;4804.6876952997945;4806.831760888422;4840.685355451955;4099.938500922489;4103.9179216416105;4129.958700413017;4139.97930010348;4194.8112334945;4345.847895323648;4347.217500849877;4358.106588149421;4367.432233809584;4380.824767009348;4514.322851572159;4521.751303678329;4535.115652447741;4557.612602928788;4571.9085618287445;4587.4036375271;4640.280756482751;4642.442906851199;4728.338032675497;4820.517948205152;4530.071335376174;4531.093781243831;4548.11311794197;4566.931496027496;4568.908621827612;4756.904861902812;4758.738269395078;4764.8332308369045;4765.571098601143;4796.904061918812;4605.700629459075;4775.856724298276;4819.204831202812;4846.345743324606;4896.608271338356;4511.729296242236;4560.498345181961;4585.335126406719;4626.421697287839;4671.976640116778;4604.424446944132;4606.147862645421;4631.050634619827;4638.814447422065;4672.626189904868;4530.637548996006;4539.682222244412;4549.272116461482;4564.543545645409;4574;4507.887302817456;4559.521250268674;4589.563991420943;4590.6327493799745;4608.423947006624;4399.47206335229;4526.230540808005;4540.364348991078;4555.908881822411;4602.171609110393 11:00:18 INFO - PROCESS | 13460 | |1;ext.html;559.5663360895306;572.6077636818779;584.9327327357355;587.9118132280161;595.7021489255372;21407;27278.727212727867;28191.43617127659;28261.717382826166;30523.236919077033;27638.723612763868;27989.720102798965;28007.439851203013;28021.439571208564;28024.299392515197;5291.4708529147065;5419.566434685215;5420.4850539198715;5426.728663566825;5428.9185662215095;5604.747786349624;5674.177244299574;5676.631018983773;5680.573956953224;5681.715914204294;5667.0932650775885;5687.431256874321;5704.77180912763;5705.885882282372;5709.743061562219;5641.717914104278;5690.687012214326;5696;5697.829065128011;5702.116171993306;5547;5624.718764061821;5639.746211420496;5642.548596112301;5642.971785141089;25256.621150682753;25356.619650705255;25428.364290892692;25474.617880731803;25507.872460637576;2921.8539073046263;2931.604233428481;2985.5223164293825;3163;3532.364174448598;17438.476845694524;17879.3742219023;18135.09324533768;18587.349442769573;18595.907020464812;2694.5958106284215;2716.904908328199;2735.1110888961166;2749.848758318292;2787.4982503149427;227201;227857;228477;228544.85727571422;228677;29657.555136672967;49112.75443622759;49155.279565215045;49248.75375623099;49476;31959.041228763173;32091.518627220612;32180.19549511281;32205.677943220737;32276;12550.372481375894;12705.555305564261;12721.173123746927;12721.491140354467;12726.490940362468;10313.587456501806;10366.948165259126;10395.660976280427;10410.583576657;10410.791784164274;7653.770386888402;7679.961600191963;7737.032870891138;7740.922590774133;7754.573498457639;3054.465468542996;3102.565640810288;3102.5966624338694;3102.9379412412077;3117.1895307219834;851.4167795060404;889.5374405309203;891.9375643705008;892.2193081054078;1011.4437059617181;26028.479430411666;26076.34809129749;26689.599656005175;26693.332666683487;26780.330491737473;764.7399884039453;907.4691305586306;938.7887725261899;981.6417007792104;984.9704508864745;11493.110236220473;13948.930255348658;14368.568942931728;14474.276286185648;14686.339114739862;349382;353065;353269;353702;354297;30803.22991925175;30828.53757193644;30844.383112337626;30895.691043089282;30899.227519311746;1037.258360272409;1056.2025670618634;1133.9773204535863;1139.800534906388;1167.8248262760314;24942;25956.480870382864;26812.949176416874;27199.320016999733;27452;38569.807150965185;39101.217975640895;39115;39304;39334.60665393309;274625;275415.6229218841;275709;276434;276456;22198.556028879007;22624.321270361914;23112.146449245174;24184.153554625504;24267.635985460587;35227.82386088053;35702.642973569935;35788;35963;36153.27693446169;30172;30969.53545696771;31180.844095779375;31473.21316967094;31544.842275788473;30284;30521.847390762905;31071.53392699066;31092.844535777178;31673.524897127023;30983.225419364695;31184.376312474076;31210.375792484476;31397.21506962253;31958.36083278275;27354.316142096606;28506.57240141358;28799.42401152007;29207.269818254714;29228.41543169082;22052.77947220507;24390.878045609657;24895.75104249007;24965.50068998646;25246.495070098128 11:00:18 INFO - PROCESS | 13460 | |2;jquery.html;344.77417291673964;361.45961787128266;363.42215876755955;366.9596344402115;372.71859745891845;9687.951560242198;10398.636047738331;11413.942930285337;11414.835988566165;12826.61520154397;12663.493460261601;12811.935940320309;12825.935870320658;12843.871561284384;14045.92977035116;3919.902002449933;4170.207660544487;4175.645070169039;4175.956010997251;4175.979120104395;2885.2786803299177;3096.7987080839785;3800.524934383202;3867.7485963412287;3867.9806600967095;3854.8843534694006;4038.6365227129554;4071.226466971281;4104.794760261975;4106.281400754856;4087.8773636790797;4093.570175131628;4098.7950602469755;4099.282625540519;4099.50805903292;3544.379733546619;3727.105494681284;3757.6993840492696;3766.3032339017095;3771.30230907283;13549.932250338685;13583.252921089335;13594.524191653343;13597.59207223775;16065.116418596972;1792.0860361215873;1999.490130016851;2100.380387785607;2389.187676190086;2478.1821998740375;10068.395896246175;10480.528376223088;10867.184961127869;11112.61105861299;11308.773824523545;1434.9856501434956;1436.080908218741;1439.2372042817324;1470.6985068061022;1480.141517919615;41808.1638367234;46497;66612.3338766611;66902;67735;7929.5242285463055;8392.664293428317;8453.239208471266;8525.914740852637;9223.723288301362;10730.873258307922;10747.623833165802;10779.838302425469;10821.404822734668;10822.18833587484;6551.377619126175;6556.606603603704;6608.603483790988;6706.22878368984;6762;6514.413702766774;6545.247296560861;6732.798016059526;6734.797956061326;6746.156730408699;3355.9664403355655;3424.9315013700084;3430.6569343065994;3581.7313701472494;3700.3154416433044;1686.3001854230356;1734.6443978984278;1766.8763186577073;1775.698131317679;1806.2594336322045;816.7876352148484;835.7367429259764;837.4514692876176;887.1926546842343;901.7610333261691;15956.202189890459;16550.6689866202;16694.749578756328;16753.497395078168;17535.298588056336;790.8457850719169;828.0312034919159;865.9956700216459;873.4060838629666;878.6221924572495;8961.800696698252;9399.859002114974;9524.8571271431;9638.9036109638;9661.758456038655;362197;372529;375344;375828;376903;51953.74023129936;64136.67931660312;67086;76094.23905760983;77330.6133469329;847.9745607631781;888.8044630181349;890.6481939633809;891.6923661336958;892.1212605583495;14349.56951291463;15207.55528224817;15219.239038047832;15360.23198840076;16072.598185045468;31875;33500.83249583736;34364.969050928514;35021.64978350286;39444.60555394409;46381.76809115933;47623;49656.50343496519;51042;51071;7042.718291268497;7159.463040271896;7258.745943891939;7512.661930213263;7736.419768517271;10354.653894993602;10947.890521095005;11753.471093800628;11822.881771182178;11860.881391185978;9181.49501777382;9534.23726101924;9934.403935763878;10457.320274182153;10483.266171368236;9866.013398660076;9883.30816842814;10544.420056896945;10704.357738535713;10888.40113793749;9221.723348299562;9660.613575456902;10382.42896640692;10686.679399618024;11268.830967535658;7350.669219885011;7356.595387253538;7390.3718183952815;7454.515456495311;7618.580978046039;8391.622376992927;10429.9478502607;10439.112675422673;10686.57253709874;11057 11:00:18 INFO - PROCESS | 13460 | |3;mootools.html;1310.233513394664;1344.1666166976474;1359.333926376076;1590.5784966983751;1598.968020639588;5555.333359996806;5742.2247996520455;5816.272965879265;6159.384061593838;6165.784197553081;6003.579749417542;6206.1931948846695;6223.844403889905;6335.144755458012;6346.746130154788;1712.3578658003248;1750.754894314797;1752.0889137648414;1753.0095496044694;1753.684336819372;1498.325753410964;1555.587769241152;1742.991285043573;1752.7458518514807;1758.8241175882438;1673.21358961288;1730.3078768492578;1733.2200509770653;1745.8079611242754;1750.4661078371091;1727.6631056943902;1728.1445684386183;1731.601731601726;1732.7487514310417;1736.0885535094114;1710.8460238578589;1773.6364045370667;1774.698301288771;1777.0315178227897;1778.262021261175;6206.379362063803;6260.906086408708;6269.686515674243;6270.65511396873;6274.780382686584;3895.824687889052;4006.6794656427414;4006.759594424344;4008.078142027321;4010.859619913318;2398.5083057973075;2572.5755250383663;2577.948441031169;2593.4035171910377;2605.6873175218907;677.9457643388517;702.5608994378514;717.3722992381666;721.3471808013755;729.194240364395;8081;8292.543910084943;8303.169683031649;8323.66705331786;8365.707200248024;3538.5930617978747;3588.372034893883;3611.4041183204477;3618.620044895248;3631.782093074424;7190.892136617955;7197.172325182566;7198.100237470317;7211;7213.422926165894;4095.774732389747;4097.91804163921;4099.61053699898;4102.261592913304;4110.876673699794;3750.2312026034597;3822.980885095557;3836.175222327213;3863.690904727615;3874.0508575398644;2746.8489233092373;2840.616516770251;2842.5025620516326;2908.1130255272346;2966.3325751705693;826.7561069484517;840.6721378662327;1025.958961641526;1077.5851297250458;1078.0567003871613;625.4496043481707;767.8502691975123;770.849684311565;784.7841843493085;802.6949759091508;4347.478302603708;4411.18393097278;4553.772311384484;4570.223062079454;4588.6099681526775;716.4089626058523;776.8174478997431;863.9308855291562;895.0914821456228;898.3890954151109;2971.5542668599883;3082.676318986519;3162.984185079106;3187.9043628691174;3232.3858466891215;7659.310662040443;7738.690452381842;7870.488418252795;7955.920440795634;7967.203279671987;7847.84304313922;7903.960480197562;7906.130325664172;7917.564533950688;7948.324392426593;5618.241537392481;5655.6606603603095;5734.598578099576;5767.740451679684;5774.711264436762;4249.086446414036;4279.465066866642;4283.464566929134;4396.472423309224;4520.163769702615;6737.528373013842;6883.139607549057;6958.930410695828;6968.9198174283065;6992.195897471653;6800.761973331108;6919.065926099912;6963.512554121163;7012.2286548478605;7106.076210092655;5804.709764511842;5834.766609335748;5874.324452687995;5876.529877609866;5970.701464926649;6185.907211391923;6247.750089996349;6253.906191407224;6255.937440625536;6261.154744109669;5433;5499.422560631237;5514.779408823762;5642.887142257214;5653.123765816305;5638.464345887134;5722.3991480895575;5725.08398656213;5765.394633563583;5858.970705146447;5008.799648014038;5018.774155162953;5059.190529515407;5067.290579318825;5117.667351622133;3950.9209815802947;3952.802359882052;4038.7980600970423;4045.4336392905607;4067.0442446024567;3925.5289365275207;4072.3077076896407;4077.938830917479;4136.9793151034055;4187.937180942349 11:00:18 INFO - PROCESS | 13460 | |4;prototype.html;274.2321499800558;277.74031280752496;283.4472778082738;284.67973529779;284.8903520786535;4689.718616882985;4706.647001474895;4717.764111794414;4737.313089602006;4753.144434001878;4613.6539759518;4636.698614590057;4639.350490931272;4645.117427688737;4661.766911654412;3425.982870085646;3493.5807703075666;3522.076676358629;3550.1834578047064;3608.350496910555;3603.4955106285142;3606.549181352331;3608.1340478285156;3618.9276214475694;3629.909252268701;3576.481410195533;3592.550931133608;3592.9101772455765;3593.6226696196914;3594.748367614268;3386.7121294689982;3454.792712437262;3502.896587574906;3587.94618080729;3596.28074385124;3158.936821263585;3162.8892988745283;3182.5226216067545;3189.202699325169;3196.904092877194;4459.439196281308;4474.82100715971;4479.5296493868;4493.775311234458;4528.343390208434;3981.3629819228786;4119.237940980928;4126.587341265879;4134.400511925754;4134.73124246923;4773.856784296477;4800.279958006292;4800.351952486404;4803.3995750531185;4814.711117332936;3506.877259295938;3509.771864828778;3515.806630635314;3516.226430185355;3516.2791627716256;4900.681455705368;5022.53445122864;5039.2944987701385;5054.696718196847;5085.211792172219;3454.360943225511;3460.8096554689732;3461.5153878457036;3465.4108801503803;3472.600650925176;3522.788632682047;3523.5419395478425;3538.752287339913;3556.324298383299;3557.1462848916076;4073.348264277701;4079.326911059701;4084.9591504085174;4086.4483294755423;4088;4777.689450185727;4848.5636292733825;4860.2223644217465;4877.366082362378;4900.950990490121;1168.4449886304108;1181.0728578066178;1184.7334349771234;1187.7208855918852;1190.3810018790355;778.5095389904324;803.967841286342;809.8015986083329;810.1372038778682;815.404754529197;4064.166845796605;4183.5775836215835;4212.620864122244;4307.65538756905;4310.7629080400875;5000.449950505442;5008.5993120550265;5009.549140577293;5012.498750124958;5015.3480047593575;4293.549177336397;4296.560652181492;4308.375285583636;4308.590683885026;4310.331898555729;2410.445597512582;2546.477972015732;2554.5912653975274;2568.8201825872384;2580.587106063021;4503.347014682852;4509.2559727644575;4516.345129956138;4526.343680166357;4554.111948170142;4939.3084968104495;4948.356713627206;4959.2561115832195;4969.701817890938;4976.576990955737;4397.912041759211;4551.906123183307;4672.906541869212;4693.178693728584;4721.339012538316;5028.2960385546785;5045.394552653705;5047.924281135859;5060.544550990428;5076.746162691925;4963.230699241623;4967.05625931072;4970.552650261349;4981.701097934136;4987.850364489072;4602.585767280961;4662.906741865211;4681.227597446383;4710.9764451177525;4713.865279589035;3510.684038436553;3515.5605549306338;3527.2945410918433;3528.1885166411357;3528.870761356444;5006.6495345325475;5025.924611130763;5030.3963524377305;5043.470435604356;5048;4596.333531637961;4795.712257264575;4830.7101573905675;4868.440129385166;4872.951270487391;4823.686460380064;4827.589654879234;4830.927536086891;4845.691663250973;4872.220444728827;4789.760511974457;4806.206975849085;4809.110314591671;4810.536413782072;4833.661643685049;4619.607333376701;4864.318995340726;4878.853469434751;4880.853574392774;4882.829100981448;4765.26138448541;4768.976155119202;4772.832950846704;4776.853555146809;4788.449328327148 11:00:18 INFO - PROCESS | 13460 | |5;yui.html;597.1520440973817;637.4868231073983;657.5791493444196;668.5654324688952;678.7929681447159;10535.63125290615;11015.394153321575;11069.778604427907;11419.486123124458;11563.479643416045;11015.118790496761;11185.272957257794;11231.775364492705;11233.831492527619;11233.887661123386;587.5886879184567;738.3650060947581;750.9324160825524;751.2037240525034;752.0298814529251;596.3827438601048;731.2139450091147;749.7263498822917;758.4956004257162;760.2853317881202;782.4327362662053;785.0422484568817;785.1363500149847;785.1441928298154;785.4619585583865;605.824310949824;781.6756046240803;781.9765407037798;782.4483738964017;782.538302401583;459.1643209358968;561.6489693941287;581.7934633205235;583.3787016827066;586.9471747542742;10151.949240253825;10169.084782369548;10177.592896284139;10187.286889917708;10218.029287217703;8592.656293748305;8892.955535222347;8950.910490895072;9130.223930965876;9225.077492250788;7868.173841746649;7944.245296696805;8046.476978996347;8321.16788321169;8342;2313.560423519526;2342.3090188394463;2450.901963921441;2465;2500.324912273676;46547.30179047317;47070.529294706954;48520.27219591709;49508.75245623749;49890.25164622533;6641.933580664131;6694.263631000586;6703.93296067033;6899.793006209822;6931.341522555349;13342.93328533351;13592.38834252461;13720;13828.516001940085;14110.71778564423;6047.516198704093;6067.453929146398;6092.086187071886;6126.417990290915;6278.246610406781;3538.752287339913;3547.9822600887346;3553.271579326232;3557.8221088945447;3606.8737594184076;2538.4923015396625;2588.365850366672;2610.2299821552688;2610.5692560727266;2610.7258737832635;440.0670578373804;441.30053864624927;449.7869690289495;456.0696179793251;460.1556144474926;448.87431519174686;451.69510580358127;467.03790192204167;497.3807609526163;501.3830396969743;6211.130441738161;6312.495000399957;6561.967190164114;6607.702653380513;6655.101561289261;453.4218870939578;480.2028632470083;496.60023680937195;506.501096420026;512.1523877981946;3115.408072466224;3122.87508499662;3126.2497000719663;3171.5084161954933;3192.8403579820915;67136;70781.29218707747;71222.64388678024;72301.2769872305;72559;37445.812770936514;37465.43801842975;37471.62528374681;55833.720831395585;60115.69942150349;34917.1270718229;35966.64033359685;47044.7647761759;55939.720301399044;56448.71775641095;6026.276846778239;6034.155218269358;6303.338149494237;6337.904931426125;6389.105525226379;38164.61835381722;38363.424548631236;39194.804025980826;39308.2138357237;40367.59632403756;48800.119988000915;48877.5112248873;52059.479405205464;52108.478915211876;54928.176077358075;8031.196880311922;8312.33501319905;8591.785205369915;8618.482891026559;8692.174243446863;9561.139497445263;9594.715406774776;9893.109620133935;10180.745481363025;10381;8688.652453902027;8764.605592748214;9170.174684278447;9288.303377246599;9481.76295592588;9085.409448385833;9152.679656212;9830.311878168746;9878.110970012733;10105.39367637944;8532.616032278438;8798.12018798115;8820.514871682119;9013.684521041732;9033.77415564616;7644.235576442311;7795.337396321376;8278.379121566028;8311.542865142475;8476.854280646729;7530.849383012419;7577.507462014952;7950.681972721027;7955.949770779396;8538.274246689101 11:00:18 INFO - PROCESS | 13460 | __end_tp_report 11:00:18 INFO - PROCESS | 13460 | __start_cc_report 11:00:18 INFO - PROCESS | 13460 | _x_x_mozilla_cycle_collect,1428 11:00:18 INFO - PROCESS | 13460 | __end_cc_report 11:00:18 INFO - PROCESS | 13460 | __startTimestamp1479409218782__endTimestamp 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | ------- Summary: start ------- 11:00:18 INFO - PROCESS | 13460 | Number of tests: 6 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | [#0] dojo.html Cycles:165 Average:4385.75 Median:4530.64 stddev:435.89 (9.6%) stddev-sans-first:410.32 11:00:18 INFO - PROCESS | 13460 | Values: 2463.7 2515.9 2522.7 2527.1 2541.0 4316.5 4329.2 4364.3 4418.1 4434.2 4397.9 4399.7 4445.6 4468.6 4540.6 4084.2 4127.1 4138.1 4160.3 4160.8 4126.6 4157.2 4161.3 4174.4 4178.0 4169.1 4185.1 4199.5 4218.1 4228.0 3959.4 3993.9 3995.6 4125.3 4135.0 4022.7 4048.3 4084.8 4087.6 4149.8 4426.9 4455.1 4459.4 4499.1 4512.4 4544.0 4706.2 4756.8 4765.9 4768.4 4577.8 4643.7 4656.6 4658.2 4674.8 4364.3 4364.8 4368.9 4369.5 4379.5 4746.8 4748.0 4756.2 4758.9 4764.1 4636.5 4656.3 4676.6 4725.4 4727.2 4690.0 4740.0 4752.0 4761.7 4797.2 4530.4 4571.2 4655.0 4673.8 4674.2 4591.2 4591.9 4592.5 4598.3 4620.4 3952.2 3966.3 3995.8 4043.8 4059.5 3563.3 3595.9 3600.4 3629.2 3644.2 4098.9 4108.1 4111.3 4111.5 4156.9 4647.4 4700.6 4804.7 4806.8 4840.7 4099.9 4103.9 4130.0 4140.0 4194.8 4345.8 4347.2 4358.1 4367.4 4380.8 4514.3 4521.8 4535.1 4557.6 4571.9 4587.4 4640.3 4642.4 4728.3 4820.5 4530.1 4531.1 4548.1 4566.9 4568.9 4756.9 4758.7 4764.8 4765.6 4796.9 4605.7 4775.9 4819.2 4846.3 4896.6 4511.7 4560.5 4585.3 4626.4 4672.0 4604.4 4606.1 4631.1 4638.8 4672.6 4530.6 4539.7 4549.3 4564.5 4574.0 4507.9 4559.5 4589.6 4590.6 4608.4 4399.5 4526.2 4540.4 4555.9 4602.2 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | [#1] ext.html Cycles:180 Average:40165.58 Median:30836.46 stddev:76736.77 (248.9%) stddev-sans-first:76894.42 11:00:18 INFO - PROCESS | 13460 | Values: 559.6 572.6 584.9 587.9 595.7 21407.0 27278.7 28191.4 28261.7 30523.2 27638.7 27989.7 28007.4 28021.4 28024.3 5291.5 5419.6 5420.5 5426.7 5428.9 5604.7 5674.2 5676.6 5680.6 5681.7 5667.1 5687.4 5704.8 5705.9 5709.7 5641.7 5690.7 5696.0 5697.8 5702.1 5547.0 5624.7 5639.7 5642.5 5643.0 25256.6 25356.6 25428.4 25474.6 25507.9 2921.9 2931.6 2985.5 3163.0 3532.4 17438.5 17879.4 18135.1 18587.3 18595.9 2694.6 2716.9 2735.1 2749.8 2787.5 227201.0 227857.0 228477.0 228544.9 228677.0 29657.6 49112.8 49155.3 49248.8 49476.0 31959.0 32091.5 32180.2 32205.7 32276.0 12550.4 12705.6 12721.2 12721.5 12726.5 10313.6 10366.9 10395.7 10410.6 10410.8 7653.8 7680.0 7737.0 7740.9 7754.6 3054.5 3102.6 3102.6 3102.9 3117.2 851.4 889.5 891.9 892.2 1011.4 26028.5 26076.3 26689.6 26693.3 26780.3 764.7 907.5 938.8 981.6 985.0 11493.1 13948.9 14368.6 14474.3 14686.3 349382.0 353065.0 353269.0 353702.0 354297.0 30803.2 30828.5 30844.4 30895.7 30899.2 1037.3 1056.2 1134.0 1139.8 1167.8 24942.0 25956.5 26812.9 27199.3 27452.0 38569.8 39101.2 39115.0 39304.0 39334.6 274625.0 275415.6 275709.0 276434.0 276456.0 22198.6 22624.3 23112.1 24184.2 24267.6 35227.8 35702.6 35788.0 35963.0 36153.3 30172.0 30969.5 31180.8 31473.2 31544.8 30284.0 30521.8 31071.5 31092.8 31673.5 30983.2 31184.4 31210.4 31397.2 31958.4 27354.3 28506.6 28799.4 29207.3 29228.4 22052.8 24390.9 24895.8 24965.5 25246.5 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | [#2] jquery.html Cycles:180 Average:22303.17 Median:190337.15 stddev:61386.78 (32.3%) stddev-sans-first:61536.85 11:00:18 INFO - PROCESS | 13460 | Values: 344.8 361.5 363.4 367.0 372.7 9688.0 10398.6 11413.9 11414.8 12826.6 12663.5 12811.9 12825.9 12843.9 14045.9 3919.9 4170.2 4175.6 4176.0 4176.0 2885.3 3096.8 3800.5 3867.7 3868.0 3854.9 4038.6 4071.2 4104.8 4106.3 4087.9 4093.6 4098.8 4099.3 4099.5 3544.4 3727.1 3757.7 3766.3 3771.3 13549.9 13583.3 13594.5 13597.6 16065.1 1792.1 1999.5 2100.4 2389.2 2478.2 10068.4 10480.5 10867.2 11112.6 11308.8 1435.0 1436.1 1439.2 1470.7 1480.1 41808.2 46497.0 66612.3 66902.0 67735.0 7929.5 8392.7 8453.2 8525.9 9223.7 10730.9 10747.6 10779.8 10821.4 10822.2 6551.4 6556.6 6608.6 6706.2 6762.0 6514.4 6545.2 6732.8 6734.8 6746.2 3356.0 3424.9 3430.7 3581.7 3700.3 1686.3 1734.6 1766.9 1775.7 1806.3 816.8 835.7 837.5 887.2 901.8 15956.2 16550.7 16694.7 16753.5 17535.3 790.8 828.0 866.0 873.4 878.6 8961.8 9399.9 9524.9 9638.9 9661.8 362197.0 372529.0 375344.0 375828.0 376903.0 51953.7 64136.7 67086.0 76094.2 77330.6 848.0 888.8 890.6 891.7 892.1 14349.6 15207.6 15219.2 15360.2 16072.6 31875.0 33500.8 34365.0 35021.6 39444.6 46381.8 47623.0 49656.5 51042.0 51071.0 7042.7 7159.5 7258.7 7512.7 7736.4 10354.7 10947.9 11753.5 11822.9 11860.9 9181.5 9534.2 9934.4 10457.3 10483.3 9866.0 9883.3 10544.4 10704.4 10888.4 9221.7 9660.6 10382.4 10686.7 11268.8 7350.7 7356.6 7390.4 7454.5 7618.6 8391.6 10429.9 10439.1 10686.6 11057.0 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | [#3] mootools.html Cycles:180 Average:4220.37 Median:5063.24 stddev:2264.52 (44.7%) stddev-sans-first:2260.31 11:00:18 INFO - PROCESS | 13460 | Values: 1310.2 1344.2 1359.3 1590.6 1599.0 5555.3 5742.2 5816.3 6159.4 6165.8 6003.6 6206.2 6223.8 6335.1 6346.7 1712.4 1750.8 1752.1 1753.0 1753.7 1498.3 1555.6 1743.0 1752.7 1758.8 1673.2 1730.3 1733.2 1745.8 1750.5 1727.7 1728.1 1731.6 1732.7 1736.1 1710.8 1773.6 1774.7 1777.0 1778.3 6206.4 6260.9 6269.7 6270.7 6274.8 3895.8 4006.7 4006.8 4008.1 4010.9 2398.5 2572.6 2577.9 2593.4 2605.7 677.9 702.6 717.4 721.3 729.2 8081.0 8292.5 8303.2 8323.7 8365.7 3538.6 3588.4 3611.4 3618.6 3631.8 7190.9 7197.2 7198.1 7211.0 7213.4 4095.8 4097.9 4099.6 4102.3 4110.9 3750.2 3823.0 3836.2 3863.7 3874.1 2746.8 2840.6 2842.5 2908.1 2966.3 826.8 840.7 1026.0 1077.6 1078.1 625.4 767.9 770.8 784.8 802.7 4347.5 4411.2 4553.8 4570.2 4588.6 716.4 776.8 863.9 895.1 898.4 2971.6 3082.7 3163.0 3187.9 3232.4 7659.3 7738.7 7870.5 7955.9 7967.2 7847.8 7904.0 7906.1 7917.6 7948.3 5618.2 5655.7 5734.6 5767.7 5774.7 4249.1 4279.5 4283.5 4396.5 4520.2 6737.5 6883.1 6958.9 6968.9 6992.2 6800.8 6919.1 6963.5 7012.2 7106.1 5804.7 5834.8 5874.3 5876.5 5970.7 6185.9 6247.8 6253.9 6255.9 6261.2 5433.0 5499.4 5514.8 5642.9 5653.1 5638.5 5722.4 5725.1 5765.4 5859.0 5008.8 5018.8 5059.2 5067.3 5117.7 3950.9 3952.8 4038.8 4045.4 4067.0 3925.5 4072.3 4077.9 4137.0 4187.9 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | [#4] prototype.html Cycles:180 Average:4009.32 Median:4553.01 stddev:1179.37 (25.9%) stddev-sans-first:1148.87 11:00:18 INFO - PROCESS | 13460 | Values: 274.2 277.7 283.4 284.7 284.9 4689.7 4706.6 4717.8 4737.3 4753.1 4613.7 4636.7 4639.4 4645.1 4661.8 3426.0 3493.6 3522.1 3550.2 3608.4 3603.5 3606.5 3608.1 3618.9 3629.9 3576.5 3592.6 3592.9 3593.6 3594.7 3386.7 3454.8 3502.9 3587.9 3596.3 3158.9 3162.9 3182.5 3189.2 3196.9 4459.4 4474.8 4479.5 4493.8 4528.3 3981.4 4119.2 4126.6 4134.4 4134.7 4773.9 4800.3 4800.4 4803.4 4814.7 3506.9 3509.8 3515.8 3516.2 3516.3 4900.7 5022.5 5039.3 5054.7 5085.2 3454.4 3460.8 3461.5 3465.4 3472.6 3522.8 3523.5 3538.8 3556.3 3557.1 4073.3 4079.3 4085.0 4086.4 4088.0 4777.7 4848.6 4860.2 4877.4 4901.0 1168.4 1181.1 1184.7 1187.7 1190.4 778.5 804.0 809.8 810.1 815.4 4064.2 4183.6 4212.6 4307.7 4310.8 5000.4 5008.6 5009.5 5012.5 5015.3 4293.5 4296.6 4308.4 4308.6 4310.3 2410.4 2546.5 2554.6 2568.8 2580.6 4503.3 4509.3 4516.3 4526.3 4554.1 4939.3 4948.4 4959.3 4969.7 4976.6 4397.9 4551.9 4672.9 4693.2 4721.3 5028.3 5045.4 5047.9 5060.5 5076.7 4963.2 4967.1 4970.6 4981.7 4987.9 4602.6 4662.9 4681.2 4711.0 4713.9 3510.7 3515.6 3527.3 3528.2 3528.9 5006.6 5025.9 5030.4 5043.5 5048.0 4596.3 4795.7 4830.7 4868.4 4873.0 4823.7 4827.6 4830.9 4845.7 4872.2 4789.8 4806.2 4809.1 4810.5 4833.7 4619.6 4864.3 4878.9 4880.9 4882.8 4765.3 4769.0 4772.8 4776.9 4788.4 11:00:18 INFO - PROCESS | 13460 | 11:00:18 INFO - PROCESS | 13460 | [#5] yui.html Cycles:180 Average:13036.84 Median:33070.99 stddev:17720.21 (53.6%) stddev-sans-first:17745.30 11:00:18 INFO - PROCESS | 13460 | Values: 597.2 637.5 657.6 668.6 678.8 10535.6 11015.4 11069.8 11419.5 11563.5 11015.1 11185.3 11231.8 11233.8 11233.9 587.6 738.4 750.9 751.2 752.0 596.4 731.2 749.7 758.5 760.3 782.4 785.0 785.1 785.1 785.5 605.8 781.7 782.0 782.4 782.5 459.2 561.6 581.8 583.4 586.9 10151.9 10169.1 10177.6 10187.3 10218.0 8592.7 8893.0 8950.9 9130.2 9225.1 7868.2 7944.2 8046.5 8321.2 8342.0 2313.6 2342.3 2450.9 2465.0 2500.3 46547.3 47070.5 48520.3 49508.8 49890.3 6641.9 6694.3 6703.9 6899.8 6931.3 13342.9 13592.4 13720.0 13828.5 14110.7 6047.5 6067.5 6092.1 6126.4 6278.2 3538.8 3548.0 3553.3 3557.8 3606.9 2538.5 2588.4 2610.2 2610.6 2610.7 440.1 441.3 449.8 456.1 460.2 448.9 451.7 467.0 497.4 501.4 6211.1 6312.5 6562.0 6607.7 6655.1 453.4 480.2 496.6 506.5 512.2 3115.4 3122.9 3126.2 3171.5 3192.8 67136.0 70781.3 71222.6 72301.3 72559.0 37445.8 37465.4 37471.6 55833.7 60115.7 34917.1 35966.6 47044.8 55939.7 56448.7 6026.3 6034.2 6303.3 6337.9 6389.1 38164.6 38363.4 39194.8 39308.2 40367.6 48800.1 48877.5 52059.5 52108.5 54928.2 8031.2 8312.3 8591.8 8618.5 8692.2 9561.1 9594.7 9893.1 10180.7 10381.0 8688.7 8764.6 9170.2 9288.3 9481.8 9085.4 9152.7 9830.3 9878.1 10105.4 8532.6 8798.1 8820.5 9013.7 9033.8 7644.2 7795.3 8278.4 8311.5 8476.9 7530.8 7577.5 7950.7 7955.9 8538.3 11:00:18 INFO - PROCESS | 13460 | -------- Summary: end -------- 11:00:18 INFO - PROCESS | 13460 | 11:00:19 INFO - TEST-INFO | 13460: exit 0 11:00:19 INFO - TEST-OK | dromaeo_css | took 1122118ms 11:00:19 INFO - TEST-START | kraken 11:00:19 INFO - operating with platform_type : linux_ 11:00:19 INFO - Initialising browser for kraken test... 11:00:19 INFO - TEST-INFO | started process 13758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfwHDxd/profile http://localhost:46462/getInfo.html) 11:00:24 INFO - PROCESS | 13758 | __metrics Screen width/height:1600/1200 11:00:24 INFO - PROCESS | 13758 | colorDepth:24 11:00:24 INFO - PROCESS | 13758 | Browser inner width/height: 1024/697 11:00:24 INFO - PROCESS | 13758 | __metrics 11:00:24 INFO - PROCESS | 13758 | 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:00:24 INFO - PROCESS | 13758 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:00:25 INFO - PROCESS | 13758 | console.error: PushService: 11:00:25 INFO - PROCESS | 13758 | stateChangeProcessEnqueue: Error transitioning state 11:00:25 INFO - PROCESS | 13758 | UnknownError 11:00:25 INFO - TEST-INFO | 13758: exit 0 11:00:25 INFO - Browser initialized. 11:00:25 INFO - Running cycle 1/1 for kraken test... 11:00:25 INFO - TEST-INFO | started process 13838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfwHDxd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:38 INFO - PROCESS | 13838 | RSS: Main: 174878720 11:00:38 INFO - PROCESS | 13838 | 11:00:40 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46462/tests/kraken/driver.html?testName=audio-beat-detection) 11:00:41 INFO - PROCESS | 13838 | RSS: Main: 231239680 11:00:41 INFO - PROCESS | 13838 | 11:00:44 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46462/tests/kraken/driver.html?testName=audio-dft) 11:00:45 INFO - PROCESS | 13838 | RSS: Main: 218038272 11:00:45 INFO - PROCESS | 13838 | 11:00:48 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46462/tests/kraken/driver.html?testName=audio-fft) 11:00:49 INFO - PROCESS | 13838 | RSS: Main: 299520000 11:00:49 INFO - PROCESS | 13838 | 11:00:51 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46462/tests/kraken/driver.html?testName=audio-oscillator) 11:00:51 INFO - PROCESS | 13838 | RSS: Main: 211210240 11:00:51 INFO - PROCESS | 13838 | 11:00:54 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:00:54 INFO - PROCESS | 13838 | RSS: Main: 214151168 11:00:54 INFO - PROCESS | 13838 | 11:00:58 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46462/tests/kraken/driver.html?testName=imaging-darkroom) 11:00:58 INFO - PROCESS | 13838 | RSS: Main: 253440000 11:00:58 INFO - PROCESS | 13838 | 11:01:02 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46462/tests/kraken/driver.html?testName=imaging-desaturate) 11:01:02 INFO - PROCESS | 13838 | RSS: Main: 253419520 11:01:02 INFO - PROCESS | 13838 | 11:01:05 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46462/tests/kraken/driver.html?testName=json-parse-financial) 11:01:06 INFO - PROCESS | 13838 | RSS: Main: 251965440 11:01:06 INFO - PROCESS | 13838 | 11:01:07 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:01:08 INFO - PROCESS | 13838 | RSS: Main: 214245376 11:01:08 INFO - PROCESS | 13838 | 11:01:10 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:01:10 INFO - PROCESS | 13838 | RSS: Main: 222261248 11:01:10 INFO - PROCESS | 13838 | 11:01:13 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:01:13 INFO - PROCESS | 13838 | RSS: Main: 230436864 11:01:13 INFO - PROCESS | 13838 | 11:01:16 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:01:17 INFO - PROCESS | 13838 | RSS: Main: 239153152 11:01:17 INFO - PROCESS | 13838 | 11:01:20 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:01:21 INFO - PROCESS | 13838 | RSS: Main: 235638784 11:01:21 INFO - PROCESS | 13838 | 11:01:22 INFO - PROCESS | 13838 | Cycle 1(1): loaded http://localhost:46462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46462/tests/kraken/driver.html?testName=ai-astar) 11:01:23 INFO - PROCESS | 13838 | RSS: Main: 286687232 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | __start_tp_report 11:01:23 INFO - PROCESS | 13838 | _x_x_mozilla_page_load 11:01:23 INFO - PROCESS | 13838 | _x_x_mozilla_page_load_details 11:01:23 INFO - PROCESS | 13838 | |i|pagename|runs| 11:01:23 INFO - PROCESS | 13838 | |0;ai-astar;108;115;114;117;115;116;117;115;115;116 11:01:23 INFO - PROCESS | 13838 | |1;audio-beat-detection;152;130;132;170;129;129;130;131;171;129 11:01:23 INFO - PROCESS | 13838 | |2;audio-dft;161;162;162;161;161;161;164;162;162;161 11:01:23 INFO - PROCESS | 13838 | |3;audio-fft;78;76;77;108;75;77;77;76;100;76 11:01:23 INFO - PROCESS | 13838 | |4;audio-oscillator;84;83;113;84;85;83;109;84;82;119 11:01:23 INFO - PROCESS | 13838 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;116;117 11:01:23 INFO - PROCESS | 13838 | |6;imaging-darkroom;146;147;148;147;146;147;147;147;146;146 11:01:23 INFO - PROCESS | 13838 | |7;imaging-desaturate;96;95;95;96;95;95;97;95;95;95 11:01:23 INFO - PROCESS | 13838 | |8;json-parse-financial;63;63;65;62;65;64;63;64;64;64 11:01:23 INFO - PROCESS | 13838 | |9;json-stringify-tinderbox;67;73;65;65;65;67;67;66;66;66 11:01:23 INFO - PROCESS | 13838 | |10;stanford-crypto-aes;83;84;90;84;93;84;82;93;83;84 11:01:23 INFO - PROCESS | 13838 | |11;stanford-crypto-ccm;143;142;141;142;142;141;144;142;185;143 11:01:23 INFO - PROCESS | 13838 | |12;stanford-crypto-pbkdf2;186;181;181;177;176;176;176;178;181;182 11:01:23 INFO - PROCESS | 13838 | |13;stanford-crypto-sha256-iterative;72;73;69;73;74;70;71;71;69;70 11:01:23 INFO - PROCESS | 13838 | __end_tp_report 11:01:23 INFO - PROCESS | 13838 | __start_cc_report 11:01:23 INFO - PROCESS | 13838 | _x_x_mozilla_cycle_collect,1983 11:01:23 INFO - PROCESS | 13838 | __end_cc_report 11:01:23 INFO - PROCESS | 13838 | __startTimestamp1479409283086__endTimestamp 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | ------- Summary: start ------- 11:01:23 INFO - PROCESS | 13838 | Number of tests: 14 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.50 stddev:2.57 (2.2%) stddev-sans-first:1.01 11:01:23 INFO - PROCESS | 13838 | Values: 108.0 115.0 114.0 117.0 115.0 116.0 117.0 115.0 115.0 116.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:131.50 stddev:17.36 (13.2%) stddev-sans-first:17.89 11:01:23 INFO - PROCESS | 13838 | Values: 152.0 130.0 132.0 170.0 129.0 129.0 130.0 131.0 171.0 129.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 11:01:23 INFO - PROCESS | 13838 | Values: 161.0 162.0 162.0 161.0 161.0 161.0 164.0 162.0 162.0 161.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.50 stddev:11.78 (15.4%) stddev-sans-first:12.40 11:01:23 INFO - PROCESS | 13838 | Values: 78.0 76.0 77.0 108.0 75.0 77.0 77.0 76.0 100.0 76.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:83.50 stddev:14.75 (17.7%) stddev-sans-first:15.31 11:01:23 INFO - PROCESS | 13838 | Values: 84.0 83.0 113.0 84.0 85.0 83.0 109.0 84.0 82.0 119.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:01:23 INFO - PROCESS | 13838 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 116.0 117.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 11:01:23 INFO - PROCESS | 13838 | Values: 146.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 11:01:23 INFO - PROCESS | 13838 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 97.0 95.0 95.0 95.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 11:01:23 INFO - PROCESS | 13838 | Values: 63.0 63.0 65.0 62.0 65.0 64.0 63.0 64.0 64.0 64.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:2.36 (3.5%) stddev-sans-first:2.50 11:01:23 INFO - PROCESS | 13838 | Values: 67.0 73.0 65.0 65.0 65.0 67.0 67.0 66.0 66.0 66.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:84.00 stddev:4.27 (5.1%) stddev-sans-first:4.39 11:01:23 INFO - PROCESS | 13838 | Values: 83.0 84.0 90.0 84.0 93.0 84.0 82.0 93.0 83.0 84.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:142.50 stddev:13.56 (9.5%) stddev-sans-first:14.32 11:01:23 INFO - PROCESS | 13838 | Values: 143.0 142.0 141.0 142.0 142.0 141.0 144.0 142.0 185.0 143.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:181.00 stddev:3.34 (1.8%) stddev-sans-first:2.55 11:01:23 INFO - PROCESS | 13838 | Values: 186.0 181.0 181.0 177.0 176.0 176.0 176.0 178.0 181.0 182.0 11:01:23 INFO - PROCESS | 13838 | 11:01:23 INFO - PROCESS | 13838 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.50 stddev:1.75 (2.4%) stddev-sans-first:1.83 11:01:23 INFO - PROCESS | 13838 | Values: 72.0 73.0 69.0 73.0 74.0 70.0 71.0 71.0 69.0 70.0 11:01:23 INFO - PROCESS | 13838 | -------- Summary: end -------- 11:01:23 INFO - PROCESS | 13838 | 11:01:24 INFO - TEST-INFO | 13838: exit 0 11:01:24 INFO - TEST-OK | kraken | took 64758ms 11:01:24 INFO - SUITE-END | took 1186s 11:01:24 INFO - Completed test suite (00:19:47) 11:01:24 INFO - javascript benchmark 11:01:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2463.7043554773422, 2515.8616276104813, 2522.7351128131545, 2527.1028784781415, 2541.0471073347494, 4316.54676258993, 4329.242382583043, 4364.345348197768, 4418.1384629997165, 4434.201843668143, 4397.890052748675, 4399.736015839044, 4445.555444455553, 4468.597826195642, 4540.636749060075, 4084.1831633673237, 4127.071408932996, 4138.08962028354, 4160.292750232453, 4160.791960401968, 4126.5667104954, 4157.230912281222, 4161.25097482453, 4174.415581818533, 4177.97911010446, 4169.14532520834, 4185.142045880602, 4199.538050814408, 4218.135282267128, 4228.02755366266, 3959.4456776051375, 3993.920121597581, 3995.62041606047, 4125.278076336629, 4135.048938744106, 4022.6982976276895, 4048.271311163989, 4084.775337356444, 4087.6116768906904, 4149.771762553059, 4426.933595996063, 4455.131249406367, 4459.420275364214, 4499.055198408339, 4512.368268442421, 4544.045750392422, 4706.22347312693, 4756.762161891927, 4765.880852978668, 4768.403949506312, 4577.771111444415, 4643.651726120521, 4656.604188643969, 4658.1848176568965, 4674.813007479696, 4364.345348197796, 4364.759938203398, 4368.912621747547, 4369.497507786582, 4379.496357918816, 4746.833860814924, 4748.0, 4756.167670657621, 4758.881027974328, 4764.118638051971, 4636.466806317249, 4656.278276867091, 4676.649251306166, 4725.40932383452, 4727.2436410174205, 4690.0, 4740.028294199681, 4751.976240118777, 4761.666683332133, 4797.160496913027, 4530.433695788027, 4571.245744452194, 4655.0, 4673.836415725501, 4674.158651442773, 4591.150637132075, 4591.931121033187, 4592.471865735483, 4598.26427771555, 4620.376249206314, 3952.24907267624, 3966.3257246268204, 3995.84016639337, 4043.8180281887385, 4059.4519739834745, 3563.340781955295, 3595.8741444049856, 3600.369935261319, 3629.201575653352, 3644.1800594865945, 4098.856540021085, 4108.055147316134, 4111.342185250345, 4111.465509483748, 4156.937645935313, 4647.419072615923, 4700.647451441156, 4804.6876952997945, 4806.831760888422, 4840.685355451955, 4099.938500922489, 4103.9179216416105, 4129.958700413017, 4139.97930010348, 4194.8112334945, 4345.847895323648, 4347.217500849877, 4358.106588149421, 4367.432233809584, 4380.824767009348, 4514.322851572159, 4521.751303678329, 4535.115652447741, 4557.612602928788, 4571.9085618287445, 4587.4036375271, 4640.280756482751, 4642.442906851199, 4728.338032675497, 4820.517948205152, 4530.071335376174, 4531.093781243831, 4548.11311794197, 4566.931496027496, 4568.908621827612, 4756.904861902812, 4758.738269395078, 4764.8332308369045, 4765.571098601143, 4796.904061918812, 4605.700629459075, 4775.856724298276, 4819.204831202812, 4846.345743324606, 4896.608271338356, 4511.729296242236, 4560.498345181961, 4585.335126406719, 4626.421697287839, 4671.976640116778, 4604.424446944132, 4606.147862645421, 4631.050634619827, 4638.814447422065, 4672.626189904868, 4530.637548996006, 4539.682222244412, 4549.272116461482, 4564.543545645409, 4574.0, 4507.887302817456, 4559.521250268674, 4589.563991420943, 4590.6327493799745, 4608.423947006624, 4399.47206335229, 4526.230540808005, 4540.364348991078, 4555.908881822411, 4602.171609110393], "value": 4359.227618025302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.5663360895306, 572.6077636818779, 584.9327327357355, 587.9118132280161, 595.7021489255372, 21407.0, 27278.727212727867, 28191.43617127659, 28261.717382826166, 30523.236919077033, 27638.723612763868, 27989.720102798965, 28007.439851203013, 28021.439571208564, 28024.299392515197, 5291.4708529147065, 5419.566434685215, 5420.4850539198715, 5426.728663566825, 5428.9185662215095, 5604.747786349624, 5674.177244299574, 5676.631018983773, 5680.573956953224, 5681.715914204294, 5667.0932650775885, 5687.431256874321, 5704.77180912763, 5705.885882282372, 5709.743061562219, 5641.717914104278, 5690.687012214326, 5696.0, 5697.829065128011, 5702.116171993306, 5547.0, 5624.718764061821, 5639.746211420496, 5642.548596112301, 5642.971785141089, 25256.621150682753, 25356.619650705255, 25428.364290892692, 25474.617880731803, 25507.872460637576, 2921.8539073046263, 2931.604233428481, 2985.5223164293825, 3163.0, 3532.364174448598, 17438.476845694524, 17879.3742219023, 18135.09324533768, 18587.349442769573, 18595.907020464812, 2694.5958106284215, 2716.904908328199, 2735.1110888961166, 2749.848758318292, 2787.4982503149427, 227201.0, 227857.0, 228477.0, 228544.85727571422, 228677.0, 29657.555136672967, 49112.75443622759, 49155.279565215045, 49248.75375623099, 49476.0, 31959.041228763173, 32091.518627220612, 32180.19549511281, 32205.677943220737, 32276.0, 12550.372481375894, 12705.555305564261, 12721.173123746927, 12721.491140354467, 12726.490940362468, 10313.587456501806, 10366.948165259126, 10395.660976280427, 10410.583576657, 10410.791784164274, 7653.770386888402, 7679.961600191963, 7737.032870891138, 7740.922590774133, 7754.573498457639, 3054.465468542996, 3102.565640810288, 3102.5966624338694, 3102.9379412412077, 3117.1895307219834, 851.4167795060404, 889.5374405309203, 891.9375643705008, 892.2193081054078, 1011.4437059617181, 26028.479430411666, 26076.34809129749, 26689.599656005175, 26693.332666683487, 26780.330491737473, 764.7399884039453, 907.4691305586306, 938.7887725261899, 981.6417007792104, 984.9704508864745, 11493.110236220473, 13948.930255348658, 14368.568942931728, 14474.276286185648, 14686.339114739862, 349382.0, 353065.0, 353269.0, 353702.0, 354297.0, 30803.22991925175, 30828.53757193644, 30844.383112337626, 30895.691043089282, 30899.227519311746, 1037.258360272409, 1056.2025670618634, 1133.9773204535863, 1139.800534906388, 1167.8248262760314, 24942.0, 25956.480870382864, 26812.949176416874, 27199.320016999733, 27452.0, 38569.807150965185, 39101.217975640895, 39115.0, 39304.0, 39334.60665393309, 274625.0, 275415.6229218841, 275709.0, 276434.0, 276456.0, 22198.556028879007, 22624.321270361914, 23112.146449245174, 24184.153554625504, 24267.635985460587, 35227.82386088053, 35702.642973569935, 35788.0, 35963.0, 36153.27693446169, 30172.0, 30969.53545696771, 31180.844095779375, 31473.21316967094, 31544.842275788473, 30284.0, 30521.847390762905, 31071.53392699066, 31092.844535777178, 31673.524897127023, 30983.225419364695, 31184.376312474076, 31210.375792484476, 31397.21506962253, 31958.36083278275, 27354.316142096606, 28506.57240141358, 28799.42401152007, 29207.269818254714, 29228.41543169082, 22052.77947220507, 24390.878045609657, 24895.75104249007, 24965.50068998646, 25246.495070098128], "value": 14001.440018193289, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.77417291673964, 361.45961787128266, 363.42215876755955, 366.9596344402115, 372.71859745891845, 9687.951560242198, 10398.636047738331, 11413.942930285337, 11414.835988566165, 12826.61520154397, 12663.493460261601, 12811.935940320309, 12825.935870320658, 12843.871561284384, 14045.92977035116, 3919.902002449933, 4170.207660544487, 4175.645070169039, 4175.956010997251, 4175.979120104395, 2885.2786803299177, 3096.7987080839785, 3800.524934383202, 3867.7485963412287, 3867.9806600967095, 3854.8843534694006, 4038.6365227129554, 4071.226466971281, 4104.794760261975, 4106.281400754856, 4087.8773636790797, 4093.570175131628, 4098.7950602469755, 4099.282625540519, 4099.50805903292, 3544.379733546619, 3727.105494681284, 3757.6993840492696, 3766.3032339017095, 3771.30230907283, 13549.932250338685, 13583.252921089335, 13594.524191653343, 13597.59207223775, 16065.116418596972, 1792.0860361215873, 1999.490130016851, 2100.380387785607, 2389.187676190086, 2478.1821998740375, 10068.395896246175, 10480.528376223088, 10867.184961127869, 11112.61105861299, 11308.773824523545, 1434.9856501434956, 1436.080908218741, 1439.2372042817324, 1470.6985068061022, 1480.141517919615, 41808.1638367234, 46497.0, 66612.3338766611, 66902.0, 67735.0, 7929.5242285463055, 8392.664293428317, 8453.239208471266, 8525.914740852637, 9223.723288301362, 10730.873258307922, 10747.623833165802, 10779.838302425469, 10821.404822734668, 10822.18833587484, 6551.377619126175, 6556.606603603704, 6608.603483790988, 6706.22878368984, 6762.0, 6514.413702766774, 6545.247296560861, 6732.798016059526, 6734.797956061326, 6746.156730408699, 3355.9664403355655, 3424.9315013700084, 3430.6569343065994, 3581.7313701472494, 3700.3154416433044, 1686.3001854230356, 1734.6443978984278, 1766.8763186577073, 1775.698131317679, 1806.2594336322045, 816.7876352148484, 835.7367429259764, 837.4514692876176, 887.1926546842343, 901.7610333261691, 15956.202189890459, 16550.6689866202, 16694.749578756328, 16753.497395078168, 17535.298588056336, 790.8457850719169, 828.0312034919159, 865.9956700216459, 873.4060838629666, 878.6221924572495, 8961.800696698252, 9399.859002114974, 9524.8571271431, 9638.9036109638, 9661.758456038655, 362197.0, 372529.0, 375344.0, 375828.0, 376903.0, 51953.74023129936, 64136.67931660312, 67086.0, 76094.23905760983, 77330.6133469329, 847.9745607631781, 888.8044630181349, 890.6481939633809, 891.6923661336958, 892.1212605583495, 14349.56951291463, 15207.55528224817, 15219.239038047832, 15360.23198840076, 16072.598185045468, 31875.0, 33500.83249583736, 34364.969050928514, 35021.64978350286, 39444.60555394409, 46381.76809115933, 47623.0, 49656.50343496519, 51042.0, 51071.0, 7042.718291268497, 7159.463040271896, 7258.745943891939, 7512.661930213263, 7736.419768517271, 10354.653894993602, 10947.890521095005, 11753.471093800628, 11822.881771182178, 11860.881391185978, 9181.49501777382, 9534.23726101924, 9934.403935763878, 10457.320274182153, 10483.266171368236, 9866.013398660076, 9883.30816842814, 10544.420056896945, 10704.357738535713, 10888.40113793749, 9221.723348299562, 9660.613575456902, 10382.42896640692, 10686.679399618024, 11268.830967535658, 7350.669219885011, 7356.595387253538, 7390.3718183952815, 7454.515456495311, 7618.580978046039, 8391.622376992927, 10429.9478502607, 10439.112675422673, 10686.57253709874, 11057.0], "value": 7332.167011340747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.233513394664, 1344.1666166976474, 1359.333926376076, 1590.5784966983751, 1598.968020639588, 5555.333359996806, 5742.2247996520455, 5816.272965879265, 6159.384061593838, 6165.784197553081, 6003.579749417542, 6206.1931948846695, 6223.844403889905, 6335.144755458012, 6346.746130154788, 1712.3578658003248, 1750.754894314797, 1752.0889137648414, 1753.0095496044694, 1753.684336819372, 1498.325753410964, 1555.587769241152, 1742.991285043573, 1752.7458518514807, 1758.8241175882438, 1673.21358961288, 1730.3078768492578, 1733.2200509770653, 1745.8079611242754, 1750.4661078371091, 1727.6631056943902, 1728.1445684386183, 1731.601731601726, 1732.7487514310417, 1736.0885535094114, 1710.8460238578589, 1773.6364045370667, 1774.698301288771, 1777.0315178227897, 1778.262021261175, 6206.379362063803, 6260.906086408708, 6269.686515674243, 6270.65511396873, 6274.780382686584, 3895.824687889052, 4006.6794656427414, 4006.759594424344, 4008.078142027321, 4010.859619913318, 2398.5083057973075, 2572.5755250383663, 2577.948441031169, 2593.4035171910377, 2605.6873175218907, 677.9457643388517, 702.5608994378514, 717.3722992381666, 721.3471808013755, 729.194240364395, 8081.0, 8292.543910084943, 8303.169683031649, 8323.66705331786, 8365.707200248024, 3538.5930617978747, 3588.372034893883, 3611.4041183204477, 3618.620044895248, 3631.782093074424, 7190.892136617955, 7197.172325182566, 7198.100237470317, 7211.0, 7213.422926165894, 4095.774732389747, 4097.91804163921, 4099.61053699898, 4102.261592913304, 4110.876673699794, 3750.2312026034597, 3822.980885095557, 3836.175222327213, 3863.690904727615, 3874.0508575398644, 2746.8489233092373, 2840.616516770251, 2842.5025620516326, 2908.1130255272346, 2966.3325751705693, 826.7561069484517, 840.6721378662327, 1025.958961641526, 1077.5851297250458, 1078.0567003871613, 625.4496043481707, 767.8502691975123, 770.849684311565, 784.7841843493085, 802.6949759091508, 4347.478302603708, 4411.18393097278, 4553.772311384484, 4570.223062079454, 4588.6099681526775, 716.4089626058523, 776.8174478997431, 863.9308855291562, 895.0914821456228, 898.3890954151109, 2971.5542668599883, 3082.676318986519, 3162.984185079106, 3187.9043628691174, 3232.3858466891215, 7659.310662040443, 7738.690452381842, 7870.488418252795, 7955.920440795634, 7967.203279671987, 7847.84304313922, 7903.960480197562, 7906.130325664172, 7917.564533950688, 7948.324392426593, 5618.241537392481, 5655.6606603603095, 5734.598578099576, 5767.740451679684, 5774.711264436762, 4249.086446414036, 4279.465066866642, 4283.464566929134, 4396.472423309224, 4520.163769702615, 6737.528373013842, 6883.139607549057, 6958.930410695828, 6968.9198174283065, 6992.195897471653, 6800.761973331108, 6919.065926099912, 6963.512554121163, 7012.2286548478605, 7106.076210092655, 5804.709764511842, 5834.766609335748, 5874.324452687995, 5876.529877609866, 5970.701464926649, 6185.907211391923, 6247.750089996349, 6253.906191407224, 6255.937440625536, 6261.154744109669, 5433.0, 5499.422560631237, 5514.779408823762, 5642.887142257214, 5653.123765816305, 5638.464345887134, 5722.3991480895575, 5725.08398656213, 5765.394633563583, 5858.970705146447, 5008.799648014038, 5018.774155162953, 5059.190529515407, 5067.290579318825, 5117.667351622133, 3950.9209815802947, 3952.802359882052, 4038.7980600970423, 4045.4336392905607, 4067.0442446024567, 3925.5289365275207, 4072.3077076896407, 4077.938830917479, 4136.9793151034055, 4187.937180942349], "value": 3442.783823637603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.2321499800558, 277.74031280752496, 283.4472778082738, 284.67973529779, 284.8903520786535, 4689.718616882985, 4706.647001474895, 4717.764111794414, 4737.313089602006, 4753.144434001878, 4613.6539759518, 4636.698614590057, 4639.350490931272, 4645.117427688737, 4661.766911654412, 3425.982870085646, 3493.5807703075666, 3522.076676358629, 3550.1834578047064, 3608.350496910555, 3603.4955106285142, 3606.549181352331, 3608.1340478285156, 3618.9276214475694, 3629.909252268701, 3576.481410195533, 3592.550931133608, 3592.9101772455765, 3593.6226696196914, 3594.748367614268, 3386.7121294689982, 3454.792712437262, 3502.896587574906, 3587.94618080729, 3596.28074385124, 3158.936821263585, 3162.8892988745283, 3182.5226216067545, 3189.202699325169, 3196.904092877194, 4459.439196281308, 4474.82100715971, 4479.5296493868, 4493.775311234458, 4528.343390208434, 3981.3629819228786, 4119.237940980928, 4126.587341265879, 4134.400511925754, 4134.73124246923, 4773.856784296477, 4800.279958006292, 4800.351952486404, 4803.3995750531185, 4814.711117332936, 3506.877259295938, 3509.771864828778, 3515.806630635314, 3516.226430185355, 3516.2791627716256, 4900.681455705368, 5022.53445122864, 5039.2944987701385, 5054.696718196847, 5085.211792172219, 3454.360943225511, 3460.8096554689732, 3461.5153878457036, 3465.4108801503803, 3472.600650925176, 3522.788632682047, 3523.5419395478425, 3538.752287339913, 3556.324298383299, 3557.1462848916076, 4073.348264277701, 4079.326911059701, 4084.9591504085174, 4086.4483294755423, 4088.0, 4777.689450185727, 4848.5636292733825, 4860.2223644217465, 4877.366082362378, 4900.950990490121, 1168.4449886304108, 1181.0728578066178, 1184.7334349771234, 1187.7208855918852, 1190.3810018790355, 778.5095389904324, 803.967841286342, 809.8015986083329, 810.1372038778682, 815.404754529197, 4064.166845796605, 4183.5775836215835, 4212.620864122244, 4307.65538756905, 4310.7629080400875, 5000.449950505442, 5008.5993120550265, 5009.549140577293, 5012.498750124958, 5015.3480047593575, 4293.549177336397, 4296.560652181492, 4308.375285583636, 4308.590683885026, 4310.331898555729, 2410.445597512582, 2546.477972015732, 2554.5912653975274, 2568.8201825872384, 2580.587106063021, 4503.347014682852, 4509.2559727644575, 4516.345129956138, 4526.343680166357, 4554.111948170142, 4939.3084968104495, 4948.356713627206, 4959.2561115832195, 4969.701817890938, 4976.576990955737, 4397.912041759211, 4551.906123183307, 4672.906541869212, 4693.178693728584, 4721.339012538316, 5028.2960385546785, 5045.394552653705, 5047.924281135859, 5060.544550990428, 5076.746162691925, 4963.230699241623, 4967.05625931072, 4970.552650261349, 4981.701097934136, 4987.850364489072, 4602.585767280961, 4662.906741865211, 4681.227597446383, 4710.9764451177525, 4713.865279589035, 3510.684038436553, 3515.5605549306338, 3527.2945410918433, 3528.1885166411357, 3528.870761356444, 5006.6495345325475, 5025.924611130763, 5030.3963524377305, 5043.470435604356, 5048.0, 4596.333531637961, 4795.712257264575, 4830.7101573905675, 4868.440129385166, 4872.951270487391, 4823.686460380064, 4827.589654879234, 4830.927536086891, 4845.691663250973, 4872.220444728827, 4789.760511974457, 4806.206975849085, 4809.110314591671, 4810.536413782072, 4833.661643685049, 4619.607333376701, 4864.318995340726, 4878.853469434751, 4880.853574392774, 4882.829100981448, 4765.26138448541, 4768.976155119202, 4772.832950846704, 4776.853555146809, 4788.449328327148], "value": 3630.10078948704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1520440973817, 637.4868231073983, 657.5791493444196, 668.5654324688952, 678.7929681447159, 10535.63125290615, 11015.394153321575, 11069.778604427907, 11419.486123124458, 11563.479643416045, 11015.118790496761, 11185.272957257794, 11231.775364492705, 11233.831492527619, 11233.887661123386, 587.5886879184567, 738.3650060947581, 750.9324160825524, 751.2037240525034, 752.0298814529251, 596.3827438601048, 731.2139450091147, 749.7263498822917, 758.4956004257162, 760.2853317881202, 782.4327362662053, 785.0422484568817, 785.1363500149847, 785.1441928298154, 785.4619585583865, 605.824310949824, 781.6756046240803, 781.9765407037798, 782.4483738964017, 782.538302401583, 459.1643209358968, 561.6489693941287, 581.7934633205235, 583.3787016827066, 586.9471747542742, 10151.949240253825, 10169.084782369548, 10177.592896284139, 10187.286889917708, 10218.029287217703, 8592.656293748305, 8892.955535222347, 8950.910490895072, 9130.223930965876, 9225.077492250788, 7868.173841746649, 7944.245296696805, 8046.476978996347, 8321.16788321169, 8342.0, 2313.560423519526, 2342.3090188394463, 2450.901963921441, 2465.0, 2500.324912273676, 46547.30179047317, 47070.529294706954, 48520.27219591709, 49508.75245623749, 49890.25164622533, 6641.933580664131, 6694.263631000586, 6703.93296067033, 6899.793006209822, 6931.341522555349, 13342.93328533351, 13592.38834252461, 13720.0, 13828.516001940085, 14110.71778564423, 6047.516198704093, 6067.453929146398, 6092.086187071886, 6126.417990290915, 6278.246610406781, 3538.752287339913, 3547.9822600887346, 3553.271579326232, 3557.8221088945447, 3606.8737594184076, 2538.4923015396625, 2588.365850366672, 2610.2299821552688, 2610.5692560727266, 2610.7258737832635, 440.0670578373804, 441.30053864624927, 449.7869690289495, 456.0696179793251, 460.1556144474926, 448.87431519174686, 451.69510580358127, 467.03790192204167, 497.3807609526163, 501.3830396969743, 6211.130441738161, 6312.495000399957, 6561.967190164114, 6607.702653380513, 6655.101561289261, 453.4218870939578, 480.2028632470083, 496.60023680937195, 506.501096420026, 512.1523877981946, 3115.408072466224, 3122.87508499662, 3126.2497000719663, 3171.5084161954933, 3192.8403579820915, 67136.0, 70781.29218707747, 71222.64388678024, 72301.2769872305, 72559.0, 37445.812770936514, 37465.43801842975, 37471.62528374681, 55833.720831395585, 60115.69942150349, 34917.1270718229, 35966.64033359685, 47044.7647761759, 55939.720301399044, 56448.71775641095, 6026.276846778239, 6034.155218269358, 6303.338149494237, 6337.904931426125, 6389.105525226379, 38164.61835381722, 38363.424548631236, 39194.804025980826, 39308.2138357237, 40367.59632403756, 48800.119988000915, 48877.5112248873, 52059.479405205464, 52108.478915211876, 54928.176077358075, 8031.196880311922, 8312.33501319905, 8591.785205369915, 8618.482891026559, 8692.174243446863, 9561.139497445263, 9594.715406774776, 9893.109620133935, 10180.745481363025, 10381.0, 8688.652453902027, 8764.605592748214, 9170.174684278447, 9288.303377246599, 9481.76295592588, 9085.409448385833, 9152.679656212, 9830.311878168746, 9878.110970012733, 10105.39367637944, 8532.616032278438, 8798.12018798115, 8820.514871682119, 9013.684521041732, 9033.77415564616, 7644.235576442311, 7795.337396321376, 8278.379121566028, 8311.542865142475, 8476.854280646729, 7530.849383012419, 7577.507462014952, 7950.681972721027, 7955.949770779396, 8538.274246689101], "value": 5276.251337003023, "unit": "score"}], "name": "dromaeo_css", "value": 5559.080384993324, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 114.0, 117.0, 115.0, 116.0, 117.0, 115.0, 115.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 132.0, 170.0, 129.0, 129.0, 130.0, 131.0, 171.0, 129.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 164.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 108.0, 75.0, 77.0, 77.0, 76.0, 100.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 113.0, 84.0, 85.0, 83.0, 109.0, 84.0, 82.0, 119.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 62.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 65.0, 65.0, 65.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 90.0, 84.0, 93.0, 84.0, 82.0, 93.0, 83.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 141.0, 142.0, 142.0, 141.0, 144.0, 142.0, 185.0, 143.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 181.0, 177.0, 176.0, 176.0, 176.0, 178.0, 181.0, 182.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 69.0, 73.0, 74.0, 70.0, 71.0, 71.0, 69.0, 70.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1564.2, "alertThreshold": 2.0}]} 11:01:24 INFO - Return code: 0 11:01:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:01:24 INFO - # TBPL SUCCESS # 11:01:24 INFO - Running post-action listener: _resource_record_post_action 11:01:24 INFO - [mozharness: 2016-11-17 19:01:24.869902Z] Finished run-tests step (success) 11:01:24 INFO - Running post-run listener: _resource_record_post_run 11:01:24 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 392912896; Read time: 0; Write time: 255012 11:01:24 INFO - TinderboxPrint: CPU usage
13.0% 11:01:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:01:24 INFO - TinderboxPrint: I/O write bytes / time
392,912,896 / 255,012 11:01:24 INFO - TinderboxPrint: CPU idle
8,347.6 (87.0%) 11:01:24 INFO - TinderboxPrint: CPU user
1,202.1 (12.5%) 11:01:24 INFO - TinderboxPrint: Swap in / out
0 / 0 11:01:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99721216; Read time: 0; Write time: 80564 11:01:24 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293191680; Read time: 0; Write time: 174448 11:01:25 INFO - Running post-run listener: _upload_blobber_files 11:01:25 INFO - Blob upload gear active. 11:01:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:01:25 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 11:01:25 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:01:25 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:01:25 INFO - (blobuploader) - INFO - Open directory for files ... 11:01:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:01:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:01:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:01:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:01:26 INFO - (blobuploader) - INFO - Done attempting. 11:01:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:01:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:01:30 INFO - (blobuploader) - INFO - Done attempting. 11:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:01:31 INFO - (blobuploader) - INFO - Done attempting. 11:01:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:01:31 INFO - Return code: 0 11:01:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:01:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:01:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/baedf90d48e47278176f3f84c43ba47f47fdf88b3dbfcd9ff85f44d1a64cfec1c03e86bff6e934a1e7ba78837f9fd8ecc3216fddf6dedb11fec667626b8a12ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee7cb35cdfba048471b4bfc4ff957e9b510b5864aead4b7d1e8104a07b919b5d234b7c51fd6cfe770ed4cab5c1c710e3b75055a17e230b85e302ea859dbe3579", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b50deedec1b96363ea4a4d5ccd6b8fa7626816d4e7eb9485ec345539e6cc7f234dd7abd2219d3e6d1c1c930112f577f1e7bc3064fee954eda7a010601e52739"} 11:01:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:01:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:01:31 INFO - Contents: 11:01:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/baedf90d48e47278176f3f84c43ba47f47fdf88b3dbfcd9ff85f44d1a64cfec1c03e86bff6e934a1e7ba78837f9fd8ecc3216fddf6dedb11fec667626b8a12ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee7cb35cdfba048471b4bfc4ff957e9b510b5864aead4b7d1e8104a07b919b5d234b7c51fd6cfe770ed4cab5c1c710e3b75055a17e230b85e302ea859dbe3579", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b50deedec1b96363ea4a4d5ccd6b8fa7626816d4e7eb9485ec345539e6cc7f234dd7abd2219d3e6d1c1c930112f577f1e7bc3064fee954eda7a010601e52739"} 11:01:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:01:31 INFO - Copying logs to upload dir... 11:01:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:01:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.776181 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-17 11:01:30.974904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 11:01:30.978219) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/baedf90d48e47278176f3f84c43ba47f47fdf88b3dbfcd9ff85f44d1a64cfec1c03e86bff6e934a1e7ba78837f9fd8ecc3216fddf6dedb11fec667626b8a12ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee7cb35cdfba048471b4bfc4ff957e9b510b5864aead4b7d1e8104a07b919b5d234b7c51fd6cfe770ed4cab5c1c710e3b75055a17e230b85e302ea859dbe3579", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b50deedec1b96363ea4a4d5ccd6b8fa7626816d4e7eb9485ec345539e6cc7f234dd7abd2219d3e6d1c1c930112f577f1e7bc3064fee954eda7a010601e52739"} build_url:https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011953 build_url: 'https://queue.taskcluster.net/v1/task/Y-rFLMcoSTy_veoLLasR0w/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/baedf90d48e47278176f3f84c43ba47f47fdf88b3dbfcd9ff85f44d1a64cfec1c03e86bff6e934a1e7ba78837f9fd8ecc3216fddf6dedb11fec667626b8a12ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ee7cb35cdfba048471b4bfc4ff957e9b510b5864aead4b7d1e8104a07b919b5d234b7c51fd6cfe770ed4cab5c1c710e3b75055a17e230b85e302ea859dbe3579", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4b50deedec1b96363ea4a4d5ccd6b8fa7626816d4e7eb9485ec345539e6cc7f234dd7abd2219d3e6d1c1c930112f577f1e7bc3064fee954eda7a010601e52739"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 11:01:31.004534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 11:01:31.004911) ========= 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=a0d2d2de893abaa8702a9954000001a7-1479408043.112537-1426305516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 11:01:31.088749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 11:01:31.089062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 11:01:31.089357) ========= ========= Total master_lag: 0.18 =========