builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1487685043.59 results: success (0) buildid: 20170221034028 builduid: b038ed4443f64c70b0d6eefbb6c3e135 revision: 86178fe492254027e0cba462ccbdc7db8cb90817 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.585761) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.586199) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.586468) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.603120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.603380) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-21 05:50:45-- 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% 35.9M=0s 2017-02-21 05:50:45 (35.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120681 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.742251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.743024) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018821 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.798341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:43.799222) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 86178fe492254027e0cba462ccbdc7db8cb90817 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 86178fe492254027e0cba462ccbdc7db8cb90817 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-21 05:50:46,108 truncating revision to first 12 chars 2017-02-21 05:50:46,108 Setting DEBUG logging. 2017-02-21 05:50:46,108 attempt 1/10 2017-02-21 05:50:46,108 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/86178fe49225?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 05:50:46,391 unpacking tar archive at: mozilla-beta-86178fe49225/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:44.421190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:44.421544) ========= script_repo_revision: 86178fe492254027e0cba462ccbdc7db8cb90817 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:44.421987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:44.422285) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 05:50:44.433161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-21 05:50:44.433481) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:46 INFO - MultiFileLogger online at 20170221 05:50:46 in /builds/slave/test 05:50:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:50:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:46 INFO - {'append_to_log': False, 05:50:46 INFO - 'base_work_dir': '/builds/slave/test', 05:50:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:50:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:46 INFO - 'branch': 'Mozilla-Beta', 05:50:46 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:46 INFO - 'config_files': ('talos/linux_config.py',), 05:50:46 INFO - 'default_actions': ('clobber', 05:50:46 INFO - 'read-buildbot-config', 05:50:46 INFO - 'download-and-extract', 05:50:46 INFO - 'populate-webroot', 05:50:46 INFO - 'create-virtualenv', 05:50:46 INFO - 'install', 05:50:46 INFO - 'run-tests'), 05:50:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:46 INFO - 'download_minidump_stackwalk': True, 05:50:46 INFO - 'download_symbols': 'ondemand', 05:50:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:46 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:46 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:46 INFO - 'installer_path': 'installer.exe', 05:50:46 INFO - 'log_level': 'info', 05:50:46 INFO - 'log_name': 'talos', 05:50:46 INFO - 'log_to_console': True, 05:50:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:46 INFO - 'opt_config_files': (), 05:50:46 INFO - 'pip_index': False, 05:50:46 INFO - 'sps_profile': False, 05:50:46 INFO - 'sps_profile_interval': 0, 05:50:46 INFO - 'suite': 'dromaeojs', 05:50:46 INFO - 'system_bits': '32', 05:50:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:46 INFO - 'title': 'talos-linux64-ix-069', 05:50:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:46 INFO - 'use_talos_json': True, 05:50:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:46 INFO - 'work_dir': 'build'} 05:50:46 INFO - [mozharness: 2017-02-21 13:50:46.834762Z] Running clobber step. 05:50:46 INFO - Running pre-action listener: _resource_record_pre_action 05:50:46 INFO - Running main action method: clobber 05:50:46 INFO - rmtree: /builds/slave/test/build 05:50:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:48 INFO - Running post-action listener: _resource_record_post_action 05:50:48 INFO - [mozharness: 2017-02-21 13:50:48.497175Z] Finished clobber step (success) 05:50:48 INFO - [mozharness: 2017-02-21 13:50:48.497274Z] Running read-buildbot-config step. 05:50:48 INFO - Running pre-action listener: _resource_record_pre_action 05:50:48 INFO - Running main action method: read_buildbot_config 05:50:48 INFO - Using buildbot properties: 05:50:48 INFO - { 05:50:48 INFO - "project": "", 05:50:48 INFO - "product": "firefox", 05:50:48 INFO - "script_repo_revision": "production", 05:50:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:50:48 INFO - "repository": "", 05:50:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:50:48 INFO - "buildid": "20170221034028", 05:50:48 INFO - "pgo_build": "True", 05:50:48 INFO - "basedir": "/builds/slave/test", 05:50:48 INFO - "buildnumber": 24, 05:50:48 INFO - "slavename": "talos-linux64-ix-069", 05:50:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:50:48 INFO - "platform": "ubuntu64_hw", 05:50:48 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:50:48 INFO - "branch": "mozilla-beta", 05:50:48 INFO - "repo_path": "releases/mozilla-beta", 05:50:48 INFO - "revision": "86178fe492254027e0cba462ccbdc7db8cb90817", 05:50:48 INFO - "stage_platform": "linux64-pgo", 05:50:48 INFO - "builduid": "b038ed4443f64c70b0d6eefbb6c3e135", 05:50:48 INFO - "slavebuilddir": "test" 05:50:48 INFO - } 05:50:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 05:50:48 INFO - Running post-action listener: _resource_record_post_action 05:50:48 INFO - [mozharness: 2017-02-21 13:50:48.499715Z] Finished read-buildbot-config step (success) 05:50:48 INFO - [mozharness: 2017-02-21 13:50:48.499803Z] Running download-and-extract step. 05:50:48 INFO - Running pre-action listener: _resource_record_pre_action 05:50:48 INFO - Running main action method: download_and_extract 05:50:48 INFO - mkdir: /builds/slave/test/build/tests 05:50:48 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')]} 05:50:48 INFO - trying https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:50:48 INFO - Downloading https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:50:49 INFO - Downloaded 1327 bytes. 05:50:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:50:49 INFO - Using the following test package requirements: 05:50:49 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:50:49 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:49 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 05:50:49 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'jsshell-linux-x86_64.zip'], 05:50:49 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:49 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:50:49 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 05:50:49 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 05:50:49 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:49 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:50:49 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:49 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:50:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:49 INFO - Fetch https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:50:49 INFO - Http code: 200 05:50:49 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 05:50:49 INFO - x-amz-cf-id: XWfO4dF3aqGim-dGawYJDjS3xnIeap9xDpr7fSAY1dII3eBwK6q7TQ== 05:50:49 INFO - x-amz-version-id: _TOUf5UZEITvZxQr2arcPLdYNtF8iU8O 05:50:50 INFO - Expected file size: 21963963 05:50:50 INFO - Obtained file size: 21963963 05:50:54 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:50:54 INFO - Http code: 200 05:50:54 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 05:50:54 INFO - x-amz-cf-id: A788KMNMCYGfVLbJoAqe9F1bZspPK_PvXyM1NO_y69V-i-38eIa4ZA== 05:50:54 INFO - x-amz-version-id: _TOUf5UZEITvZxQr2arcPLdYNtF8iU8O 05:50:55 INFO - Expected file size: 21963963 05:50:55 INFO - Obtained file size: 21963963 05:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 05:50:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:50:59 INFO - Fetch https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 05:51:00 INFO - Http code: 200 05:51:00 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 05:51:00 INFO - x-amz-cf-id: 8mXVLkuAUHzRNqfSB5UCdMk8R3Sfvdif4MYj6MmB3w28QxyTSbPKXA== 05:51:00 INFO - x-amz-version-id: .YOe8yMGcTnCuSTZpQ0vP2VskqtBJDS5 05:51:00 INFO - Expected file size: 14403005 05:51:00 INFO - Obtained file size: 14403005 05:51:00 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')]} 05:51:00 INFO - trying https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:51:01 INFO - Downloaded 57765688 bytes. 05:51:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:51:01 INFO - mkdir: /builds/slave/test/properties 05:51:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:01 INFO - Contents: 05:51:01 INFO - build_url:https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:51:02 INFO - Running post-action listener: _resource_record_post_action 05:51:02 INFO - Running post-action listener: set_extra_try_arguments 05:51:02 INFO - [mozharness: 2017-02-21 13:51:02.582939Z] Finished download-and-extract step (success) 05:51:02 INFO - [mozharness: 2017-02-21 13:51:02.583166Z] Running populate-webroot step. 05:51:02 INFO - Running pre-action listener: _resource_record_pre_action 05:51:02 INFO - Running main action method: populate_webroot 05:51:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:02 INFO - '--tppagecycles', 05:51:02 INFO - '7'], 05:51:02 INFO - 'tests': ['tsvgm']}}, 05:51:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['damp', 'tps']}, 05:51:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'tests': ['damp', 'tps']}, 05:51:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['dromaeo_dom']}, 05:51:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['basic_compositor_video']}, 05:51:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:51:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['a11yr', 05:51:02 INFO - 'ts_paint', 05:51:02 INFO - 'tpaint', 05:51:02 INFO - 'sessionrestore', 05:51:02 INFO - 'sessionrestore_no_auto_restore', 05:51:02 INFO - 'tabpaint']}, 05:51:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:02 INFO - 'ts_paint', 05:51:02 INFO - 'tpaint', 05:51:02 INFO - 'sessionrestore', 05:51:02 INFO - 'sessionrestore_no_auto_restore', 05:51:02 INFO - 'tabpaint']}, 05:51:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:02 INFO - 'ts_paint', 05:51:02 INFO - 'tpaint', 05:51:02 INFO - 'sessionrestore', 05:51:02 INFO - 'sessionrestore_no_auto_restore', 05:51:02 INFO - 'tabpaint']}, 05:51:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:02 INFO - 'ts_paint', 05:51:02 INFO - 'tpaint', 05:51:02 INFO - 'sessionrestore', 05:51:02 INFO - 'sessionrestore_no_auto_restore', 05:51:02 INFO - 'tabpaint']}, 05:51:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['a11yr', 05:51:02 INFO - 'ts_paint', 05:51:02 INFO - 'tpaint', 05:51:02 INFO - 'sessionrestore', 05:51:02 INFO - 'sessionrestore_no_auto_restore', 05:51:02 INFO - 'tabpaint']}, 05:51:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['a11yr', 05:51:02 INFO - 'ts_paint', 05:51:02 INFO - 'tpaint', 05:51:02 INFO - 'sessionrestore', 05:51:02 INFO - 'sessionrestore_no_auto_restore', 05:51:02 INFO - 'tabpaint']}, 05:51:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['tsvgx', 05:51:02 INFO - 'tsvgr_opacity', 05:51:02 INFO - 'tart', 05:51:02 INFO - 'tscrollx', 05:51:02 INFO - 'cart']}, 05:51:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:02 INFO - 'tsvgr_opacity', 05:51:02 INFO - 'tart', 05:51:02 INFO - 'tscrollx', 05:51:02 INFO - 'cart']}, 05:51:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'talos_options': ['--disable-e10s'], 05:51:02 INFO - 'tests': ['tp5o']}, 05:51:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'tests': ['tp5o']}, 05:51:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'talos_options': ['--disable-e10s', 05:51:02 INFO - '--xperf_path', 05:51:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:02 INFO - 'tests': ['tp5n']}, 05:51:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:02 INFO - 'talos_options': ['--xperf_path', 05:51:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:02 INFO - 'tests': ['tp5n']}}, 05:51:02 INFO - 'talos.zip': {'path': '', 05:51:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:02 INFO - Running post-action listener: _resource_record_post_action 05:51:02 INFO - [mozharness: 2017-02-21 13:51:02.598488Z] Finished populate-webroot step (success) 05:51:02 INFO - [mozharness: 2017-02-21 13:51:02.598576Z] Running create-virtualenv step. 05:51:02 INFO - Running pre-action listener: _resource_record_pre_action 05:51:02 INFO - Running main action method: create_virtualenv 05:51:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:02 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 05:51:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:02 INFO - Using real prefix '/usr' 05:51:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:05 INFO - Installing pip.................done. 05:51:05 INFO - Return code: 0 05:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:51:05 INFO - Reading from file tmpfile_stdout 05:51:05 INFO - Output received: 05:51:05 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) 05:51:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:05 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')]} 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:05 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')]} 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:05 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:05 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 05:51:05 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 05:51:05 INFO - Using env: {'DISPLAY': ':0', 05:51:05 INFO - 'HOME': '/home/cltbld', 05:51:05 INFO - 'LANG': 'en_US.UTF-8', 05:51:05 INFO - 'LANGUAGE': 'en_US:en', 05:51:05 INFO - 'LOGNAME': 'cltbld', 05:51:05 INFO - 'MAIL': '/var/mail/cltbld', 05:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:05 INFO - 'MOZ_NO_REMOTE': '1', 05:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:05 INFO - 'NO_EM_RESTART': '1', 05:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:05 INFO - 'PWD': '/builds/slave/test', 05:51:05 INFO - 'SHELL': '/bin/bash', 05:51:05 INFO - 'SHLVL': '1', 05:51:05 INFO - 'TERM': 'linux', 05:51:05 INFO - 'TMOUT': '86400', 05:51:05 INFO - 'USER': 'cltbld', 05:51:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:05 INFO - '_': '/tools/buildbot/bin/python'} 05:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:05 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 05:51:05 INFO - Cleaning up... 05:51:05 INFO - Return code: 0 05:51:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51:05 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')]} 05:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:05 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')]} 05:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:05 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:05 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 05:51:05 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 05:51:05 INFO - Using env: {'DISPLAY': ':0', 05:51:05 INFO - 'HOME': '/home/cltbld', 05:51:05 INFO - 'LANG': 'en_US.UTF-8', 05:51:05 INFO - 'LANGUAGE': 'en_US:en', 05:51:05 INFO - 'LOGNAME': 'cltbld', 05:51:05 INFO - 'MAIL': '/var/mail/cltbld', 05:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:05 INFO - 'MOZ_NO_REMOTE': '1', 05:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:05 INFO - 'NO_EM_RESTART': '1', 05:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:05 INFO - 'PWD': '/builds/slave/test', 05:51:05 INFO - 'SHELL': '/bin/bash', 05:51:05 INFO - 'SHLVL': '1', 05:51:05 INFO - 'TERM': 'linux', 05:51:05 INFO - 'TMOUT': '86400', 05:51:05 INFO - 'USER': 'cltbld', 05:51:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:05 INFO - '_': '/tools/buildbot/bin/python'} 05:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:05 INFO - Downloading/unpacking psutil>=3.1.1 05:51:05 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 05:51:05 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 05:51:05 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 05:51:05 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 05:51:05 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 05:51:05 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 05:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:08 INFO - Installing collected packages: psutil 05:51:08 INFO - Running setup.py install for psutil 05:51:09 INFO - building 'psutil._psutil_linux' extension 05:51:09 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 05:51:09 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 05:51:09 INFO - building 'psutil._psutil_posix' extension 05:51:09 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 05:51:09 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 05:51:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:09 INFO - Successfully installed psutil 05:51:09 INFO - Cleaning up... 05:51:09 INFO - Return code: 0 05:51:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:51: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 mozsystemmonitor==0.3 05:51:09 INFO - Using env: {'DISPLAY': ':0', 05:51:09 INFO - 'HOME': '/home/cltbld', 05:51:09 INFO - 'LANG': 'en_US.UTF-8', 05:51:09 INFO - 'LANGUAGE': 'en_US:en', 05:51:09 INFO - 'LOGNAME': 'cltbld', 05:51:09 INFO - 'MAIL': '/var/mail/cltbld', 05:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:09 INFO - 'MOZ_NO_REMOTE': '1', 05:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:09 INFO - 'NO_EM_RESTART': '1', 05:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:09 INFO - 'PWD': '/builds/slave/test', 05:51:09 INFO - 'SHELL': '/bin/bash', 05:51:09 INFO - 'SHLVL': '1', 05:51:09 INFO - 'TERM': 'linux', 05:51:09 INFO - 'TMOUT': '86400', 05:51:09 INFO - 'USER': 'cltbld', 05:51:09 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:09 INFO - '_': '/tools/buildbot/bin/python'} 05:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:11 INFO - Installing collected packages: mozsystemmonitor 05:51:11 INFO - Running setup.py install for mozsystemmonitor 05:51:11 INFO - Successfully installed mozsystemmonitor 05:51:11 INFO - Cleaning up... 05:51:11 INFO - Return code: 0 05:51:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:11 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:11 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 05:51:11 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 05:51:11 INFO - Using env: {'DISPLAY': ':0', 05:51:11 INFO - 'HOME': '/home/cltbld', 05:51:11 INFO - 'LANG': 'en_US.UTF-8', 05:51:11 INFO - 'LANGUAGE': 'en_US:en', 05:51:11 INFO - 'LOGNAME': 'cltbld', 05:51:11 INFO - 'MAIL': '/var/mail/cltbld', 05:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:11 INFO - 'MOZ_NO_REMOTE': '1', 05:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:11 INFO - 'NO_EM_RESTART': '1', 05:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:11 INFO - 'PWD': '/builds/slave/test', 05:51:11 INFO - 'SHELL': '/bin/bash', 05:51:11 INFO - 'SHLVL': '1', 05:51:11 INFO - 'TERM': 'linux', 05:51:11 INFO - 'TMOUT': '86400', 05:51:11 INFO - 'USER': 'cltbld', 05:51:11 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:11 INFO - '_': '/tools/buildbot/bin/python'} 05:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51:14 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 05:51:14 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 05:51:14 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 05:51:14 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 05:51:14 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 05:51:14 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 05:51:14 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:14 INFO - warning: no files found matching '*.txt' 05:51:14 INFO - no previously-included directories found matching 'build' 05:51:14 INFO - no previously-included directories found matching 'dist' 05:51:14 INFO - no previously-included directories found matching '.git*' 05:51:14 INFO - Installing collected packages: jsonschema, functools32 05:51:14 INFO - Running setup.py install for functools32 05:51:14 INFO - warning: no files found matching '*.txt' 05:51:14 INFO - no previously-included directories found matching 'build' 05:51:14 INFO - no previously-included directories found matching 'dist' 05:51:14 INFO - no previously-included directories found matching '.git*' 05:51:14 INFO - Successfully installed jsonschema functools32 05:51:14 INFO - Cleaning up... 05:51:14 INFO - Return code: 0 05:51:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:14 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:14 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 05:51:14 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 05:51:14 INFO - Using env: {'DISPLAY': ':0', 05:51:14 INFO - 'HOME': '/home/cltbld', 05:51:14 INFO - 'LANG': 'en_US.UTF-8', 05:51:14 INFO - 'LANGUAGE': 'en_US:en', 05:51:14 INFO - 'LOGNAME': 'cltbld', 05:51:14 INFO - 'MAIL': '/var/mail/cltbld', 05:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:14 INFO - 'MOZ_NO_REMOTE': '1', 05:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:14 INFO - 'NO_EM_RESTART': '1', 05:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:14 INFO - 'PWD': '/builds/slave/test', 05:51:14 INFO - 'SHELL': '/bin/bash', 05:51:14 INFO - 'SHLVL': '1', 05:51:14 INFO - 'TERM': 'linux', 05:51:14 INFO - 'TMOUT': '86400', 05:51:14 INFO - 'USER': 'cltbld', 05:51:14 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:14 INFO - '_': '/tools/buildbot/bin/python'} 05:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:51:14 INFO - Cleaning up... 05:51:14 INFO - Return code: 0 05:51:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:14 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:14 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 05:51:14 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 05:51:14 INFO - Using env: {'DISPLAY': ':0', 05:51:14 INFO - 'HOME': '/home/cltbld', 05:51:14 INFO - 'LANG': 'en_US.UTF-8', 05:51:14 INFO - 'LANGUAGE': 'en_US:en', 05:51:14 INFO - 'LOGNAME': 'cltbld', 05:51:14 INFO - 'MAIL': '/var/mail/cltbld', 05:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:14 INFO - 'MOZ_NO_REMOTE': '1', 05:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:14 INFO - 'NO_EM_RESTART': '1', 05:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:14 INFO - 'PWD': '/builds/slave/test', 05:51:14 INFO - 'SHELL': '/bin/bash', 05:51:14 INFO - 'SHLVL': '1', 05:51:14 INFO - 'TERM': 'linux', 05:51:14 INFO - 'TMOUT': '86400', 05:51:14 INFO - 'USER': 'cltbld', 05:51:14 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:14 INFO - '_': '/tools/buildbot/bin/python'} 05:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:15 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:15 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 05:51:15 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 05:51:15 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 05:51:15 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 05:51:15 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 05:51:15 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 05:51:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 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 05:51:17 INFO - Downloading docopt-0.6.1.tar.gz 05:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:17 INFO - Running setup.py install for blobuploader 05:51:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:18 INFO - Running setup.py install for requests 05:51:18 INFO - Running setup.py install for docopt 05:51:18 INFO - Successfully installed blobuploader requests docopt 05:51:18 INFO - Cleaning up... 05:51:18 INFO - Return code: 0 05:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:18 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')]} 05:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:18 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')]} 05:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:18 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:18 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 05:51:18 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 05:51:18 INFO - Using env: {'DISPLAY': ':0', 05:51:18 INFO - 'HOME': '/home/cltbld', 05:51:18 INFO - 'LANG': 'en_US.UTF-8', 05:51:18 INFO - 'LANGUAGE': 'en_US:en', 05:51:18 INFO - 'LOGNAME': 'cltbld', 05:51:18 INFO - 'MAIL': '/var/mail/cltbld', 05:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:18 INFO - 'MOZ_NO_REMOTE': '1', 05:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:18 INFO - 'NO_EM_RESTART': '1', 05:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:18 INFO - 'PWD': '/builds/slave/test', 05:51:18 INFO - 'SHELL': '/bin/bash', 05:51:18 INFO - 'SHLVL': '1', 05:51:18 INFO - 'TERM': 'linux', 05:51:18 INFO - 'TMOUT': '86400', 05:51:18 INFO - 'USER': 'cltbld', 05:51:18 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:18 INFO - '_': '/tools/buildbot/bin/python'} 05:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:18 INFO - Running setup.py (path:/tmp/pip-jJWzWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:18 INFO - Running setup.py (path:/tmp/pip-hvC9ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:18 INFO - Running setup.py (path:/tmp/pip-3JRTQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:18 INFO - Running setup.py (path:/tmp/pip-wgn23c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:19 INFO - Running setup.py (path:/tmp/pip-wzWzo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:19 INFO - Running setup.py (path:/tmp/pip-0jvAaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:19 INFO - Running setup.py (path:/tmp/pip-XLTP91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:19 INFO - Running setup.py (path:/tmp/pip-Roc94h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:19 INFO - Running setup.py (path:/tmp/pip-H7x2nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:19 INFO - Running setup.py (path:/tmp/pip-p6QX3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:19 INFO - Running setup.py (path:/tmp/pip-eW9yjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:19 INFO - Running setup.py (path:/tmp/pip-7U3o9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:19 INFO - Running setup.py (path:/tmp/pip-i3zTb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:19 INFO - Running setup.py (path:/tmp/pip-pplc9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:19 INFO - Running setup.py (path:/tmp/pip-CQYwh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:19 INFO - Running setup.py (path:/tmp/pip-Rym_xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:19 INFO - Running setup.py (path:/tmp/pip-9aRNeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:19 INFO - Running setup.py install for manifestparser 05:51:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Running setup.py install for mozcrash 05:51:20 INFO - Running setup.py install for mozdebug 05:51:20 INFO - Running setup.py install for mozdevice 05:51:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Running setup.py install for mozfile 05:51:20 INFO - Running setup.py install for mozhttpd 05:51:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Running setup.py install for mozinfo 05:51:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Running setup.py install for mozInstall 05:51:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:20 INFO - Running setup.py install for mozleak 05:51:20 INFO - Running setup.py install for mozlog 05:51:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Running setup.py install for moznetwork 05:51:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Running setup.py install for mozprocess 05:51:21 INFO - Running setup.py install for mozprofile 05:51:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Running setup.py install for mozrunner 05:51:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Running setup.py install for mozscreenshot 05:51:21 INFO - Running setup.py install for moztest 05:51:21 INFO - Running setup.py install for mozversion 05:51:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:21 INFO - Cleaning up... 05:51:21 INFO - Return code: 0 05:51:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:21 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:21 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 05:51:21 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 05:51:21 INFO - Using env: {'DISPLAY': ':0', 05:51:21 INFO - 'HOME': '/home/cltbld', 05:51:21 INFO - 'LANG': 'en_US.UTF-8', 05:51:21 INFO - 'LANGUAGE': 'en_US:en', 05:51:21 INFO - 'LOGNAME': 'cltbld', 05:51:21 INFO - 'MAIL': '/var/mail/cltbld', 05:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:21 INFO - 'MOZ_NO_REMOTE': '1', 05:51:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:21 INFO - 'NO_EM_RESTART': '1', 05:51:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:21 INFO - 'PWD': '/builds/slave/test', 05:51:21 INFO - 'SHELL': '/bin/bash', 05:51:21 INFO - 'SHLVL': '1', 05:51:21 INFO - 'TERM': 'linux', 05:51:21 INFO - 'TMOUT': '86400', 05:51:21 INFO - 'USER': 'cltbld', 05:51:21 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:21 INFO - '_': '/tools/buildbot/bin/python'} 05:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:22 INFO - Running setup.py (path:/tmp/pip-zvNz7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:22 INFO - Running setup.py (path:/tmp/pip-T57KSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:22 INFO - Running setup.py (path:/tmp/pip-9uQ3VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:22 INFO - Running setup.py (path:/tmp/pip-Ff7SyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:22 INFO - Running setup.py (path:/tmp/pip-wtsbJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:22 INFO - Running setup.py (path:/tmp/pip-Cm8HeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:22 INFO - Running setup.py (path:/tmp/pip-u7nv18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:22 INFO - Running setup.py (path:/tmp/pip-E0vRs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:22 INFO - Running setup.py (path:/tmp/pip-KILPQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:22 INFO - Running setup.py (path:/tmp/pip-nt0kK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:22 INFO - Running setup.py (path:/tmp/pip-ksDrWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:22 INFO - Running setup.py (path:/tmp/pip-DxSTeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:22 INFO - Running setup.py (path:/tmp/pip-GGX6O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:22 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)) 05:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:22 INFO - Running setup.py (path:/tmp/pip-XUfZjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:23 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)) 05:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:23 INFO - Running setup.py (path:/tmp/pip-ORybnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:23 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)) 05:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:23 INFO - Running setup.py (path:/tmp/pip-2qgUzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:23 INFO - Running setup.py (path:/tmp/pip-rzKldw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:23 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)) 05:51:23 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)) 05:51:23 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)) 05:51:23 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)) 05:51:23 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)) 05:51:23 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)) 05:51:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:25 INFO - Downloading blessings-1.6.tar.gz 05:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:25 INFO - Installing collected packages: blessings 05:51:25 INFO - Running setup.py install for blessings 05:51:25 INFO - Successfully installed blessings 05:51:25 INFO - Cleaning up... 05:51:25 INFO - Return code: 0 05:51:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:25 INFO - Reading from file tmpfile_stdout 05:51:25 INFO - Current package versions: 05:51:25 INFO - argparse == 1.2.1 05:51:25 INFO - blessings == 1.6 05:51:25 INFO - blobuploader == 1.2.4 05:51:25 INFO - docopt == 0.6.1 05:51:25 INFO - functools32 == 3.2.3-2 05:51:25 INFO - jsonschema == 2.5.1 05:51:25 INFO - manifestparser == 1.1 05:51:25 INFO - mozInstall == 1.12 05:51:25 INFO - mozcrash == 1.0 05:51:25 INFO - mozdebug == 0.1 05:51:25 INFO - mozdevice == 0.48 05:51:25 INFO - mozfile == 1.2 05:51:25 INFO - mozhttpd == 0.7 05:51:25 INFO - mozinfo == 0.9 05:51:25 INFO - mozleak == 0.1 05:51:25 INFO - mozlog == 3.4 05:51:25 INFO - moznetwork == 0.27 05:51:25 INFO - mozprocess == 0.23 05:51:25 INFO - mozprofile == 0.28 05:51:25 INFO - mozrunner == 6.13 05:51:25 INFO - mozscreenshot == 0.1 05:51:25 INFO - mozsystemmonitor == 0.3 05:51:25 INFO - moztest == 0.8 05:51:25 INFO - mozversion == 1.4 05:51:25 INFO - psutil == 3.1.1 05:51:25 INFO - requests == 1.2.3 05:51:25 INFO - wsgiref == 0.1.2 05:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:25 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')]} 05:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:25 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')]} 05:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:25 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 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:25 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 05:51:25 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 05:51:25 INFO - Using env: {'DISPLAY': ':0', 05:51:25 INFO - 'HOME': '/home/cltbld', 05:51:25 INFO - 'LANG': 'en_US.UTF-8', 05:51:25 INFO - 'LANGUAGE': 'en_US:en', 05:51:25 INFO - 'LOGNAME': 'cltbld', 05:51:25 INFO - 'MAIL': '/var/mail/cltbld', 05:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:25 INFO - 'MOZ_NO_REMOTE': '1', 05:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:25 INFO - 'NO_EM_RESTART': '1', 05:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:25 INFO - 'PWD': '/builds/slave/test', 05:51:25 INFO - 'SHELL': '/bin/bash', 05:51:25 INFO - 'SHLVL': '1', 05:51:25 INFO - 'TERM': 'linux', 05:51:25 INFO - 'TMOUT': '86400', 05:51:25 INFO - 'USER': 'cltbld', 05:51:25 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:25 INFO - '_': '/tools/buildbot/bin/python'} 05:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 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)) 05:51:26 INFO - Cleaning up... 05:51:26 INFO - Return code: 0 05:51:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c8a18ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x218eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', '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 05:51:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:51:26 INFO - Using env: {'DISPLAY': ':0', 05:51:26 INFO - 'HOME': '/home/cltbld', 05:51:26 INFO - 'LANG': 'en_US.UTF-8', 05:51:26 INFO - 'LANGUAGE': 'en_US:en', 05:51:26 INFO - 'LOGNAME': 'cltbld', 05:51:26 INFO - 'MAIL': '/var/mail/cltbld', 05:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:26 INFO - 'MOZ_NO_REMOTE': '1', 05:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:26 INFO - 'NO_EM_RESTART': '1', 05:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:26 INFO - 'PWD': '/builds/slave/test', 05:51:26 INFO - 'SHELL': '/bin/bash', 05:51:26 INFO - 'SHLVL': '1', 05:51:26 INFO - 'TERM': 'linux', 05:51:26 INFO - 'TMOUT': '86400', 05:51:26 INFO - 'USER': 'cltbld', 05:51:26 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:26 INFO - '_': '/tools/buildbot/bin/python'} 05:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:26 INFO - Cleaning up... 05:51:26 INFO - Return code: 0 05:51:26 INFO - Running post-action listener: _resource_record_post_action 05:51:26 INFO - Running post-action listener: _start_resource_monitoring 05:51:26 INFO - Starting resource monitoring. 05:51:26 INFO - [mozharness: 2017-02-21 13:51:26.311521Z] Finished create-virtualenv step (success) 05:51:26 INFO - [mozharness: 2017-02-21 13:51:26.312021Z] Running install step. 05:51:26 INFO - Running pre-action listener: _resource_record_pre_action 05:51:26 INFO - Running main action method: install 05:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:26 INFO - Reading from file tmpfile_stdout 05:51:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:26 INFO - Reading from file tmpfile_stdout 05:51:26 INFO - Output received: 05:51:26 INFO - Usage: mozinstall [options] installer 05:51:26 INFO - Options: 05:51:26 INFO - -h, --help show this help message and exit 05:51:26 INFO - -d DEST, --destination=DEST 05:51:26 INFO - Directory to install application into. [default: 05:51:26 INFO - "/builds/slave/test"] 05:51:26 INFO - --app=APP Application being installed. [default: firefox] 05:51:26 INFO - mkdir: /builds/slave/test/build/application 05:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:51:40 INFO - Reading from file tmpfile_stdout 05:51:40 INFO - Output received: 05:51:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:40 INFO - Running post-action listener: _resource_record_post_action 05:51:40 INFO - [mozharness: 2017-02-21 13:51:40.758663Z] Finished install step (success) 05:51:40 INFO - [mozharness: 2017-02-21 13:51:40.758781Z] Running run-tests step. 05:51:40 INFO - Running pre-action listener: _resource_record_pre_action 05:51:40 INFO - Running main action method: run_tests 05:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:40 INFO - Python 2.7.3 05:51:40 INFO - Return code: 0 05:51:40 INFO - grabbing minidump binary from tooltool 05:51:40 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')]} 05:51:40 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 0x218bf60>, '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 0x218cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:40 INFO - Return code: 0 05:51:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 05:51:40 INFO - Using env: {'DISPLAY': ':0', 05:51:40 INFO - 'HOME': '/home/cltbld', 05:51:40 INFO - 'LANG': 'en_US.UTF-8', 05:51:40 INFO - 'LANGUAGE': 'en_US:en', 05:51:40 INFO - 'LOGNAME': 'cltbld', 05:51:40 INFO - 'MAIL': '/var/mail/cltbld', 05:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:40 INFO - 'MOZ_NO_REMOTE': '1', 05:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:40 INFO - 'NO_EM_RESTART': '1', 05:51:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:40 INFO - 'PWD': '/builds/slave/test', 05:51:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:40 INFO - 'SHELL': '/bin/bash', 05:51:40 INFO - 'SHLVL': '1', 05:51:40 INFO - 'TERM': 'linux', 05:51:40 INFO - 'TMOUT': '86400', 05:51:40 INFO - 'USER': 'cltbld', 05:51:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328', 05:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:40 INFO - '_': '/tools/buildbot/bin/python'} 05:51:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 05:51:41 INFO - mozversion application_buildid: 20170221034028 05:51:41 INFO - mozversion application_changeset: 86178fe492254027e0cba462ccbdc7db8cb90817 05:51:41 INFO - mozversion application_display_name: Firefox 05:51:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:41 INFO - mozversion application_name: Firefox 05:51:41 INFO - mozversion application_remotingname: firefox 05:51:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:51:41 INFO - mozversion application_vendor: Mozilla 05:51:41 INFO - mozversion application_version: 52.0 05:51:41 INFO - mozversion platform_buildid: 20170221034028 05:51:41 INFO - mozversion platform_changeset: 86178fe492254027e0cba462ccbdc7db8cb90817 05:51:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:51:41 INFO - mozversion platform_version: 52.0 05:51:41 INFO - using testdate: 1487685101 05:51:41 INFO - actual date: 1487685101 05:51:41 INFO - starting webserver on 'localhost:37755' 05:51:41 INFO - SUITE-START | Running 2 tests 05:51:41 INFO - TEST-START | dromaeo_css 05:51:41 INFO - operating with platform_type : linux_ 05:51:41 INFO - Initialising browser for dromaeo_css test... 05:51:41 INFO - TEST-INFO | started process 8634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp69rJnV/profile http://localhost:37755/getInfo.html) 05:51:45 INFO - PROCESS | 8634 | __metrics Screen width/height:1600/1200 05:51:45 INFO - PROCESS | 8634 | colorDepth:24 05:51:45 INFO - PROCESS | 8634 | Browser inner width/height: 1024/697 05:51:45 INFO - PROCESS | 8634 | __metrics 05:51:46 INFO - PROCESS | 8634 | 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" 05:51:46 INFO - PROCESS | 8634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:51:47 INFO - TEST-INFO | 8634: exit 0 05:51:47 INFO - Browser initialized. 05:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:47 INFO - TEST-INFO | started process 8725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp69rJnV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:59 INFO - PROCESS | 8725 | RSS: Main: 142041088 05:51:59 INFO - PROCESS | 8725 | 05:55:00 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37755/tests/dromaeo/cssquery-ext.html) 05:55:01 INFO - PROCESS | 8725 | RSS: Main: 240877568 05:55:01 INFO - PROCESS | 8725 | 05:58:03 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-ext.html (next: http://localhost:37755/tests/dromaeo/cssquery-jquery.html) 05:58:04 INFO - PROCESS | 8725 | RSS: Main: 230330368 05:58:04 INFO - PROCESS | 8725 | 06:01:06 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37755/tests/dromaeo/cssquery-mootools.html) 06:01:06 INFO - PROCESS | 8725 | RSS: Main: 180314112 06:01:06 INFO - PROCESS | 8725 | 06:04:08 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37755/tests/dromaeo/cssquery-prototype.html) 06:04:09 INFO - PROCESS | 8725 | RSS: Main: 230543360 06:04:09 INFO - PROCESS | 8725 | 06:07:11 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37755/tests/dromaeo/cssquery-yui.html) 06:07:12 INFO - PROCESS | 8725 | RSS: Main: 174092288 06:07:12 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-yui.html (next: http://localhost:37755/tests/dromaeo/cssquery-dojo.html) 06:10:15 INFO - PROCESS | 8725 | RSS: Main: 265965568 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | __start_tp_report 06:10:15 INFO - PROCESS | 8725 | _x_x_mozilla_page_load 06:10:15 INFO - PROCESS | 8725 | _x_x_mozilla_page_load_details 06:10:15 INFO - PROCESS | 8725 | |i|pagename|runs| 06:10:15 INFO - PROCESS | 8725 | |0;dojo.html;3193.6486986431487;3223.6131664200284;3239.2063944333636;3251.9349613007757;3265.167382317509;5397.4062853086125;5547.861303467415;5565.387807341189;5565.777368905239;5575.052241119004;5528;5545.944540554593;5553.7778488860395;5561.332640083186;5569.610127291091;5008.023435430102;5036.496350364952;5071.391433028023;5084.720340381277;5144.048351055067;4955.975220123894;4993.201087825949;5080.568151707109;5133.5893128549815;5137.743112844361;5007.273945277932;5008.3238762767105;5053.84838454847;5060.6963582185;5092.796288148488;5045.798168073273;5060.544550990428;5123.2315152727015;5123.974380128113;5156.793728250866;4848.248521479177;5012.323336349619;5039.294498770175;5065.569426598743;5093.1087059764395;5371.543418809367;5396.460353964611;5458.590605704588;5502.614816962814;5531.834044978657;5918.940810591925;5942.554308426886;5957.434043765836;5959.165716799652;5960.552958528127;5781.132830075522;5995.490383317423;6000.159977603095;6015.428534289235;6017.247844019497;5421.539169170625;5507.03626865297;5555.916661250044;5566.081596536607;5645.604807663506;6120.846978825476;6125.663088530174;6131.110988906673;6134.263888333428;6142.385761423822;5869.618474799125;5869.941300587025;5874.559408044413;5874.882502350015;5888.175655408247;5706.686132262683;5723.885522289531;5776.56675749312;5818.389069147764;5827.941720582825;5810.099434587646;5855.765769369177;5858.062709966385;5881.823545293648;5892.057270836645;5836.737346819404;5845.181674565564;5845.912311315334;5848.766049357978;5855.531557475391;4489.304157855538;4528.43394575678;4532.32015197723;4555.362249285103;4590.563896429834;4081.8571350002608;4083.972700397301;4085.428040074392;4094.0788322627172;4109.732867363612;5636.802711905146;5640.605157638925;5643;5645.096784514458;5654.802081927195;5712.11462223356;5763.625364351304;5838.241028666246;5870.178175055496;5950.285965684146;5626.803061892814;5685.914711279334;5689.203511508392;5711.400302968212;5716.914246286309;5037.345145131109;5068.873278168002;5069.062223488592;5081.74591270435;5144.61415393847;5917.970410148007;5952.761889524544;6182.1345011698395;6196.256449226032;6199.256089269316;5828.038373668467;5877.823665290048;5880.500157486662;5925.674087925206;5955;6142.109394137914;6145.293291271561;6150.077488376779;6150.354212807591;6152.600080994721;5648.096304591246;5766.740496677576;5818.418158184148;5824.796132135355;5832.708364581669;5786.218860453953;5828.358880523224;5864.560157988082;5865.149553314831;5977.7310021050025;5764.337101233412;5803.47768700819;5819.039858423482;5823.912641310469;5826.096954971986;5771.711414429178;5776.220210271559;5776.624519406225;5776.7111644418455;5781.797637082682;5494.890102198014;5519.668819870821;5740.0815869460685;5771.336296325809;5786.103154011135;5927;5929.407059294209;5930.11048342752;5930.584859059824;5943.1679564861815;5475.780968761364;5516;5779.450952159538;5781.94218057814;5798.043322851682 06:10:15 INFO - PROCESS | 8725 | |1;ext.html;583.5360888093965;616.1558664629457;645.0936434309793;651.0917270407781;657.3459407889151;32870.178245543844;45560.31659525105;46766.766166169204;46797.298040529335;46857.06285874281;46385;46726.29910551345;46933.29600056002;46952.76523617386;46991.29513057307;8433.578321083953;8792.516411597375;8942.239909607692;8948.284137269004;8949.552522373855;8388.874166887472;10484.947575262113;10717.732056698605;10720.892791072067;11057.336559806437;10940.617078402258;10985.890141098607;10991.61529346473;10992.17558683098;10993.175511836644;10715.303505272172;10769.084627806646;10775.353478791258;10779.407132607743;10782.622608208754;10747.570097196103;10807.78384432307;10813.783724325549;10816.67549973502;10818.837717434244;44060.118797623865;44354.334684979425;44375.55624443747;44407.33388999168;44410;3698.9630103698887;3793.715471339661;3873.4383514390256;3892.785896775676;4048.6153815387784;32303.35393292121;32617;33248.66751332504;33396;33605.49591756125;4472.46330440346;4484.260097083978;4596.816127354902;4761.928571071437;4801.375821143229;353347;355026;355382;355770.99999999744;357880;61280;61319.38680613137;61743.07385389223;61806;61877.690611546655;63266.367336326046;64093.35906640874;64203.67898160479;64243;64247;17339.739903901453;17545.736813947802;17545.736813947802;17558.122093895254;17576.384826531266;11057.889421105847;11408.600698975662;13095.869041309656;13128.343582821011;13148.145370550883;17609.911950440164;18364.540886477676;18502.167402466923;18537.35119270819;18646.440606781547;6382.7234553089565;6402.119046429032;6474.223093228748;6511.804645860631;6543.25613929897;1003.8092762375126;1034.7361422837128;1130.4404319861721;1141.5662048421548;1154.163231657042;31529.52705709416;32095.679043209737;32156;32284.19289517781;32598.511022334686;1099.5656715597295;1124.1288001798507;1135.137295655308;1136.4772204785727;1156.3119943633524;14781.63045923839;17119.74320385195;17631.559211019572;18023.549411264823;18444.170012349477;489835;491763;493660;493747;494834;61104;61196;61209.38790612126;61236.693816530635;61559.076613850826;1291.3865913690922;1317.8089177069462;1363.4886917405972;1388.8750012498924;1417.340936464549;29059.12822615325;32712.672873270963;32812;32983.01050968475;33419.16452088717;52637;53137.7343113282;53164.73417632887;53235;53336.19995700145;386064;387978;388601;388674;388778;41433.58566414297;42668;42790.57209427866;43034.78482607567;43164.784176078916;47318.29022564733;48698.51301487081;49017;49035;49285.753571231915;41758;42264.577354227295;42498.575014250695;43002;44110.77944610256;41183.7940810294;41322.79338603288;42086.78956605197;42785.144297113264;43155.78422107869;41301.586984129775;42278;42941.141177176905;43135;44599.55400445954;33727;37401;40184.59815401809;40481.797591011855;41241.38137927873;27405;27765.722342776313;27882.721172788013;27913.302167445163;28107.578386323814 06:10:15 INFO - PROCESS | 8725 | |2;jquery.html;417.1094712788198;419.6600753389753;419.96640268778503;420.6760794188474;442.84943119339437;18445.53886152845;19266.710999334988;19834.305799297028;19889.3038743644;20055.29806456774;18954.52613684655;19252.518687032796;19401.90299048506;19484.318048868256;19492.9025354873;5454.12733962567;5784;5819;5822.417758224186;5830.970845145768;5635.915461268084;5663.688497132656;5806.187133801272;5816.040353341694;5817.040188368914;5807.941920580783;5814.273215848019;5838.503727183194;5843.503302219296;5848.41515848416;5740.741666625012;5824.417558244163;5827.067669172912;5832.854178645525;5978.970105149447;5903.852403689899;5907.438793314628;5908.231929849135;5917.852053698649;5928.318243402021;14043.1574105554;21737.23919662804;22203.66694499584;22340.441488962744;23361.065557377686;2404.89177986991;2478.4547399572066;2498.675172227617;2500.5124000819847;2736.0287098080094;9789.97205293441;10120.595176192943;10310.639127630571;10645.93540645937;10683.893161068445;1886.6038131992298;1890.6029733755927;1917.7411049508278;1922.0870086708842;1935.7096435534781;82229.58885205536;82864.17135828685;83177.58411207965;83281;83963.58018209931;10940.890591093987;10988.395638239974;11094.334339939629;11193.328400296008;11340.546378144782;15995.600109997344;16020.118893460738;16049.759253611206;16104.275307611186;16165.434209802836;7980.640871160812;8212.917870821335;8275.710350137717;8442;8452.661893524313;7851.254130857559;7854.567998760123;7890.8816367754525;8030.959845200853;8098.514089154552;4651.604613607814;4711.387519622495;4783.354247176656;4836.830710925101;4966.8758281043265;1948.7271781950537;1969.7242386065961;2018.1422895269452;2040.40828159832;2068.865523740952;897.3090720145451;973.776031512756;992.6327258914248;1006.6124542051363;1026;18345.908270458563;18675.81324186768;18742.531436713918;18783.624327513648;19064.2374305029;984.8325784616633;1001.5743309093751;1014.7209517382631;1019.9235057370727;1029.0224286927448;9930.453825039547;10524.105451036748;10530.157587393143;10550.683479495627;10558;486450;490203;490337;491664;493440;80906.19093809104;89872;90643.54678226566;90784;93369.53315233381;1027.1012863744372;1065.6856227412932;1105.6130354375905;1106.950187241576;1109.0295991007868;15915.283812228708;16549.50351489457;16726.916365418096;16734.748978765572;17003.574910627332;39935.20129597334;40639;40705.79647101746;41365.58634413617;41923;54601.72699136479;55268;55500;56867.715661421425;57332;5575.944240557705;7686.654100565376;8390.119037500974;8552;8643.870341945001;11753.05975521939;11834.171607987702;11958.282503049497;12445.066620003718;12597.559085431965;9743;10297.485125743833;10755.516001779783;11069.833952490559;11248.351121237636;10930.617428389969;10945.069669078217;11172.162087843606;11477.139214559109;11553.82669259945;5204.869878253074;5997.670128142994;9879.851802223116;11148.219624626523;11334.60328888485;8075.152109028468;8354.248117669438;8510.914890851012;8745.169208925143;8775.166359195866;8454.788630284293;10799.514021868878;10920.508577114208;11122.277051991594;11315.773684526428 06:10:15 INFO - PROCESS | 8725 | |3;mootools.html;1381.820363352764;1508.1403599948028;1536.8780790023284;1673.155056696368;1783.072802142885;7866.803329916748;8452.197041281077;8713.30293576514;8717.0411254762;8900.8664870027;8772;8853.070427605106;8859.512726800023;8862.06948270432;8867.60095795689;2441.8779061046966;2468.753124687526;2469.0247352295924;2473.492933948545;2475.405902583385;2361.2325994051916;2439.097533912446;2439.451123497208;2440.511897620483;2448.2288079255068;2426.9029238830512;2432.659427680126;2461.212412028143;2462.249014050714;2469.09877894569;2340.9297721068397;2344.859308441499;2360.9763902361015;2363.52729454109;2395.5927492326173;2291.702078729771;2351.7413084560685;2369.336585755991;2373.679553260305;2374.5963186258205;7893.8026549336155;8126.471779334324;8742.956285218597;8810.559472026438;8943.955280223558;5367.865803354908;5527.115661494182;5540.9168862467095;5609.214709940612;5616.66300022;3350.2964377480757;3395.337909107725;3462.0652423845672;3472.0625431133453;3541.557305336833;1105.5190991918462;1106.0874778307927;1113.0817075912405;1118.4519585403093;1124.2523721725042;12523.812142817866;12531.498740050387;12557.623271301876;12597.307148106851;12608.495660173581;4750.168720473972;4775.188218002948;4798.640101992364;4950.3069570260195;5028.421731500851;10498.31760935552;10519.211059170593;10521.263511554118;10531.94734026325;10541.578336866593;5479.479449452296;5491;5492.80775172867;5499.367572729107;5501.5323697486165;4838.225883858566;4991.301217829507;5045.5459008689395;5072.873178170576;5073.213651883964;4108.02924025614;4159.064210552601;4215.683823713233;4254.404383386328;4344.218040752695;1349.5411560069624;1354.4379082680578;1363.5432130236284;1365.9726805463836;1370.3353873371407;909.3679892474798;916.3585490156917;927.972160835176;930.8570149921602;949.3354651743807;5512.614117011851;5825.657747578004;5832.591718579659;5844.736986835517;6123.326434092246;910.2990697163148;940.5391358234552;945.1399226703804;968.5833844557873;971.9465429401309;3682.8710995115043;3786.583475817658;3797.810109494514;3836.693064554829;3894.6884249259992;9967.501624918725;10347.017033381817;10443.84334234987;10589;10958.178136639784;11230.438478076063;11239.55041798319;11249.887501125047;11253.212275140826;11253.324800511995;8086.191380861985;8258.463199892109;8265.132161123116;8265.214804593674;8270.627821748036;5580.162975553537;5652.349979752381;5707.971460142673;5757.424257574209;5817.767289308549;9686.709398717769;9698.515074246401;9752.219822414048;9806.705798826046;9809.068138526829;9826.4104153751;9827.361221520865;10161.237907156845;10164.440955747505;10517.316374435637;7835.49069310493;7937.801554960941;7938.761837144895;7954.482958607672;7984.361251100015;8329.12544182852;8374.63816963417;8404.831903362021;8467.57662116904;8475.49147051179;7357;7494.737684181027;7511;7692.884606731015;7737.613119344122;7466.178720340867;7521.285477879593;7572.7728168155045;7640.426967977312;7753.767386978399;6643.667816609053;6766.661666916733;6848.657567121723;7106.182788979334;7147.714091436284;5017.799288028438;5073.416557095834;5120.948790512047;5155.381354237516;5183.844484665466;4997.5002499749735;5020.49795020495;5059.822906198413;5167.715775632226;5188.870278243074 06:10:15 INFO - PROCESS | 8725 | |4;prototype.html;330.4085686620947;333.24353717062286;334.6686780087712;345.7787016309562;353.21233648962806;5319.787208511664;5346.91979620306;5412.4046354900975;5447.45525447455;5476.205950137228;5289.285946397235;5299.947000529994;5312.203169524573;5324.307839980806;5331.946680533193;4205.053862880843;4213.831446742134;4232.74603523788;4233.491980962289;4245.257080010986;3875.670568001723;3970.094354709741;4126.071633882382;4138;4156.127213285198;4090.97954510227;4108.650764685005;4112.342025275956;4113.136241389312;4142.855000074998;4128.710990230685;4133.4499562664005;4133.813978370966;4139.441175441307;4148.958510414887;3467.4105402081705;3536.9115772105647;3578.3022310649435;3643.0710168907026;3659.597444281127;5161.922571161435;5171.120909445403;5188.45521220274;5198.194279886624;5199.818006369796;4724.055188962187;4724.4094488188975;4738.507370178383;4756.312683333906;4763.14263432582;5348.171033489815;5446.210299506589;5478.424765399615;5484;5487.945120548783;3974.6621537169376;3984.5417776955733;3992.740471869319;3995.380715989026;3997.300472417315;5703.771849126071;5722.570807189436;5730.828075157752;5748.45389687979;5753.827385178452;3907.2185562886966;4089.5705950875326;4121.402396652528;4121.464209652726;4130;4148.23257697327;4155.210510003089;4164.271252530855;4169.958300416957;4171.20747058058;4709.835155769531;4717.858464246078;4721.622270218443;4723.456802467692;4733.928991065137;5402.6758394496455;5477.247280870083;5535.1180598595865;5551.417101204315;5552.444755524415;1375.910565813219;1376.827896512936;1382.7096309774859;1397.538812191974;1398.189050350794;905.3029167540957;952.7999120184838;955.3121752338305;957.6736220334886;959.5250351076122;5167.896642067213;5235;5236.345456817898;5271.42014378418;5275;5607.66354018752;5638.605297629127;5707.315122185281;5728.971355143198;5749.655020698771;5453.972730136324;5457.290552228185;5467.972660136674;5480.150576660624;5499.835004949858;2877.438899414636;2888.7400133988044;2925.7074292570996;2931.530955047182;2931.9560206596916;5597.692126932976;5684.431556844283;5701.522071536359;5708.942910570924;5718.25662663851;5441.29263195782;5593.832185034374;5603.7478313475995;5615.775368985276;5629.268195134607;5683.69275066737;5705.771769129271;5752.597318187771;5756.94243057564;5762.510186634099;5484.698341591251;5509.972450137724;5513.696746678971;5520.199571062093;5525.309336332958;5290.761915713725;5441.27936031984;5461.9180712290145;5472.726363681721;5476.397596264328;5737.34020587621;5753.510951569164;5757.712114394348;5762.798302059407;5772.94227057724;3996.300647386754;4005.2790497710694;4013.819378127933;4016.2930754429835;4022.577629348876;5332.146856502941;5340.332458442695;5402.567794576503;5449.918251226156;5536.806211782568;5397.9460205397445;5412.594055445778;5420.918686219631;5423.674579525241;5435.266239057834;5360.195970604441;5379.462053794589;5383.246345511553;5398.2982212312145;5431.6740995540395;5101.668391554537;5339.3058902342445;5350.5184533392185;5375.543078838343;5384.865378365572;5387.86530336729;5413.675179489243;5443.122122867604;5455.61810673265;5460.535854452257;5365.980463711882;5389.784408623611;5489.39616642161;5503.834884953458;5505.201745746925 06:10:15 INFO - PROCESS | 8725 | |5;yui.html;792.9453826410875;809.101896894447;848.9915100848991;849.2144766091368;869.5739087846957;15313.464028758995;16003.679926401464;16053.518394448185;16059.839401605981;16196.271167797448;13868.583942481742;13873.098248613833;13879.722405551884;13901.304934753272;13927.791083133736;707.7381368893516;725.4994054102652;827.1397746343811;832.3507664022072;856.002756788344;846.1115828380207;857.8027053777635;857.9356548258875;857.9828403431927;858.635080090962;903.421810041574;905.2441211588332;905.4793493741092;905.597009330848;906.7823722306665;900.045951291633;900.4507250577143;900.5812297281763;900.7883147460342;900.9774755631063;662.7812821768805;664.0537234440951;664.2062735031639;664.2361284522789;664.2394458345216;14687.63280917975;14703.852961470355;14736.115833050051;14750.483733069399;15606.765898511532;13435.932820335933;14340.64148396288;14460.770834479083;14535;14538.418463261456;11129.387883666395;11191.216614836965;11234.662960111209;11249.83125253122;11505.252158609663;3727.0682329417646;3732.757370770891;3737.5141231639714;3822.0827001519433;3826.7321287509885;54221.45778542203;55816.72091639556;56078.15882761762;62813.37186628121;63206;11262.662120136409;11555.075593952464;11591.24656897299;11635.709107272385;11674.824877626843;19712.802871971096;19723.50691232702;19738.70391944122;19808.70286945697;19856.801431985783;8255.834883302301;8356.874646880302;8447.155284471504;8498.192671696179;8564.400491965627;4457.175422546774;4527.253003254492;4564.931526027112;4575.039241759201;4576.931346029813;3163.620365556148;3229.0958531611186;3232.434323993292;3236.2233064064453;3236.660150684191;621.293700220829;623.2863371439677;623.5603899251017;625.0655270370734;636.424036247197;680.3298750730527;689.5276735436242;689.7896141676837;709.2269426325227;716.9713211471587;8747.693830715894;8762.561871906379;8788.648454061893;8840.513771742488;9052.366334356664;650.677914432359;703.736098962889;724.3010494872368;726.1395246632757;737.5279820914619;4263.893402664959;4271.124419493996;4346.8043938022865;4427.756473393994;4438.370103601856;83904.58047709844;84498.57750711207;85059;86956;90363.54818225867;75566.24433755701;76345.61827190829;76786.61606692043;78133;79465;67374;69287;71306.28693713101;72222.63888680523;72227.99999999895;8366.958165209378;8467;8592.742217733477;8657.61040753155;8807.647694092164;40629.1874162521;40664.39003414892;46822.76588617035;47904;48133.75933120312;40491.39262911;41102.58897411107;57198.42801572097;58352;62419.6879015602;11633.76732465329;11900.642980710592;12146.878531214576;12315.507379704712;12873;14052.508162214273;14392.928035360175;14437.85562144407;14476.565703028504;14511;13296;13722.794158087836;14019.369128389042;14220.36008379646;14298.142111473346;13006.349682516025;13412.530561430303;13734.969877259045;14053.648658783612;14699.265036748333;11229.101671866069;11314.717132071764;11449;11521.366324852213;11599.826002610136;10486;10598.20513461509;10635.840462393226;10708.355149973944;10903.78192436131;10290;10752.784944300915;10771.676849694522;10815.297005694605;10854.728631783953 06:10:15 INFO - PROCESS | 8725 | __end_tp_report 06:10:15 INFO - PROCESS | 8725 | __start_cc_report 06:10:15 INFO - PROCESS | 8725 | _x_x_mozilla_cycle_collect,1028 06:10:15 INFO - PROCESS | 8725 | __end_cc_report 06:10:15 INFO - PROCESS | 8725 | __startTimestamp1487686215458__endTimestamp 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | ------- Summary: start ------- 06:10:15 INFO - PROCESS | 8725 | Number of tests: 6 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | [#0] dojo.html Cycles:165 Average:5499.34 Median:5723.89 stddev:612.59 (10.7%) stddev-sans-first:587.16 06:10:15 INFO - PROCESS | 8725 | Values: 3193.6 3223.6 3239.2 3251.9 3265.2 5397.4 5547.9 5565.4 5565.8 5575.1 5528.0 5545.9 5553.8 5561.3 5569.6 5008.0 5036.5 5071.4 5084.7 5144.0 4956.0 4993.2 5080.6 5133.6 5137.7 5007.3 5008.3 5053.8 5060.7 5092.8 5045.8 5060.5 5123.2 5124.0 5156.8 4848.2 5012.3 5039.3 5065.6 5093.1 5371.5 5396.5 5458.6 5502.6 5531.8 5918.9 5942.6 5957.4 5959.2 5960.6 5781.1 5995.5 6000.2 6015.4 6017.2 5421.5 5507.0 5555.9 5566.1 5645.6 6120.8 6125.7 6131.1 6134.3 6142.4 5869.6 5869.9 5874.6 5874.9 5888.2 5706.7 5723.9 5776.6 5818.4 5827.9 5810.1 5855.8 5858.1 5881.8 5892.1 5836.7 5845.2 5845.9 5848.8 5855.5 4489.3 4528.4 4532.3 4555.4 4590.6 4081.9 4084.0 4085.4 4094.1 4109.7 5636.8 5640.6 5643.0 5645.1 5654.8 5712.1 5763.6 5838.2 5870.2 5950.3 5626.8 5685.9 5689.2 5711.4 5716.9 5037.3 5068.9 5069.1 5081.7 5144.6 5918.0 5952.8 6182.1 6196.3 6199.3 5828.0 5877.8 5880.5 5925.7 5955.0 6142.1 6145.3 6150.1 6150.4 6152.6 5648.1 5766.7 5818.4 5824.8 5832.7 5786.2 5828.4 5864.6 5865.1 5977.7 5764.3 5803.5 5819.0 5823.9 5826.1 5771.7 5776.2 5776.6 5776.7 5781.8 5494.9 5519.7 5740.1 5771.3 5786.1 5927.0 5929.4 5930.1 5930.6 5943.2 5475.8 5516.0 5779.5 5781.9 5798.0 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | [#1] ext.html Cycles:180 Average:59169.45 Median:22038.69 stddev:109729.71 (497.9%) stddev-sans-first:109949.36 06:10:15 INFO - PROCESS | 8725 | Values: 583.5 616.2 645.1 651.1 657.3 32870.2 45560.3 46766.8 46797.3 46857.1 46385.0 46726.3 46933.3 46952.8 46991.3 8433.6 8792.5 8942.2 8948.3 8949.6 8388.9 10484.9 10717.7 10720.9 11057.3 10940.6 10985.9 10991.6 10992.2 10993.2 10715.3 10769.1 10775.4 10779.4 10782.6 10747.6 10807.8 10813.8 10816.7 10818.8 44060.1 44354.3 44375.6 44407.3 44410.0 3699.0 3793.7 3873.4 3892.8 4048.6 32303.4 32617.0 33248.7 33396.0 33605.5 4472.5 4484.3 4596.8 4761.9 4801.4 353347.0 355026.0 355382.0 355771.0 357880.0 61280.0 61319.4 61743.1 61806.0 61877.7 63266.4 64093.4 64203.7 64243.0 64247.0 17339.7 17545.7 17545.7 17558.1 17576.4 11057.9 11408.6 13095.9 13128.3 13148.1 17609.9 18364.5 18502.2 18537.4 18646.4 6382.7 6402.1 6474.2 6511.8 6543.3 1003.8 1034.7 1130.4 1141.6 1154.2 31529.5 32095.7 32156.0 32284.2 32598.5 1099.6 1124.1 1135.1 1136.5 1156.3 14781.6 17119.7 17631.6 18023.5 18444.2 489835.0 491763.0 493660.0 493747.0 494834.0 61104.0 61196.0 61209.4 61236.7 61559.1 1291.4 1317.8 1363.5 1388.9 1417.3 29059.1 32712.7 32812.0 32983.0 33419.2 52637.0 53137.7 53164.7 53235.0 53336.2 386064.0 387978.0 388601.0 388674.0 388778.0 41433.6 42668.0 42790.6 43034.8 43164.8 47318.3 48698.5 49017.0 49035.0 49285.8 41758.0 42264.6 42498.6 43002.0 44110.8 41183.8 41322.8 42086.8 42785.1 43155.8 41301.6 42278.0 42941.1 43135.0 44599.6 33727.0 37401.0 40184.6 40481.8 41241.4 27405.0 27765.7 27882.7 27913.3 28107.6 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | [#2] jquery.html Cycles:180 Average:28658.58 Median:40672.40 stddev:80862.96 (198.8%) stddev-sans-first:81062.00 06:10:15 INFO - PROCESS | 8725 | Values: 417.1 419.7 420.0 420.7 442.8 18445.5 19266.7 19834.3 19889.3 20055.3 18954.5 19252.5 19401.9 19484.3 19492.9 5454.1 5784.0 5819.0 5822.4 5831.0 5635.9 5663.7 5806.2 5816.0 5817.0 5807.9 5814.3 5838.5 5843.5 5848.4 5740.7 5824.4 5827.1 5832.9 5979.0 5903.9 5907.4 5908.2 5917.9 5928.3 14043.2 21737.2 22203.7 22340.4 23361.1 2404.9 2478.5 2498.7 2500.5 2736.0 9790.0 10120.6 10310.6 10645.9 10683.9 1886.6 1890.6 1917.7 1922.1 1935.7 82229.6 82864.2 83177.6 83281.0 83963.6 10940.9 10988.4 11094.3 11193.3 11340.5 15995.6 16020.1 16049.8 16104.3 16165.4 7980.6 8212.9 8275.7 8442.0 8452.7 7851.3 7854.6 7890.9 8031.0 8098.5 4651.6 4711.4 4783.4 4836.8 4966.9 1948.7 1969.7 2018.1 2040.4 2068.9 897.3 973.8 992.6 1006.6 1026.0 18345.9 18675.8 18742.5 18783.6 19064.2 984.8 1001.6 1014.7 1019.9 1029.0 9930.5 10524.1 10530.2 10550.7 10558.0 486450.0 490203.0 490337.0 491664.0 493440.0 80906.2 89872.0 90643.5 90784.0 93369.5 1027.1 1065.7 1105.6 1107.0 1109.0 15915.3 16549.5 16726.9 16734.7 17003.6 39935.2 40639.0 40705.8 41365.6 41923.0 54601.7 55268.0 55500.0 56867.7 57332.0 5575.9 7686.7 8390.1 8552.0 8643.9 11753.1 11834.2 11958.3 12445.1 12597.6 9743.0 10297.5 10755.5 11069.8 11248.4 10930.6 10945.1 11172.2 11477.1 11553.8 5204.9 5997.7 9879.9 11148.2 11334.6 8075.2 8354.2 8510.9 8745.2 8775.2 8454.8 10799.5 10920.5 11122.3 11315.8 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | [#3] mootools.html Cycles:180 Average:5811.09 Median:5073.32 stddev:3266.36 (64.4%) stddev-sans-first:3258.56 06:10:15 INFO - PROCESS | 8725 | Values: 1381.8 1508.1 1536.9 1673.2 1783.1 7866.8 8452.2 8713.3 8717.0 8900.9 8772.0 8853.1 8859.5 8862.1 8867.6 2441.9 2468.8 2469.0 2473.5 2475.4 2361.2 2439.1 2439.5 2440.5 2448.2 2426.9 2432.7 2461.2 2462.2 2469.1 2340.9 2344.9 2361.0 2363.5 2395.6 2291.7 2351.7 2369.3 2373.7 2374.6 7893.8 8126.5 8743.0 8810.6 8944.0 5367.9 5527.1 5540.9 5609.2 5616.7 3350.3 3395.3 3462.1 3472.1 3541.6 1105.5 1106.1 1113.1 1118.5 1124.3 12523.8 12531.5 12557.6 12597.3 12608.5 4750.2 4775.2 4798.6 4950.3 5028.4 10498.3 10519.2 10521.3 10531.9 10541.6 5479.5 5491.0 5492.8 5499.4 5501.5 4838.2 4991.3 5045.5 5072.9 5073.2 4108.0 4159.1 4215.7 4254.4 4344.2 1349.5 1354.4 1363.5 1366.0 1370.3 909.4 916.4 928.0 930.9 949.3 5512.6 5825.7 5832.6 5844.7 6123.3 910.3 940.5 945.1 968.6 971.9 3682.9 3786.6 3797.8 3836.7 3894.7 9967.5 10347.0 10443.8 10589.0 10958.2 11230.4 11239.6 11249.9 11253.2 11253.3 8086.2 8258.5 8265.1 8265.2 8270.6 5580.2 5652.3 5708.0 5757.4 5817.8 9686.7 9698.5 9752.2 9806.7 9809.1 9826.4 9827.4 10161.2 10164.4 10517.3 7835.5 7937.8 7938.8 7954.5 7984.4 8329.1 8374.6 8404.8 8467.6 8475.5 7357.0 7494.7 7511.0 7692.9 7737.6 7466.2 7521.3 7572.8 7640.4 7753.8 6643.7 6766.7 6848.7 7106.2 7147.7 5017.8 5073.4 5120.9 5155.4 5183.8 4997.5 5020.5 5059.8 5167.7 5188.9 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | [#4] prototype.html Cycles:180 Average:4624.05 Median:5343.63 stddev:1344.24 (25.2%) stddev-sans-first:1308.81 06:10:15 INFO - PROCESS | 8725 | Values: 330.4 333.2 334.7 345.8 353.2 5319.8 5346.9 5412.4 5447.5 5476.2 5289.3 5299.9 5312.2 5324.3 5331.9 4205.1 4213.8 4232.7 4233.5 4245.3 3875.7 3970.1 4126.1 4138.0 4156.1 4091.0 4108.7 4112.3 4113.1 4142.9 4128.7 4133.4 4133.8 4139.4 4149.0 3467.4 3536.9 3578.3 3643.1 3659.6 5161.9 5171.1 5188.5 5198.2 5199.8 4724.1 4724.4 4738.5 4756.3 4763.1 5348.2 5446.2 5478.4 5484.0 5487.9 3974.7 3984.5 3992.7 3995.4 3997.3 5703.8 5722.6 5730.8 5748.5 5753.8 3907.2 4089.6 4121.4 4121.5 4130.0 4148.2 4155.2 4164.3 4170.0 4171.2 4709.8 4717.9 4721.6 4723.5 4733.9 5402.7 5477.2 5535.1 5551.4 5552.4 1375.9 1376.8 1382.7 1397.5 1398.2 905.3 952.8 955.3 957.7 959.5 5167.9 5235.0 5236.3 5271.4 5275.0 5607.7 5638.6 5707.3 5729.0 5749.7 5454.0 5457.3 5468.0 5480.2 5499.8 2877.4 2888.7 2925.7 2931.5 2932.0 5597.7 5684.4 5701.5 5708.9 5718.3 5441.3 5593.8 5603.7 5615.8 5629.3 5683.7 5705.8 5752.6 5756.9 5762.5 5484.7 5510.0 5513.7 5520.2 5525.3 5290.8 5441.3 5461.9 5472.7 5476.4 5737.3 5753.5 5757.7 5762.8 5772.9 3996.3 4005.3 4013.8 4016.3 4022.6 5332.1 5340.3 5402.6 5449.9 5536.8 5397.9 5412.6 5420.9 5423.7 5435.3 5360.2 5379.5 5383.2 5398.3 5431.7 5101.7 5339.3 5350.5 5375.5 5384.9 5387.9 5413.7 5443.1 5455.6 5460.5 5366.0 5389.8 5489.4 5503.8 5505.2 06:10:15 INFO - PROCESS | 8725 | 06:10:15 INFO - PROCESS | 8725 | [#5] yui.html Cycles:180 Average:17398.51 Median:4546.09 stddev:22803.96 (501.6%) stddev-sans-first:22833.84 06:10:15 INFO - PROCESS | 8725 | Values: 792.9 809.1 849.0 849.2 869.6 15313.5 16003.7 16053.5 16059.8 16196.3 13868.6 13873.1 13879.7 13901.3 13927.8 707.7 725.5 827.1 832.4 856.0 846.1 857.8 857.9 858.0 858.6 903.4 905.2 905.5 905.6 906.8 900.0 900.5 900.6 900.8 901.0 662.8 664.1 664.2 664.2 664.2 14687.6 14703.9 14736.1 14750.5 15606.8 13435.9 14340.6 14460.8 14535.0 14538.4 11129.4 11191.2 11234.7 11249.8 11505.3 3727.1 3732.8 3737.5 3822.1 3826.7 54221.5 55816.7 56078.2 62813.4 63206.0 11262.7 11555.1 11591.2 11635.7 11674.8 19712.8 19723.5 19738.7 19808.7 19856.8 8255.8 8356.9 8447.2 8498.2 8564.4 4457.2 4527.3 4564.9 4575.0 4576.9 3163.6 3229.1 3232.4 3236.2 3236.7 621.3 623.3 623.6 625.1 636.4 680.3 689.5 689.8 709.2 717.0 8747.7 8762.6 8788.6 8840.5 9052.4 650.7 703.7 724.3 726.1 737.5 4263.9 4271.1 4346.8 4427.8 4438.4 83904.6 84498.6 85059.0 86956.0 90363.5 75566.2 76345.6 76786.6 78133.0 79465.0 67374.0 69287.0 71306.3 72222.6 72228.0 8367.0 8467.0 8592.7 8657.6 8807.6 40629.2 40664.4 46822.8 47904.0 48133.8 40491.4 41102.6 57198.4 58352.0 62419.7 11633.8 11900.6 12146.9 12315.5 12873.0 14052.5 14392.9 14437.9 14476.6 14511.0 13296.0 13722.8 14019.4 14220.4 14298.1 13006.3 13412.5 13735.0 14053.6 14699.3 11229.1 11314.7 11449.0 11521.4 11599.8 10486.0 10598.2 10635.8 10708.4 10903.8 10290.0 10752.8 10771.7 10815.3 10854.7 06:10:15 INFO - PROCESS | 8725 | -------- Summary: end -------- 06:10:15 INFO - PROCESS | 8725 | 06:10:16 INFO - TEST-INFO | 8725: exit 0 06:10:16 INFO - TEST-OK | dromaeo_css | took 1115185ms 06:10:16 INFO - TEST-START | kraken 06:10:16 INFO - operating with platform_type : linux_ 06:10:16 INFO - Initialising browser for kraken test... 06:10:16 INFO - TEST-INFO | started process 9031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesbg0L/profile http://localhost:37755/getInfo.html) 06:10:20 INFO - PROCESS | 9031 | __metrics Screen width/height:1600/1200 06:10:20 INFO - PROCESS | 9031 | colorDepth:24 06:10:20 INFO - PROCESS | 9031 | Browser inner width/height: 1024/697 06:10:20 INFO - PROCESS | 9031 | __metrics 06:10:20 INFO - PROCESS | 9031 | 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" 06:10:20 INFO - PROCESS | 9031 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:10:21 INFO - PROCESS | 9031 | console.error: PushService: 06:10:21 INFO - PROCESS | 9031 | stateChangeProcessEnqueue: Error transitioning state 06:10:21 INFO - PROCESS | 9031 | UnknownError 06:10:21 INFO - TEST-INFO | 9031: exit 0 06:10:21 INFO - Browser initialized. 06:10:21 INFO - Running cycle 1/1 for kraken test... 06:10:21 INFO - TEST-INFO | started process 9125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesbg0L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:33 INFO - PROCESS | 9125 | RSS: Main: 142172160 06:10:33 INFO - PROCESS | 9125 | 06:10:36 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:36 INFO - PROCESS | 9125 | RSS: Main: 182996992 06:10:36 INFO - PROCESS | 9125 | 06:10:39 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-dft) 06:10:40 INFO - PROCESS | 9125 | RSS: Main: 173371392 06:10:40 INFO - PROCESS | 9125 | 06:10:42 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-fft) 06:10:43 INFO - PROCESS | 9125 | RSS: Main: 264847360 06:10:43 INFO - PROCESS | 9125 | 06:10:45 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-oscillator) 06:10:46 INFO - PROCESS | 9125 | RSS: Main: 171388928 06:10:46 INFO - PROCESS | 9125 | 06:10:48 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:48 INFO - PROCESS | 9125 | RSS: Main: 174215168 06:10:48 INFO - PROCESS | 9125 | 06:10:51 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:52 INFO - PROCESS | 9125 | RSS: Main: 212512768 06:10:52 INFO - PROCESS | 9125 | 06:10:55 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:56 INFO - PROCESS | 9125 | RSS: Main: 211341312 06:10:56 INFO - PROCESS | 9125 | 06:10:58 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37755/tests/kraken/driver.html?testName=json-parse-financial) 06:10:59 INFO - PROCESS | 9125 | RSS: Main: 210186240 06:10:59 INFO - PROCESS | 9125 | 06:11:00 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:01 INFO - PROCESS | 9125 | RSS: Main: 172552192 06:11:01 INFO - PROCESS | 9125 | 06:11:03 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:03 INFO - PROCESS | 9125 | RSS: Main: 179355648 06:11:03 INFO - PROCESS | 9125 | 06:11:05 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:06 INFO - PROCESS | 9125 | RSS: Main: 188153856 06:11:06 INFO - PROCESS | 9125 | 06:11:09 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:09 INFO - PROCESS | 9125 | RSS: Main: 196747264 06:11:09 INFO - PROCESS | 9125 | 06:11:12 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:13 INFO - PROCESS | 9125 | RSS: Main: 193601536 06:11:13 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37755/tests/kraken/driver.html?testName=ai-astar) 06:11:14 INFO - PROCESS | 9125 | RSS: Main: 244666368 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | __start_tp_report 06:11:14 INFO - PROCESS | 9125 | _x_x_mozilla_page_load 06:11:14 INFO - PROCESS | 9125 | _x_x_mozilla_page_load_details 06:11:14 INFO - PROCESS | 9125 | |i|pagename|runs| 06:11:14 INFO - PROCESS | 9125 | |0;ai-astar;103;113;111;111;111;113;112;111;111;112 06:11:14 INFO - PROCESS | 9125 | |1;audio-beat-detection;142;117;116;162;124;123;121;117;151;123 06:11:14 INFO - PROCESS | 9125 | |2;audio-dft;160;161;161;160;161;161;159;162;161;160 06:11:14 INFO - PROCESS | 9125 | |3;audio-fft;75;75;75;114;76;76;75;76;98;76 06:11:14 INFO - PROCESS | 9125 | |4;audio-oscillator;82;82;105;83;82;81;102;82;82;105 06:11:14 INFO - PROCESS | 9125 | |5;imaging-gaussian-blur;116;117;117;116;116;116;116;117;117;117 06:11:14 INFO - PROCESS | 9125 | |6;imaging-darkroom;147;145;146;146;146;145;145;145;146;145 06:11:14 INFO - PROCESS | 9125 | |7;imaging-desaturate;84;85;84;85;85;85;84;84;85;85 06:11:14 INFO - PROCESS | 9125 | |8;json-parse-financial;52;51;51;52;50;50;51;50;51;51 06:11:14 INFO - PROCESS | 9125 | |9;json-stringify-tinderbox;60;59;59;60;61;59;60;59;59;59 06:11:14 INFO - PROCESS | 9125 | |10;stanford-crypto-aes;75;78;81;75;75;74;76;75;75;75 06:11:14 INFO - PROCESS | 9125 | |11;stanford-crypto-ccm;134;135;125;129;140;123;132;121;156;130 06:11:14 INFO - PROCESS | 9125 | |12;stanford-crypto-pbkdf2;158;167;165;163;158;160;160;164;162;164 06:11:14 INFO - PROCESS | 9125 | |13;stanford-crypto-sha256-iterative;64;63;68;63;65;71;64;63;65;62 06:11:14 INFO - PROCESS | 9125 | __end_tp_report 06:11:14 INFO - PROCESS | 9125 | __start_cc_report 06:11:14 INFO - PROCESS | 9125 | _x_x_mozilla_cycle_collect,1583 06:11:14 INFO - PROCESS | 9125 | __end_cc_report 06:11:14 INFO - PROCESS | 9125 | __startTimestamp1487686274965__endTimestamp 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | ------- Summary: start ------- 06:11:14 INFO - PROCESS | 9125 | Number of tests: 14 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.86 (2.6%) stddev-sans-first:0.87 06:11:14 INFO - PROCESS | 9125 | Values: 103.0 113.0 111.0 111.0 111.0 113.0 112.0 111.0 111.0 112.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:123.50 stddev:16.18 (13.1%) stddev-sans-first:16.53 06:11:14 INFO - PROCESS | 9125 | Values: 142.0 117.0 116.0 162.0 124.0 123.0 121.0 117.0 151.0 123.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 06:11:14 INFO - PROCESS | 9125 | Values: 160.0 161.0 161.0 160.0 161.0 161.0 159.0 162.0 161.0 160.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:13.41 (17.6%) stddev-sans-first:14.01 06:11:14 INFO - PROCESS | 9125 | Values: 75.0 75.0 75.0 114.0 76.0 76.0 75.0 76.0 98.0 76.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:82.00 stddev:10.67 (13.0%) stddev-sans-first:11.05 06:11:14 INFO - PROCESS | 9125 | Values: 82.0 82.0 105.0 83.0 82.0 81.0 102.0 82.0 82.0 105.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:11:14 INFO - PROCESS | 9125 | Values: 116.0 117.0 117.0 116.0 116.0 116.0 116.0 117.0 117.0 117.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 06:11:14 INFO - PROCESS | 9125 | Values: 147.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 06:11:14 INFO - PROCESS | 9125 | Values: 84.0 85.0 84.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 06:11:14 INFO - PROCESS | 9125 | Values: 52.0 51.0 51.0 52.0 50.0 50.0 51.0 50.0 51.0 51.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 06:11:14 INFO - PROCESS | 9125 | Values: 60.0 59.0 59.0 60.0 61.0 59.0 60.0 59.0 59.0 59.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:2.08 (2.8%) stddev-sans-first:2.18 06:11:14 INFO - PROCESS | 9125 | Values: 75.0 78.0 81.0 75.0 75.0 74.0 76.0 75.0 75.0 75.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:133.00 stddev:10.08 (7.6%) stddev-sans-first:10.68 06:11:14 INFO - PROCESS | 9125 | Values: 134.0 135.0 125.0 129.0 140.0 123.0 132.0 121.0 156.0 130.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:163.50 stddev:3.03 (1.9%) stddev-sans-first:2.83 06:11:14 INFO - PROCESS | 9125 | Values: 158.0 167.0 165.0 163.0 158.0 160.0 160.0 164.0 162.0 164.0 06:11:14 INFO - PROCESS | 9125 | 06:11:14 INFO - PROCESS | 9125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:2.74 (4.2%) stddev-sans-first:2.89 06:11:14 INFO - PROCESS | 9125 | Values: 64.0 63.0 68.0 63.0 65.0 71.0 64.0 63.0 65.0 62.0 06:11:14 INFO - PROCESS | 9125 | -------- Summary: end -------- 06:11:14 INFO - PROCESS | 9125 | 06:11:16 INFO - TEST-INFO | 9125: exit 0 06:11:16 INFO - TEST-OK | kraken | took 60056ms 06:11:16 INFO - SUITE-END | took 1175s 06:11:16 INFO - Completed test suite (00:19:35) 06:11:16 INFO - javascript benchmark 06:11:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3193.6486986431487, 3223.6131664200284, 3239.2063944333636, 3251.9349613007757, 3265.167382317509, 5397.4062853086125, 5547.861303467415, 5565.387807341189, 5565.777368905239, 5575.052241119004, 5528.0, 5545.944540554593, 5553.7778488860395, 5561.332640083186, 5569.610127291091, 5008.023435430102, 5036.496350364952, 5071.391433028023, 5084.720340381277, 5144.048351055067, 4955.975220123894, 4993.201087825949, 5080.568151707109, 5133.5893128549815, 5137.743112844361, 5007.273945277932, 5008.3238762767105, 5053.84838454847, 5060.6963582185, 5092.796288148488, 5045.798168073273, 5060.544550990428, 5123.2315152727015, 5123.974380128113, 5156.793728250866, 4848.248521479177, 5012.323336349619, 5039.294498770175, 5065.569426598743, 5093.1087059764395, 5371.543418809367, 5396.460353964611, 5458.590605704588, 5502.614816962814, 5531.834044978657, 5918.940810591925, 5942.554308426886, 5957.434043765836, 5959.165716799652, 5960.552958528127, 5781.132830075522, 5995.490383317423, 6000.159977603095, 6015.428534289235, 6017.247844019497, 5421.539169170625, 5507.03626865297, 5555.916661250044, 5566.081596536607, 5645.604807663506, 6120.846978825476, 6125.663088530174, 6131.110988906673, 6134.263888333428, 6142.385761423822, 5869.618474799125, 5869.941300587025, 5874.559408044413, 5874.882502350015, 5888.175655408247, 5706.686132262683, 5723.885522289531, 5776.56675749312, 5818.389069147764, 5827.941720582825, 5810.099434587646, 5855.765769369177, 5858.062709966385, 5881.823545293648, 5892.057270836645, 5836.737346819404, 5845.181674565564, 5845.912311315334, 5848.766049357978, 5855.531557475391, 4489.304157855538, 4528.43394575678, 4532.32015197723, 4555.362249285103, 4590.563896429834, 4081.8571350002608, 4083.972700397301, 4085.428040074392, 4094.0788322627172, 4109.732867363612, 5636.802711905146, 5640.605157638925, 5643.0, 5645.096784514458, 5654.802081927195, 5712.11462223356, 5763.625364351304, 5838.241028666246, 5870.178175055496, 5950.285965684146, 5626.803061892814, 5685.914711279334, 5689.203511508392, 5711.400302968212, 5716.914246286309, 5037.345145131109, 5068.873278168002, 5069.062223488592, 5081.74591270435, 5144.61415393847, 5917.970410148007, 5952.761889524544, 6182.1345011698395, 6196.256449226032, 6199.256089269316, 5828.038373668467, 5877.823665290048, 5880.500157486662, 5925.674087925206, 5955.0, 6142.109394137914, 6145.293291271561, 6150.077488376779, 6150.354212807591, 6152.600080994721, 5648.096304591246, 5766.740496677576, 5818.418158184148, 5824.796132135355, 5832.708364581669, 5786.218860453953, 5828.358880523224, 5864.560157988082, 5865.149553314831, 5977.7310021050025, 5764.337101233412, 5803.47768700819, 5819.039858423482, 5823.912641310469, 5826.096954971986, 5771.711414429178, 5776.220210271559, 5776.624519406225, 5776.7111644418455, 5781.797637082682, 5494.890102198014, 5519.668819870821, 5740.0815869460685, 5771.336296325809, 5786.103154011135, 5927.0, 5929.407059294209, 5930.11048342752, 5930.584859059824, 5943.1679564861815, 5475.780968761364, 5516.0, 5779.450952159538, 5781.94218057814, 5798.043322851682], "value": 5458.9871513152475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.5360888093965, 616.1558664629457, 645.0936434309793, 651.0917270407781, 657.3459407889151, 32870.178245543844, 45560.31659525105, 46766.766166169204, 46797.298040529335, 46857.06285874281, 46385.0, 46726.29910551345, 46933.29600056002, 46952.76523617386, 46991.29513057307, 8433.578321083953, 8792.516411597375, 8942.239909607692, 8948.284137269004, 8949.552522373855, 8388.874166887472, 10484.947575262113, 10717.732056698605, 10720.892791072067, 11057.336559806437, 10940.617078402258, 10985.890141098607, 10991.61529346473, 10992.17558683098, 10993.175511836644, 10715.303505272172, 10769.084627806646, 10775.353478791258, 10779.407132607743, 10782.622608208754, 10747.570097196103, 10807.78384432307, 10813.783724325549, 10816.67549973502, 10818.837717434244, 44060.118797623865, 44354.334684979425, 44375.55624443747, 44407.33388999168, 44410.0, 3698.9630103698887, 3793.715471339661, 3873.4383514390256, 3892.785896775676, 4048.6153815387784, 32303.35393292121, 32617.0, 33248.66751332504, 33396.0, 33605.49591756125, 4472.46330440346, 4484.260097083978, 4596.816127354902, 4761.928571071437, 4801.375821143229, 353347.0, 355026.0, 355382.0, 355770.99999999744, 357880.0, 61280.0, 61319.38680613137, 61743.07385389223, 61806.0, 61877.690611546655, 63266.367336326046, 64093.35906640874, 64203.67898160479, 64243.0, 64247.0, 17339.739903901453, 17545.736813947802, 17545.736813947802, 17558.122093895254, 17576.384826531266, 11057.889421105847, 11408.600698975662, 13095.869041309656, 13128.343582821011, 13148.145370550883, 17609.911950440164, 18364.540886477676, 18502.167402466923, 18537.35119270819, 18646.440606781547, 6382.7234553089565, 6402.119046429032, 6474.223093228748, 6511.804645860631, 6543.25613929897, 1003.8092762375126, 1034.7361422837128, 1130.4404319861721, 1141.5662048421548, 1154.163231657042, 31529.52705709416, 32095.679043209737, 32156.0, 32284.19289517781, 32598.511022334686, 1099.5656715597295, 1124.1288001798507, 1135.137295655308, 1136.4772204785727, 1156.3119943633524, 14781.63045923839, 17119.74320385195, 17631.559211019572, 18023.549411264823, 18444.170012349477, 489835.0, 491763.0, 493660.0, 493747.0, 494834.0, 61104.0, 61196.0, 61209.38790612126, 61236.693816530635, 61559.076613850826, 1291.3865913690922, 1317.8089177069462, 1363.4886917405972, 1388.8750012498924, 1417.340936464549, 29059.12822615325, 32712.672873270963, 32812.0, 32983.01050968475, 33419.16452088717, 52637.0, 53137.7343113282, 53164.73417632887, 53235.0, 53336.19995700145, 386064.0, 387978.0, 388601.0, 388674.0, 388778.0, 41433.58566414297, 42668.0, 42790.57209427866, 43034.78482607567, 43164.784176078916, 47318.29022564733, 48698.51301487081, 49017.0, 49035.0, 49285.753571231915, 41758.0, 42264.577354227295, 42498.575014250695, 43002.0, 44110.77944610256, 41183.7940810294, 41322.79338603288, 42086.78956605197, 42785.144297113264, 43155.78422107869, 41301.586984129775, 42278.0, 42941.141177176905, 43135.0, 44599.55400445954, 33727.0, 37401.0, 40184.59815401809, 40481.797591011855, 41241.38137927873, 27405.0, 27765.722342776313, 27882.721172788013, 27913.302167445163, 28107.578386323814], "value": 21070.28390164566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.1094712788198, 419.6600753389753, 419.96640268778503, 420.6760794188474, 442.84943119339437, 18445.53886152845, 19266.710999334988, 19834.305799297028, 19889.3038743644, 20055.29806456774, 18954.52613684655, 19252.518687032796, 19401.90299048506, 19484.318048868256, 19492.9025354873, 5454.12733962567, 5784.0, 5819.0, 5822.417758224186, 5830.970845145768, 5635.915461268084, 5663.688497132656, 5806.187133801272, 5816.040353341694, 5817.040188368914, 5807.941920580783, 5814.273215848019, 5838.503727183194, 5843.503302219296, 5848.41515848416, 5740.741666625012, 5824.417558244163, 5827.067669172912, 5832.854178645525, 5978.970105149447, 5903.852403689899, 5907.438793314628, 5908.231929849135, 5917.852053698649, 5928.318243402021, 14043.1574105554, 21737.23919662804, 22203.66694499584, 22340.441488962744, 23361.065557377686, 2404.89177986991, 2478.4547399572066, 2498.675172227617, 2500.5124000819847, 2736.0287098080094, 9789.97205293441, 10120.595176192943, 10310.639127630571, 10645.93540645937, 10683.893161068445, 1886.6038131992298, 1890.6029733755927, 1917.7411049508278, 1922.0870086708842, 1935.7096435534781, 82229.58885205536, 82864.17135828685, 83177.58411207965, 83281.0, 83963.58018209931, 10940.890591093987, 10988.395638239974, 11094.334339939629, 11193.328400296008, 11340.546378144782, 15995.600109997344, 16020.118893460738, 16049.759253611206, 16104.275307611186, 16165.434209802836, 7980.640871160812, 8212.917870821335, 8275.710350137717, 8442.0, 8452.661893524313, 7851.254130857559, 7854.567998760123, 7890.8816367754525, 8030.959845200853, 8098.514089154552, 4651.604613607814, 4711.387519622495, 4783.354247176656, 4836.830710925101, 4966.8758281043265, 1948.7271781950537, 1969.7242386065961, 2018.1422895269452, 2040.40828159832, 2068.865523740952, 897.3090720145451, 973.776031512756, 992.6327258914248, 1006.6124542051363, 1026.0, 18345.908270458563, 18675.81324186768, 18742.531436713918, 18783.624327513648, 19064.2374305029, 984.8325784616633, 1001.5743309093751, 1014.7209517382631, 1019.9235057370727, 1029.0224286927448, 9930.453825039547, 10524.105451036748, 10530.157587393143, 10550.683479495627, 10558.0, 486450.0, 490203.0, 490337.0, 491664.0, 493440.0, 80906.19093809104, 89872.0, 90643.54678226566, 90784.0, 93369.53315233381, 1027.1012863744372, 1065.6856227412932, 1105.6130354375905, 1106.950187241576, 1109.0295991007868, 15915.283812228708, 16549.50351489457, 16726.916365418096, 16734.748978765572, 17003.574910627332, 39935.20129597334, 40639.0, 40705.79647101746, 41365.58634413617, 41923.0, 54601.72699136479, 55268.0, 55500.0, 56867.715661421425, 57332.0, 5575.944240557705, 7686.654100565376, 8390.119037500974, 8552.0, 8643.870341945001, 11753.05975521939, 11834.171607987702, 11958.282503049497, 12445.066620003718, 12597.559085431965, 9743.0, 10297.485125743833, 10755.516001779783, 11069.833952490559, 11248.351121237636, 10930.617428389969, 10945.069669078217, 11172.162087843606, 11477.139214559109, 11553.82669259945, 5204.869878253074, 5997.670128142994, 9879.851802223116, 11148.219624626523, 11334.60328888485, 8075.152109028468, 8354.248117669438, 8510.914890851012, 8745.169208925143, 8775.166359195866, 8454.788630284293, 10799.514021868878, 10920.508577114208, 11122.277051991594, 11315.773684526428], "value": 9082.144613852723, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.820363352764, 1508.1403599948028, 1536.8780790023284, 1673.155056696368, 1783.072802142885, 7866.803329916748, 8452.197041281077, 8713.30293576514, 8717.0411254762, 8900.8664870027, 8772.0, 8853.070427605106, 8859.512726800023, 8862.06948270432, 8867.60095795689, 2441.8779061046966, 2468.753124687526, 2469.0247352295924, 2473.492933948545, 2475.405902583385, 2361.2325994051916, 2439.097533912446, 2439.451123497208, 2440.511897620483, 2448.2288079255068, 2426.9029238830512, 2432.659427680126, 2461.212412028143, 2462.249014050714, 2469.09877894569, 2340.9297721068397, 2344.859308441499, 2360.9763902361015, 2363.52729454109, 2395.5927492326173, 2291.702078729771, 2351.7413084560685, 2369.336585755991, 2373.679553260305, 2374.5963186258205, 7893.8026549336155, 8126.471779334324, 8742.956285218597, 8810.559472026438, 8943.955280223558, 5367.865803354908, 5527.115661494182, 5540.9168862467095, 5609.214709940612, 5616.66300022, 3350.2964377480757, 3395.337909107725, 3462.0652423845672, 3472.0625431133453, 3541.557305336833, 1105.5190991918462, 1106.0874778307927, 1113.0817075912405, 1118.4519585403093, 1124.2523721725042, 12523.812142817866, 12531.498740050387, 12557.623271301876, 12597.307148106851, 12608.495660173581, 4750.168720473972, 4775.188218002948, 4798.640101992364, 4950.3069570260195, 5028.421731500851, 10498.31760935552, 10519.211059170593, 10521.263511554118, 10531.94734026325, 10541.578336866593, 5479.479449452296, 5491.0, 5492.80775172867, 5499.367572729107, 5501.5323697486165, 4838.225883858566, 4991.301217829507, 5045.5459008689395, 5072.873178170576, 5073.213651883964, 4108.02924025614, 4159.064210552601, 4215.683823713233, 4254.404383386328, 4344.218040752695, 1349.5411560069624, 1354.4379082680578, 1363.5432130236284, 1365.9726805463836, 1370.3353873371407, 909.3679892474798, 916.3585490156917, 927.972160835176, 930.8570149921602, 949.3354651743807, 5512.614117011851, 5825.657747578004, 5832.591718579659, 5844.736986835517, 6123.326434092246, 910.2990697163148, 940.5391358234552, 945.1399226703804, 968.5833844557873, 971.9465429401309, 3682.8710995115043, 3786.583475817658, 3797.810109494514, 3836.693064554829, 3894.6884249259992, 9967.501624918725, 10347.017033381817, 10443.84334234987, 10589.0, 10958.178136639784, 11230.438478076063, 11239.55041798319, 11249.887501125047, 11253.212275140826, 11253.324800511995, 8086.191380861985, 8258.463199892109, 8265.132161123116, 8265.214804593674, 8270.627821748036, 5580.162975553537, 5652.349979752381, 5707.971460142673, 5757.424257574209, 5817.767289308549, 9686.709398717769, 9698.515074246401, 9752.219822414048, 9806.705798826046, 9809.068138526829, 9826.4104153751, 9827.361221520865, 10161.237907156845, 10164.440955747505, 10517.316374435637, 7835.49069310493, 7937.801554960941, 7938.761837144895, 7954.482958607672, 7984.361251100015, 8329.12544182852, 8374.63816963417, 8404.831903362021, 8467.57662116904, 8475.49147051179, 7357.0, 7494.737684181027, 7511.0, 7692.884606731015, 7737.613119344122, 7466.178720340867, 7521.285477879593, 7572.7728168155045, 7640.426967977312, 7753.767386978399, 6643.667816609053, 6766.661666916733, 6848.657567121723, 7106.182788979334, 7147.714091436284, 5017.799288028438, 5073.416557095834, 5120.948790512047, 5155.381354237516, 5183.844484665466, 4997.5002499749735, 5020.49795020495, 5059.822906198413, 5167.715775632226, 5188.870278243074], "value": 4674.346187764921, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.4085686620947, 333.24353717062286, 334.6686780087712, 345.7787016309562, 353.21233648962806, 5319.787208511664, 5346.91979620306, 5412.4046354900975, 5447.45525447455, 5476.205950137228, 5289.285946397235, 5299.947000529994, 5312.203169524573, 5324.307839980806, 5331.946680533193, 4205.053862880843, 4213.831446742134, 4232.74603523788, 4233.491980962289, 4245.257080010986, 3875.670568001723, 3970.094354709741, 4126.071633882382, 4138.0, 4156.127213285198, 4090.97954510227, 4108.650764685005, 4112.342025275956, 4113.136241389312, 4142.855000074998, 4128.710990230685, 4133.4499562664005, 4133.813978370966, 4139.441175441307, 4148.958510414887, 3467.4105402081705, 3536.9115772105647, 3578.3022310649435, 3643.0710168907026, 3659.597444281127, 5161.922571161435, 5171.120909445403, 5188.45521220274, 5198.194279886624, 5199.818006369796, 4724.055188962187, 4724.4094488188975, 4738.507370178383, 4756.312683333906, 4763.14263432582, 5348.171033489815, 5446.210299506589, 5478.424765399615, 5484.0, 5487.945120548783, 3974.6621537169376, 3984.5417776955733, 3992.740471869319, 3995.380715989026, 3997.300472417315, 5703.771849126071, 5722.570807189436, 5730.828075157752, 5748.45389687979, 5753.827385178452, 3907.2185562886966, 4089.5705950875326, 4121.402396652528, 4121.464209652726, 4130.0, 4148.23257697327, 4155.210510003089, 4164.271252530855, 4169.958300416957, 4171.20747058058, 4709.835155769531, 4717.858464246078, 4721.622270218443, 4723.456802467692, 4733.928991065137, 5402.6758394496455, 5477.247280870083, 5535.1180598595865, 5551.417101204315, 5552.444755524415, 1375.910565813219, 1376.827896512936, 1382.7096309774859, 1397.538812191974, 1398.189050350794, 905.3029167540957, 952.7999120184838, 955.3121752338305, 957.6736220334886, 959.5250351076122, 5167.896642067213, 5235.0, 5236.345456817898, 5271.42014378418, 5275.0, 5607.66354018752, 5638.605297629127, 5707.315122185281, 5728.971355143198, 5749.655020698771, 5453.972730136324, 5457.290552228185, 5467.972660136674, 5480.150576660624, 5499.835004949858, 2877.438899414636, 2888.7400133988044, 2925.7074292570996, 2931.530955047182, 2931.9560206596916, 5597.692126932976, 5684.431556844283, 5701.522071536359, 5708.942910570924, 5718.25662663851, 5441.29263195782, 5593.832185034374, 5603.7478313475995, 5615.775368985276, 5629.268195134607, 5683.69275066737, 5705.771769129271, 5752.597318187771, 5756.94243057564, 5762.510186634099, 5484.698341591251, 5509.972450137724, 5513.696746678971, 5520.199571062093, 5525.309336332958, 5290.761915713725, 5441.27936031984, 5461.9180712290145, 5472.726363681721, 5476.397596264328, 5737.34020587621, 5753.510951569164, 5757.712114394348, 5762.798302059407, 5772.94227057724, 3996.300647386754, 4005.2790497710694, 4013.819378127933, 4016.2930754429835, 4022.577629348876, 5332.146856502941, 5340.332458442695, 5402.567794576503, 5449.918251226156, 5536.806211782568, 5397.9460205397445, 5412.594055445778, 5420.918686219631, 5423.674579525241, 5435.266239057834, 5360.195970604441, 5379.462053794589, 5383.246345511553, 5398.2982212312145, 5431.6740995540395, 5101.668391554537, 5339.3058902342445, 5350.5184533392185, 5375.543078838343, 5384.865378365572, 5387.86530336729, 5413.675179489243, 5443.122122867604, 5455.61810673265, 5460.535854452257, 5365.980463711882, 5389.784408623611, 5489.39616642161, 5503.834884953458, 5505.201745746925], "value": 4197.004990157083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.9453826410875, 809.101896894447, 848.9915100848991, 849.2144766091368, 869.5739087846957, 15313.464028758995, 16003.679926401464, 16053.518394448185, 16059.839401605981, 16196.271167797448, 13868.583942481742, 13873.098248613833, 13879.722405551884, 13901.304934753272, 13927.791083133736, 707.7381368893516, 725.4994054102652, 827.1397746343811, 832.3507664022072, 856.002756788344, 846.1115828380207, 857.8027053777635, 857.9356548258875, 857.9828403431927, 858.635080090962, 903.421810041574, 905.2441211588332, 905.4793493741092, 905.597009330848, 906.7823722306665, 900.045951291633, 900.4507250577143, 900.5812297281763, 900.7883147460342, 900.9774755631063, 662.7812821768805, 664.0537234440951, 664.2062735031639, 664.2361284522789, 664.2394458345216, 14687.63280917975, 14703.852961470355, 14736.115833050051, 14750.483733069399, 15606.765898511532, 13435.932820335933, 14340.64148396288, 14460.770834479083, 14535.0, 14538.418463261456, 11129.387883666395, 11191.216614836965, 11234.662960111209, 11249.83125253122, 11505.252158609663, 3727.0682329417646, 3732.757370770891, 3737.5141231639714, 3822.0827001519433, 3826.7321287509885, 54221.45778542203, 55816.72091639556, 56078.15882761762, 62813.37186628121, 63206.0, 11262.662120136409, 11555.075593952464, 11591.24656897299, 11635.709107272385, 11674.824877626843, 19712.802871971096, 19723.50691232702, 19738.70391944122, 19808.70286945697, 19856.801431985783, 8255.834883302301, 8356.874646880302, 8447.155284471504, 8498.192671696179, 8564.400491965627, 4457.175422546774, 4527.253003254492, 4564.931526027112, 4575.039241759201, 4576.931346029813, 3163.620365556148, 3229.0958531611186, 3232.434323993292, 3236.2233064064453, 3236.660150684191, 621.293700220829, 623.2863371439677, 623.5603899251017, 625.0655270370734, 636.424036247197, 680.3298750730527, 689.5276735436242, 689.7896141676837, 709.2269426325227, 716.9713211471587, 8747.693830715894, 8762.561871906379, 8788.648454061893, 8840.513771742488, 9052.366334356664, 650.677914432359, 703.736098962889, 724.3010494872368, 726.1395246632757, 737.5279820914619, 4263.893402664959, 4271.124419493996, 4346.8043938022865, 4427.756473393994, 4438.370103601856, 83904.58047709844, 84498.57750711207, 85059.0, 86956.0, 90363.54818225867, 75566.24433755701, 76345.61827190829, 76786.61606692043, 78133.0, 79465.0, 67374.0, 69287.0, 71306.28693713101, 72222.63888680523, 72227.99999999895, 8366.958165209378, 8467.0, 8592.742217733477, 8657.61040753155, 8807.647694092164, 40629.1874162521, 40664.39003414892, 46822.76588617035, 47904.0, 48133.75933120312, 40491.39262911, 41102.58897411107, 57198.42801572097, 58352.0, 62419.6879015602, 11633.76732465329, 11900.642980710592, 12146.878531214576, 12315.507379704712, 12873.0, 14052.508162214273, 14392.928035360175, 14437.85562144407, 14476.565703028504, 14511.0, 13296.0, 13722.794158087836, 14019.369128389042, 14220.36008379646, 14298.142111473346, 13006.349682516025, 13412.530561430303, 13734.969877259045, 14053.648658783612, 14699.265036748333, 11229.101671866069, 11314.717132071764, 11449.0, 11521.366324852213, 11599.826002610136, 10486.0, 10598.20513461509, 10635.840462393226, 10708.355149973944, 10903.78192436131, 10290.0, 10752.784944300915, 10771.676849694522, 10815.297005694605, 10854.728631783953], "value": 7120.793661451245, "unit": "score"}], "name": "dromaeo_css", "value": 7256.061884233723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 111.0, 111.0, 113.0, 112.0, 111.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 116.0, 162.0, 124.0, 123.0, 121.0, 117.0, 151.0, 123.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 159.0, 162.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 114.0, 76.0, 76.0, 75.0, 76.0, 98.0, 76.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 105.0, 83.0, 82.0, 81.0, 102.0, 82.0, 82.0, 105.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 52.0, 50.0, 50.0, 51.0, 50.0, 51.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 61.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 81.0, 75.0, 75.0, 74.0, 76.0, 75.0, 75.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 125.0, 129.0, 140.0, 123.0, 132.0, 121.0, 156.0, 130.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 167.0, 165.0, 163.0, 158.0, 160.0, 160.0, 164.0, 162.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 68.0, 63.0, 65.0, 71.0, 64.0, 63.0, 65.0, 62.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1463.6000000000001, "alertThreshold": 2.0}]} 06:11:16 INFO - Return code: 0 06:11:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:11:16 INFO - # TBPL SUCCESS # 06:11:16 INFO - Running post-action listener: _resource_record_post_action 06:11:16 INFO - [mozharness: 2017-02-21 14:11:16.747495Z] Finished run-tests step (success) 06:11:16 INFO - Running post-run listener: _resource_record_post_run 06:11:16 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2215936; Write bytes: 329621504; Read time: 788; Write time: 418156 06:11:16 INFO - TinderboxPrint: CPU usage
13.0% 06:11:16 INFO - TinderboxPrint: I/O read bytes / time
2,215,936 / 788 06:11:16 INFO - TinderboxPrint: I/O write bytes / time
329,621,504 / 418,156 06:11:16 INFO - TinderboxPrint: CPU idle
8,263.2 (87.0%) 06:11:16 INFO - TinderboxPrint: CPU user
1,190.1 (12.5%) 06:11:16 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:16 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 108077056; Read time: 0; Write time: 151052 06:11:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 2113536; Write bytes: 221544448; Read time: 280; Write time: 267104 06:11:17 INFO - Running post-run listener: _upload_blobber_files 06:11:17 INFO - Blob upload gear active. 06:11:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:17 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 06:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:11:17 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:11:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:11:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:18 INFO - (blobuploader) - INFO - Done attempting. 06:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:11:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:21 INFO - (blobuploader) - INFO - Done attempting. 06:11:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:11:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:11:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:22 INFO - (blobuploader) - INFO - Done attempting. 06:11:22 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:22 INFO - Return code: 0 06:11:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb4a2dcc76d1e8c9481caf848a13ae799f68cad9b28662da0e0050d811fa933b9b18ee63f2f38490ec95b6b72e57bb0fcc63dff409777b0e5cd020b5351c2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2f49d2ed4ef219f24bc847dc279cf9310ce45e6fb13ab10e262578ce1df9ad3abcc28241a42582566fc9328f83e448e0204829ef1189a0812a33a0c3b2224e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0bb4c1c88f7ab0f76286a4c274954644ff95dbc3310654616046593bacafcd02dd7990eed8f6098ddca573a0c990829e8e708270d9e1d74af852428c09016a"} 06:11:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:22 INFO - Contents: 06:11:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb4a2dcc76d1e8c9481caf848a13ae799f68cad9b28662da0e0050d811fa933b9b18ee63f2f38490ec95b6b72e57bb0fcc63dff409777b0e5cd020b5351c2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2f49d2ed4ef219f24bc847dc279cf9310ce45e6fb13ab10e262578ce1df9ad3abcc28241a42582566fc9328f83e448e0204829ef1189a0812a33a0c3b2224e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0bb4c1c88f7ab0f76286a4c274954644ff95dbc3310654616046593bacafcd02dd7990eed8f6098ddca573a0c990829e8e708270d9e1d74af852428c09016a"} 06:11:22 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:22 INFO - Copying logs to upload dir... 06:11:22 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.098815 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-21 06:11:20.527241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 06:11:20.531460) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb4a2dcc76d1e8c9481caf848a13ae799f68cad9b28662da0e0050d811fa933b9b18ee63f2f38490ec95b6b72e57bb0fcc63dff409777b0e5cd020b5351c2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2f49d2ed4ef219f24bc847dc279cf9310ce45e6fb13ab10e262578ce1df9ad3abcc28241a42582566fc9328f83e448e0204829ef1189a0812a33a0c3b2224e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0bb4c1c88f7ab0f76286a4c274954644ff95dbc3310654616046593bacafcd02dd7990eed8f6098ddca573a0c990829e8e708270d9e1d74af852428c09016a"} build_url:https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/QW9x0vlvQRyymIRhvHhmOA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/deb4a2dcc76d1e8c9481caf848a13ae799f68cad9b28662da0e0050d811fa933b9b18ee63f2f38490ec95b6b72e57bb0fcc63dff409777b0e5cd020b5351c2f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e2f49d2ed4ef219f24bc847dc279cf9310ce45e6fb13ab10e262578ce1df9ad3abcc28241a42582566fc9328f83e448e0204829ef1189a0812a33a0c3b2224e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef0bb4c1c88f7ab0f76286a4c274954644ff95dbc3310654616046593bacafcd02dd7990eed8f6098ddca573a0c990829e8e708270d9e1d74af852428c09016a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 06:11:20.556540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 06:11:20.556909) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1487685045.57136-941342328 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 06:11:20.641155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 06:11:20.641503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 06:11:20.641840) ========= ========= Total master_lag: 0.16 =========