builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-013 starttime: 1483979073.04 results: success (0) buildid: 20170109063808 builduid: a7a9b49f365d4acaa2c116a54b2d1900 revision: bb6a56511146b31c57a2a3c792ccd464891b0593 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.044401) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.044876) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.045178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.056324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.056597) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 08:24:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2017-01-09 08:24:33 (210 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.186943) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.187508) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019820 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.238104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:33.238474) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb6a56511146b31c57a2a3c792ccd464891b0593 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb6a56511146b31c57a2a3c792ccd464891b0593 --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=9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 08:24:34,042 truncating revision to first 12 chars 2017-01-09 08:24:34,042 Setting DEBUG logging. 2017-01-09 08:24:34,042 attempt 1/10 2017-01-09 08:24:34,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb6a56511146?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 08:24:34,640 unpacking tar archive at: mozilla-aurora-bb6a56511146/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:34.144837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:34.145224) ========= script_repo_revision: bb6a56511146b31c57a2a3c792ccd464891b0593 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:34.145679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:34.145969) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 08:24:34.156784) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-09 08:24:34.157342) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:35 INFO - MultiFileLogger online at 20170109 08:24:35 in /builds/slave/test 08:24:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:24:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:35 INFO - {'append_to_log': False, 08:24:35 INFO - 'base_work_dir': '/builds/slave/test', 08:24:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:24:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:35 INFO - 'branch': 'Mozilla-Aurora', 08:24:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:35 INFO - 'config_files': ('talos/linux_config.py',), 08:24:35 INFO - 'default_actions': ('clobber', 08:24:35 INFO - 'read-buildbot-config', 08:24:35 INFO - 'download-and-extract', 08:24:35 INFO - 'populate-webroot', 08:24:35 INFO - 'create-virtualenv', 08:24:35 INFO - 'install', 08:24:35 INFO - 'run-tests'), 08:24:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:35 INFO - 'download_minidump_stackwalk': True, 08:24:35 INFO - 'download_symbols': 'ondemand', 08:24:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:35 INFO - 'installer_path': 'installer.exe', 08:24:35 INFO - 'log_level': 'info', 08:24:35 INFO - 'log_name': 'talos', 08:24:35 INFO - 'log_to_console': True, 08:24:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:35 INFO - 'opt_config_files': (), 08:24:35 INFO - 'pip_index': False, 08:24:35 INFO - 'sps_profile': False, 08:24:35 INFO - 'sps_profile_interval': 0, 08:24:35 INFO - 'suite': 'dromaeojs', 08:24:35 INFO - 'system_bits': '32', 08:24:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:35 INFO - 'title': 'talos-linux64-ix-013', 08:24:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:35 INFO - 'use_talos_json': True, 08:24:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:35 INFO - 'work_dir': 'build'} 08:24:35 INFO - [mozharness: 2017-01-09 16:24:35.062824Z] Running clobber step. 08:24:35 INFO - Running pre-action listener: _resource_record_pre_action 08:24:35 INFO - Running main action method: clobber 08:24:35 INFO - rmtree: /builds/slave/test/build 08:24:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:36 INFO - Running post-action listener: _resource_record_post_action 08:24:36 INFO - [mozharness: 2017-01-09 16:24:36.129505Z] Finished clobber step (success) 08:24:36 INFO - [mozharness: 2017-01-09 16:24:36.129603Z] Running read-buildbot-config step. 08:24:36 INFO - Running pre-action listener: _resource_record_pre_action 08:24:36 INFO - Running main action method: read_buildbot_config 08:24:36 INFO - Using buildbot properties: 08:24:36 INFO - { 08:24:36 INFO - "project": "", 08:24:36 INFO - "product": "firefox", 08:24:36 INFO - "script_repo_revision": "production", 08:24:36 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:24:36 INFO - "repository": "", 08:24:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:24:36 INFO - "buildid": "20170109063808", 08:24:36 INFO - "pgo_build": "True", 08:24:36 INFO - "basedir": "/builds/slave/test", 08:24:36 INFO - "buildnumber": 687, 08:24:36 INFO - "slavename": "talos-linux64-ix-013", 08:24:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:24:36 INFO - "platform": "ubuntu64_hw", 08:24:36 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:24:36 INFO - "branch": "mozilla-aurora", 08:24:36 INFO - "repo_path": "releases/mozilla-aurora", 08:24:36 INFO - "revision": "bb6a56511146b31c57a2a3c792ccd464891b0593", 08:24:36 INFO - "stage_platform": "linux64-pgo", 08:24:36 INFO - "builduid": "a7a9b49f365d4acaa2c116a54b2d1900", 08:24:36 INFO - "slavebuilddir": "test" 08:24:36 INFO - } 08:24:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:24:36 INFO - Running post-action listener: _resource_record_post_action 08:24:36 INFO - [mozharness: 2017-01-09 16:24:36.132051Z] Finished read-buildbot-config step (success) 08:24:36 INFO - [mozharness: 2017-01-09 16:24:36.132139Z] Running download-and-extract step. 08:24:36 INFO - Running pre-action listener: _resource_record_pre_action 08:24:36 INFO - Running main action method: download_and_extract 08:24:36 INFO - mkdir: /builds/slave/test/build/tests 08:24:36 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')]} 08:24:36 INFO - trying https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:24:36 INFO - Downloading https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:24:36 INFO - Downloaded 1361 bytes. 08:24:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:24:36 INFO - Using the following test package requirements: 08:24:36 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:24:36 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:36 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:24:36 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'jsshell-linux-x86_64.zip'], 08:24:36 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:36 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:24:36 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:24:36 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:24:36 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:36 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:36 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:36 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:24:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:36 INFO - Fetch https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:24:37 INFO - Http code: 200 08:24:37 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 08:24:37 INFO - x-amz-cf-id: 3-ilkmOuUgMf7v0ocRLiuLJi9krS3rlM1YjcQR9qE-jKJuDUGZRJlA== 08:24:37 INFO - x-amz-version-id: 1628ZE1qPg4EnS_cHcDvxX.ZhSUHMBWs 08:24:37 INFO - Expected file size: 21943813 08:24:37 INFO - Obtained file size: 21943813 08:24:41 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:24:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:24:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:24:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:24:42 INFO - Http code: 200 08:24:42 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 08:24:42 INFO - x-amz-cf-id: AVap532UBVwZDUesMmCaYX94ij9UHcJRdP9XQZ_aWmwfH6GA_Mf0SA== 08:24:42 INFO - x-amz-version-id: 1628ZE1qPg4EnS_cHcDvxX.ZhSUHMBWs 08:24:42 INFO - Expected file size: 21943813 08:24:42 INFO - Obtained file size: 21943813 08:24:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:24:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:24:46 INFO - Fetch https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:24:47 INFO - Http code: 200 08:24:47 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 08:24:47 INFO - x-amz-cf-id: 3k-uETBB7IxXgHykT_i4rRZwjjlf9LZO44NaRCvZRBLRBKkh3Pc3Tw== 08:24:47 INFO - x-amz-version-id: 2J40oP.D1aQ8eKXIDstL72HmeaFyKyH1 08:24:47 INFO - Expected file size: 14409038 08:24:47 INFO - Obtained file size: 14409038 08:24:47 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')]} 08:24:47 INFO - trying https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:24:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:24:49 INFO - Downloaded 64081383 bytes. 08:24:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:24:49 INFO - mkdir: /builds/slave/test/properties 08:24:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:49 INFO - Contents: 08:24:49 INFO - build_url:https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:24:49 INFO - Running post-action listener: _resource_record_post_action 08:24:49 INFO - Running post-action listener: set_extra_try_arguments 08:24:49 INFO - [mozharness: 2017-01-09 16:24:49.755984Z] Finished download-and-extract step (success) 08:24:49 INFO - [mozharness: 2017-01-09 16:24:49.756209Z] Running populate-webroot step. 08:24:49 INFO - Running pre-action listener: _resource_record_pre_action 08:24:49 INFO - Running main action method: populate_webroot 08:24:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:49 INFO - '--tppagecycles', 08:24:49 INFO - '7'], 08:24:49 INFO - 'tests': ['tsvgm']}}, 08:24:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:24:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:24:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:24:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['damp', 'tps']}, 08:24:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'tests': ['damp', 'tps']}, 08:24:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['dromaeo_dom']}, 08:24:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['basic_compositor_video']}, 08:24:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:24:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['a11yr', 08:24:49 INFO - 'ts_paint', 08:24:49 INFO - 'tpaint', 08:24:49 INFO - 'sessionrestore', 08:24:49 INFO - 'sessionrestore_no_auto_restore', 08:24:49 INFO - 'tabpaint']}, 08:24:49 INFO - 'other-e10s': {'tests': ['a11yr', 08:24:49 INFO - 'ts_paint', 08:24:49 INFO - 'tpaint', 08:24:49 INFO - 'sessionrestore', 08:24:49 INFO - 'sessionrestore_no_auto_restore', 08:24:49 INFO - 'tabpaint']}, 08:24:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:24:49 INFO - 'ts_paint', 08:24:49 INFO - 'tpaint', 08:24:49 INFO - 'sessionrestore', 08:24:49 INFO - 'sessionrestore_no_auto_restore', 08:24:49 INFO - 'tabpaint']}, 08:24:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:24:49 INFO - 'ts_paint', 08:24:49 INFO - 'tpaint', 08:24:49 INFO - 'sessionrestore', 08:24:49 INFO - 'sessionrestore_no_auto_restore', 08:24:49 INFO - 'tabpaint']}, 08:24:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['a11yr', 08:24:49 INFO - 'ts_paint', 08:24:49 INFO - 'tpaint', 08:24:49 INFO - 'sessionrestore', 08:24:49 INFO - 'sessionrestore_no_auto_restore', 08:24:49 INFO - 'tabpaint']}, 08:24:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['a11yr', 08:24:49 INFO - 'ts_paint', 08:24:49 INFO - 'tpaint', 08:24:49 INFO - 'sessionrestore', 08:24:49 INFO - 'sessionrestore_no_auto_restore', 08:24:49 INFO - 'tabpaint']}, 08:24:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['tsvgx', 08:24:49 INFO - 'tsvgr_opacity', 08:24:49 INFO - 'tart', 08:24:49 INFO - 'tscrollx', 08:24:49 INFO - 'cart']}, 08:24:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:24:49 INFO - 'tsvgr_opacity', 08:24:49 INFO - 'tart', 08:24:49 INFO - 'tscrollx', 08:24:49 INFO - 'cart']}, 08:24:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'talos_options': ['--disable-e10s'], 08:24:49 INFO - 'tests': ['tp5o']}, 08:24:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'tests': ['tp5o']}, 08:24:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'talos_options': ['--disable-e10s', 08:24:49 INFO - '--xperf_path', 08:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:49 INFO - 'tests': ['tp5n']}, 08:24:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:49 INFO - 'talos_options': ['--xperf_path', 08:24:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:49 INFO - 'tests': ['tp5n']}}, 08:24:49 INFO - 'talos.zip': {'path': '', 08:24:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:49 INFO - Running post-action listener: _resource_record_post_action 08:24:49 INFO - [mozharness: 2017-01-09 16:24:49.773761Z] Finished populate-webroot step (success) 08:24:49 INFO - [mozharness: 2017-01-09 16:24:49.773849Z] Running create-virtualenv step. 08:24:49 INFO - Running pre-action listener: _resource_record_pre_action 08:24:49 INFO - Running main action method: create_virtualenv 08:24:49 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:49 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 08:24:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:49 INFO - Using real prefix '/usr' 08:24:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:52 INFO - Installing pip.................done. 08:24:52 INFO - Return code: 0 08:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:24:52 INFO - Reading from file tmpfile_stdout 08:24:52 INFO - Output received: 08:24:52 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) 08:24:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:52 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:24:52 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 08:24:52 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 08:24:52 INFO - Using env: {'DISPLAY': ':0', 08:24:52 INFO - 'HOME': '/home/cltbld', 08:24:52 INFO - 'LANG': 'en_US.UTF-8', 08:24:52 INFO - 'LANGUAGE': 'en_US:en', 08:24:52 INFO - 'LOGNAME': 'cltbld', 08:24:52 INFO - 'MAIL': '/var/mail/cltbld', 08:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:52 INFO - 'MOZ_NO_REMOTE': '1', 08:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:52 INFO - 'NO_EM_RESTART': '1', 08:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:52 INFO - 'PWD': '/builds/slave/test', 08:24:52 INFO - 'SHELL': '/bin/bash', 08:24:52 INFO - 'SHLVL': '1', 08:24:52 INFO - 'TERM': 'linux', 08:24:52 INFO - 'TMOUT': '86400', 08:24:52 INFO - 'USER': 'cltbld', 08:24:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:52 INFO - '_': '/tools/buildbot/bin/python'} 08:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:52 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 08:24:52 INFO - Cleaning up... 08:24:52 INFO - Return code: 0 08:24:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:52 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:24:52 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 08:24:52 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 08:24:52 INFO - Using env: {'DISPLAY': ':0', 08:24:52 INFO - 'HOME': '/home/cltbld', 08:24:52 INFO - 'LANG': 'en_US.UTF-8', 08:24:52 INFO - 'LANGUAGE': 'en_US:en', 08:24:52 INFO - 'LOGNAME': 'cltbld', 08:24:52 INFO - 'MAIL': '/var/mail/cltbld', 08:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:52 INFO - 'MOZ_NO_REMOTE': '1', 08:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:52 INFO - 'NO_EM_RESTART': '1', 08:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:52 INFO - 'PWD': '/builds/slave/test', 08:24:52 INFO - 'SHELL': '/bin/bash', 08:24:52 INFO - 'SHLVL': '1', 08:24:52 INFO - 'TERM': 'linux', 08:24:52 INFO - 'TMOUT': '86400', 08:24:52 INFO - 'USER': 'cltbld', 08:24:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:52 INFO - '_': '/tools/buildbot/bin/python'} 08:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:53 INFO - Downloading/unpacking psutil>=3.1.1 08:24:53 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 08:24:53 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 08:24:53 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 08:24:53 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 08:24:53 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 08:24:53 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 08:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:55 INFO - Installing collected packages: psutil 08:24:55 INFO - Running setup.py install for psutil 08:24:55 INFO - building 'psutil._psutil_linux' extension 08:24:55 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 08:24:55 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 08:24:55 INFO - building 'psutil._psutil_posix' extension 08:24:55 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 08:24:55 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 08:24:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:55 INFO - Successfully installed psutil 08:24:55 INFO - Cleaning up... 08:24:55 INFO - Return code: 0 08:24:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:24:55 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')]} 08:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:55 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')]} 08:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:55 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:24:55 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 08:24:55 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 08:24:55 INFO - Using env: {'DISPLAY': ':0', 08:24:55 INFO - 'HOME': '/home/cltbld', 08:24:55 INFO - 'LANG': 'en_US.UTF-8', 08:24:55 INFO - 'LANGUAGE': 'en_US:en', 08:24:55 INFO - 'LOGNAME': 'cltbld', 08:24:55 INFO - 'MAIL': '/var/mail/cltbld', 08:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:55 INFO - 'MOZ_NO_REMOTE': '1', 08:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:55 INFO - 'NO_EM_RESTART': '1', 08:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:55 INFO - 'PWD': '/builds/slave/test', 08:24:55 INFO - 'SHELL': '/bin/bash', 08:24:55 INFO - 'SHLVL': '1', 08:24:55 INFO - 'TERM': 'linux', 08:24:55 INFO - 'TMOUT': '86400', 08:24:55 INFO - 'USER': 'cltbld', 08:24:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:55 INFO - '_': '/tools/buildbot/bin/python'} 08:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:24:55 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 08:24:55 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 08:24:55 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 08:24:55 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 08:24:55 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 08:24:55 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 08:24:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:57 INFO - Installing collected packages: mozsystemmonitor 08:24:57 INFO - Running setup.py install for mozsystemmonitor 08:24:58 INFO - Successfully installed mozsystemmonitor 08:24:58 INFO - Cleaning up... 08:24:58 INFO - Return code: 0 08:24:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:24:58 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')]} 08:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:58 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')]} 08:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:58 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:24:58 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 08:24:58 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 08:24:58 INFO - Using env: {'DISPLAY': ':0', 08:24:58 INFO - 'HOME': '/home/cltbld', 08:24:58 INFO - 'LANG': 'en_US.UTF-8', 08:24:58 INFO - 'LANGUAGE': 'en_US:en', 08:24:58 INFO - 'LOGNAME': 'cltbld', 08:24:58 INFO - 'MAIL': '/var/mail/cltbld', 08:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:58 INFO - 'MOZ_NO_REMOTE': '1', 08:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:58 INFO - 'NO_EM_RESTART': '1', 08:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:58 INFO - 'PWD': '/builds/slave/test', 08:24:58 INFO - 'SHELL': '/bin/bash', 08:24:58 INFO - 'SHLVL': '1', 08:24:58 INFO - 'TERM': 'linux', 08:24:58 INFO - 'TMOUT': '86400', 08:24:58 INFO - 'USER': 'cltbld', 08:24:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:58 INFO - '_': '/tools/buildbot/bin/python'} 08:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:24:58 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 08:24:58 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 08:24:58 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 08:24:58 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 08:24:58 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 08:24:58 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 08:25:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:00 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 08:25:00 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 08:25:00 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 08:25:00 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 08:25:00 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 08:25:00 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 08:25:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:00 INFO - warning: no files found matching '*.txt' 08:25:00 INFO - no previously-included directories found matching 'build' 08:25:00 INFO - no previously-included directories found matching 'dist' 08:25:00 INFO - no previously-included directories found matching '.git*' 08:25:00 INFO - Installing collected packages: jsonschema, functools32 08:25:00 INFO - Running setup.py install for functools32 08:25:00 INFO - warning: no files found matching '*.txt' 08:25:00 INFO - no previously-included directories found matching 'build' 08:25:00 INFO - no previously-included directories found matching 'dist' 08:25:00 INFO - no previously-included directories found matching '.git*' 08:25:00 INFO - Successfully installed jsonschema functools32 08:25:00 INFO - Cleaning up... 08:25:00 INFO - Return code: 0 08:25:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:00 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:25:00 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 08:25:00 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 08:25:00 INFO - Using env: {'DISPLAY': ':0', 08:25:00 INFO - 'HOME': '/home/cltbld', 08:25:00 INFO - 'LANG': 'en_US.UTF-8', 08:25:00 INFO - 'LANGUAGE': 'en_US:en', 08:25:00 INFO - 'LOGNAME': 'cltbld', 08:25:00 INFO - 'MAIL': '/var/mail/cltbld', 08:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:00 INFO - 'MOZ_NO_REMOTE': '1', 08:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:00 INFO - 'NO_EM_RESTART': '1', 08:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:00 INFO - 'PWD': '/builds/slave/test', 08:25:00 INFO - 'SHELL': '/bin/bash', 08:25:00 INFO - 'SHLVL': '1', 08:25:00 INFO - 'TERM': 'linux', 08:25:00 INFO - 'TMOUT': '86400', 08:25:00 INFO - 'USER': 'cltbld', 08:25:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:00 INFO - '_': '/tools/buildbot/bin/python'} 08:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:25:01 INFO - Cleaning up... 08:25:01 INFO - Return code: 0 08:25:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:25:01 INFO - Using env: {'DISPLAY': ':0', 08:25:01 INFO - 'HOME': '/home/cltbld', 08:25:01 INFO - 'LANG': 'en_US.UTF-8', 08:25:01 INFO - 'LANGUAGE': 'en_US:en', 08:25:01 INFO - 'LOGNAME': 'cltbld', 08:25:01 INFO - 'MAIL': '/var/mail/cltbld', 08:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:01 INFO - 'MOZ_NO_REMOTE': '1', 08:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:01 INFO - 'NO_EM_RESTART': '1', 08:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:01 INFO - 'PWD': '/builds/slave/test', 08:25:01 INFO - 'SHELL': '/bin/bash', 08:25:01 INFO - 'SHLVL': '1', 08:25:01 INFO - 'TERM': 'linux', 08:25:01 INFO - 'TMOUT': '86400', 08:25:01 INFO - 'USER': 'cltbld', 08:25:01 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:01 INFO - '_': '/tools/buildbot/bin/python'} 08:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 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 08:25:03 INFO - Downloading docopt-0.6.1.tar.gz 08:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:04 INFO - Running setup.py install for blobuploader 08:25:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:04 INFO - Running setup.py install for requests 08:25:04 INFO - Running setup.py install for docopt 08:25:04 INFO - Successfully installed blobuploader requests docopt 08:25:04 INFO - Cleaning up... 08:25:04 INFO - Return code: 0 08:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:04 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:25:04 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 08:25:04 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 08:25:04 INFO - Using env: {'DISPLAY': ':0', 08:25:04 INFO - 'HOME': '/home/cltbld', 08:25:04 INFO - 'LANG': 'en_US.UTF-8', 08:25:04 INFO - 'LANGUAGE': 'en_US:en', 08:25:04 INFO - 'LOGNAME': 'cltbld', 08:25:04 INFO - 'MAIL': '/var/mail/cltbld', 08:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:04 INFO - 'MOZ_NO_REMOTE': '1', 08:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:04 INFO - 'NO_EM_RESTART': '1', 08:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:04 INFO - 'PWD': '/builds/slave/test', 08:25:04 INFO - 'SHELL': '/bin/bash', 08:25:04 INFO - 'SHLVL': '1', 08:25:04 INFO - 'TERM': 'linux', 08:25:04 INFO - 'TMOUT': '86400', 08:25:04 INFO - 'USER': 'cltbld', 08:25:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:04 INFO - '_': '/tools/buildbot/bin/python'} 08:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:04 INFO - Running setup.py (path:/tmp/pip-tTHl9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:04 INFO - Running setup.py (path:/tmp/pip-dTppiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:05 INFO - Running setup.py (path:/tmp/pip-JcyrpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:05 INFO - Running setup.py (path:/tmp/pip-wWSFtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:05 INFO - Running setup.py (path:/tmp/pip-m5JaqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:05 INFO - Running setup.py (path:/tmp/pip-4eEsBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:05 INFO - Running setup.py (path:/tmp/pip-8LF8ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:05 INFO - Running setup.py (path:/tmp/pip-O4W4kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:05 INFO - Running setup.py (path:/tmp/pip-C3TLvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:05 INFO - Running setup.py (path:/tmp/pip-V6jFNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:05 INFO - Running setup.py (path:/tmp/pip-1AF2zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:05 INFO - Running setup.py (path:/tmp/pip-sIBJTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:05 INFO - Running setup.py (path:/tmp/pip-znj4Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:05 INFO - Running setup.py (path:/tmp/pip-zY5v26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:05 INFO - Running setup.py (path:/tmp/pip-DRBvaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:05 INFO - Running setup.py (path:/tmp/pip-bXyoTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:06 INFO - Running setup.py (path:/tmp/pip-1x3_lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:06 INFO - Running setup.py install for manifestparser 08:25:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozcrash 08:25:06 INFO - Running setup.py install for mozdebug 08:25:06 INFO - Running setup.py install for mozdevice 08:25:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozfile 08:25:06 INFO - Running setup.py install for mozhttpd 08:25:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozinfo 08:25:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozInstall 08:25:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozleak 08:25:07 INFO - Running setup.py install for mozlog 08:25:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for moznetwork 08:25:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozprocess 08:25:07 INFO - Running setup.py install for mozprofile 08:25:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozrunner 08:25:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozscreenshot 08:25:07 INFO - Running setup.py install for moztest 08:25:07 INFO - Running setup.py install for mozversion 08:25:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:07 INFO - Cleaning up... 08:25:07 INFO - Return code: 0 08:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:07 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:25:07 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 08:25:07 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 08:25:07 INFO - Using env: {'DISPLAY': ':0', 08:25:07 INFO - 'HOME': '/home/cltbld', 08:25:07 INFO - 'LANG': 'en_US.UTF-8', 08:25:07 INFO - 'LANGUAGE': 'en_US:en', 08:25:07 INFO - 'LOGNAME': 'cltbld', 08:25:07 INFO - 'MAIL': '/var/mail/cltbld', 08:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:07 INFO - 'MOZ_NO_REMOTE': '1', 08:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:07 INFO - 'NO_EM_RESTART': '1', 08:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:07 INFO - 'PWD': '/builds/slave/test', 08:25:07 INFO - 'SHELL': '/bin/bash', 08:25:07 INFO - 'SHLVL': '1', 08:25:07 INFO - 'TERM': 'linux', 08:25:07 INFO - 'TMOUT': '86400', 08:25:07 INFO - 'USER': 'cltbld', 08:25:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:07 INFO - '_': '/tools/buildbot/bin/python'} 08:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:08 INFO - Running setup.py (path:/tmp/pip-7NBQdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:08 INFO - Running setup.py (path:/tmp/pip-s3eUh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:08 INFO - Running setup.py (path:/tmp/pip-gqQJs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:08 INFO - Running setup.py (path:/tmp/pip-azGZl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:08 INFO - Running setup.py (path:/tmp/pip-OpxDcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:08 INFO - Running setup.py (path:/tmp/pip-rXuDpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:08 INFO - Running setup.py (path:/tmp/pip-7XHc5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:08 INFO - Running setup.py (path:/tmp/pip-YV9Ysn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:08 INFO - Running setup.py (path:/tmp/pip-qdDRAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:08 INFO - Running setup.py (path:/tmp/pip-jPlItb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:08 INFO - Running setup.py (path:/tmp/pip-t4RUsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:08 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)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:08 INFO - Running setup.py (path:/tmp/pip-iQpeSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:09 INFO - Running setup.py (path:/tmp/pip-ZycSTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:09 INFO - Running setup.py (path:/tmp/pip-VJ4Tsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:09 INFO - Running setup.py (path:/tmp/pip-2u0Km_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:09 INFO - Running setup.py (path:/tmp/pip-pjha5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:09 INFO - Running setup.py (path:/tmp/pip-h4Jxiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:09 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)) 08:25:09 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)) 08:25:09 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)) 08:25:09 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)) 08:25:09 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)) 08:25:09 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)) 08:25:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25:11 INFO - Downloading blessings-1.6.tar.gz 08:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:11 INFO - Installing collected packages: blessings 08:25:11 INFO - Running setup.py install for blessings 08:25:11 INFO - Successfully installed blessings 08:25:11 INFO - Cleaning up... 08:25:11 INFO - Return code: 0 08:25:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:11 INFO - Reading from file tmpfile_stdout 08:25:11 INFO - Current package versions: 08:25:11 INFO - argparse == 1.2.1 08:25:11 INFO - blessings == 1.6 08:25:11 INFO - blobuploader == 1.2.4 08:25:11 INFO - docopt == 0.6.1 08:25:11 INFO - functools32 == 3.2.3-2 08:25:11 INFO - jsonschema == 2.5.1 08:25:11 INFO - manifestparser == 1.1 08:25:11 INFO - mozInstall == 1.12 08:25:11 INFO - mozcrash == 1.0 08:25:11 INFO - mozdebug == 0.1 08:25:11 INFO - mozdevice == 0.48 08:25:11 INFO - mozfile == 1.2 08:25:11 INFO - mozhttpd == 0.7 08:25:11 INFO - mozinfo == 0.9 08:25:11 INFO - mozleak == 0.1 08:25:11 INFO - mozlog == 3.4 08:25:11 INFO - moznetwork == 0.27 08:25:11 INFO - mozprocess == 0.23 08:25:11 INFO - mozprofile == 0.28 08:25:11 INFO - mozrunner == 6.13 08:25:11 INFO - mozscreenshot == 0.1 08:25:11 INFO - mozsystemmonitor == 0.3 08:25:11 INFO - moztest == 0.8 08:25:11 INFO - mozversion == 1.4 08:25:11 INFO - psutil == 3.1.1 08:25:11 INFO - requests == 1.2.3 08:25:11 INFO - wsgiref == 0.1.2 08:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:11 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:25:11 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 08:25:11 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 08:25:11 INFO - Using env: {'DISPLAY': ':0', 08:25:11 INFO - 'HOME': '/home/cltbld', 08:25:11 INFO - 'LANG': 'en_US.UTF-8', 08:25:11 INFO - 'LANGUAGE': 'en_US:en', 08:25:11 INFO - 'LOGNAME': 'cltbld', 08:25:11 INFO - 'MAIL': '/var/mail/cltbld', 08:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:11 INFO - 'MOZ_NO_REMOTE': '1', 08:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:11 INFO - 'NO_EM_RESTART': '1', 08:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:11 INFO - 'PWD': '/builds/slave/test', 08:25:11 INFO - 'SHELL': '/bin/bash', 08:25:11 INFO - 'SHLVL': '1', 08:25:11 INFO - 'TERM': 'linux', 08:25:11 INFO - 'TMOUT': '86400', 08:25:11 INFO - 'USER': 'cltbld', 08:25:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:11 INFO - '_': '/tools/buildbot/bin/python'} 08:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 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)) 08:25:12 INFO - Cleaning up... 08:25:12 INFO - Return code: 0 08:25:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:12 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')]} 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 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')]} 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 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 0x7f2924525f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', '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 08:25:12 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 08:25:12 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 08:25:12 INFO - Using env: {'DISPLAY': ':0', 08:25:12 INFO - 'HOME': '/home/cltbld', 08:25:12 INFO - 'LANG': 'en_US.UTF-8', 08:25:12 INFO - 'LANGUAGE': 'en_US:en', 08:25:12 INFO - 'LOGNAME': 'cltbld', 08:25:12 INFO - 'MAIL': '/var/mail/cltbld', 08:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:12 INFO - 'MOZ_NO_REMOTE': '1', 08:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:12 INFO - 'NO_EM_RESTART': '1', 08:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:12 INFO - 'PWD': '/builds/slave/test', 08:25:12 INFO - 'SHELL': '/bin/bash', 08:25:12 INFO - 'SHLVL': '1', 08:25:12 INFO - 'TERM': 'linux', 08:25:12 INFO - 'TMOUT': '86400', 08:25:12 INFO - 'USER': 'cltbld', 08:25:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:12 INFO - '_': '/tools/buildbot/bin/python'} 08:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:12 INFO - Cleaning up... 08:25:12 INFO - Return code: 0 08:25:12 INFO - Running post-action listener: _resource_record_post_action 08:25:12 INFO - Running post-action listener: _start_resource_monitoring 08:25:12 INFO - Starting resource monitoring. 08:25:12 INFO - [mozharness: 2017-01-09 16:25:12.375852Z] Finished create-virtualenv step (success) 08:25:12 INFO - [mozharness: 2017-01-09 16:25:12.376354Z] Running install step. 08:25:12 INFO - Running pre-action listener: _resource_record_pre_action 08:25:12 INFO - Running main action method: install 08:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:12 INFO - Reading from file tmpfile_stdout 08:25:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:12 INFO - Reading from file tmpfile_stdout 08:25:12 INFO - Output received: 08:25:12 INFO - Usage: mozinstall [options] installer 08:25:12 INFO - Options: 08:25:12 INFO - -h, --help show this help message and exit 08:25:12 INFO - -d DEST, --destination=DEST 08:25:12 INFO - Directory to install application into. [default: 08:25:12 INFO - "/builds/slave/test"] 08:25:12 INFO - --app=APP Application being installed. [default: firefox] 08:25:12 INFO - mkdir: /builds/slave/test/build/application 08:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:25:28 INFO - Reading from file tmpfile_stdout 08:25:28 INFO - Output received: 08:25:28 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:28 INFO - Running post-action listener: _resource_record_post_action 08:25:28 INFO - [mozharness: 2017-01-09 16:25:28.600275Z] Finished install step (success) 08:25:28 INFO - [mozharness: 2017-01-09 16:25:28.600518Z] Running run-tests step. 08:25:28 INFO - Running pre-action listener: _resource_record_pre_action 08:25:28 INFO - Running main action method: run_tests 08:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:28 INFO - Python 2.7.3 08:25:28 INFO - Return code: 0 08:25:28 INFO - grabbing minidump binary from tooltool 08:25:28 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')]} 08:25:28 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 0xfddf60>, '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 0xfded40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfdf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:28 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 08:25:28 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 08:25:28 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 08:25:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:28 INFO - Return code: 0 08:25:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 08:25:28 INFO - Using env: {'DISPLAY': ':0', 08:25:28 INFO - 'HOME': '/home/cltbld', 08:25:28 INFO - 'LANG': 'en_US.UTF-8', 08:25:28 INFO - 'LANGUAGE': 'en_US:en', 08:25:28 INFO - 'LOGNAME': 'cltbld', 08:25:28 INFO - 'MAIL': '/var/mail/cltbld', 08:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:28 INFO - 'MOZ_NO_REMOTE': '1', 08:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:28 INFO - 'NO_EM_RESTART': '1', 08:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:28 INFO - 'PWD': '/builds/slave/test', 08:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:28 INFO - 'SHELL': '/bin/bash', 08:25:28 INFO - 'SHLVL': '1', 08:25:28 INFO - 'TERM': 'linux', 08:25:28 INFO - 'TMOUT': '86400', 08:25:28 INFO - 'USER': 'cltbld', 08:25:28 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068', 08:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:28 INFO - '_': '/tools/buildbot/bin/python'} 08:25:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 08:25:28 INFO - mozversion application_buildid: 20170109063808 08:25:28 INFO - mozversion application_changeset: bb6a56511146b31c57a2a3c792ccd464891b0593 08:25:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:28 INFO - mozversion application_name: Firefox 08:25:28 INFO - mozversion application_remotingname: firefox-dev 08:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:25:28 INFO - mozversion application_vendor: Mozilla 08:25:28 INFO - mozversion application_version: 52.0a2 08:25:28 INFO - mozversion platform_buildid: 20170109063808 08:25:28 INFO - mozversion platform_changeset: bb6a56511146b31c57a2a3c792ccd464891b0593 08:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:25:28 INFO - mozversion platform_version: 52.0a2 08:25:28 INFO - using testdate: 1483979128 08:25:28 INFO - actual date: 1483979128 08:25:28 INFO - starting webserver on 'localhost:34204' 08:25:28 INFO - SUITE-START | Running 2 tests 08:25:28 INFO - TEST-START | dromaeo_css 08:25:28 INFO - operating with platform_type : linux_ 08:25:28 INFO - Initialising browser for dromaeo_css test... 08:25:28 INFO - TEST-INFO | started process 16654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhJJG9/profile http://localhost:34204/getInfo.html) 08:25:32 INFO - PROCESS | 16654 | __metrics Screen width/height:1600/1200 08:25:32 INFO - PROCESS | 16654 | colorDepth:24 08:25:32 INFO - PROCESS | 16654 | Browser inner width/height: 1024/697 08:25:32 INFO - PROCESS | 16654 | __metrics 08:25:33 INFO - PROCESS | 16654 | 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" 08:25:33 INFO - PROCESS | 16654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:34 INFO - PROCESS | 16654 | console.error: PushService: 08:25:34 INFO - PROCESS | 16654 | stateChangeProcessEnqueue: Error transitioning state 08:25:34 INFO - PROCESS | 16654 | UnknownError 08:25:34 INFO - TEST-INFO | 16654: exit 0 08:25:34 INFO - Browser initialized. 08:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:34 INFO - TEST-INFO | started process 16745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhJJG9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:46 INFO - PROCESS | 16745 | RSS: Main: 144650240 08:25:46 INFO - PROCESS | 16745 | 08:28:48 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:34204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34204/tests/dromaeo/cssquery-ext.html) 08:28:49 INFO - PROCESS | 16745 | RSS: Main: 236810240 08:28:49 INFO - PROCESS | 16745 | 08:31:51 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:34204/tests/dromaeo/cssquery-ext.html (next: http://localhost:34204/tests/dromaeo/cssquery-jquery.html) 08:31:52 INFO - PROCESS | 16745 | RSS: Main: 229384192 08:31:52 INFO - PROCESS | 16745 | 08:34:54 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:34204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34204/tests/dromaeo/cssquery-mootools.html) 08:34:55 INFO - PROCESS | 16745 | RSS: Main: 173871104 08:34:55 INFO - PROCESS | 16745 | 08:37:57 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:34204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34204/tests/dromaeo/cssquery-prototype.html) 08:37:57 INFO - PROCESS | 16745 | RSS: Main: 216866816 08:37:57 INFO - PROCESS | 16745 | 08:41:00 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:34204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34204/tests/dromaeo/cssquery-yui.html) 08:41:00 INFO - PROCESS | 16745 | RSS: Main: 175816704 08:41:00 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:34204/tests/dromaeo/cssquery-yui.html (next: http://localhost:34204/tests/dromaeo/cssquery-dojo.html) 08:44:03 INFO - PROCESS | 16745 | RSS: Main: 268279808 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | __start_tp_report 08:44:03 INFO - PROCESS | 16745 | _x_x_mozilla_page_load 08:44:03 INFO - PROCESS | 16745 | _x_x_mozilla_page_load_details 08:44:03 INFO - PROCESS | 16745 | |i|pagename|runs| 08:44:03 INFO - PROCESS | 16745 | |0;dojo.html;3144.2296637323852;3196.6004249468815;3202.103411044907;3224.580804495415;3232.6928941750525;5468.453154684529;5486.177073438987;5519.116941289394;5557.444255574445;5562.082256427695;5521.861953451165;5538.556915446765;5553.0837411827;5553.333599967999;5562.193481945115;5027.622928280375;5043.697378157304;5049.697018178921;5079.085764562377;5083.440821509631;4898.53463920927;5076.36545431821;5123.205903085028;5129.9230511542355;5167.715775632339;4855.465898751135;4998.925016124761;5012.573931215851;5040.571551418134;5043.773030213649;5041.974790126044;5074.974625126869;5078.873028174288;5141.434442211354;5158.303629010074;4972.055309491185;5071.3407257056715;5104.770285337132;5115.20714289282;5122.538971492583;5305.761240744176;5330.520253177233;5346.331708536433;5346.4118946915805;5389.272448219479;5710.77156913723;5725.2843394575675;5745.6265342753;5830.970845145747;5843.912341314884;5877.294724633029;5879.617824841414;5885.4997325227405;5889.9705501472645;5891.7054147292465;5339.5194432500875;5395.946040539623;5406.864828379283;5441.83674489766;5448.427915068861;5937.554683398763;5941.079132734433;5947.434993675594;5956.970215148896;5981.282246130492;5719.056355701263;5728.026235539968;5733.226014487991;5734.4838964492565;5742.684152371659;5671.291088613923;5716.685582292931;5815.651060936358;5862.501687356623;5870.178175055496;5899.587028908021;5906.055031194988;5910.024845900378;5941.881162376815;5948.10778383246;5865.94134058654;5893.823185304362;5919.822405327847;5923.229980102559;5926.8814623707285;4459.152760975404;4463.018136010072;4470.865874023784;4483.058557702919;4585.197590421662;4029.81865816039;4048.817803198863;4053.61490658387;4080.7347522410946;4102.876913692594;5595.160725891149;5596.580256480699;5601.831945041656;5608.074667679787;5608.355039170548;5739.16782066598;5790.01569733138;5896.469317761422;5898.587098903122;5906.675132867647;5526.530244929146;5535.861603459945;5570.303712035996;5616.831495055155;5655.5475561954945;5133.666311689803;5143.5627971622835;5146.562542183881;5150.253213284128;5153.845384638467;5936.020556608111;6094.481969032682;6124.448799608057;6143.201383820075;6160.1375807387;5728.341240757366;5805.883882322245;5856.531477481706;5863.853403664772;6000.159977603226;6160.13758073861;6164.6917654118015;6166.969165154145;6167.938320616737;6198.473129784019;5850.619709718854;5858.531317494675;5866.2960444745195;5869.148973398918;5869.618474799125;5707.400722924199;5723.284589426322;5792.247007888947;5840.386759390372;5848.678322692293;5786.971065144648;5796.304443466811;5799.710014499174;5805.506531944832;5828.59199856006;5704.087346024616;5765.971170144123;5768.798092066925;5770.451807078321;5775.27809023872;5565.30433695788;5578.386377498553;5623.634463759842;5679.8864022720145;5722.742476588647;5798.76804927815;5809.302883653989;5814.273215848019;5829.446202610745;5847.1229315603;5498.037843377313;5657.4059723728415;5657.773689052392;5658.321001479849;5660.547156227574 08:44:03 INFO - PROCESS | 16745 | |1;ext.html;590.4066413254678;635.7139287320705;652.1261509577167;656.7176114270861;671.1878626861497;33989.150271243234;37242.441363379534;46945.29582056268;47133.52866471334;47325;44991.55008449915;45351.09297814042;45379.546204537946;45396.31905521412;45415.54584454154;8765.430247033939;8935.06181850906;8950.86573701395;8955.194032537103;8957.955210223972;8214.260716535511;8448.23965843074;10550.525226364794;10774.245802793808;10787.78424431511;10855.348679079241;10900.890991090106;10908.727281817979;10910.563577456933;10922.126229901629;10607.045365917065;10689.198310126694;10689.358638481677;10701.357918524836;10702.250842441032;10748.892511074868;10806.081483073947;10812.621558245502;10813.83779243312;10816.296940698909;43094.784526077485;43591.782041089595;43660.56339436597;43704;43724.78137609323;3953.0710283083454;3988.162485877969;3991.2217117662067;4041.4948131483566;4551.931721024187;33206.6679333206;33396.33207335864;33701.83149084263;34089;35516.28967420637;4277.657787377002;4285.9785701071605;4290.2706539888295;4311.719738217006;4319.308910574325;341620.2918985414;341730;342336;342648;342809;59329.40670593325;59839;59853.401465985655;59855;59902;40936.590634093875;41531.58468415338;41761.58238417638;43702.781486093;43707;18083.186256618483;18197.27210911575;18203;18204.635907282045;18211.63576728458;12719.046071544672;12975.091743578048;13304.068715189844;13339.866601333862;13342.66643333905;19484.725324471794;20386.388408347775;20615.793842061386;20767.480812979495;20850.791492084885;7350.311216792693;7405.629718514053;7414.443916706268;7471.813204669927;7525.661345239478;970.6020531582018;1051.784384201237;1066.4081434803604;1075.584140601317;1135.7785231879704;32555.67444325574;33314.500847461924;33629.49555756665;33678.49482257768;33999.830000850336;1125.7185703574107;1129.8757136714955;1221.8045112781913;1222.6454328244888;1248;16848.24182911772;17628.647427051386;17641.823581764274;17755.911220443813;17911.552211194823;525300;527912;528001;528123;530222;62070.68964655148;62550.68724656347;62648.68675656593;62692.37307626956;62799;1323.444153455551;1348.9055766096476;1381.8341798984186;1386.5840247925582;1412.6680230146112;32356.514652280704;34217.60476766702;34239.315213696085;34429.827850861584;34478.31043379169;54328.72835635796;54873;54885;54902.17646735382;54964;407712;407792;408840;409135;410007;29652.517374130777;30702.84648576832;32246.516302255015;32258.83870580632;32676;48059.27911081267;48186.759066204446;48606;49588;50152.24771628501;41576;42149.789251053546;42198.78900605477;42532;43546.78226608974;42091.789541053324;42159.36760948527;42613.14773704446;43773.78113109541;44087.33868992032;41327.23386404072;42638.36042459303;42685.14629707326;43131.137377252904;43300;34958.47562286517;37858.77038695182;37908.43137352887;38067.42898856464;38513;28651.856740716164;28822.279443014093;28863.5670464939;28876.855615722627;28910.710892890802 08:44:03 INFO - PROCESS | 16745 | |2;jquery.html;398.1340584229301;426.692644909888;433.71374892570907;437.9189849877772;442.42484769799273;16676.332946682134;19524.21903123875;20916.89541552292;21679.45801354967;21746.238881639147;20535.691964620542;20608.8969555152;20784.48038799031;21417.14331426741;21603.351899443;5026.723530205837;5728.083506638938;5942.6137301075505;5948.464638182562;5952.166696662471;6448.161738973927;6630.933690663104;6660.467162626978;6667.899981500257;6697.2967838377;5496.31296087989;5720.685362305072;5758.049921762925;6671.799846004627;6673.299303573128;5736.1682556029355;5750.971245143789;5764.510016648548;5769.365369809318;5769.942300577003;5601.523870471015;5837.066069428871;5853.063509838448;5864.941350586525;5892.646441213541;15146.469873554373;15388.692226155526;20276;24373.756262437328;24578.385540361454;2532.240327901622;2635.4465562231953;2956.1870485616414;3050.2679356954172;3079.1840162356993;10761.461926903701;10855.24013319068;10859.51132199045;10862.511186996604;10890.074343680797;1998.860079794415;2010.7386039814876;2037.4600730806349;2072.336852207294;2073.450535608065;82576.58711706403;88390;89224.5538772302;90783.54608226982;91630.54184729034;10300.175985921258;11855.881441185651;11923.523059077714;12047.39763011846;12354.135210535176;15470.149141797085;15831.129287889276;16683.49949501517;16740.246688898784;17305.56736081608;8526.23263906239;8639.956800216085;8665.220130188314;8887.066857979948;8977.596008179647;8285.378596605158;8308.875366869503;8372.916270837335;8394.790130246793;8718.43330183536;5062.873428164326;5131.820386286537;5135.35808023997;5200.5059519345605;5260.28986086881;2049.9795002050087;2092.790720927895;2096.853220274566;2111.5776844631137;2144.4188205696214;964.744342749172;983.4050399508337;995.3530205366425;1020.0564477857952;1055.4247934875511;19494.610107797766;20172.596548068956;20248.797512024987;20292.492687682632;20539.4865128373;981.5337714585658;1004.6985904228702;1014.4065721552975;1027.5016616940777;1068.3963560588397;10568.894311056945;11412.258203216765;11536.134789890624;11579.768404632028;11697.88302116985;473779;477144;480323;482515;484901;99433.50283248682;103121.48439257756;104618;104663.47668261762;108234;1030.2427715629008;1067.9946600266949;1084.1868598551087;1085.4572713643179;1089.3790539392628;17661.82338176653;17979.370722024665;18024;18381.264749409875;18850.245990160787;32414.35171296608;41448.37827432651;41816.58183418127;45660.315095272934;47574.04851903012;56873;57899.4210057894;58185.709071454374;58358.708206458694;58461.123083154635;8720.869186962327;8792.208701216921;8949.194572488508;9023.954880225558;9079.591418386057;9784.608615655294;13062;13280.667983300495;13646;13982.370793314121;11988.520459181535;11995.940020299842;12240.816387754368;12245.69385765363;12391.273919737643;11620.767584648429;11632.825507617561;11905.821412678644;11913.285202887855;12123.393830308625;12011.279323240633;12385.876141238472;12428.937855310665;12433.06751993586;12550.937245313715;8884.422512536923;8976.057513960941;9063.456192628464;9270.490123043297;9338;9654.082862128087;12062.155649104478;12316.753664926831;12336.259824410565;12367.134300598871 08:44:03 INFO - PROCESS | 16745 | |3;mootools.html;1497.1241823533232;1529.9311530981106;1704.4460550321141;1822.152698994967;1834.4496651004695;8318.126596707349;8861.91138088619;8867.955660221705;8872.911270887289;8875.778105547364;7644.503107298022;7845.058592968838;7846.4899781514305;8031.277185053344;8793.340499462534;2212.966805497919;2438.5610590093775;2498;2504.261242933339;2507.8119141064494;2409.77107174819;2454.0919859651954;2457.913973010945;2466.4573793765344;2505.887235074417;2447.486027934136;2450.669159663449;2454.9263522094275;2472.81453890958;2479.454520005605;2418.830681852271;2432.4526981429035;2437.0739119134705;2439.841410308342;2441.4872876695913;2405.7353691093967;2455.2511483997373;2456.1649039326535;2458.4222707663685;2460.065175233418;8978.326625503114;9029.367944243906;9066.501342426163;9087.227585655228;9112.681056163003;5547.583931205136;5691.117876729072;5691.48776610103;5695.572832037572;5698.230738850285;3441.7074548663395;3491.598466176397;3538.327717733622;3720.813959302024;3726.2920045191327;1151.8560179977503;1155.0817100405197;1155.422288855572;1165.7085728567858;1215.9270443773403;12294.446749896277;12334.876651233462;12358.629241122691;12412.069094817925;12440.253584784941;4769.974455492086;4872.244802055687;4952.5542701157065;4968.503149685002;5000.224965130411;10458.477076146315;10467.84298235527;10475.633352832614;10476.266661333786;10493.265471416928;5647.548196144298;5651.406602306781;5655;5655.519280861173;5658.7170641467765;4539.795709193028;4958.752062396938;5053.722045287471;5185.533302002837;5193.039287731782;3650.762700424517;3900.8829735107993;3944.4872166618156;3956.4658771066115;3981.9203615927518;1231.378154032208;1232.6363722701824;1238;1241.075398827879;1252.6367353467574;905.5743800413795;986.6941248212934;1023.3348323589727;1030.9484525773682;1039.3348257115451;5874.1776151338845;6101.511879049665;6116;6171.197744293213;6207.099970504251;988.7936717204998;998.5157198758596;1005.4721271332609;1005.4872015272264;1025.3386565665105;4138.5654506276405;4154.958450415457;4161.438205842233;4202.70581059329;4243.002894319832;10413;10898.346099234072;10911.508982095826;10925.235233533735;10926.125909927187;10524.684259472227;10859.565617375216;10900;10905.291156074989;11244.66266012021;8272.917270827335;8451.11263317355;8467.703630372907;8467.788305292417;8483.533405662625;5909.172715819875;5929.555283353679;5977.3126090500145;6026.457618814327;6135.1717518136265;9926.106650401498;10055.899441005497;10139.087482126644;10176.898231017594;10207.387556746618;10221.131203847755;10339.741506462398;10512.42181680015;10660.200484963503;10664.893351066701;7152.713891444284;7798.220177982156;7889.408294377829;7912.446128770931;7920.683172673259;7788.805279868048;8411.116832732476;8565.400421970402;8662.393632445668;8877.422967507091;7723.150453450004;7788.610569471391;7945.801354966172;7960.2039796019935;8092.554909480035;7612.1246056704185;7689.6539655714505;7701.345385642059;7745.728899488491;7841.490303130278;7240.637968101469;7365.8158546036775;7368.37368823656;7372.004779354718;7373.3732632726815;4905.190643543775;4920.065187614342;5101.923471147861;5200.349956255468;5358.35699716021;5023.748812559431;5042.495750424928;5096.108181068224;5228.503292187236;5321.095413779744 08:44:03 INFO - PROCESS | 16745 | |4;prototype.html;359.94960705501217;366.61139192456;368.2193749251587;373.2441805344176;373.51070098171397;5433.864153396157;5493.560515158788;5519.69641669708;5544.306961629796;5558.194061861028;5097.923531147027;5224.503672151149;5240.292560504331;5327.680339179652;5365.275687782148;4272;4277.8288868445225;4292.291771857647;4349.69552131351;4352.847650332239;4274.572542745716;4288.828446862121;4293.8067786949505;4342.652587792969;4343.326784348431;3993.0017495626093;3998.5005622891417;4208.957910420887;4254.404383386328;4302.41917341158;4257.467816522934;4257.657738675125;4265.168292183025;4266.530681625019;4286.485621725382;3831.214601006815;3831.980840095782;3833.15670552478;3841.42378643203;3842.1355195081164;5105.923411148836;5186.7925282988635;5221.791128354861;5335.973320133413;5343.358796944352;4881.682690625134;4883.411791750378;4889.315495830587;4906.067847109038;4932.506749325039;5637.408072152406;5644.802431914904;5645.830625081254;5652.378238393773;5673.574481913832;4107.383892416132;4166.64583510402;4170.332746760504;4204.768737719424;4210.810513526899;5779.855503612402;5824.621399609012;5826;5845.912311315334;5852.824415267549;4280.5291417944;4297.314178638351;4298.548652391516;4301.827926882889;4323.762193079411;4198.097409057067;4288.571142885687;4311.331743579687;4351.456067991501;4376.474823021258;4814.374131362901;4831.51684831514;4845.781939812717;4861.891701512217;4880.292357608127;5604.60767746262;5615.887682246333;5644.294463192101;5661.915071273934;5672.943270567324;1385.847556768775;1420.8934329925296;1438.0227187617027;1463.3268696399775;1476.6234610174338;928.1878356438117;949.3829011142813;995.5171741705267;1019.8266294729914;1030.4950574218728;5377.596680248997;5447.073997420369;5462.743568979157;5472.808451704172;5474.2609747683555;5685.260916080883;5696.174054762119;5724;5746.936816688926;5756.366799652035;5138.460461651547;5287.576993840484;5295.232191332235;5320.920186197211;5327.9733601331745;2968.8218706877656;2969.7624190065176;2972.2272209225757;2986.25343664084;2986.6117404737247;5542.778288868481;5774.653520788682;5786.276715410574;5799.5650326225705;5806.274215723035;5580.525655319262;5591.217229587861;5633.774649014075;5688.459596338341;5694;5757.165211044375;5785.88428231433;5812.33158186797;5862.325832529228;5886.117082437583;5311.814086506954;5520.558355331484;5557.944420555905;5560.554255893416;5575.637583557056;5509.834704958857;5514.696691681996;5522;5542.584306177134;5593.4126916674795;5739.368669446274;5766.625169363978;5785.9132113017495;5882.49998750111;5884.7940322088525;4224;4259.65922726175;4278.422412974209;4284.421603083544;4295.72077814941;5930.940690593039;5934.228550288608;5936.5844390892225;5948.970255148696;5976.462118409364;5702.600817942704;5747.683877386784;5770.8845823082465;5849.824505264849;5855.765769369177;5639.125935480007;5683.658980461186;5684.914726279027;5691.430856914441;5700.372958974426;5515.558755299486;5640.379558248507;5661.207430959751;5684.772609095755;5698.886022279614;5433.864153396196;5719.599628026164;5757.424257574209;5763.7118144093465;5781.190633311256;5609.382967873612;5620.269364982526;5644.294463192101;5657.4059723728415;5706.8573285666525 08:44:03 INFO - PROCESS | 16745 | |5;yui.html;765.1048273519981;813.3330668851543;818.4148333941231;847.1782371100034;895.3777124898198;14805.851941480581;15151.848481515182;15297.388104475822;15373.769393459108;15415.997960132598;16228.83771162288;16467;16541.255643496042;16548.66902661946;16714.24785884635;737.2958824322785;842.7303262955857;844.1389782421926;844.1727107434717;845.0999685335129;756.5838788666239;836.2933321343486;843.1989609870617;847.7456762971115;856.0540602634093;858.5792961448908;858.7037472072125;858.7853036740814;858.995705021474;861.4099341950783;769.3729610367533;851.7019043334783;851.7189327521934;852.6631980367752;859.2782063067023;579.7217335678898;648.2739331948248;655.7016557466342;655.9409653131241;659.6635715784936;14534.418623255056;14552.126872387691;14568.70862582753;14573.198474083922;14639.41442342305;13545.187288762607;13619.931900340534;13694.246816425093;13716.314184290846;13896.51362202318;12864.356782160854;12868.935655321757;12875.163114397534;12944.546940857119;13189.802152967713;4478.261086920655;4527.592516673515;4545.272756359;4559.293309536994;4654.953450465519;59745.402545974415;60080.69959650218;60219.69890150565;60360.39639603592;60415;10968.17738669587;11130.33218006906;11224.382658953673;11438.199326047097;11493.77012459746;18805.059747012594;18806.247750089842;18815.62368752617;18856;18977.146028428753;8000.919990800134;8015.719449819228;8028.759137225892;8100.270975612223;8565.61454734526;4723.362346083235;4765.642576806753;4837.830675926326;4871.269309603588;4922.680025798311;3449.965500345015;3557.0395993081725;3560.857565697395;3561.679448849616;3573.0531409176588;629.902365133405;634.552640388525;642.6465444005778;649.4804156674642;654.8002859128012;653.183520599251;657.8256761958085;712.3375261007313;720.4128635162326;741.9777406677808;8598.484090954562;8868.201861832466;9265.397749146285;9710.854337184948;9732.805343893224;720.1718024272025;723.6779633063236;725.3580581185689;725.4631572636316;730.2697302697303;4290.785460726951;4340.696151269381;4348.195583817004;4404.163208990281;4467.128909862546;48665;54623.45376546263;69775.65112174508;70661.2933870665;71936.28063719401;45272;48762.268565971535;69909;70250.64874675593;73376.63311683407;61970.69014654898;63612.36387636064;64619;64857.67571162114;65717.67141164263;9735;9967.252456065678;10075.89924100779;10077.19382449417;10078;43327.566724333614;43817.34273985829;44346.334804977305;45599.31601025921;45711.54288457206;56440.7177964124;59102.704486479015;62441.37558624356;62854.68572657107;62889;11619.128565357802;11937.701557461132;12141;12215.816762748744;12224.75550489003;14053.789193162314;14239.35922883452;14606.12363258208;14880.330385132911;15392.307346169673;13648.181109133087;13719.451221951409;13836.584902452943;13849;14811.407543698562;13281.203127812361;13952.232627205602;14040.859591403956;14369.497067602584;14479.638009049859;13888;13966;14162.221077840817;14241.074330168505;14274;11388.886111138783;11696.005839503738;11729.706757331134;11793.646190614296;11900.404979750805;11835.585754498552;12305.692357691129;12359.567415140427;12567.497300107892;12637.17858339205 08:44:03 INFO - PROCESS | 16745 | __end_tp_report 08:44:03 INFO - PROCESS | 16745 | __start_cc_report 08:44:03 INFO - PROCESS | 16745 | _x_x_mozilla_cycle_collect,991 08:44:03 INFO - PROCESS | 16745 | __end_cc_report 08:44:03 INFO - PROCESS | 16745 | __startTimestamp1483980243582__endTimestamp 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | ------- Summary: start ------- 08:44:03 INFO - PROCESS | 16745 | Number of tests: 6 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | [#0] dojo.html Cycles:165 Average:5466.73 Median:5660.55 stddev:605.14 (10.7%) stddev-sans-first:578.92 08:44:03 INFO - PROCESS | 16745 | Values: 3144.2 3196.6 3202.1 3224.6 3232.7 5468.5 5486.2 5519.1 5557.4 5562.1 5521.9 5538.6 5553.1 5553.3 5562.2 5027.6 5043.7 5049.7 5079.1 5083.4 4898.5 5076.4 5123.2 5129.9 5167.7 4855.5 4998.9 5012.6 5040.6 5043.8 5042.0 5075.0 5078.9 5141.4 5158.3 4972.1 5071.3 5104.8 5115.2 5122.5 5305.8 5330.5 5346.3 5346.4 5389.3 5710.8 5725.3 5745.6 5831.0 5843.9 5877.3 5879.6 5885.5 5890.0 5891.7 5339.5 5395.9 5406.9 5441.8 5448.4 5937.6 5941.1 5947.4 5957.0 5981.3 5719.1 5728.0 5733.2 5734.5 5742.7 5671.3 5716.7 5815.7 5862.5 5870.2 5899.6 5906.1 5910.0 5941.9 5948.1 5865.9 5893.8 5919.8 5923.2 5926.9 4459.2 4463.0 4470.9 4483.1 4585.2 4029.8 4048.8 4053.6 4080.7 4102.9 5595.2 5596.6 5601.8 5608.1 5608.4 5739.2 5790.0 5896.5 5898.6 5906.7 5526.5 5535.9 5570.3 5616.8 5655.5 5133.7 5143.6 5146.6 5150.3 5153.8 5936.0 6094.5 6124.4 6143.2 6160.1 5728.3 5805.9 5856.5 5863.9 6000.2 6160.1 6164.7 6167.0 6167.9 6198.5 5850.6 5858.5 5866.3 5869.1 5869.6 5707.4 5723.3 5792.2 5840.4 5848.7 5787.0 5796.3 5799.7 5805.5 5828.6 5704.1 5766.0 5768.8 5770.5 5775.3 5565.3 5578.4 5623.6 5679.9 5722.7 5798.8 5809.3 5814.3 5829.4 5847.1 5498.0 5657.4 5657.8 5658.3 5660.5 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | [#1] ext.html Cycles:180 Average:59614.60 Median:3989.69 stddev:114498.80 (2869.9%) stddev-sans-first:114734.23 08:44:03 INFO - PROCESS | 16745 | Values: 590.4 635.7 652.1 656.7 671.2 33989.2 37242.4 46945.3 47133.5 47325.0 44991.6 45351.1 45379.5 45396.3 45415.5 8765.4 8935.1 8950.9 8955.2 8958.0 8214.3 8448.2 10550.5 10774.2 10787.8 10855.3 10900.9 10908.7 10910.6 10922.1 10607.0 10689.2 10689.4 10701.4 10702.3 10748.9 10806.1 10812.6 10813.8 10816.3 43094.8 43591.8 43660.6 43704.0 43724.8 3953.1 3988.2 3991.2 4041.5 4551.9 33206.7 33396.3 33701.8 34089.0 35516.3 4277.7 4286.0 4290.3 4311.7 4319.3 341620.3 341730.0 342336.0 342648.0 342809.0 59329.4 59839.0 59853.4 59855.0 59902.0 40936.6 41531.6 41761.6 43702.8 43707.0 18083.2 18197.3 18203.0 18204.6 18211.6 12719.0 12975.1 13304.1 13339.9 13342.7 19484.7 20386.4 20615.8 20767.5 20850.8 7350.3 7405.6 7414.4 7471.8 7525.7 970.6 1051.8 1066.4 1075.6 1135.8 32555.7 33314.5 33629.5 33678.5 33999.8 1125.7 1129.9 1221.8 1222.6 1248.0 16848.2 17628.6 17641.8 17755.9 17911.6 525300.0 527912.0 528001.0 528123.0 530222.0 62070.7 62550.7 62648.7 62692.4 62799.0 1323.4 1348.9 1381.8 1386.6 1412.7 32356.5 34217.6 34239.3 34429.8 34478.3 54328.7 54873.0 54885.0 54902.2 54964.0 407712.0 407792.0 408840.0 409135.0 410007.0 29652.5 30702.8 32246.5 32258.8 32676.0 48059.3 48186.8 48606.0 49588.0 50152.2 41576.0 42149.8 42198.8 42532.0 43546.8 42091.8 42159.4 42613.1 43773.8 44087.3 41327.2 42638.4 42685.1 43131.1 43300.0 34958.5 37858.8 37908.4 38067.4 38513.0 28651.9 28822.3 28863.6 28876.9 28910.7 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | [#2] jquery.html Cycles:180 Average:29538.38 Median:23060.00 stddev:79539.53 (344.9%) stddev-sans-first:79732.56 08:44:03 INFO - PROCESS | 16745 | Values: 398.1 426.7 433.7 437.9 442.4 16676.3 19524.2 20916.9 21679.5 21746.2 20535.7 20608.9 20784.5 21417.1 21603.4 5026.7 5728.1 5942.6 5948.5 5952.2 6448.2 6630.9 6660.5 6667.9 6697.3 5496.3 5720.7 5758.0 6671.8 6673.3 5736.2 5751.0 5764.5 5769.4 5769.9 5601.5 5837.1 5853.1 5864.9 5892.6 15146.5 15388.7 20276.0 24373.8 24578.4 2532.2 2635.4 2956.2 3050.3 3079.2 10761.5 10855.2 10859.5 10862.5 10890.1 1998.9 2010.7 2037.5 2072.3 2073.5 82576.6 88390.0 89224.6 90783.5 91630.5 10300.2 11855.9 11923.5 12047.4 12354.1 15470.1 15831.1 16683.5 16740.2 17305.6 8526.2 8640.0 8665.2 8887.1 8977.6 8285.4 8308.9 8372.9 8394.8 8718.4 5062.9 5131.8 5135.4 5200.5 5260.3 2050.0 2092.8 2096.9 2111.6 2144.4 964.7 983.4 995.4 1020.1 1055.4 19494.6 20172.6 20248.8 20292.5 20539.5 981.5 1004.7 1014.4 1027.5 1068.4 10568.9 11412.3 11536.1 11579.8 11697.9 473779.0 477144.0 480323.0 482515.0 484901.0 99433.5 103121.5 104618.0 104663.5 108234.0 1030.2 1068.0 1084.2 1085.5 1089.4 17661.8 17979.4 18024.0 18381.3 18850.2 32414.4 41448.4 41816.6 45660.3 47574.0 56873.0 57899.4 58185.7 58358.7 58461.1 8720.9 8792.2 8949.2 9024.0 9079.6 9784.6 13062.0 13280.7 13646.0 13982.4 11988.5 11995.9 12240.8 12245.7 12391.3 11620.8 11632.8 11905.8 11913.3 12123.4 12011.3 12385.9 12428.9 12433.1 12550.9 8884.4 8976.1 9063.5 9270.5 9338.0 9654.1 12062.2 12316.8 12336.3 12367.1 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | [#3] mootools.html Cycles:180 Average:5891.04 Median:4654.89 stddev:3278.20 (70.4%) stddev-sans-first:3270.77 08:44:03 INFO - PROCESS | 16745 | Values: 1497.1 1529.9 1704.4 1822.2 1834.4 8318.1 8861.9 8868.0 8872.9 8875.8 7644.5 7845.1 7846.5 8031.3 8793.3 2213.0 2438.6 2498.0 2504.3 2507.8 2409.8 2454.1 2457.9 2466.5 2505.9 2447.5 2450.7 2454.9 2472.8 2479.5 2418.8 2432.5 2437.1 2439.8 2441.5 2405.7 2455.3 2456.2 2458.4 2460.1 8978.3 9029.4 9066.5 9087.2 9112.7 5547.6 5691.1 5691.5 5695.6 5698.2 3441.7 3491.6 3538.3 3720.8 3726.3 1151.9 1155.1 1155.4 1165.7 1215.9 12294.4 12334.9 12358.6 12412.1 12440.3 4770.0 4872.2 4952.6 4968.5 5000.2 10458.5 10467.8 10475.6 10476.3 10493.3 5647.5 5651.4 5655.0 5655.5 5658.7 4539.8 4958.8 5053.7 5185.5 5193.0 3650.8 3900.9 3944.5 3956.5 3981.9 1231.4 1232.6 1238.0 1241.1 1252.6 905.6 986.7 1023.3 1030.9 1039.3 5874.2 6101.5 6116.0 6171.2 6207.1 988.8 998.5 1005.5 1005.5 1025.3 4138.6 4155.0 4161.4 4202.7 4243.0 10413.0 10898.3 10911.5 10925.2 10926.1 10524.7 10859.6 10900.0 10905.3 11244.7 8272.9 8451.1 8467.7 8467.8 8483.5 5909.2 5929.6 5977.3 6026.5 6135.2 9926.1 10055.9 10139.1 10176.9 10207.4 10221.1 10339.7 10512.4 10660.2 10664.9 7152.7 7798.2 7889.4 7912.4 7920.7 7788.8 8411.1 8565.4 8662.4 8877.4 7723.2 7788.6 7945.8 7960.2 8092.6 7612.1 7689.7 7701.3 7745.7 7841.5 7240.6 7365.8 7368.4 7372.0 7373.4 4905.2 4920.1 5101.9 5200.3 5358.4 5023.7 5042.5 5096.1 5228.5 5321.1 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | [#4] prototype.html Cycles:180 Average:4762.01 Median:5440.47 stddev:1368.39 (25.2%) stddev-sans-first:1331.74 08:44:03 INFO - PROCESS | 16745 | Values: 359.9 366.6 368.2 373.2 373.5 5433.9 5493.6 5519.7 5544.3 5558.2 5097.9 5224.5 5240.3 5327.7 5365.3 4272.0 4277.8 4292.3 4349.7 4352.8 4274.6 4288.8 4293.8 4342.7 4343.3 3993.0 3998.5 4209.0 4254.4 4302.4 4257.5 4257.7 4265.2 4266.5 4286.5 3831.2 3832.0 3833.2 3841.4 3842.1 5105.9 5186.8 5221.8 5336.0 5343.4 4881.7 4883.4 4889.3 4906.1 4932.5 5637.4 5644.8 5645.8 5652.4 5673.6 4107.4 4166.6 4170.3 4204.8 4210.8 5779.9 5824.6 5826.0 5845.9 5852.8 4280.5 4297.3 4298.5 4301.8 4323.8 4198.1 4288.6 4311.3 4351.5 4376.5 4814.4 4831.5 4845.8 4861.9 4880.3 5604.6 5615.9 5644.3 5661.9 5672.9 1385.8 1420.9 1438.0 1463.3 1476.6 928.2 949.4 995.5 1019.8 1030.5 5377.6 5447.1 5462.7 5472.8 5474.3 5685.3 5696.2 5724.0 5746.9 5756.4 5138.5 5287.6 5295.2 5320.9 5328.0 2968.8 2969.8 2972.2 2986.3 2986.6 5542.8 5774.7 5786.3 5799.6 5806.3 5580.5 5591.2 5633.8 5688.5 5694.0 5757.2 5785.9 5812.3 5862.3 5886.1 5311.8 5520.6 5557.9 5560.6 5575.6 5509.8 5514.7 5522.0 5542.6 5593.4 5739.4 5766.6 5785.9 5882.5 5884.8 4224.0 4259.7 4278.4 4284.4 4295.7 5930.9 5934.2 5936.6 5949.0 5976.5 5702.6 5747.7 5770.9 5849.8 5855.8 5639.1 5683.7 5684.9 5691.4 5700.4 5515.6 5640.4 5661.2 5684.8 5698.9 5433.9 5719.6 5757.4 5763.7 5781.2 5609.4 5620.3 5644.3 5657.4 5706.9 08:44:03 INFO - PROCESS | 16745 | 08:44:03 INFO - PROCESS | 16745 | [#5] yui.html Cycles:180 Average:16712.24 Median:25079.30 stddev:20122.44 (80.2%) stddev-sans-first:20143.26 08:44:03 INFO - PROCESS | 16745 | Values: 765.1 813.3 818.4 847.2 895.4 14805.9 15151.8 15297.4 15373.8 15416.0 16228.8 16467.0 16541.3 16548.7 16714.2 737.3 842.7 844.1 844.2 845.1 756.6 836.3 843.2 847.7 856.1 858.6 858.7 858.8 859.0 861.4 769.4 851.7 851.7 852.7 859.3 579.7 648.3 655.7 655.9 659.7 14534.4 14552.1 14568.7 14573.2 14639.4 13545.2 13619.9 13694.2 13716.3 13896.5 12864.4 12868.9 12875.2 12944.5 13189.8 4478.3 4527.6 4545.3 4559.3 4655.0 59745.4 60080.7 60219.7 60360.4 60415.0 10968.2 11130.3 11224.4 11438.2 11493.8 18805.1 18806.2 18815.6 18856.0 18977.1 8000.9 8015.7 8028.8 8100.3 8565.6 4723.4 4765.6 4837.8 4871.3 4922.7 3450.0 3557.0 3560.9 3561.7 3573.1 629.9 634.6 642.6 649.5 654.8 653.2 657.8 712.3 720.4 742.0 8598.5 8868.2 9265.4 9710.9 9732.8 720.2 723.7 725.4 725.5 730.3 4290.8 4340.7 4348.2 4404.2 4467.1 48665.0 54623.5 69775.7 70661.3 71936.3 45272.0 48762.3 69909.0 70250.6 73376.6 61970.7 63612.4 64619.0 64857.7 65717.7 9735.0 9967.3 10075.9 10077.2 10078.0 43327.6 43817.3 44346.3 45599.3 45711.5 56440.7 59102.7 62441.4 62854.7 62889.0 11619.1 11937.7 12141.0 12215.8 12224.8 14053.8 14239.4 14606.1 14880.3 15392.3 13648.2 13719.5 13836.6 13849.0 14811.4 13281.2 13952.2 14040.9 14369.5 14479.6 13888.0 13966.0 14162.2 14241.1 14274.0 11388.9 11696.0 11729.7 11793.6 11900.4 11835.6 12305.7 12359.6 12567.5 12637.2 08:44:03 INFO - PROCESS | 16745 | -------- Summary: end -------- 08:44:03 INFO - PROCESS | 16745 | 08:44:04 INFO - TEST-INFO | 16745: exit 0 08:44:04 INFO - TEST-OK | dromaeo_css | took 1115516ms 08:44:04 INFO - TEST-START | kraken 08:44:04 INFO - operating with platform_type : linux_ 08:44:04 INFO - Initialising browser for kraken test... 08:44:04 INFO - TEST-INFO | started process 17062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6I_HgP/profile http://localhost:34204/getInfo.html) 08:44:08 INFO - PROCESS | 17062 | __metrics Screen width/height:1600/1200 08:44:08 INFO - PROCESS | 17062 | colorDepth:24 08:44:08 INFO - PROCESS | 17062 | Browser inner width/height: 1024/697 08:44:08 INFO - PROCESS | 17062 | __metrics 08:44:09 INFO - PROCESS | 17062 | 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" 08:44:09 INFO - PROCESS | 17062 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:09 INFO - PROCESS | 17062 | console.error: PushService: 08:44:09 INFO - PROCESS | 17062 | stateChangeProcessEnqueue: Error transitioning state 08:44:09 INFO - PROCESS | 17062 | UnknownError 08:44:10 INFO - TEST-INFO | 17062: exit 0 08:44:10 INFO - Browser initialized. 08:44:10 INFO - Running cycle 1/1 for kraken test... 08:44:10 INFO - TEST-INFO | started process 17154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6I_HgP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:22 INFO - PROCESS | 17154 | RSS: Main: 144777216 08:44:22 INFO - PROCESS | 17154 | 08:44:24 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34204/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:25 INFO - PROCESS | 17154 | RSS: Main: 185663488 08:44:25 INFO - PROCESS | 17154 | 08:44:27 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34204/tests/kraken/driver.html?testName=audio-dft) 08:44:28 INFO - PROCESS | 17154 | RSS: Main: 175280128 08:44:28 INFO - PROCESS | 17154 | 08:44:31 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34204/tests/kraken/driver.html?testName=audio-fft) 08:44:31 INFO - PROCESS | 17154 | RSS: Main: 266682368 08:44:31 INFO - PROCESS | 17154 | 08:44:33 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34204/tests/kraken/driver.html?testName=audio-oscillator) 08:44:34 INFO - PROCESS | 17154 | RSS: Main: 173015040 08:44:34 INFO - PROCESS | 17154 | 08:44:36 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:37 INFO - PROCESS | 17154 | RSS: Main: 175517696 08:44:37 INFO - PROCESS | 17154 | 08:44:40 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34204/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:40 INFO - PROCESS | 17154 | RSS: Main: 213868544 08:44:40 INFO - PROCESS | 17154 | 08:44:44 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34204/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:44 INFO - PROCESS | 17154 | RSS: Main: 212504576 08:44:44 INFO - PROCESS | 17154 | 08:44:47 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34204/tests/kraken/driver.html?testName=json-parse-financial) 08:44:47 INFO - PROCESS | 17154 | RSS: Main: 210526208 08:44:47 INFO - PROCESS | 17154 | 08:44:49 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:50 INFO - PROCESS | 17154 | RSS: Main: 173367296 08:44:50 INFO - PROCESS | 17154 | 08:44:51 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:52 INFO - PROCESS | 17154 | RSS: Main: 180703232 08:44:52 INFO - PROCESS | 17154 | 08:44:54 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:54 INFO - PROCESS | 17154 | RSS: Main: 189767680 08:44:54 INFO - PROCESS | 17154 | 08:44:57 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:58 INFO - PROCESS | 17154 | RSS: Main: 198492160 08:44:58 INFO - PROCESS | 17154 | 08:45:00 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:01 INFO - PROCESS | 17154 | RSS: Main: 194301952 08:45:01 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | Cycle 1(1): loaded http://localhost:34204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34204/tests/kraken/driver.html?testName=ai-astar) 08:45:03 INFO - PROCESS | 17154 | RSS: Main: 246153216 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | __start_tp_report 08:45:03 INFO - PROCESS | 17154 | _x_x_mozilla_page_load 08:45:03 INFO - PROCESS | 17154 | _x_x_mozilla_page_load_details 08:45:03 INFO - PROCESS | 17154 | |i|pagename|runs| 08:45:03 INFO - PROCESS | 17154 | |0;ai-astar;103;113;113;111;112;111;112;111;112;112 08:45:03 INFO - PROCESS | 17154 | |1;audio-beat-detection;140;123;116;155;120;118;118;118;149;121 08:45:03 INFO - PROCESS | 17154 | |2;audio-dft;160;161;161;161;161;161;160;162;161;160 08:45:03 INFO - PROCESS | 17154 | |3;audio-fft;73;74;75;112;75;75;76;79;100;75 08:45:03 INFO - PROCESS | 17154 | |4;audio-oscillator;82;81;113;82;81;82;112;82;82;116 08:45:03 INFO - PROCESS | 17154 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;116;117 08:45:03 INFO - PROCESS | 17154 | |6;imaging-darkroom;146;145;146;146;145;146;146;146;147;147 08:45:03 INFO - PROCESS | 17154 | |7;imaging-desaturate;85;85;85;85;84;85;85;84;85;85 08:45:03 INFO - PROCESS | 17154 | |8;json-parse-financial;51;50;51;50;51;50;50;50;50;49 08:45:03 INFO - PROCESS | 17154 | |9;json-stringify-tinderbox;58;60;58;58;60;58;62;59;58;59 08:45:03 INFO - PROCESS | 17154 | |10;stanford-crypto-aes;74;75;76;78;76;75;75;75;75;75 08:45:03 INFO - PROCESS | 17154 | |11;stanford-crypto-ccm;128;128;122;128;121;133;121;121;162;122 08:45:03 INFO - PROCESS | 17154 | |12;stanford-crypto-pbkdf2;162;160;159;159;160;158;160;156;155;162 08:45:03 INFO - PROCESS | 17154 | |13;stanford-crypto-sha256-iterative;65;63;66;62;64;63;63;62;61;61 08:45:03 INFO - PROCESS | 17154 | __end_tp_report 08:45:03 INFO - PROCESS | 17154 | __start_cc_report 08:45:03 INFO - PROCESS | 17154 | _x_x_mozilla_cycle_collect,1588 08:45:03 INFO - PROCESS | 17154 | __end_cc_report 08:45:03 INFO - PROCESS | 17154 | __startTimestamp1483980303289__endTimestamp 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | ------- Summary: start ------- 08:45:03 INFO - PROCESS | 17154 | Number of tests: 14 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.91 (2.6%) stddev-sans-first:0.78 08:45:03 INFO - PROCESS | 17154 | Values: 103.0 113.0 113.0 111.0 112.0 111.0 112.0 111.0 112.0 112.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:122.00 stddev:14.51 (11.9%) stddev-sans-first:14.71 08:45:03 INFO - PROCESS | 17154 | Values: 140.0 123.0 116.0 155.0 120.0 118.0 118.0 118.0 149.0 121.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 08:45:03 INFO - PROCESS | 17154 | Values: 160.0 161.0 161.0 161.0 161.0 161.0 160.0 162.0 161.0 160.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:13.36 (17.8%) stddev-sans-first:13.82 08:45:03 INFO - PROCESS | 17154 | Values: 73.0 74.0 75.0 112.0 75.0 75.0 76.0 79.0 100.0 75.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:82.00 stddev:15.47 (18.9%) stddev-sans-first:16.04 08:45:03 INFO - PROCESS | 17154 | Values: 82.0 81.0 113.0 82.0 81.0 82.0 112.0 82.0 82.0 116.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:45:03 INFO - PROCESS | 17154 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:45:03 INFO - PROCESS | 17154 | Values: 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 08:45:03 INFO - PROCESS | 17154 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 85.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:0.63 (1.3%) stddev-sans-first:0.60 08:45:03 INFO - PROCESS | 17154 | Values: 51.0 50.0 51.0 50.0 51.0 50.0 50.0 50.0 50.0 49.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:1.33 (2.3%) stddev-sans-first:1.36 08:45:03 INFO - PROCESS | 17154 | Values: 58.0 60.0 58.0 58.0 60.0 58.0 62.0 59.0 58.0 59.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.00 stddev:1.07 (1.4%) stddev-sans-first:1.01 08:45:03 INFO - PROCESS | 17154 | Values: 74.0 75.0 76.0 78.0 76.0 75.0 75.0 75.0 75.0 75.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:12.46 (9.7%) stddev-sans-first:13.21 08:45:03 INFO - PROCESS | 17154 | Values: 128.0 128.0 122.0 128.0 121.0 133.0 121.0 121.0 162.0 122.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:2.28 (1.4%) stddev-sans-first:2.17 08:45:03 INFO - PROCESS | 17154 | Values: 162.0 160.0 159.0 159.0 160.0 158.0 160.0 156.0 155.0 162.0 08:45:03 INFO - PROCESS | 17154 | 08:45:03 INFO - PROCESS | 17154 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.63 (2.6%) stddev-sans-first:1.56 08:45:03 INFO - PROCESS | 17154 | Values: 65.0 63.0 66.0 62.0 64.0 63.0 63.0 62.0 61.0 61.0 08:45:03 INFO - PROCESS | 17154 | -------- Summary: end -------- 08:45:03 INFO - PROCESS | 17154 | 08:45:04 INFO - TEST-INFO | 17154: exit 0 08:45:04 INFO - TEST-OK | kraken | took 59999ms 08:45:04 INFO - SUITE-END | took 1175s 08:45:04 INFO - Completed test suite (00:19:35) 08:45:04 INFO - javascript benchmark 08:45:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.2296637323852, 3196.6004249468815, 3202.103411044907, 3224.580804495415, 3232.6928941750525, 5468.453154684529, 5486.177073438987, 5519.116941289394, 5557.444255574445, 5562.082256427695, 5521.861953451165, 5538.556915446765, 5553.0837411827, 5553.333599967999, 5562.193481945115, 5027.622928280375, 5043.697378157304, 5049.697018178921, 5079.085764562377, 5083.440821509631, 4898.53463920927, 5076.36545431821, 5123.205903085028, 5129.9230511542355, 5167.715775632339, 4855.465898751135, 4998.925016124761, 5012.573931215851, 5040.571551418134, 5043.773030213649, 5041.974790126044, 5074.974625126869, 5078.873028174288, 5141.434442211354, 5158.303629010074, 4972.055309491185, 5071.3407257056715, 5104.770285337132, 5115.20714289282, 5122.538971492583, 5305.761240744176, 5330.520253177233, 5346.331708536433, 5346.4118946915805, 5389.272448219479, 5710.77156913723, 5725.2843394575675, 5745.6265342753, 5830.970845145747, 5843.912341314884, 5877.294724633029, 5879.617824841414, 5885.4997325227405, 5889.9705501472645, 5891.7054147292465, 5339.5194432500875, 5395.946040539623, 5406.864828379283, 5441.83674489766, 5448.427915068861, 5937.554683398763, 5941.079132734433, 5947.434993675594, 5956.970215148896, 5981.282246130492, 5719.056355701263, 5728.026235539968, 5733.226014487991, 5734.4838964492565, 5742.684152371659, 5671.291088613923, 5716.685582292931, 5815.651060936358, 5862.501687356623, 5870.178175055496, 5899.587028908021, 5906.055031194988, 5910.024845900378, 5941.881162376815, 5948.10778383246, 5865.94134058654, 5893.823185304362, 5919.822405327847, 5923.229980102559, 5926.8814623707285, 4459.152760975404, 4463.018136010072, 4470.865874023784, 4483.058557702919, 4585.197590421662, 4029.81865816039, 4048.817803198863, 4053.61490658387, 4080.7347522410946, 4102.876913692594, 5595.160725891149, 5596.580256480699, 5601.831945041656, 5608.074667679787, 5608.355039170548, 5739.16782066598, 5790.01569733138, 5896.469317761422, 5898.587098903122, 5906.675132867647, 5526.530244929146, 5535.861603459945, 5570.303712035996, 5616.831495055155, 5655.5475561954945, 5133.666311689803, 5143.5627971622835, 5146.562542183881, 5150.253213284128, 5153.845384638467, 5936.020556608111, 6094.481969032682, 6124.448799608057, 6143.201383820075, 6160.1375807387, 5728.341240757366, 5805.883882322245, 5856.531477481706, 5863.853403664772, 6000.159977603226, 6160.13758073861, 6164.6917654118015, 6166.969165154145, 6167.938320616737, 6198.473129784019, 5850.619709718854, 5858.531317494675, 5866.2960444745195, 5869.148973398918, 5869.618474799125, 5707.400722924199, 5723.284589426322, 5792.247007888947, 5840.386759390372, 5848.678322692293, 5786.971065144648, 5796.304443466811, 5799.710014499174, 5805.506531944832, 5828.59199856006, 5704.087346024616, 5765.971170144123, 5768.798092066925, 5770.451807078321, 5775.27809023872, 5565.30433695788, 5578.386377498553, 5623.634463759842, 5679.8864022720145, 5722.742476588647, 5798.76804927815, 5809.302883653989, 5814.273215848019, 5829.446202610745, 5847.1229315603, 5498.037843377313, 5657.4059723728415, 5657.773689052392, 5658.321001479849, 5660.547156227574], "value": 5426.7836542700115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.4066413254678, 635.7139287320705, 652.1261509577167, 656.7176114270861, 671.1878626861497, 33989.150271243234, 37242.441363379534, 46945.29582056268, 47133.52866471334, 47325.0, 44991.55008449915, 45351.09297814042, 45379.546204537946, 45396.31905521412, 45415.54584454154, 8765.430247033939, 8935.06181850906, 8950.86573701395, 8955.194032537103, 8957.955210223972, 8214.260716535511, 8448.23965843074, 10550.525226364794, 10774.245802793808, 10787.78424431511, 10855.348679079241, 10900.890991090106, 10908.727281817979, 10910.563577456933, 10922.126229901629, 10607.045365917065, 10689.198310126694, 10689.358638481677, 10701.357918524836, 10702.250842441032, 10748.892511074868, 10806.081483073947, 10812.621558245502, 10813.83779243312, 10816.296940698909, 43094.784526077485, 43591.782041089595, 43660.56339436597, 43704.0, 43724.78137609323, 3953.0710283083454, 3988.162485877969, 3991.2217117662067, 4041.4948131483566, 4551.931721024187, 33206.6679333206, 33396.33207335864, 33701.83149084263, 34089.0, 35516.28967420637, 4277.657787377002, 4285.9785701071605, 4290.2706539888295, 4311.719738217006, 4319.308910574325, 341620.2918985414, 341730.0, 342336.0, 342648.0, 342809.0, 59329.40670593325, 59839.0, 59853.401465985655, 59855.0, 59902.0, 40936.590634093875, 41531.58468415338, 41761.58238417638, 43702.781486093, 43707.0, 18083.186256618483, 18197.27210911575, 18203.0, 18204.635907282045, 18211.63576728458, 12719.046071544672, 12975.091743578048, 13304.068715189844, 13339.866601333862, 13342.66643333905, 19484.725324471794, 20386.388408347775, 20615.793842061386, 20767.480812979495, 20850.791492084885, 7350.311216792693, 7405.629718514053, 7414.443916706268, 7471.813204669927, 7525.661345239478, 970.6020531582018, 1051.784384201237, 1066.4081434803604, 1075.584140601317, 1135.7785231879704, 32555.67444325574, 33314.500847461924, 33629.49555756665, 33678.49482257768, 33999.830000850336, 1125.7185703574107, 1129.8757136714955, 1221.8045112781913, 1222.6454328244888, 1248.0, 16848.24182911772, 17628.647427051386, 17641.823581764274, 17755.911220443813, 17911.552211194823, 525300.0, 527912.0, 528001.0, 528123.0, 530222.0, 62070.68964655148, 62550.68724656347, 62648.68675656593, 62692.37307626956, 62799.0, 1323.444153455551, 1348.9055766096476, 1381.8341798984186, 1386.5840247925582, 1412.6680230146112, 32356.514652280704, 34217.60476766702, 34239.315213696085, 34429.827850861584, 34478.31043379169, 54328.72835635796, 54873.0, 54885.0, 54902.17646735382, 54964.0, 407712.0, 407792.0, 408840.0, 409135.0, 410007.0, 29652.517374130777, 30702.84648576832, 32246.516302255015, 32258.83870580632, 32676.0, 48059.27911081267, 48186.759066204446, 48606.0, 49588.0, 50152.24771628501, 41576.0, 42149.789251053546, 42198.78900605477, 42532.0, 43546.78226608974, 42091.789541053324, 42159.36760948527, 42613.14773704446, 43773.78113109541, 44087.33868992032, 41327.23386404072, 42638.36042459303, 42685.14629707326, 43131.137377252904, 43300.0, 34958.47562286517, 37858.77038695182, 37908.43137352887, 38067.42898856464, 38513.0, 28651.856740716164, 28822.279443014093, 28863.5670464939, 28876.855615722627, 28910.710892890802], "value": 20950.131613903774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.1340584229301, 426.692644909888, 433.71374892570907, 437.9189849877772, 442.42484769799273, 16676.332946682134, 19524.21903123875, 20916.89541552292, 21679.45801354967, 21746.238881639147, 20535.691964620542, 20608.8969555152, 20784.48038799031, 21417.14331426741, 21603.351899443, 5026.723530205837, 5728.083506638938, 5942.6137301075505, 5948.464638182562, 5952.166696662471, 6448.161738973927, 6630.933690663104, 6660.467162626978, 6667.899981500257, 6697.2967838377, 5496.31296087989, 5720.685362305072, 5758.049921762925, 6671.799846004627, 6673.299303573128, 5736.1682556029355, 5750.971245143789, 5764.510016648548, 5769.365369809318, 5769.942300577003, 5601.523870471015, 5837.066069428871, 5853.063509838448, 5864.941350586525, 5892.646441213541, 15146.469873554373, 15388.692226155526, 20276.0, 24373.756262437328, 24578.385540361454, 2532.240327901622, 2635.4465562231953, 2956.1870485616414, 3050.2679356954172, 3079.1840162356993, 10761.461926903701, 10855.24013319068, 10859.51132199045, 10862.511186996604, 10890.074343680797, 1998.860079794415, 2010.7386039814876, 2037.4600730806349, 2072.336852207294, 2073.450535608065, 82576.58711706403, 88390.0, 89224.5538772302, 90783.54608226982, 91630.54184729034, 10300.175985921258, 11855.881441185651, 11923.523059077714, 12047.39763011846, 12354.135210535176, 15470.149141797085, 15831.129287889276, 16683.49949501517, 16740.246688898784, 17305.56736081608, 8526.23263906239, 8639.956800216085, 8665.220130188314, 8887.066857979948, 8977.596008179647, 8285.378596605158, 8308.875366869503, 8372.916270837335, 8394.790130246793, 8718.43330183536, 5062.873428164326, 5131.820386286537, 5135.35808023997, 5200.5059519345605, 5260.28986086881, 2049.9795002050087, 2092.790720927895, 2096.853220274566, 2111.5776844631137, 2144.4188205696214, 964.744342749172, 983.4050399508337, 995.3530205366425, 1020.0564477857952, 1055.4247934875511, 19494.610107797766, 20172.596548068956, 20248.797512024987, 20292.492687682632, 20539.4865128373, 981.5337714585658, 1004.6985904228702, 1014.4065721552975, 1027.5016616940777, 1068.3963560588397, 10568.894311056945, 11412.258203216765, 11536.134789890624, 11579.768404632028, 11697.88302116985, 473779.0, 477144.0, 480323.0, 482515.0, 484901.0, 99433.50283248682, 103121.48439257756, 104618.0, 104663.47668261762, 108234.0, 1030.2427715629008, 1067.9946600266949, 1084.1868598551087, 1085.4572713643179, 1089.3790539392628, 17661.82338176653, 17979.370722024665, 18024.0, 18381.264749409875, 18850.245990160787, 32414.35171296608, 41448.37827432651, 41816.58183418127, 45660.315095272934, 47574.04851903012, 56873.0, 57899.4210057894, 58185.709071454374, 58358.708206458694, 58461.123083154635, 8720.869186962327, 8792.208701216921, 8949.194572488508, 9023.954880225558, 9079.591418386057, 9784.608615655294, 13062.0, 13280.667983300495, 13646.0, 13982.370793314121, 11988.520459181535, 11995.940020299842, 12240.816387754368, 12245.69385765363, 12391.273919737643, 11620.767584648429, 11632.825507617561, 11905.821412678644, 11913.285202887855, 12123.393830308625, 12011.279323240633, 12385.876141238472, 12428.937855310665, 12433.06751993586, 12550.937245313715, 8884.422512536923, 8976.057513960941, 9063.456192628464, 9270.490123043297, 9338.0, 9654.082862128087, 12062.155649104478, 12316.753664926831, 12336.259824410565, 12367.134300598871], "value": 9655.653089081985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.1241823533232, 1529.9311530981106, 1704.4460550321141, 1822.152698994967, 1834.4496651004695, 8318.126596707349, 8861.91138088619, 8867.955660221705, 8872.911270887289, 8875.778105547364, 7644.503107298022, 7845.058592968838, 7846.4899781514305, 8031.277185053344, 8793.340499462534, 2212.966805497919, 2438.5610590093775, 2498.0, 2504.261242933339, 2507.8119141064494, 2409.77107174819, 2454.0919859651954, 2457.913973010945, 2466.4573793765344, 2505.887235074417, 2447.486027934136, 2450.669159663449, 2454.9263522094275, 2472.81453890958, 2479.454520005605, 2418.830681852271, 2432.4526981429035, 2437.0739119134705, 2439.841410308342, 2441.4872876695913, 2405.7353691093967, 2455.2511483997373, 2456.1649039326535, 2458.4222707663685, 2460.065175233418, 8978.326625503114, 9029.367944243906, 9066.501342426163, 9087.227585655228, 9112.681056163003, 5547.583931205136, 5691.117876729072, 5691.48776610103, 5695.572832037572, 5698.230738850285, 3441.7074548663395, 3491.598466176397, 3538.327717733622, 3720.813959302024, 3726.2920045191327, 1151.8560179977503, 1155.0817100405197, 1155.422288855572, 1165.7085728567858, 1215.9270443773403, 12294.446749896277, 12334.876651233462, 12358.629241122691, 12412.069094817925, 12440.253584784941, 4769.974455492086, 4872.244802055687, 4952.5542701157065, 4968.503149685002, 5000.224965130411, 10458.477076146315, 10467.84298235527, 10475.633352832614, 10476.266661333786, 10493.265471416928, 5647.548196144298, 5651.406602306781, 5655.0, 5655.519280861173, 5658.7170641467765, 4539.795709193028, 4958.752062396938, 5053.722045287471, 5185.533302002837, 5193.039287731782, 3650.762700424517, 3900.8829735107993, 3944.4872166618156, 3956.4658771066115, 3981.9203615927518, 1231.378154032208, 1232.6363722701824, 1238.0, 1241.075398827879, 1252.6367353467574, 905.5743800413795, 986.6941248212934, 1023.3348323589727, 1030.9484525773682, 1039.3348257115451, 5874.1776151338845, 6101.511879049665, 6116.0, 6171.197744293213, 6207.099970504251, 988.7936717204998, 998.5157198758596, 1005.4721271332609, 1005.4872015272264, 1025.3386565665105, 4138.5654506276405, 4154.958450415457, 4161.438205842233, 4202.70581059329, 4243.002894319832, 10413.0, 10898.346099234072, 10911.508982095826, 10925.235233533735, 10926.125909927187, 10524.684259472227, 10859.565617375216, 10900.0, 10905.291156074989, 11244.66266012021, 8272.917270827335, 8451.11263317355, 8467.703630372907, 8467.788305292417, 8483.533405662625, 5909.172715819875, 5929.555283353679, 5977.3126090500145, 6026.457618814327, 6135.1717518136265, 9926.106650401498, 10055.899441005497, 10139.087482126644, 10176.898231017594, 10207.387556746618, 10221.131203847755, 10339.741506462398, 10512.42181680015, 10660.200484963503, 10664.893351066701, 7152.713891444284, 7798.220177982156, 7889.408294377829, 7912.446128770931, 7920.683172673259, 7788.805279868048, 8411.116832732476, 8565.400421970402, 8662.393632445668, 8877.422967507091, 7723.150453450004, 7788.610569471391, 7945.801354966172, 7960.2039796019935, 8092.554909480035, 7612.1246056704185, 7689.6539655714505, 7701.345385642059, 7745.728899488491, 7841.490303130278, 7240.637968101469, 7365.8158546036775, 7368.37368823656, 7372.004779354718, 7373.3732632726815, 4905.190643543775, 4920.065187614342, 5101.923471147861, 5200.349956255468, 5358.35699716021, 5023.748812559431, 5042.495750424928, 5096.108181068224, 5228.503292187236, 5321.095413779744], "value": 4754.680833988837, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.94960705501217, 366.61139192456, 368.2193749251587, 373.2441805344176, 373.51070098171397, 5433.864153396157, 5493.560515158788, 5519.69641669708, 5544.306961629796, 5558.194061861028, 5097.923531147027, 5224.503672151149, 5240.292560504331, 5327.680339179652, 5365.275687782148, 4272.0, 4277.8288868445225, 4292.291771857647, 4349.69552131351, 4352.847650332239, 4274.572542745716, 4288.828446862121, 4293.8067786949505, 4342.652587792969, 4343.326784348431, 3993.0017495626093, 3998.5005622891417, 4208.957910420887, 4254.404383386328, 4302.41917341158, 4257.467816522934, 4257.657738675125, 4265.168292183025, 4266.530681625019, 4286.485621725382, 3831.214601006815, 3831.980840095782, 3833.15670552478, 3841.42378643203, 3842.1355195081164, 5105.923411148836, 5186.7925282988635, 5221.791128354861, 5335.973320133413, 5343.358796944352, 4881.682690625134, 4883.411791750378, 4889.315495830587, 4906.067847109038, 4932.506749325039, 5637.408072152406, 5644.802431914904, 5645.830625081254, 5652.378238393773, 5673.574481913832, 4107.383892416132, 4166.64583510402, 4170.332746760504, 4204.768737719424, 4210.810513526899, 5779.855503612402, 5824.621399609012, 5826.0, 5845.912311315334, 5852.824415267549, 4280.5291417944, 4297.314178638351, 4298.548652391516, 4301.827926882889, 4323.762193079411, 4198.097409057067, 4288.571142885687, 4311.331743579687, 4351.456067991501, 4376.474823021258, 4814.374131362901, 4831.51684831514, 4845.781939812717, 4861.891701512217, 4880.292357608127, 5604.60767746262, 5615.887682246333, 5644.294463192101, 5661.915071273934, 5672.943270567324, 1385.847556768775, 1420.8934329925296, 1438.0227187617027, 1463.3268696399775, 1476.6234610174338, 928.1878356438117, 949.3829011142813, 995.5171741705267, 1019.8266294729914, 1030.4950574218728, 5377.596680248997, 5447.073997420369, 5462.743568979157, 5472.808451704172, 5474.2609747683555, 5685.260916080883, 5696.174054762119, 5724.0, 5746.936816688926, 5756.366799652035, 5138.460461651547, 5287.576993840484, 5295.232191332235, 5320.920186197211, 5327.9733601331745, 2968.8218706877656, 2969.7624190065176, 2972.2272209225757, 2986.25343664084, 2986.6117404737247, 5542.778288868481, 5774.653520788682, 5786.276715410574, 5799.5650326225705, 5806.274215723035, 5580.525655319262, 5591.217229587861, 5633.774649014075, 5688.459596338341, 5694.0, 5757.165211044375, 5785.88428231433, 5812.33158186797, 5862.325832529228, 5886.117082437583, 5311.814086506954, 5520.558355331484, 5557.944420555905, 5560.554255893416, 5575.637583557056, 5509.834704958857, 5514.696691681996, 5522.0, 5542.584306177134, 5593.4126916674795, 5739.368669446274, 5766.625169363978, 5785.9132113017495, 5882.49998750111, 5884.7940322088525, 4224.0, 4259.65922726175, 4278.422412974209, 4284.421603083544, 4295.72077814941, 5930.940690593039, 5934.228550288608, 5936.5844390892225, 5948.970255148696, 5976.462118409364, 5702.600817942704, 5747.683877386784, 5770.8845823082465, 5849.824505264849, 5855.765769369177, 5639.125935480007, 5683.658980461186, 5684.914726279027, 5691.430856914441, 5700.372958974426, 5515.558755299486, 5640.379558248507, 5661.207430959751, 5684.772609095755, 5698.886022279614, 5433.864153396196, 5719.599628026164, 5757.424257574209, 5763.7118144093465, 5781.190633311256, 5609.382967873612, 5620.269364982526, 5644.294463192101, 5657.4059723728415, 5706.8573285666525], "value": 4332.961507027284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.1048273519981, 813.3330668851543, 818.4148333941231, 847.1782371100034, 895.3777124898198, 14805.851941480581, 15151.848481515182, 15297.388104475822, 15373.769393459108, 15415.997960132598, 16228.83771162288, 16467.0, 16541.255643496042, 16548.66902661946, 16714.24785884635, 737.2958824322785, 842.7303262955857, 844.1389782421926, 844.1727107434717, 845.0999685335129, 756.5838788666239, 836.2933321343486, 843.1989609870617, 847.7456762971115, 856.0540602634093, 858.5792961448908, 858.7037472072125, 858.7853036740814, 858.995705021474, 861.4099341950783, 769.3729610367533, 851.7019043334783, 851.7189327521934, 852.6631980367752, 859.2782063067023, 579.7217335678898, 648.2739331948248, 655.7016557466342, 655.9409653131241, 659.6635715784936, 14534.418623255056, 14552.126872387691, 14568.70862582753, 14573.198474083922, 14639.41442342305, 13545.187288762607, 13619.931900340534, 13694.246816425093, 13716.314184290846, 13896.51362202318, 12864.356782160854, 12868.935655321757, 12875.163114397534, 12944.546940857119, 13189.802152967713, 4478.261086920655, 4527.592516673515, 4545.272756359, 4559.293309536994, 4654.953450465519, 59745.402545974415, 60080.69959650218, 60219.69890150565, 60360.39639603592, 60415.0, 10968.17738669587, 11130.33218006906, 11224.382658953673, 11438.199326047097, 11493.77012459746, 18805.059747012594, 18806.247750089842, 18815.62368752617, 18856.0, 18977.146028428753, 8000.919990800134, 8015.719449819228, 8028.759137225892, 8100.270975612223, 8565.61454734526, 4723.362346083235, 4765.642576806753, 4837.830675926326, 4871.269309603588, 4922.680025798311, 3449.965500345015, 3557.0395993081725, 3560.857565697395, 3561.679448849616, 3573.0531409176588, 629.902365133405, 634.552640388525, 642.6465444005778, 649.4804156674642, 654.8002859128012, 653.183520599251, 657.8256761958085, 712.3375261007313, 720.4128635162326, 741.9777406677808, 8598.484090954562, 8868.201861832466, 9265.397749146285, 9710.854337184948, 9732.805343893224, 720.1718024272025, 723.6779633063236, 725.3580581185689, 725.4631572636316, 730.2697302697303, 4290.785460726951, 4340.696151269381, 4348.195583817004, 4404.163208990281, 4467.128909862546, 48665.0, 54623.45376546263, 69775.65112174508, 70661.2933870665, 71936.28063719401, 45272.0, 48762.268565971535, 69909.0, 70250.64874675593, 73376.63311683407, 61970.69014654898, 63612.36387636064, 64619.0, 64857.67571162114, 65717.67141164263, 9735.0, 9967.252456065678, 10075.89924100779, 10077.19382449417, 10078.0, 43327.566724333614, 43817.34273985829, 44346.334804977305, 45599.31601025921, 45711.54288457206, 56440.7177964124, 59102.704486479015, 62441.37558624356, 62854.68572657107, 62889.0, 11619.128565357802, 11937.701557461132, 12141.0, 12215.816762748744, 12224.75550489003, 14053.789193162314, 14239.35922883452, 14606.12363258208, 14880.330385132911, 15392.307346169673, 13648.181109133087, 13719.451221951409, 13836.584902452943, 13849.0, 14811.407543698562, 13281.203127812361, 13952.232627205602, 14040.859591403956, 14369.497067602584, 14479.638009049859, 13888.0, 13966.0, 14162.221077840817, 14241.074330168505, 14274.0, 11388.886111138783, 11696.005839503738, 11729.706757331134, 11793.646190614296, 11900.404979750805, 11835.585754498552, 12305.692357691129, 12359.567415140427, 12567.497300107892, 12637.17858339205], "value": 7230.452672475233, "unit": "score"}], "name": "dromaeo_css", "value": 7394.995819373908, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 111.0, 112.0, 111.0, 112.0, 111.0, 112.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 123.0, 116.0, 155.0, 120.0, 118.0, 118.0, 118.0, 149.0, 121.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 112.0, 75.0, 75.0, 76.0, 79.0, 100.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 113.0, 82.0, 81.0, 82.0, 112.0, 82.0, 82.0, 116.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 50.0, 51.0, 50.0, 50.0, 50.0, 50.0, 49.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 58.0, 60.0, 58.0, 62.0, 59.0, 58.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 78.0, 76.0, 75.0, 75.0, 75.0, 75.0, 75.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 122.0, 128.0, 121.0, 133.0, 121.0, 121.0, 162.0, 122.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 159.0, 159.0, 160.0, 158.0, 160.0, 156.0, 155.0, 162.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 62.0, 64.0, 63.0, 63.0, 62.0, 61.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1455.1999999999998, "alertThreshold": 2.0}]} 08:45:04 INFO - Return code: 0 08:45:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:45:04 INFO - # TBPL SUCCESS # 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - [mozharness: 2017-01-09 16:45:04.589838Z] Finished run-tests step (success) 08:45:04 INFO - Running post-run listener: _resource_record_post_run 08:45:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 361885696; Read time: 24; Write time: 315844 08:45:04 INFO - TinderboxPrint: CPU usage
13.0% 08:45:04 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 08:45:04 INFO - TinderboxPrint: I/O write bytes / time
361,885,696 / 315,844 08:45:04 INFO - TinderboxPrint: CPU idle
8,277.4 (87.0%) 08:45:04 INFO - TinderboxPrint: CPU user
1,191.7 (12.5%) 08:45:04 INFO - TinderboxPrint: Swap in / out
0 / 0 08:45:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113872896; Read time: 0; Write time: 115780 08:45:04 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246218752; Read time: 20; Write time: 200040 08:45:05 INFO - Running post-run listener: _upload_blobber_files 08:45:05 INFO - Blob upload gear active. 08:45:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:05 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 08:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:45:05 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:06 INFO - (blobuploader) - INFO - Done attempting. 08:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:09 INFO - (blobuploader) - INFO - Done attempting. 08:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:10 INFO - (blobuploader) - INFO - Done attempting. 08:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:10 INFO - Return code: 0 08:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0465a3b5229110dd599a4777ea0dd9947a1d3054e230601dd89be7ee845c1cbbd895b3bde1af0877fcfbe964ecd5536479b70524d2f53621e4cbc877b4690912", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8ea0cdb9f40b35c9e223cead859031be9acf2ee7781b96647601327a1d2f1f211393679936b8648aa43c0b943c7dfa00b70534843c5561579205c3390ff8c60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f43e538c7839aef112e7325a003d97ee688bb547b0c8deba5d66f5b2bc1816cc850647e927935e8cb7edc7e90c6cd8157cdaebacfb80d8d8ff01e1f0e6691018"} 08:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:10 INFO - Contents: 08:45:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0465a3b5229110dd599a4777ea0dd9947a1d3054e230601dd89be7ee845c1cbbd895b3bde1af0877fcfbe964ecd5536479b70524d2f53621e4cbc877b4690912", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8ea0cdb9f40b35c9e223cead859031be9acf2ee7781b96647601327a1d2f1f211393679936b8648aa43c0b943c7dfa00b70534843c5561579205c3390ff8c60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f43e538c7839aef112e7325a003d97ee688bb547b0c8deba5d66f5b2bc1816cc850647e927935e8cb7edc7e90c6cd8157cdaebacfb80d8d8ff01e1f0e6691018"} 08:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:10 INFO - Copying logs to upload dir... 08:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.544832 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-09 08:45:09.718834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 08:45:09.722987) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0465a3b5229110dd599a4777ea0dd9947a1d3054e230601dd89be7ee845c1cbbd895b3bde1af0877fcfbe964ecd5536479b70524d2f53621e4cbc877b4690912", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8ea0cdb9f40b35c9e223cead859031be9acf2ee7781b96647601327a1d2f1f211393679936b8648aa43c0b943c7dfa00b70534843c5561579205c3390ff8c60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f43e538c7839aef112e7325a003d97ee688bb547b0c8deba5d66f5b2bc1816cc850647e927935e8cb7edc7e90c6cd8157cdaebacfb80d8d8ff01e1f0e6691018"} build_url:https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/YjlZcpIjQfexTEoEFQGdbQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0465a3b5229110dd599a4777ea0dd9947a1d3054e230601dd89be7ee845c1cbbd895b3bde1af0877fcfbe964ecd5536479b70524d2f53621e4cbc877b4690912", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f8ea0cdb9f40b35c9e223cead859031be9acf2ee7781b96647601327a1d2f1f211393679936b8648aa43c0b943c7dfa00b70534843c5561579205c3390ff8c60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f43e538c7839aef112e7325a003d97ee688bb547b0c8deba5d66f5b2bc1816cc850647e927935e8cb7edc7e90c6cd8157cdaebacfb80d8d8ff01e1f0e6691018"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 08:45:09.748982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:45:09.749575) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1483979073.38128-1543562068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 08:45:09.831829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 08:45:09.832197) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 08:45:09.832461) ========= ========= Total master_lag: 0.17 =========