builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1479161838.63 results: success (0) buildid: 20161114112842 builduid: 37b75e2f2cc64a04813759037c6ea815 revision: 3f2202420b01fcc253118f5dcc07f1be9b3c3009 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.629694) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.630136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.630409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.644797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.645086) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 14:17:19-- 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% 46.2M=0s 2016-11-14 14:17:19 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.789175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.789482) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020076 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.839183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:18.839534) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 3f2202420b01fcc253118f5dcc07f1be9b3c3009 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 3f2202420b01fcc253118f5dcc07f1be9b3c3009 --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=78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 14:17:19,402 truncating revision to first 12 chars 2016-11-14 14:17:19,402 Setting DEBUG logging. 2016-11-14 14:17:19,402 attempt 1/10 2016-11-14 14:17:19,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/3f2202420b01?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 14:17:19,744 unpacking tar archive at: larch-3f2202420b01/testing/mozharness/ program finished with exit code 0 elapsedTime=0.725998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:19.580226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:19.580564) ========= script_repo_revision: 3f2202420b01fcc253118f5dcc07f1be9b3c3009 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:19.580946) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:19.581212) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 14:17:19.590576) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-14 14:17:19.590855) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] 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=78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:20 INFO - MultiFileLogger online at 20161114 14:17:20 in /builds/slave/test 14:17:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 14:17:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:20 INFO - {'append_to_log': False, 14:17:20 INFO - 'base_work_dir': '/builds/slave/test', 14:17:20 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 14:17:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:20 INFO - 'branch': 'Larch-Non-PGO', 14:17:20 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:20 INFO - 'config_files': ('talos/linux_config.py',), 14:17:20 INFO - 'default_actions': ('clobber', 14:17:20 INFO - 'read-buildbot-config', 14:17:20 INFO - 'download-and-extract', 14:17:20 INFO - 'populate-webroot', 14:17:20 INFO - 'create-virtualenv', 14:17:20 INFO - 'install', 14:17:20 INFO - 'run-tests'), 14:17:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:20 INFO - 'download_minidump_stackwalk': True, 14:17:20 INFO - 'download_symbols': 'ondemand', 14:17:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:20 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:20 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:20 INFO - 'installer_path': 'installer.exe', 14:17:20 INFO - 'log_level': 'info', 14:17:20 INFO - 'log_name': 'talos', 14:17:20 INFO - 'log_to_console': True, 14:17:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:20 INFO - 'opt_config_files': (), 14:17:20 INFO - 'pip_index': False, 14:17:20 INFO - 'sps_profile': False, 14:17:20 INFO - 'sps_profile_interval': 0, 14:17:20 INFO - 'suite': 'dromaeojs', 14:17:20 INFO - 'system_bits': '32', 14:17:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:20 INFO - 'title': 'talos-linux64-ix-019', 14:17:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:20 INFO - 'use_talos_json': True, 14:17:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:20 INFO - 'work_dir': 'build'} 14:17:20 INFO - [mozharness: 2016-11-14 22:17:20.248447Z] Running clobber step. 14:17:20 INFO - Running pre-action listener: _resource_record_pre_action 14:17:20 INFO - Running main action method: clobber 14:17:20 INFO - rmtree: /builds/slave/test/build 14:17:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:20 INFO - Running post-action listener: _resource_record_post_action 14:17:20 INFO - [mozharness: 2016-11-14 22:17:20.744033Z] Finished clobber step (success) 14:17:20 INFO - [mozharness: 2016-11-14 22:17:20.744134Z] Running read-buildbot-config step. 14:17:20 INFO - Running pre-action listener: _resource_record_pre_action 14:17:20 INFO - Running main action method: read_buildbot_config 14:17:20 INFO - Using buildbot properties: 14:17:20 INFO - { 14:17:20 INFO - "project": "", 14:17:20 INFO - "product": "firefox", 14:17:20 INFO - "script_repo_revision": "production", 14:17:20 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 14:17:20 INFO - "repository": "", 14:17:20 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 14:17:20 INFO - "buildid": "20161114112842", 14:17:20 INFO - "pgo_build": "False", 14:17:20 INFO - "basedir": "/builds/slave/test", 14:17:20 INFO - "buildnumber": 3, 14:17:20 INFO - "slavename": "talos-linux64-ix-019", 14:17:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:17:20 INFO - "platform": "ubuntu64_hw", 14:17:20 INFO - "scheduler": "tests-larch-linux64-talos", 14:17:20 INFO - "branch": "larch", 14:17:20 INFO - "repo_path": "projects/larch", 14:17:20 INFO - "revision": "3f2202420b01fcc253118f5dcc07f1be9b3c3009", 14:17:20 INFO - "stage_platform": "linux64", 14:17:20 INFO - "builduid": "37b75e2f2cc64a04813759037c6ea815", 14:17:20 INFO - "slavebuilddir": "test" 14:17:20 INFO - } 14:17:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:17:20 INFO - Running post-action listener: _resource_record_post_action 14:17:20 INFO - [mozharness: 2016-11-14 22:17:20.746661Z] Finished read-buildbot-config step (success) 14:17:20 INFO - [mozharness: 2016-11-14 22:17:20.746750Z] Running download-and-extract step. 14:17:20 INFO - Running pre-action listener: _resource_record_pre_action 14:17:20 INFO - Running main action method: download_and_extract 14:17:20 INFO - mkdir: /builds/slave/test/build/tests 14:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:20 INFO - trying https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:17:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:17:21 INFO - Downloaded 1361 bytes. 14:17:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:17:21 INFO - Using the following test package requirements: 14:17:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'jsshell-linux-x86_64.zip'], 14:17:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:17:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:21 INFO - Fetch https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:17:21 INFO - Http code: 200 14:17:21 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 14:17:21 INFO - x-amz-cf-id: fvlVIxk5HfNd4sYFItk4ekMCEGtcpRDCyynd3TabsfyNImLVLuDjsg== 14:17:21 INFO - x-amz-version-id: EeihfcBqfYm1qYYZcfpnGufxvhgDzZND 14:17:22 INFO - Expected file size: 20414097 14:17:22 INFO - Obtained file size: 20414097 14:17:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:17:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:17:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:17:26 INFO - Http code: 200 14:17:26 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 14:17:26 INFO - x-amz-cf-id: BItL1T938a5VnajnbP4m3IfWF5GBpc7lFvUifrcoej0N6ZH2ZVGwsw== 14:17:26 INFO - x-amz-version-id: EeihfcBqfYm1qYYZcfpnGufxvhgDzZND 14:17:26 INFO - Expected file size: 20414097 14:17:26 INFO - Obtained file size: 20414097 14:17:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:17:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:17:31 INFO - Http code: 200 14:17:31 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 14:17:31 INFO - x-amz-cf-id: OAI9nwV7UEQ6v3tLqrPADODQMobnLvlpaxx33e6DsVr5-60E-F5LUQ== 14:17:31 INFO - x-amz-version-id: GjivTfhq.YK0xLN4.LWvVO0ZVNbS1RkG 14:17:32 INFO - Expected file size: 14409038 14:17:32 INFO - Obtained file size: 14409038 14:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:32 INFO - trying https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:17:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:17:33 INFO - Downloaded 55755391 bytes. 14:17:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:17:33 INFO - mkdir: /builds/slave/test/properties 14:17:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:33 INFO - Contents: 14:17:33 INFO - build_url:https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:17:34 INFO - Running post-action listener: _resource_record_post_action 14:17:34 INFO - Running post-action listener: set_extra_try_arguments 14:17:34 INFO - [mozharness: 2016-11-14 22:17:34.210077Z] Finished download-and-extract step (success) 14:17:34 INFO - [mozharness: 2016-11-14 22:17:34.210304Z] Running populate-webroot step. 14:17:34 INFO - Running pre-action listener: _resource_record_pre_action 14:17:34 INFO - Running main action method: populate_webroot 14:17:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:34 INFO - '--tppagecycles', 14:17:34 INFO - '7'], 14:17:34 INFO - 'tests': ['tsvgm']}}, 14:17:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['damp', 'tps']}, 14:17:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'tests': ['damp', 'tps']}, 14:17:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['dromaeo_dom']}, 14:17:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['basic_compositor_video']}, 14:17:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:17:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['a11yr', 14:17:34 INFO - 'ts_paint', 14:17:34 INFO - 'tpaint', 14:17:34 INFO - 'sessionrestore', 14:17:34 INFO - 'sessionrestore_no_auto_restore', 14:17:34 INFO - 'tabpaint']}, 14:17:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:34 INFO - 'ts_paint', 14:17:34 INFO - 'tpaint', 14:17:34 INFO - 'sessionrestore', 14:17:34 INFO - 'sessionrestore_no_auto_restore', 14:17:34 INFO - 'tabpaint']}, 14:17:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:34 INFO - 'ts_paint', 14:17:34 INFO - 'tpaint', 14:17:34 INFO - 'sessionrestore', 14:17:34 INFO - 'sessionrestore_no_auto_restore', 14:17:34 INFO - 'tabpaint']}, 14:17:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:34 INFO - 'ts_paint', 14:17:34 INFO - 'tpaint', 14:17:34 INFO - 'sessionrestore', 14:17:34 INFO - 'sessionrestore_no_auto_restore', 14:17:34 INFO - 'tabpaint']}, 14:17:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['a11yr', 14:17:34 INFO - 'ts_paint', 14:17:34 INFO - 'tpaint', 14:17:34 INFO - 'sessionrestore', 14:17:34 INFO - 'sessionrestore_no_auto_restore', 14:17:34 INFO - 'tabpaint']}, 14:17:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['a11yr', 14:17:34 INFO - 'ts_paint', 14:17:34 INFO - 'tpaint', 14:17:34 INFO - 'sessionrestore', 14:17:34 INFO - 'sessionrestore_no_auto_restore', 14:17:34 INFO - 'tabpaint']}, 14:17:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['tsvgx', 14:17:34 INFO - 'tsvgr_opacity', 14:17:34 INFO - 'tart', 14:17:34 INFO - 'tscrollx', 14:17:34 INFO - 'cart']}, 14:17:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:34 INFO - 'tsvgr_opacity', 14:17:34 INFO - 'tart', 14:17:34 INFO - 'tscrollx', 14:17:34 INFO - 'cart']}, 14:17:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'talos_options': ['--disable-e10s'], 14:17:34 INFO - 'tests': ['tp5o']}, 14:17:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'tests': ['tp5o']}, 14:17:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'talos_options': ['--disable-e10s', 14:17:34 INFO - '--xperf_path', 14:17:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:34 INFO - 'tests': ['tp5n']}, 14:17:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:34 INFO - 'talos_options': ['--xperf_path', 14:17:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:34 INFO - 'tests': ['tp5n']}}, 14:17:34 INFO - 'talos.zip': {'path': '', 14:17:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:34 INFO - Running post-action listener: _resource_record_post_action 14:17:34 INFO - [mozharness: 2016-11-14 22:17:34.227581Z] Finished populate-webroot step (success) 14:17:34 INFO - [mozharness: 2016-11-14 22:17:34.227670Z] Running create-virtualenv step. 14:17:34 INFO - Running pre-action listener: _resource_record_pre_action 14:17:34 INFO - Running main action method: create_virtualenv 14:17:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:34 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 14:17:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:34 INFO - Using real prefix '/usr' 14:17:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:34 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:36 INFO - Installing pip.................done. 14:17:36 INFO - Return code: 0 14:17:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:17:37 INFO - Reading from file tmpfile_stdout 14:17:37 INFO - Output received: 14:17:37 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) 14:17:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:37 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:37 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 14:17:37 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 14:17:37 INFO - Using env: {'DISPLAY': ':0', 14:17:37 INFO - 'HOME': '/home/cltbld', 14:17:37 INFO - 'LANG': 'en_US.UTF-8', 14:17:37 INFO - 'LANGUAGE': 'en_US:en', 14:17:37 INFO - 'LOGNAME': 'cltbld', 14:17:37 INFO - 'MAIL': '/var/mail/cltbld', 14:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:37 INFO - 'MOZ_NO_REMOTE': '1', 14:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:37 INFO - 'NO_EM_RESTART': '1', 14:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:37 INFO - 'PWD': '/builds/slave/test', 14:17:37 INFO - 'SHELL': '/bin/bash', 14:17:37 INFO - 'SHLVL': '1', 14:17:37 INFO - 'TERM': 'linux', 14:17:37 INFO - 'TMOUT': '86400', 14:17:37 INFO - 'USER': 'cltbld', 14:17:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:37 INFO - '_': '/tools/buildbot/bin/python'} 14:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:37 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 14:17:37 INFO - Cleaning up... 14:17:37 INFO - Return code: 0 14:17:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:37 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:37 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 14:17:37 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 14:17:37 INFO - Using env: {'DISPLAY': ':0', 14:17:37 INFO - 'HOME': '/home/cltbld', 14:17:37 INFO - 'LANG': 'en_US.UTF-8', 14:17:37 INFO - 'LANGUAGE': 'en_US:en', 14:17:37 INFO - 'LOGNAME': 'cltbld', 14:17:37 INFO - 'MAIL': '/var/mail/cltbld', 14:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:37 INFO - 'MOZ_NO_REMOTE': '1', 14:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:37 INFO - 'NO_EM_RESTART': '1', 14:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:37 INFO - 'PWD': '/builds/slave/test', 14:17:37 INFO - 'SHELL': '/bin/bash', 14:17:37 INFO - 'SHLVL': '1', 14:17:37 INFO - 'TERM': 'linux', 14:17:37 INFO - 'TMOUT': '86400', 14:17:37 INFO - 'USER': 'cltbld', 14:17:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:37 INFO - '_': '/tools/buildbot/bin/python'} 14:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:37 INFO - Downloading/unpacking psutil>=3.1.1 14:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:39 INFO - Installing collected packages: psutil 14:17:39 INFO - Running setup.py install for psutil 14:17:39 INFO - building 'psutil._psutil_linux' extension 14:17:39 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 14:17:39 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 14:17:39 INFO - building 'psutil._psutil_posix' extension 14:17:39 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 14:17:39 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 14:17:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:40 INFO - Successfully installed psutil 14:17:40 INFO - Cleaning up... 14:17:40 INFO - Return code: 0 14:17:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:40 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:40 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 14:17:40 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 14:17:40 INFO - Using env: {'DISPLAY': ':0', 14:17:40 INFO - 'HOME': '/home/cltbld', 14:17:40 INFO - 'LANG': 'en_US.UTF-8', 14:17:40 INFO - 'LANGUAGE': 'en_US:en', 14:17:40 INFO - 'LOGNAME': 'cltbld', 14:17:40 INFO - 'MAIL': '/var/mail/cltbld', 14:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:40 INFO - 'MOZ_NO_REMOTE': '1', 14:17:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:40 INFO - 'NO_EM_RESTART': '1', 14:17:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:40 INFO - 'PWD': '/builds/slave/test', 14:17:40 INFO - 'SHELL': '/bin/bash', 14:17:40 INFO - 'SHLVL': '1', 14:17:40 INFO - 'TERM': 'linux', 14:17:40 INFO - 'TMOUT': '86400', 14:17:40 INFO - 'USER': 'cltbld', 14:17:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:40 INFO - '_': '/tools/buildbot/bin/python'} 14:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:17:40 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 14:17:40 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 14:17:40 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 14:17:40 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 14:17:40 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 14:17:40 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 14:17:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:17:42 INFO - Installing collected packages: mozsystemmonitor 14:17:42 INFO - Running setup.py install for mozsystemmonitor 14:17:42 INFO - Successfully installed mozsystemmonitor 14:17:42 INFO - Cleaning up... 14:17:42 INFO - Return code: 0 14:17:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:42 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:42 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 14:17:42 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 14:17:42 INFO - Using env: {'DISPLAY': ':0', 14:17:42 INFO - 'HOME': '/home/cltbld', 14:17:42 INFO - 'LANG': 'en_US.UTF-8', 14:17:42 INFO - 'LANGUAGE': 'en_US:en', 14:17:42 INFO - 'LOGNAME': 'cltbld', 14:17:42 INFO - 'MAIL': '/var/mail/cltbld', 14:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:42 INFO - 'MOZ_NO_REMOTE': '1', 14:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:42 INFO - 'NO_EM_RESTART': '1', 14:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:42 INFO - 'PWD': '/builds/slave/test', 14:17:42 INFO - 'SHELL': '/bin/bash', 14:17:42 INFO - 'SHLVL': '1', 14:17:42 INFO - 'TERM': 'linux', 14:17:42 INFO - 'TMOUT': '86400', 14:17:42 INFO - 'USER': 'cltbld', 14:17:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:42 INFO - '_': '/tools/buildbot/bin/python'} 14:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:42 INFO - Downloading/unpacking jsonschema==2.5.1 14:17:42 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 14:17:42 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 14:17:42 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 14:17:42 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 14:17:42 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 14:17:42 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 14:17:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:17:44 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 14:17:44 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 14:17:44 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 14:17:44 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 14:17:44 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 14:17:44 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 14:17:44 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:44 INFO - warning: no files found matching '*.txt' 14:17:44 INFO - no previously-included directories found matching 'build' 14:17:44 INFO - no previously-included directories found matching 'dist' 14:17:44 INFO - no previously-included directories found matching '.git*' 14:17:44 INFO - Installing collected packages: jsonschema, functools32 14:17:44 INFO - Running setup.py install for functools32 14:17:44 INFO - warning: no files found matching '*.txt' 14:17:44 INFO - no previously-included directories found matching 'build' 14:17:44 INFO - no previously-included directories found matching 'dist' 14:17:44 INFO - no previously-included directories found matching '.git*' 14:17:45 INFO - Successfully installed jsonschema functools32 14:17:45 INFO - Cleaning up... 14:17:45 INFO - Return code: 0 14:17:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:17:45 INFO - Using env: {'DISPLAY': ':0', 14:17:45 INFO - 'HOME': '/home/cltbld', 14:17:45 INFO - 'LANG': 'en_US.UTF-8', 14:17:45 INFO - 'LANGUAGE': 'en_US:en', 14:17:45 INFO - 'LOGNAME': 'cltbld', 14:17:45 INFO - 'MAIL': '/var/mail/cltbld', 14:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:45 INFO - 'MOZ_NO_REMOTE': '1', 14:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:45 INFO - 'NO_EM_RESTART': '1', 14:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:45 INFO - 'PWD': '/builds/slave/test', 14:17:45 INFO - 'SHELL': '/bin/bash', 14:17:45 INFO - 'SHLVL': '1', 14:17:45 INFO - 'TERM': 'linux', 14:17:45 INFO - 'TMOUT': '86400', 14:17:45 INFO - 'USER': 'cltbld', 14:17:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:45 INFO - '_': '/tools/buildbot/bin/python'} 14:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:17:45 INFO - Cleaning up... 14:17:45 INFO - Return code: 0 14:17:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:17:45 INFO - Using env: {'DISPLAY': ':0', 14:17:45 INFO - 'HOME': '/home/cltbld', 14:17:45 INFO - 'LANG': 'en_US.UTF-8', 14:17:45 INFO - 'LANGUAGE': 'en_US:en', 14:17:45 INFO - 'LOGNAME': 'cltbld', 14:17:45 INFO - 'MAIL': '/var/mail/cltbld', 14:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:45 INFO - 'MOZ_NO_REMOTE': '1', 14:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:45 INFO - 'NO_EM_RESTART': '1', 14:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:45 INFO - 'PWD': '/builds/slave/test', 14:17:45 INFO - 'SHELL': '/bin/bash', 14:17:45 INFO - 'SHLVL': '1', 14:17:45 INFO - 'TERM': 'linux', 14:17:45 INFO - 'TMOUT': '86400', 14:17:45 INFO - 'USER': 'cltbld', 14:17:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:45 INFO - '_': '/tools/buildbot/bin/python'} 14:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:45 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:45 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 14:17:45 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 14:17:45 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 14:17:45 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 14:17:45 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 14:17:45 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 14:17:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:17:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 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 14:17:47 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 14:17:48 INFO - Downloading docopt-0.6.1.tar.gz 14:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:48 INFO - Running setup.py install for blobuploader 14:17:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:17:48 INFO - Running setup.py install for requests 14:17:48 INFO - Running setup.py install for docopt 14:17:48 INFO - Successfully installed blobuploader requests docopt 14:17:48 INFO - Cleaning up... 14:17:48 INFO - Return code: 0 14:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:48 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:48 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 14:17:48 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 14:17:48 INFO - Using env: {'DISPLAY': ':0', 14:17:48 INFO - 'HOME': '/home/cltbld', 14:17:48 INFO - 'LANG': 'en_US.UTF-8', 14:17:48 INFO - 'LANGUAGE': 'en_US:en', 14:17:48 INFO - 'LOGNAME': 'cltbld', 14:17:48 INFO - 'MAIL': '/var/mail/cltbld', 14:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:48 INFO - 'MOZ_NO_REMOTE': '1', 14:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:48 INFO - 'NO_EM_RESTART': '1', 14:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:48 INFO - 'PWD': '/builds/slave/test', 14:17:48 INFO - 'SHELL': '/bin/bash', 14:17:48 INFO - 'SHLVL': '1', 14:17:48 INFO - 'TERM': 'linux', 14:17:48 INFO - 'TMOUT': '86400', 14:17:48 INFO - 'USER': 'cltbld', 14:17:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:48 INFO - '_': '/tools/buildbot/bin/python'} 14:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:49 INFO - Running setup.py (path:/tmp/pip-bhG5_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:49 INFO - Running setup.py (path:/tmp/pip-4gCUVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:49 INFO - Running setup.py (path:/tmp/pip-qKFbhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:49 INFO - Running setup.py (path:/tmp/pip-pHlhJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:49 INFO - Running setup.py (path:/tmp/pip-mOGvRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:49 INFO - Running setup.py (path:/tmp/pip-kZGfJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:49 INFO - Running setup.py (path:/tmp/pip-KsX4YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:49 INFO - Running setup.py (path:/tmp/pip-SN1W5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:49 INFO - Running setup.py (path:/tmp/pip-q9fnVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:49 INFO - Running setup.py (path:/tmp/pip-BjUkz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:49 INFO - Running setup.py (path:/tmp/pip-idUms_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:49 INFO - Running setup.py (path:/tmp/pip-O9e4Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:49 INFO - Running setup.py (path:/tmp/pip-5M8A9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:50 INFO - Running setup.py (path:/tmp/pip-8DLp9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:50 INFO - Running setup.py (path:/tmp/pip-LdMYAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:50 INFO - Running setup.py (path:/tmp/pip-p5d9Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:50 INFO - Running setup.py (path:/tmp/pip-_ztgJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:50 INFO - Running setup.py install for manifestparser 14:17:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozcrash 14:17:50 INFO - Running setup.py install for mozdebug 14:17:50 INFO - Running setup.py install for mozdevice 14:17:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozfile 14:17:50 INFO - Running setup.py install for mozhttpd 14:17:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozinfo 14:17:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozInstall 14:17:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozleak 14:17:51 INFO - Running setup.py install for mozlog 14:17:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for moznetwork 14:17:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozprocess 14:17:51 INFO - Running setup.py install for mozprofile 14:17:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozrunner 14:17:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozscreenshot 14:17:51 INFO - Running setup.py install for moztest 14:17:51 INFO - Running setup.py install for mozversion 14:17:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:17:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:52 INFO - Cleaning up... 14:17:52 INFO - Return code: 0 14:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:52 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:52 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 14:17:52 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 14:17:52 INFO - Using env: {'DISPLAY': ':0', 14:17:52 INFO - 'HOME': '/home/cltbld', 14:17:52 INFO - 'LANG': 'en_US.UTF-8', 14:17:52 INFO - 'LANGUAGE': 'en_US:en', 14:17:52 INFO - 'LOGNAME': 'cltbld', 14:17:52 INFO - 'MAIL': '/var/mail/cltbld', 14:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:52 INFO - 'MOZ_NO_REMOTE': '1', 14:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:52 INFO - 'NO_EM_RESTART': '1', 14:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:52 INFO - 'PWD': '/builds/slave/test', 14:17:52 INFO - 'SHELL': '/bin/bash', 14:17:52 INFO - 'SHLVL': '1', 14:17:52 INFO - 'TERM': 'linux', 14:17:52 INFO - 'TMOUT': '86400', 14:17:52 INFO - 'USER': 'cltbld', 14:17:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:52 INFO - '_': '/tools/buildbot/bin/python'} 14:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:52 INFO - Running setup.py (path:/tmp/pip-p6C6Fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:52 INFO - Running setup.py (path:/tmp/pip-A_xck4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:52 INFO - Running setup.py (path:/tmp/pip-ABMQ3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:52 INFO - Running setup.py (path:/tmp/pip-RDRkWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:52 INFO - Running setup.py (path:/tmp/pip-DgQazT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:52 INFO - Running setup.py (path:/tmp/pip-LeE7Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:52 INFO - Running setup.py (path:/tmp/pip-4fKpRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:52 INFO - Running setup.py (path:/tmp/pip-_zLxsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:52 INFO - Running setup.py (path:/tmp/pip-Ts9d1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:52 INFO - Running setup.py (path:/tmp/pip-PeUOMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:53 INFO - Running setup.py (path:/tmp/pip-VTzEeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:53 INFO - Running setup.py (path:/tmp/pip-IRoA3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:53 INFO - Running setup.py (path:/tmp/pip-kV0vgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:53 INFO - Running setup.py (path:/tmp/pip-kTRHWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:53 INFO - Running setup.py (path:/tmp/pip-AJvzJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:53 INFO - Running setup.py (path:/tmp/pip-cYWTrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:53 INFO - Running setup.py (path:/tmp/pip-uWBzx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:53 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)) 14:17:53 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)) 14:17:53 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)) 14:17:53 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)) 14:17:53 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)) 14:17:53 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)) 14:17:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:55 INFO - Downloading blessings-1.6.tar.gz 14:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:55 INFO - Installing collected packages: blessings 14:17:55 INFO - Running setup.py install for blessings 14:17:55 INFO - Successfully installed blessings 14:17:55 INFO - Cleaning up... 14:17:55 INFO - Return code: 0 14:17:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:55 INFO - Reading from file tmpfile_stdout 14:17:55 INFO - Current package versions: 14:17:55 INFO - argparse == 1.2.1 14:17:55 INFO - blessings == 1.6 14:17:55 INFO - blobuploader == 1.2.4 14:17:55 INFO - docopt == 0.6.1 14:17:55 INFO - functools32 == 3.2.3-2 14:17:55 INFO - jsonschema == 2.5.1 14:17:55 INFO - manifestparser == 1.1 14:17:55 INFO - mozInstall == 1.12 14:17:55 INFO - mozcrash == 1.0 14:17:55 INFO - mozdebug == 0.1 14:17:55 INFO - mozdevice == 0.48 14:17:55 INFO - mozfile == 1.2 14:17:55 INFO - mozhttpd == 0.7 14:17:55 INFO - mozinfo == 0.9 14:17:55 INFO - mozleak == 0.1 14:17:55 INFO - mozlog == 3.4 14:17:55 INFO - moznetwork == 0.27 14:17:55 INFO - mozprocess == 0.23 14:17:55 INFO - mozprofile == 0.28 14:17:55 INFO - mozrunner == 6.13 14:17:55 INFO - mozscreenshot == 0.1 14:17:55 INFO - mozsystemmonitor == 0.3 14:17:55 INFO - moztest == 0.7 14:17:55 INFO - mozversion == 1.4 14:17:55 INFO - psutil == 3.1.1 14:17:55 INFO - requests == 1.2.3 14:17:55 INFO - wsgiref == 0.1.2 14:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:55 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:55 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 14:17:55 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 14:17:55 INFO - Using env: {'DISPLAY': ':0', 14:17:55 INFO - 'HOME': '/home/cltbld', 14:17:55 INFO - 'LANG': 'en_US.UTF-8', 14:17:55 INFO - 'LANGUAGE': 'en_US:en', 14:17:55 INFO - 'LOGNAME': 'cltbld', 14:17:55 INFO - 'MAIL': '/var/mail/cltbld', 14:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:55 INFO - 'MOZ_NO_REMOTE': '1', 14:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:55 INFO - 'NO_EM_RESTART': '1', 14:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:55 INFO - 'PWD': '/builds/slave/test', 14:17:55 INFO - 'SHELL': '/bin/bash', 14:17:55 INFO - 'SHLVL': '1', 14:17:55 INFO - 'TERM': 'linux', 14:17:55 INFO - 'TMOUT': '86400', 14:17:55 INFO - 'USER': 'cltbld', 14:17:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:55 INFO - '_': '/tools/buildbot/bin/python'} 14:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 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)) 14:17:56 INFO - Cleaning up... 14:17:56 INFO - Return code: 0 14:17:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:56 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 0x7f5c7ce26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', '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 14:17:56 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 14:17:56 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 14:17:56 INFO - Using env: {'DISPLAY': ':0', 14:17:56 INFO - 'HOME': '/home/cltbld', 14:17:56 INFO - 'LANG': 'en_US.UTF-8', 14:17:56 INFO - 'LANGUAGE': 'en_US:en', 14:17:56 INFO - 'LOGNAME': 'cltbld', 14:17:56 INFO - 'MAIL': '/var/mail/cltbld', 14:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:56 INFO - 'MOZ_NO_REMOTE': '1', 14:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:56 INFO - 'NO_EM_RESTART': '1', 14:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:56 INFO - 'PWD': '/builds/slave/test', 14:17:56 INFO - 'SHELL': '/bin/bash', 14:17:56 INFO - 'SHLVL': '1', 14:17:56 INFO - 'TERM': 'linux', 14:17:56 INFO - 'TMOUT': '86400', 14:17:56 INFO - 'USER': 'cltbld', 14:17:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:56 INFO - '_': '/tools/buildbot/bin/python'} 14:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:17:56 INFO - Cleaning up... 14:17:56 INFO - Return code: 0 14:17:56 INFO - Running post-action listener: _resource_record_post_action 14:17:56 INFO - Running post-action listener: _start_resource_monitoring 14:17:56 INFO - Starting resource monitoring. 14:17:56 INFO - [mozharness: 2016-11-14 22:17:56.480525Z] Finished create-virtualenv step (success) 14:17:56 INFO - [mozharness: 2016-11-14 22:17:56.481042Z] Running install step. 14:17:56 INFO - Running pre-action listener: _resource_record_pre_action 14:17:56 INFO - Running main action method: install 14:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:56 INFO - Reading from file tmpfile_stdout 14:17:56 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:17:56 INFO - Reading from file tmpfile_stdout 14:17:56 INFO - Output received: 14:17:56 INFO - Usage: mozinstall [options] installer 14:17:56 INFO - Options: 14:17:56 INFO - -h, --help show this help message and exit 14:17:56 INFO - -d DEST, --destination=DEST 14:17:56 INFO - Directory to install application into. [default: 14:17:56 INFO - "/builds/slave/test"] 14:17:56 INFO - --app=APP Application being installed. [default: firefox] 14:17:56 INFO - mkdir: /builds/slave/test/build/application 14:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:18:12 INFO - Reading from file tmpfile_stdout 14:18:12 INFO - Output received: 14:18:12 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:12 INFO - Running post-action listener: _resource_record_post_action 14:18:12 INFO - [mozharness: 2016-11-14 22:18:12.843305Z] Finished install step (success) 14:18:12 INFO - [mozharness: 2016-11-14 22:18:12.843633Z] Running run-tests step. 14:18:12 INFO - Running pre-action listener: _resource_record_pre_action 14:18:12 INFO - Running main action method: run_tests 14:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:12 INFO - Python 2.7.3 14:18:12 INFO - Return code: 0 14:18:12 INFO - grabbing minidump binary from tooltool 14:18: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')]} 14:18:12 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 0x1219f60>, '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 0x121ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:12 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 14:18:12 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 14:18:12 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 14:18:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:12 INFO - Return code: 0 14:18:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 14:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 14:18:12 INFO - Using env: {'DISPLAY': ':0', 14:18:12 INFO - 'HOME': '/home/cltbld', 14:18:12 INFO - 'LANG': 'en_US.UTF-8', 14:18:12 INFO - 'LANGUAGE': 'en_US:en', 14:18:12 INFO - 'LOGNAME': 'cltbld', 14:18:12 INFO - 'MAIL': '/var/mail/cltbld', 14:18:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:12 INFO - 'MOZ_NO_REMOTE': '1', 14:18:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:12 INFO - 'NO_EM_RESTART': '1', 14:18:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:12 INFO - 'PWD': '/builds/slave/test', 14:18:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:12 INFO - 'SHELL': '/bin/bash', 14:18:12 INFO - 'SHLVL': '1', 14:18:12 INFO - 'TERM': 'linux', 14:18:12 INFO - 'TMOUT': '86400', 14:18:12 INFO - 'USER': 'cltbld', 14:18:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847', 14:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:12 INFO - '_': '/tools/buildbot/bin/python'} 14:18:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 14:18:13 INFO - mozversion application_buildid: 20161114112842 14:18:13 INFO - mozversion application_changeset: 3f2202420b01fcc253118f5dcc07f1be9b3c3009 14:18:13 INFO - mozversion application_display_name: Nightly 14:18:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:13 INFO - mozversion application_name: Firefox 14:18:13 INFO - mozversion application_remotingname: firefox 14:18:13 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 14:18:13 INFO - mozversion application_vendor: Mozilla 14:18:13 INFO - mozversion application_version: 52.0a1 14:18:13 INFO - mozversion platform_buildid: 20161114112842 14:18:13 INFO - mozversion platform_changeset: 3f2202420b01fcc253118f5dcc07f1be9b3c3009 14:18:13 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 14:18:13 INFO - mozversion platform_version: 52.0a1 14:18:13 INFO - using testdate: 1479161893 14:18:13 INFO - actual date: 1479161893 14:18:13 INFO - starting webserver on 'localhost:50270' 14:18:13 INFO - SUITE-START | Running 2 tests 14:18:13 INFO - TEST-START | dromaeo_css 14:18:13 INFO - operating with platform_type : linux_ 14:18:13 INFO - Initialising browser for dromaeo_css test... 14:18:13 INFO - TEST-INFO | started process 3451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFvEmSl/profile http://localhost:50270/getInfo.html) 14:18:17 INFO - PROCESS | 3451 | __metrics Screen width/height:1600/1200 14:18:17 INFO - PROCESS | 3451 | colorDepth:24 14:18:17 INFO - PROCESS | 3451 | Browser inner width/height: 1024/697 14:18:17 INFO - PROCESS | 3451 | __metrics 14:18:18 INFO - PROCESS | 3451 | 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" 14:18:18 INFO - PROCESS | 3451 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:19 INFO - PROCESS | 3451 | console.error: PushService: 14:18:19 INFO - PROCESS | 3451 | stateChangeProcessEnqueue: Error transitioning state 14:18:19 INFO - PROCESS | 3451 | UnknownError 14:18:19 INFO - TEST-INFO | 3451: exit 0 14:18:19 INFO - Browser initialized. 14:18:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:19 INFO - TEST-INFO | started process 3535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFvEmSl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:32 INFO - PROCESS | 3535 | RSS: Main: 176164864 14:18:32 INFO - PROCESS | 3535 | 14:19:23 INFO - PROCESS | 3535 | 1479161963930 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:21:35 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:50270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50270/tests/dromaeo/cssquery-ext.html) 14:21:39 INFO - PROCESS | 3535 | RSS: Main: 436895744 14:21:39 INFO - PROCESS | 3535 | 14:24:42 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:50270/tests/dromaeo/cssquery-ext.html (next: http://localhost:50270/tests/dromaeo/cssquery-jquery.html) 14:24:42 INFO - PROCESS | 3535 | RSS: Main: 288604160 14:24:42 INFO - PROCESS | 3535 | 14:27:45 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:50270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50270/tests/dromaeo/cssquery-mootools.html) 14:27:45 INFO - PROCESS | 3535 | RSS: Main: 252542976 14:27:45 INFO - PROCESS | 3535 | 14:30:48 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:50270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50270/tests/dromaeo/cssquery-prototype.html) 14:30:48 INFO - PROCESS | 3535 | RSS: Main: 242630656 14:30:48 INFO - PROCESS | 3535 | 14:33:51 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:50270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50270/tests/dromaeo/cssquery-yui.html) 14:33:52 INFO - PROCESS | 3535 | RSS: Main: 227266560 14:33:52 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | Cycle 1(1): loaded http://localhost:50270/tests/dromaeo/cssquery-yui.html (next: http://localhost:50270/tests/dromaeo/cssquery-dojo.html) 14:36:55 INFO - PROCESS | 3535 | RSS: Main: 314871808 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | __start_tp_report 14:36:55 INFO - PROCESS | 3535 | _x_x_mozilla_page_load 14:36:55 INFO - PROCESS | 3535 | _x_x_mozilla_page_load_details 14:36:55 INFO - PROCESS | 3535 | |i|pagename|runs| 14:36:55 INFO - PROCESS | 3535 | |0;dojo.html;2568.332233619259;2594.4940736556377;2609.360706626876;2610.7780838628714;2634.86825658717;4537.568930951563;4623.722576645395;4677.555632214939;4700.1304758619635;4728.385309909711;4634.258518637019;4666.626669866411;4678.368420263263;4723.267893476508;4781.450133234679;4292.957070429287;4313.676474264443;4350.934735978963;4361.040571074359;4373.715708478954;4401.757903315316;4462.977685111586;4469.106178764244;4470.865874023784;4478.171538265415;4243.045314804175;4385.846495372679;4395.648348132142;4412.97793511032;4489.797959091832;4276.18752437036;4344.782760861945;4349.99950011496;4350.32569951658;4350.630196433307;4257.723247988902;4314.590113939171;4319.3952846601505;4329.285667864799;4332.155229730204;4657.18499262631;4674.182018146811;4696.671233013691;4744.146053710365;4757.857264282077;5030.522100400456;5041.773120209599;5044.8234311798915;5046.545810877039;5091.261767043758;4994.700317980933;5055.241713742931;5070.518300761421;5083.542481176675;5105.387353517564;4612.884677883079;4722.268048452495;4775.212090005145;4834.154023046023;4838.927416088762;5185.792568297301;5232.084385232569;5237.3453318335205;5272.630915835932;5283.867903302371;5014.89970200594;5021.573166280834;5026.045051440215;5028.7737051832755;5030.647854650212;4889.48660390661;4928.654994150375;4934.55588996992;5099.235114732745;5106;4971.353724015855;5008.5993120550265;5009.7244651544515;5026.723530205801;5086.0845047891;5009.173486374707;5009.24861270805;5013.323201367769;5015.3730783652045;5051;4232.153569286155;4340.60934515895;4346.826126954887;4371.759553224603;4381.364702118175;3711.721620878445;3732.9440058399146;3762.360398732222;3777.660010599059;3778.962210377861;4432.113577284556;4433.224185767543;4434.82260709568;4467.396901418332;4475.194464996332;5059.06407314648;5064.898702025939;5070.518300761421;5073.441921388644;5110.105731497048;4235.301175306102;4243.427137336482;4279.443672322641;4319.049809042006;4415.602595766396;4487.080148569536;4495.730256184639;4499.437570303712;4505.5719706627815;4507.729536227836;4689.882752931204;4702.6708130431225;4740.146773580651;4810.2063159579675;4810.374651295309;5076.7207803571155;5083.644144909968;5084.9745751272485;5087.160618497906;5117.692938423706;4763.333133361263;4766.022965292037;4766.880827979328;4768.523147685204;4800.543948324904;4799.136155492045;4872.90254194907;4876.634252431011;4948.282499037691;5037.395512538519;5000.1749711297225;5015.097282489187;5025.949740502549;5045.142325804549;5047.343845300087;4892.8532144035735;4901.9264711028645;4904.141775189256;4906.582940450102;4912.189488734319;4901.240307752304;4905.607551395951;4912.508749125059;4913.582345500672;4915.21356582945;4831.275308703723;4831.541003604792;4835.057163853015;4835.468098509232;4839.322494850794;4905.2151655734915;4919.434265059564;4922.753862306942;4924.384451943507;4929.433115191656;4806.351142595705;4814.061258054646;4819.518048195152;4824.662273640812;4947.876303092451 14:36:55 INFO - PROCESS | 3535 | |1;ext.html;555.8304717061296;559.62225497789;565.5560385097699;575.4274496875612;578.5284992730926;36937.81531092344;38545.22909541811;38590.22819543611;38700.41949370762;38767.80616096916;38235.42646860299;38607;38652;38665.22669546607;38689.80655096721;7408.777736667908;7586.127595326525;7736;7741.57421341826;7745.070591529025;7317.890231646529;7564.243575642447;7568.318851303382;7586.544807311579;9617.519124043805;9605.423674579513;9661.903380966205;9663.661771837988;9671.129598336149;9676.355019646677;9847;9923.206143508574;9931.50342482873;9934.602615895355;9935.701928942071;9777.41335519864;9843.950780246125;9851.852222216601;9861.457619830906;9861.852072218851;35745.64254357449;36066.45900311497;36100.27799444023;36104.63895361039;36109.81945090284;2949.1594895454905;3004.459197344477;3062.448759223339;3154.858031388593;3322.8670853165845;24844.627330590054;25164.119255826143;25435.745642543523;25545.489090218278;28712.425751484854;3311.93376132476;3459.930801383958;3484.3553942520716;3501.1947252132154;3606.278744251134;193484;246017;246166;246798;247612;31446.37107257842;32241.35517289688;32334.19164520906;53404;54261.72869135708;32366.838165809022;32678.18304542358;32814.83592582022;32820.343593128004;32865.67134328674;13672;13803.447862085604;13812.792808107886;13815.171089734447;13816.93091534556;11390.601328953448;11450.54197832094;11504.36725980079;11509.712257193638;11520.308781473139;7084.326988936146;7219.458540609476;7469.385714999707;7655.808604784814;7698.153203147649;3040.133561934882;3057.602511673468;3063.7395821355435;3084.3677046205476;3114.76639252057;812.4597142899905;892.4154678685471;900.5407242306471;912.8950170730318;968.9563969621383;25895.74104258971;27117.186484405498;27284.31789205246;27464.725352746216;27473.31316717098;920.406337912043;943.5423819447562;981.906718861707;983.8671779309844;1011.8431643095332;13731.519396821062;14528.709425811425;14561.635959100895;14640.267986600627;15416.691666166615;329455;330448;331660;332307;332907;47570.5242947573;47871.521284787406;47925;47995.76002119967;48056.759716201894;1136.8294755786533;1155.763068570941;1169.6491052684162;1173.3136115372602;1174.137009298148;27003.729962700123;27586.448271034868;28000.43999120047;28195.718042820128;28633.570496442153;39375.21249574935;40110.39834402428;40135.1972960545;40161;40228.597714022486;297474;298759;299698;299914;300176;23801.072822984013;24142;24307.513849723262;24319.51360972806;24335.75664243406;38164.80917595505;38762;38897.80551097226;39505.209895802494;39546.406803897386;32965.67034329626;33069.33861322808;33298.66701333052;33555.328893422484;33642.15894602556;32644.673553264165;33009;33637.663623363456;34363.82818085894;34462.48306275358;32801.17997049997;33180.83409582936;33405.83297083499;33644.83177584096;33736.49395259024;28385.29036774097;30428.087157385315;30520.847395762878;30560.694393055786;30884.53828278457;23511.41221469477;23874.88062559676;24020.759792401852;24343.29596928198;24363.26910192697 14:36:55 INFO - PROCESS | 3535 | |2;jquery.html;309.8048229615342;319.6611591712783;324.336731384319;326.6358010817938;343.510497541004;12982.870171298284;13529.864701352984;15663.843361566382;16066.437674681389;16925.984440933553;16229.350825966976;16399.180040997962;16461.176941152924;16575.336986520553;16587.17064146791;4277.615014648681;4804.087223427555;5035.823746168885;5038.697678139305;5040.067587496325;5782.971085144568;5866.472017518422;5881.970590147043;5905.852353691149;5914.4381283777975;4987.725675087869;5236.371635403757;5836.2996440427205;5845.649261044329;5855.824325270249;5275.762590683428;5305.946940530623;5308.787648494055;5311.521963023347;5315.388730296027;4987.625928055374;5125.103106956268;5140.974295128501;5142.948570514284;5178;11148.665540033811;11308.321500709984;11322.716932076682;11381.487833047533;12716.872831271661;1719.6904557179703;1738.5132162994382;1763.4885883094016;2040.1941233212797;2180.4112889519897;8005.199480052006;8122.63448144829;8122.878156827653;8529.232369086812;8539.701110461167;1667.608112093657;1687.0805411051006;1695.127009590062;1705.4201571465637;1723.7155869281678;66181.66909165471;69114.65442672804;70496;71350;71942.28057719408;9296.256299496024;9340.206082483064;9575.186109180659;9596.376235544667;9887.159591434665;12786.808197877039;12878.742425151444;12879.42042608085;12893;12896.742065158644;7112.395446387011;7255.238199988925;7306.890396644055;7374.410047196211;7426.101296819105;7126.857462850714;7129.964350178216;7370.373518250902;7399.223081576464;7403.7408690695565;3980.044789250559;3983.1237127831832;4026.255142798592;4069;4109.773962432095;1712.4177779555012;1752.1677203328318;1799.5411170151528;1837.0906401331426;1844.2069909938855;753.1376573823052;774.7288449042902;816.2612835383987;853.7492573380028;857.3141486810526;15503.457378991907;15602.375904963674;15929.601759955862;16418.6716265674;16908.57728556796;822.2065706593166;824.8968878890139;840.0759164918663;852.5225873510853;860.0883063952231;8730.563471826383;8796.34027447944;9157.992620811705;9356;10049.196064314838;367773;390158;406984;407618;409953;46850.53149468462;47935.5206447938;57360;77124;81273.59363203146;900.6622516556291;903.336048004716;905.7509184974053;924.0528458330131;925.2597921662643;15385.307661155499;15448.536543903701;15987.760183597024;16263.67472650564;16323.102229377499;36554.268914621025;37423;38100;38348.2330353397;38879;46371.304430432894;48147.277790832464;49399.07211134687;51812.740936296585;51953.48046519638;6500.902486462802;6552.803415897531;6994.33553812387;7090.220075791762;7280.3083707047745;9394.577244023898;11589.6523104307;11702.35637039971;11830.231034982698;11896.821547676618;10228.693139205836;10245;10259.7435064121;10399.480025998519;10479.94760026195;10240.180785537288;10254.179665626882;10339.327943683636;10425.53085111187;10458.58165673395;10119.190464762949;10193.490325483548;10557;10579.788404232026;10851.240413171317;6859.828504287233;6873.2783057778215;6963.408110310477;7020.894686579603;7125.1093613298335;9381.249500040118;9784.315097943361;10125.89874101279;10165.13596344319;10237.283390162616 14:36:55 INFO - PROCESS | 3535 | |3;mootools.html;1234.0744441668749;1329.9867001329987;1367.5692156970556;1427.32915529701;1628.9918550407247;5955.821325360241;6684.398404143626;6955.165380154376;6967.4077703395205;7068.929310706892;6894.586324820514;6962.199347075088;6972.337627925339;6992.720291188359;6993.265707100757;2054.2296638760427;2071.5649713560097;2072.6062048210865;2077.3041031254547;2078.7817279185692;1982.3161009451717;2041.897375417273;2042.213747707136;2049.2929939171036;2057.670772676372;1955.5795503966644;1969.3894892583273;1971.5859669469428;1974.2892558678864;1978.4262563856464;2017.5561376497146;2030.1270453704901;2031.2484380779058;2036.134642776814;2046.3860841747417;1991.2831380702935;2023.9190432382686;2030.604032213719;2034.888081155536;2043.2542122125467;6792.728290868359;6857.759978400732;6882.03651488792;6927.965360173167;6991.335823096798;4113.691473139526;4248.532661407243;4248.872533823959;4287.549807270254;4294.141171765659;2652.6949400818958;2823.435312937421;2885.797994140411;2898.2754311422145;2898.68114507404;887.9866801997975;892.0989800301677;903.1781079217881;932.9067093290685;940.5767404667859;9103.499307538083;9248.491332976751;9257.074292570756;9258.213051890598;9264.629414823467;3525.4888041233876;3528.3648943190474;3674.338619048597;3733.4132993477665;3733.4773131761576;7398.371138453184;7457;7459.738909138154;7474.476786624884;7479.326860582573;4106.630403263661;4111.588841115924;4111.773852438145;4113.629773320416;4116.526599441043;3399.5750531183603;3508.245727168671;3518.7199753545333;3825.5218097737784;3827.8086095695103;2744.31392151962;2830.235836324181;3016;3018.079485756821;3019.9245018874703;862.7498025572513;871.4248595926784;872.3283072034498;875.5797217335714;875.9080296568895;703.9964800175966;831.584207896052;837.6942416018231;839.1189251286125;844.5777111444278;4619.676622636451;4765.26138448541;4822.903541929142;4852.708837469763;5084.059449001947;379.618483424157;380.8419505905018;381.372642003902;389.76614031580823;860.4622111180512;3308.801471911693;3346.8159251240927;3379.831008449568;3422.9486557701653;3580.695640870503;7999.600019998977;8196.959015204886;8355.791105222417;8359.373047021498;8360.916390836013;8315.251627353568;8318.8336233275;8328.750137495885;8343.16568343173;8348.582570871433;6201.56589038772;6379.266384365857;6506.41442270198;6660.96669516659;6682.5322227444585;4638.976805115953;4862.367892173995;4935.679180853233;4968.751562421792;5196.376434827845;7724.0731112266885;7759.379249659901;7769.339606133542;7810.843783124419;7840.764777056697;7370;7639.159692433716;7656.272654097852;7779.4554381192775;7863.842723145391;5227.869303267449;5389.326334208224;5686.829395118153;5769.307683078057;5827.271591051119;6543.345665433419;6747.021681856201;6747.763828265987;6752.358525940028;6755.6622168892345;5988.820335389945;6031.969840150771;6045.939540604538;6088.665123418077;6198.535109866688;5954.374790647093;6008.789692360921;6071.696415179135;6075.574709770273;6152.7538898445355;5598.692071936082;5695.629784064023;5697.259356283656;5701.486866182064;5702.144678298288;3997.92004159921;4004.7597144170277;4017.176478821776;4082.795860207037;4163.562825903236;4095.201435720006;4135.875923722293;4220.430241917302;4223.598758117974;4229.767362795076 14:36:55 INFO - PROCESS | 3535 | |4;prototype.html;268.2622787334829;270.90382914065503;278.76862204370366;280.62676640068713;282.72010709397705;4600.654950878681;4800.855974320776;4839;4846.176150054491;4873.269009648555;4602.59408038052;4713.410823647044;4715.740634265114;4725.173094708421;4753.572178503934;3726.962730372702;3731.6641502264924;3749.1751814600743;3788.450674652174;3792.4880141180934;3585.713142948558;3747.9812600937094;3765.6234376562397;3773.622637736232;3774.0942173878348;3471.861125554987;3699.408094704848;3715.7956312402807;3732.42147467143;3749.4750734897134;3711.925761484782;3713.771736957831;3716.907077323075;3717.2565486902727;3722.441633754945;3269.397994982465;3271.1167984644253;3271.623763267231;3281.36013477372;3282.425575524274;4609.469910960249;4654.627629789643;4655.324977878188;4704.811807527695;4736.455307639631;4217.957820421787;4222.9577704223175;4229.598188172149;4231.4710661167355;4235.49174099107;4973.5523802857915;4977.178765503688;4995.350604421438;5010.298558201855;5013.072581572421;3469.202083520779;3542.3446662367546;3560.430331147004;3566.4472006838723;3569.464580312948;5201.40183878855;5205.687658740488;5218.66078704883;5224.608154388436;5236.973815130938;3635.909102272464;3636;3638.2541578976247;3650.361186792301;3651.3062518121474;3682.655830621857;3708.332500149999;3709.5919448860604;3712.387456069718;3728.6830619397656;4137.441445404832;4192.086499882614;4223.68322375823;4252.744835309892;4265.104328091135;4951.579115775199;4974.328465657162;4982.576480999083;4983.90032199354;4990.925136122961;1200.2558413783336;1224.3755684600917;1229.8193734015267;1249.09440655524;1258.3708145927037;823.9412355123637;826.3017750001239;831.4470876866816;834.7120243515977;854.6495936665937;4317.136572685413;4327.935080973788;4354.346847972829;4378.365137055172;4378.452693413324;4990.850274491771;5009.5491405773655;5016.720736212243;5025.623078269145;5042.39491261051;4230.090530535949;4289.957100429018;4307.759964818277;4323.740575565476;4358.455193100863;2621.829581077224;2624.8319497823286;2646.623755647053;2649.3509090273005;2660.6009098634972;4667;4693.741844198534;4695.43654761424;4704.670673052853;4718.4809670936165;4920.335754673145;5014.874628134253;5056.9494305057215;5079.212722028092;5090.847274581768;4610.5389461054965;4624.26011838111;4655.627549796008;4674.135284972291;4679.602233810164;4921.286413469955;4947.901041979212;4948.19390922318;4955.900881982268;4960.528749768766;4607.953920460753;4842.7820748065715;4867.172580661225;4876.171050921423;4891.872035664497;4643.4892161862845;4677.836275730333;4679.741435293866;4679.789409476513;4698.815051001301;3522.7710198836994;3529.2059286660296;3558.1994051338243;3565.821708914492;3575.910602234965;4777.737224452689;4953.306537084739;4953.975230123826;4963.205887058053;4965.708915682021;4790.5448982346625;4790.784414701417;4792.3530323407285;4804.6876952997945;4848.684835485823;4779.545943135397;4810.302506136661;4831;4832.63755218353;4862.367892173995;4581.762924010565;4724.6534737601;4749;4753.809847606057;4757.477607165673;4802.27965805132;4807.879803004953;4810.42274926997;4855.587275081658;4856.39295088114;4713.552212539803;4722.716637001791;4728.865072382535;4738.31294462308;4756.215224488059 14:36:55 INFO - PROCESS | 3535 | |5;yui.html;615.9846003849904;619.498206452773;637.1907677249891;645.2643985856125;693.7641201991322;11715.414229288534;12504.374781260945;12522.123451358408;12546.937265313672;12557.058220633455;11483.368414737186;11607.593734219305;11611.593594224203;11615.883841161585;11627.47676354564;604.6795198544778;621.7264403662397;744.4342299852098;753.41986670264;758.8899609556638;763.6525380951654;769.6844293839526;769.8421823526164;770.2528547309129;770.4837758701656;803.1887793328751;803.7106641609016;804.1516200408566;804.1797366685977;804.5373910001744;642.1587720086654;661.137215933207;784.8979632647777;799.0371602219312;800.1998001998002;580.4021857486796;588.808637192914;592.9495992840614;593.6764463367432;593.8248216776061;11150.832737508943;11169.16231282649;11187.552497900075;11188.66434006981;11189.608363707232;11908.58319958806;11981.400929953468;12091.879081209252;12274.447649855778;12383.69040773988;11015.83476247857;11083.889161108447;11312.773744525146;11387.658370248906;11799.823002654966;3955.1891862168186;3972;3984.1035766952496;4048.109415928491;4067.8576249831112;54005.729971349894;54229.45770542323;54857.45142548563;55868;56045.71977140088;9534.380265282734;9573.712788616353;9746.902530974741;9761.853572196424;9852.655157069468;18084.728729069073;18111.366102186625;18148.818511814712;18228.63542729138;18388.816111838976;6194.38056194377;6448.709808058648;6493.4415740222;6537.477001839841;6623.768168114093;3423.7774544654517;3463.8960831175104;3516.9648303517147;3605.85576576934;3729.310077635646;2751.55975043992;2822.0969289827467;2835.943281134366;2838.318803487148;2851.3726980064353;497.34847349971653;503.0768539729637;505.07571144804916;512.8410192840231;516.5970542976485;468.8199870601661;545.0434487474457;573.7160105747598;602.4547784255255;603.432773193197;7381.594012329373;7456.40348772097;7806.451935131023;7855.960720196363;7942.563159026309;527.3355571979333;575.8741660054583;606.8664893723374;614.1678026274424;614.6619359352338;3499.9475007874903;3604.441311596707;3712.6658600725523;3718.3492888744363;3734.234481931252;54514.45485545173;56139.438605613424;56383;62239;66578;38172.23655526874;56436.717816411474;57323.42676573181;57581.71209143927;58690.706546466994;35254.11864703403;36554.81722591423;50183.74908125436;51300;53506;7809.548557322271;8123;8267.669293228204;8333.791655208668;8356.456830306011;31712.365752684356;35949;35991.64008359883;36164.45753313755;37248.44127338146;43720.78139609282;45838.77080614575;49334.50665493443;49699.254511183084;51985.7400712994;10357.896421035693;10800.621978230723;10800.729981750519;10877.184211184034;11132.332060076422;11804.70488237801;11808;11876.82184767212;11899.940500297444;12296.631101066982;10952.507137179005;10967.50646220938;11045.155924332437;11307.660770176908;11331.773364532499;10912.672619821418;10956.34261944286;11227.607033753779;11363.375014373958;11463.942680286546;10051.69844904654;10107.191424686154;10129.139023183112;10188.949055254676;10779.568817247222;9351.766205844637;9428.858567121635;9585.760355991157;9848.556814943202;9875.753106172404;8893.866592000995;9609.663661772083;9748.610055597697;9749.268804839807;9813.656522021694 14:36:55 INFO - PROCESS | 3535 | __end_tp_report 14:36:55 INFO - PROCESS | 3535 | __start_cc_report 14:36:55 INFO - PROCESS | 3535 | _x_x_mozilla_cycle_collect,3184 14:36:55 INFO - PROCESS | 3535 | __end_cc_report 14:36:55 INFO - PROCESS | 3535 | __startTimestamp1479163015805__endTimestamp 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | ------- Summary: start ------- 14:36:55 INFO - PROCESS | 3535 | Number of tests: 6 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | [#0] dojo.html Cycles:165 Average:4667.28 Median:4806.35 stddev:489.58 (10.2%) stddev-sans-first:462.56 14:36:55 INFO - PROCESS | 3535 | Values: 2568.3 2594.5 2609.4 2610.8 2634.9 4537.6 4623.7 4677.6 4700.1 4728.4 4634.3 4666.6 4678.4 4723.3 4781.5 4293.0 4313.7 4350.9 4361.0 4373.7 4401.8 4463.0 4469.1 4470.9 4478.2 4243.0 4385.8 4395.6 4413.0 4489.8 4276.2 4344.8 4350.0 4350.3 4350.6 4257.7 4314.6 4319.4 4329.3 4332.2 4657.2 4674.2 4696.7 4744.1 4757.9 5030.5 5041.8 5044.8 5046.5 5091.3 4994.7 5055.2 5070.5 5083.5 5105.4 4612.9 4722.3 4775.2 4834.2 4838.9 5185.8 5232.1 5237.3 5272.6 5283.9 5014.9 5021.6 5026.0 5028.8 5030.6 4889.5 4928.7 4934.6 5099.2 5106.0 4971.4 5008.6 5009.7 5026.7 5086.1 5009.2 5009.2 5013.3 5015.4 5051.0 4232.2 4340.6 4346.8 4371.8 4381.4 3711.7 3732.9 3762.4 3777.7 3779.0 4432.1 4433.2 4434.8 4467.4 4475.2 5059.1 5064.9 5070.5 5073.4 5110.1 4235.3 4243.4 4279.4 4319.0 4415.6 4487.1 4495.7 4499.4 4505.6 4507.7 4689.9 4702.7 4740.1 4810.2 4810.4 5076.7 5083.6 5085.0 5087.2 5117.7 4763.3 4766.0 4766.9 4768.5 4800.5 4799.1 4872.9 4876.6 4948.3 5037.4 5000.2 5015.1 5025.9 5045.1 5047.3 4892.9 4901.9 4904.1 4906.6 4912.2 4901.2 4905.6 4912.5 4913.6 4915.2 4831.3 4831.5 4835.1 4835.5 4839.3 4905.2 4919.4 4922.8 4924.4 4929.4 4806.4 4814.1 4819.5 4824.7 4947.9 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | [#1] ext.html Cycles:180 Average:42910.66 Median:183102.83 stddev:76652.11 (41.9%) stddev-sans-first:76801.17 14:36:55 INFO - PROCESS | 3535 | Values: 555.8 559.6 565.6 575.4 578.5 36937.8 38545.2 38590.2 38700.4 38767.8 38235.4 38607.0 38652.0 38665.2 38689.8 7408.8 7586.1 7736.0 7741.6 7745.1 7317.9 7564.2 7568.3 7586.5 9617.5 9605.4 9661.9 9663.7 9671.1 9676.4 9847.0 9923.2 9931.5 9934.6 9935.7 9777.4 9844.0 9851.9 9861.5 9861.9 35745.6 36066.5 36100.3 36104.6 36109.8 2949.2 3004.5 3062.4 3154.9 3322.9 24844.6 25164.1 25435.7 25545.5 28712.4 3311.9 3459.9 3484.4 3501.2 3606.3 193484.0 246017.0 246166.0 246798.0 247612.0 31446.4 32241.4 32334.2 53404.0 54261.7 32366.8 32678.2 32814.8 32820.3 32865.7 13672.0 13803.4 13812.8 13815.2 13816.9 11390.6 11450.5 11504.4 11509.7 11520.3 7084.3 7219.5 7469.4 7655.8 7698.2 3040.1 3057.6 3063.7 3084.4 3114.8 812.5 892.4 900.5 912.9 969.0 25895.7 27117.2 27284.3 27464.7 27473.3 920.4 943.5 981.9 983.9 1011.8 13731.5 14528.7 14561.6 14640.3 15416.7 329455.0 330448.0 331660.0 332307.0 332907.0 47570.5 47871.5 47925.0 47995.8 48056.8 1136.8 1155.8 1169.6 1173.3 1174.1 27003.7 27586.4 28000.4 28195.7 28633.6 39375.2 40110.4 40135.2 40161.0 40228.6 297474.0 298759.0 299698.0 299914.0 300176.0 23801.1 24142.0 24307.5 24319.5 24335.8 38164.8 38762.0 38897.8 39505.2 39546.4 32965.7 33069.3 33298.7 33555.3 33642.2 32644.7 33009.0 33637.7 34363.8 34462.5 32801.2 33180.8 33405.8 33644.8 33736.5 28385.3 30428.1 30520.8 30560.7 30884.5 23511.4 23874.9 24020.8 24343.3 24363.3 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | [#2] jquery.html Cycles:180 Average:23624.40 Median:47393.03 stddev:65307.79 (137.8%) stddev-sans-first:65467.54 14:36:55 INFO - PROCESS | 3535 | Values: 309.8 319.7 324.3 326.6 343.5 12982.9 13529.9 15663.8 16066.4 16926.0 16229.4 16399.2 16461.2 16575.3 16587.2 4277.6 4804.1 5035.8 5038.7 5040.1 5783.0 5866.5 5882.0 5905.9 5914.4 4987.7 5236.4 5836.3 5845.6 5855.8 5275.8 5305.9 5308.8 5311.5 5315.4 4987.6 5125.1 5141.0 5142.9 5178.0 11148.7 11308.3 11322.7 11381.5 12716.9 1719.7 1738.5 1763.5 2040.2 2180.4 8005.2 8122.6 8122.9 8529.2 8539.7 1667.6 1687.1 1695.1 1705.4 1723.7 66181.7 69114.7 70496.0 71350.0 71942.3 9296.3 9340.2 9575.2 9596.4 9887.2 12786.8 12878.7 12879.4 12893.0 12896.7 7112.4 7255.2 7306.9 7374.4 7426.1 7126.9 7130.0 7370.4 7399.2 7403.7 3980.0 3983.1 4026.3 4069.0 4109.8 1712.4 1752.2 1799.5 1837.1 1844.2 753.1 774.7 816.3 853.7 857.3 15503.5 15602.4 15929.6 16418.7 16908.6 822.2 824.9 840.1 852.5 860.1 8730.6 8796.3 9158.0 9356.0 10049.2 367773.0 390158.0 406984.0 407618.0 409953.0 46850.5 47935.5 57360.0 77124.0 81273.6 900.7 903.3 905.8 924.1 925.3 15385.3 15448.5 15987.8 16263.7 16323.1 36554.3 37423.0 38100.0 38348.2 38879.0 46371.3 48147.3 49399.1 51812.7 51953.5 6500.9 6552.8 6994.3 7090.2 7280.3 9394.6 11589.7 11702.4 11830.2 11896.8 10228.7 10245.0 10259.7 10399.5 10479.9 10240.2 10254.2 10339.3 10425.5 10458.6 10119.2 10193.5 10557.0 10579.8 10851.2 6859.8 6873.3 6963.4 7020.9 7125.1 9381.2 9784.3 10125.9 10165.1 10237.3 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | [#3] mootools.html Cycles:180 Average:4533.98 Median:5494.01 stddev:2472.78 (45.0%) stddev-sans-first:2467.28 14:36:55 INFO - PROCESS | 3535 | Values: 1234.1 1330.0 1367.6 1427.3 1629.0 5955.8 6684.4 6955.2 6967.4 7068.9 6894.6 6962.2 6972.3 6992.7 6993.3 2054.2 2071.6 2072.6 2077.3 2078.8 1982.3 2041.9 2042.2 2049.3 2057.7 1955.6 1969.4 1971.6 1974.3 1978.4 2017.6 2030.1 2031.2 2036.1 2046.4 1991.3 2023.9 2030.6 2034.9 2043.3 6792.7 6857.8 6882.0 6928.0 6991.3 4113.7 4248.5 4248.9 4287.5 4294.1 2652.7 2823.4 2885.8 2898.3 2898.7 888.0 892.1 903.2 932.9 940.6 9103.5 9248.5 9257.1 9258.2 9264.6 3525.5 3528.4 3674.3 3733.4 3733.5 7398.4 7457.0 7459.7 7474.5 7479.3 4106.6 4111.6 4111.8 4113.6 4116.5 3399.6 3508.2 3518.7 3825.5 3827.8 2744.3 2830.2 3016.0 3018.1 3019.9 862.7 871.4 872.3 875.6 875.9 704.0 831.6 837.7 839.1 844.6 4619.7 4765.3 4822.9 4852.7 5084.1 379.6 380.8 381.4 389.8 860.5 3308.8 3346.8 3379.8 3422.9 3580.7 7999.6 8197.0 8355.8 8359.4 8360.9 8315.3 8318.8 8328.8 8343.2 8348.6 6201.6 6379.3 6506.4 6661.0 6682.5 4639.0 4862.4 4935.7 4968.8 5196.4 7724.1 7759.4 7769.3 7810.8 7840.8 7370.0 7639.2 7656.3 7779.5 7863.8 5227.9 5389.3 5686.8 5769.3 5827.3 6543.3 6747.0 6747.8 6752.4 6755.7 5988.8 6032.0 6045.9 6088.7 6198.5 5954.4 6008.8 6071.7 6075.6 6152.8 5598.7 5695.6 5697.3 5701.5 5702.1 3997.9 4004.8 4017.2 4082.8 4163.6 4095.2 4135.9 4220.4 4223.6 4229.8 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | [#4] prototype.html Cycles:180 Average:4074.59 Median:4661.31 stddev:1169.60 (25.1%) stddev-sans-first:1137.45 14:36:55 INFO - PROCESS | 3535 | Values: 268.3 270.9 278.8 280.6 282.7 4600.7 4800.9 4839.0 4846.2 4873.3 4602.6 4713.4 4715.7 4725.2 4753.6 3727.0 3731.7 3749.2 3788.5 3792.5 3585.7 3748.0 3765.6 3773.6 3774.1 3471.9 3699.4 3715.8 3732.4 3749.5 3711.9 3713.8 3716.9 3717.3 3722.4 3269.4 3271.1 3271.6 3281.4 3282.4 4609.5 4654.6 4655.3 4704.8 4736.5 4218.0 4223.0 4229.6 4231.5 4235.5 4973.6 4977.2 4995.4 5010.3 5013.1 3469.2 3542.3 3560.4 3566.4 3569.5 5201.4 5205.7 5218.7 5224.6 5237.0 3635.9 3636.0 3638.3 3650.4 3651.3 3682.7 3708.3 3709.6 3712.4 3728.7 4137.4 4192.1 4223.7 4252.7 4265.1 4951.6 4974.3 4982.6 4983.9 4990.9 1200.3 1224.4 1229.8 1249.1 1258.4 823.9 826.3 831.4 834.7 854.6 4317.1 4327.9 4354.3 4378.4 4378.5 4990.9 5009.5 5016.7 5025.6 5042.4 4230.1 4290.0 4307.8 4323.7 4358.5 2621.8 2624.8 2646.6 2649.4 2660.6 4667.0 4693.7 4695.4 4704.7 4718.5 4920.3 5014.9 5056.9 5079.2 5090.8 4610.5 4624.3 4655.6 4674.1 4679.6 4921.3 4947.9 4948.2 4955.9 4960.5 4608.0 4842.8 4867.2 4876.2 4891.9 4643.5 4677.8 4679.7 4679.8 4698.8 3522.8 3529.2 3558.2 3565.8 3575.9 4777.7 4953.3 4954.0 4963.2 4965.7 4790.5 4790.8 4792.4 4804.7 4848.7 4779.5 4810.3 4831.0 4832.6 4862.4 4581.8 4724.7 4749.0 4753.8 4757.5 4802.3 4807.9 4810.4 4855.6 4856.4 4713.6 4722.7 4728.9 4738.3 4756.2 14:36:55 INFO - PROCESS | 3535 | 14:36:55 INFO - PROCESS | 3535 | [#5] yui.html Cycles:180 Average:13885.74 Median:504.08 stddev:17024.14 (3377.3%) stddev-sans-first:17042.73 14:36:55 INFO - PROCESS | 3535 | Values: 616.0 619.5 637.2 645.3 693.8 11715.4 12504.4 12522.1 12546.9 12557.1 11483.4 11607.6 11611.6 11615.9 11627.5 604.7 621.7 744.4 753.4 758.9 763.7 769.7 769.8 770.3 770.5 803.2 803.7 804.2 804.2 804.5 642.2 661.1 784.9 799.0 800.2 580.4 588.8 592.9 593.7 593.8 11150.8 11169.2 11187.6 11188.7 11189.6 11908.6 11981.4 12091.9 12274.4 12383.7 11015.8 11083.9 11312.8 11387.7 11799.8 3955.2 3972.0 3984.1 4048.1 4067.9 54005.7 54229.5 54857.5 55868.0 56045.7 9534.4 9573.7 9746.9 9761.9 9852.7 18084.7 18111.4 18148.8 18228.6 18388.8 6194.4 6448.7 6493.4 6537.5 6623.8 3423.8 3463.9 3517.0 3605.9 3729.3 2751.6 2822.1 2835.9 2838.3 2851.4 497.3 503.1 505.1 512.8 516.6 468.8 545.0 573.7 602.5 603.4 7381.6 7456.4 7806.5 7856.0 7942.6 527.3 575.9 606.9 614.2 614.7 3499.9 3604.4 3712.7 3718.3 3734.2 54514.5 56139.4 56383.0 62239.0 66578.0 38172.2 56436.7 57323.4 57581.7 58690.7 35254.1 36554.8 50183.7 51300.0 53506.0 7809.5 8123.0 8267.7 8333.8 8356.5 31712.4 35949.0 35991.6 36164.5 37248.4 43720.8 45838.8 49334.5 49699.3 51985.7 10357.9 10800.6 10800.7 10877.2 11132.3 11804.7 11808.0 11876.8 11899.9 12296.6 10952.5 10967.5 11045.2 11307.7 11331.8 10912.7 10956.3 11227.6 11363.4 11463.9 10051.7 10107.2 10129.1 10188.9 10779.6 9351.8 9428.9 9585.8 9848.6 9875.8 8893.9 9609.7 9748.6 9749.3 9813.7 14:36:55 INFO - PROCESS | 3535 | -------- Summary: end -------- 14:36:55 INFO - PROCESS | 3535 | 14:36:56 INFO - TEST-INFO | 3535: exit 0 14:36:56 INFO - TEST-OK | dromaeo_css | took 1123751ms 14:36:56 INFO - TEST-START | kraken 14:36:56 INFO - operating with platform_type : linux_ 14:36:56 INFO - Initialising browser for kraken test... 14:36:56 INFO - TEST-INFO | started process 3837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBifXWd/profile http://localhost:50270/getInfo.html) 14:37:01 INFO - PROCESS | 3837 | __metrics Screen width/height:1600/1200 14:37:01 INFO - PROCESS | 3837 | colorDepth:24 14:37:01 INFO - PROCESS | 3837 | Browser inner width/height: 1024/697 14:37:01 INFO - PROCESS | 3837 | __metrics 14:37:02 INFO - PROCESS | 3837 | 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" 14:37:02 INFO - PROCESS | 3837 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:02 INFO - PROCESS | 3837 | console.error: PushService: 14:37:02 INFO - PROCESS | 3837 | stateChangeProcessEnqueue: Error transitioning state 14:37:02 INFO - PROCESS | 3837 | UnknownError 14:37:03 INFO - TEST-INFO | 3837: exit 0 14:37:03 INFO - Browser initialized. 14:37:03 INFO - Running cycle 1/1 for kraken test... 14:37:03 INFO - TEST-INFO | started process 3920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBifXWd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:15 INFO - PROCESS | 3920 | RSS: Main: 175861760 14:37:15 INFO - PROCESS | 3920 | 14:37:18 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50270/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:19 INFO - PROCESS | 3920 | RSS: Main: 241201152 14:37:19 INFO - PROCESS | 3920 | 14:37:22 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50270/tests/kraken/driver.html?testName=audio-dft) 14:37:23 INFO - PROCESS | 3920 | RSS: Main: 218374144 14:37:23 INFO - PROCESS | 3920 | 14:37:26 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50270/tests/kraken/driver.html?testName=audio-fft) 14:37:26 INFO - PROCESS | 3920 | RSS: Main: 300953600 14:37:26 INFO - PROCESS | 3920 | 14:37:29 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50270/tests/kraken/driver.html?testName=audio-oscillator) 14:37:29 INFO - PROCESS | 3920 | RSS: Main: 211705856 14:37:29 INFO - PROCESS | 3920 | 14:37:32 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:32 INFO - PROCESS | 3920 | RSS: Main: 214855680 14:37:32 INFO - PROCESS | 3920 | 14:37:35 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50270/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:36 INFO - PROCESS | 3920 | RSS: Main: 250716160 14:37:36 INFO - PROCESS | 3920 | 14:37:39 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50270/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:40 INFO - PROCESS | 3920 | RSS: Main: 249933824 14:37:40 INFO - PROCESS | 3920 | 14:37:43 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50270/tests/kraken/driver.html?testName=json-parse-financial) 14:37:43 INFO - PROCESS | 3920 | RSS: Main: 249171968 14:37:43 INFO - PROCESS | 3920 | 14:37:45 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:37:46 INFO - PROCESS | 3920 | RSS: Main: 211902464 14:37:46 INFO - PROCESS | 3920 | 14:37:47 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:37:48 INFO - PROCESS | 3920 | RSS: Main: 218742784 14:37:48 INFO - PROCESS | 3920 | 14:37:50 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:51 INFO - PROCESS | 3920 | RSS: Main: 227430400 14:37:51 INFO - PROCESS | 3920 | 14:37:54 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:55 INFO - PROCESS | 3920 | RSS: Main: 236666880 14:37:55 INFO - PROCESS | 3920 | 14:37:58 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:58 INFO - PROCESS | 3920 | RSS: Main: 233197568 14:37:58 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | Cycle 1(1): loaded http://localhost:50270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50270/tests/kraken/driver.html?testName=ai-astar) 14:38:00 INFO - PROCESS | 3920 | RSS: Main: 281767936 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | __start_tp_report 14:38:00 INFO - PROCESS | 3920 | _x_x_mozilla_page_load 14:38:00 INFO - PROCESS | 3920 | _x_x_mozilla_page_load_details 14:38:00 INFO - PROCESS | 3920 | |i|pagename|runs| 14:38:00 INFO - PROCESS | 3920 | |0;ai-astar;107;116;116;116;116;115;115;117;116;115 14:38:00 INFO - PROCESS | 3920 | |1;audio-beat-detection;158;128;130;173;130;129;129;130;161;137 14:38:00 INFO - PROCESS | 3920 | |2;audio-dft;163;162;162;161;163;162;162;162;161;162 14:38:00 INFO - PROCESS | 3920 | |3;audio-fft;75;77;76;113;76;78;78;76;103;78 14:38:00 INFO - PROCESS | 3920 | |4;audio-oscillator;84;83;110;85;84;84;105;84;83;107 14:38:00 INFO - PROCESS | 3920 | |5;imaging-gaussian-blur;117;116;117;118;118;117;117;116;118;117 14:38:00 INFO - PROCESS | 3920 | |6;imaging-darkroom;147;146;146;146;146;147;147;146;146;146 14:38:00 INFO - PROCESS | 3920 | |7;imaging-desaturate;85;84;85;85;84;85;84;84;84;85 14:38:00 INFO - PROCESS | 3920 | |8;json-parse-financial;66;64;64;63;64;65;64;67;67;64 14:38:00 INFO - PROCESS | 3920 | |9;json-stringify-tinderbox;66;65;65;65;66;65;66;65;67;67 14:38:00 INFO - PROCESS | 3920 | |10;stanford-crypto-aes;85;84;93;83;83;93;94;84;93;86 14:38:00 INFO - PROCESS | 3920 | |11;stanford-crypto-ccm;159;147;148;148;159;152;153;143;187;142 14:38:00 INFO - PROCESS | 3920 | |12;stanford-crypto-pbkdf2;181;176;178;177;179;181;177;180;176;182 14:38:00 INFO - PROCESS | 3920 | |13;stanford-crypto-sha256-iterative;70;69;70;70;69;73;69;69;69;68 14:38:00 INFO - PROCESS | 3920 | __end_tp_report 14:38:00 INFO - PROCESS | 3920 | __start_cc_report 14:38:00 INFO - PROCESS | 3920 | _x_x_mozilla_cycle_collect,2008 14:38:00 INFO - PROCESS | 3920 | __end_cc_report 14:38:00 INFO - PROCESS | 3920 | __startTimestamp1479163080799__endTimestamp 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | ------- Summary: start ------- 14:38:00 INFO - PROCESS | 3920 | Number of tests: 14 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.85 (2.5%) stddev-sans-first:0.67 14:38:00 INFO - PROCESS | 3920 | Values: 107.0 116.0 116.0 116.0 116.0 115.0 115.0 117.0 116.0 115.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:133.50 stddev:16.82 (12.6%) stddev-sans-first:16.61 14:38:00 INFO - PROCESS | 3920 | Values: 158.0 128.0 130.0 173.0 130.0 129.0 129.0 130.0 161.0 137.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 14:38:00 INFO - PROCESS | 3920 | Values: 163.0 162.0 162.0 161.0 163.0 162.0 162.0 162.0 161.0 162.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.42 (17.5%) stddev-sans-first:13.92 14:38:00 INFO - PROCESS | 3920 | Values: 75.0 77.0 76.0 113.0 76.0 78.0 78.0 76.0 103.0 78.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:11.42 (13.6%) stddev-sans-first:11.83 14:38:00 INFO - PROCESS | 3920 | Values: 84.0 83.0 110.0 85.0 84.0 84.0 105.0 84.0 83.0 107.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 14:38:00 INFO - PROCESS | 3920 | Values: 117.0 116.0 117.0 118.0 118.0 117.0 117.0 116.0 118.0 117.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:38:00 INFO - PROCESS | 3920 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 14:38:00 INFO - PROCESS | 3920 | Values: 85.0 84.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 85.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:1.40 (2.2%) stddev-sans-first:1.41 14:38:00 INFO - PROCESS | 3920 | Values: 66.0 64.0 64.0 63.0 64.0 65.0 64.0 67.0 67.0 64.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 14:38:00 INFO - PROCESS | 3920 | Values: 66.0 65.0 65.0 65.0 66.0 65.0 66.0 65.0 67.0 67.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:89.50 stddev:4.78 (5.3%) stddev-sans-first:4.96 14:38:00 INFO - PROCESS | 3920 | Values: 85.0 84.0 93.0 83.0 83.0 93.0 94.0 84.0 93.0 86.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:152.50 stddev:13.04 (8.5%) stddev-sans-first:13.69 14:38:00 INFO - PROCESS | 3920 | Values: 159.0 147.0 148.0 148.0 159.0 152.0 153.0 143.0 187.0 142.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.50 stddev:2.21 (1.2%) stddev-sans-first:2.19 14:38:00 INFO - PROCESS | 3920 | Values: 181.0 176.0 178.0 177.0 179.0 181.0 177.0 180.0 176.0 182.0 14:38:00 INFO - PROCESS | 3920 | 14:38:00 INFO - PROCESS | 3920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.35 (1.9%) stddev-sans-first:1.42 14:38:00 INFO - PROCESS | 3920 | Values: 70.0 69.0 70.0 70.0 69.0 73.0 69.0 69.0 69.0 68.0 14:38:00 INFO - PROCESS | 3920 | -------- Summary: end -------- 14:38:00 INFO - PROCESS | 3920 | 14:38:02 INFO - TEST-INFO | 3920: exit 0 14:38:02 INFO - TEST-OK | kraken | took 65267ms 14:38:02 INFO - SUITE-END | took 1189s 14:38:02 INFO - Completed test suite (00:19:49) 14:38:02 INFO - javascript benchmark 14:38:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.332233619259, 2594.4940736556377, 2609.360706626876, 2610.7780838628714, 2634.86825658717, 4537.568930951563, 4623.722576645395, 4677.555632214939, 4700.1304758619635, 4728.385309909711, 4634.258518637019, 4666.626669866411, 4678.368420263263, 4723.267893476508, 4781.450133234679, 4292.957070429287, 4313.676474264443, 4350.934735978963, 4361.040571074359, 4373.715708478954, 4401.757903315316, 4462.977685111586, 4469.106178764244, 4470.865874023784, 4478.171538265415, 4243.045314804175, 4385.846495372679, 4395.648348132142, 4412.97793511032, 4489.797959091832, 4276.18752437036, 4344.782760861945, 4349.99950011496, 4350.32569951658, 4350.630196433307, 4257.723247988902, 4314.590113939171, 4319.3952846601505, 4329.285667864799, 4332.155229730204, 4657.18499262631, 4674.182018146811, 4696.671233013691, 4744.146053710365, 4757.857264282077, 5030.522100400456, 5041.773120209599, 5044.8234311798915, 5046.545810877039, 5091.261767043758, 4994.700317980933, 5055.241713742931, 5070.518300761421, 5083.542481176675, 5105.387353517564, 4612.884677883079, 4722.268048452495, 4775.212090005145, 4834.154023046023, 4838.927416088762, 5185.792568297301, 5232.084385232569, 5237.3453318335205, 5272.630915835932, 5283.867903302371, 5014.89970200594, 5021.573166280834, 5026.045051440215, 5028.7737051832755, 5030.647854650212, 4889.48660390661, 4928.654994150375, 4934.55588996992, 5099.235114732745, 5106.0, 4971.353724015855, 5008.5993120550265, 5009.7244651544515, 5026.723530205801, 5086.0845047891, 5009.173486374707, 5009.24861270805, 5013.323201367769, 5015.3730783652045, 5051.0, 4232.153569286155, 4340.60934515895, 4346.826126954887, 4371.759553224603, 4381.364702118175, 3711.721620878445, 3732.9440058399146, 3762.360398732222, 3777.660010599059, 3778.962210377861, 4432.113577284556, 4433.224185767543, 4434.82260709568, 4467.396901418332, 4475.194464996332, 5059.06407314648, 5064.898702025939, 5070.518300761421, 5073.441921388644, 5110.105731497048, 4235.301175306102, 4243.427137336482, 4279.443672322641, 4319.049809042006, 4415.602595766396, 4487.080148569536, 4495.730256184639, 4499.437570303712, 4505.5719706627815, 4507.729536227836, 4689.882752931204, 4702.6708130431225, 4740.146773580651, 4810.2063159579675, 4810.374651295309, 5076.7207803571155, 5083.644144909968, 5084.9745751272485, 5087.160618497906, 5117.692938423706, 4763.333133361263, 4766.022965292037, 4766.880827979328, 4768.523147685204, 4800.543948324904, 4799.136155492045, 4872.90254194907, 4876.634252431011, 4948.282499037691, 5037.395512538519, 5000.1749711297225, 5015.097282489187, 5025.949740502549, 5045.142325804549, 5047.343845300087, 4892.8532144035735, 4901.9264711028645, 4904.141775189256, 4906.582940450102, 4912.189488734319, 4901.240307752304, 4905.607551395951, 4912.508749125059, 4913.582345500672, 4915.21356582945, 4831.275308703723, 4831.541003604792, 4835.057163853015, 4835.468098509232, 4839.322494850794, 4905.2151655734915, 4919.434265059564, 4922.753862306942, 4924.384451943507, 4929.433115191656, 4806.351142595705, 4814.061258054646, 4819.518048195152, 4824.662273640812, 4947.876303092451], "value": 4635.660878151924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8304717061296, 559.62225497789, 565.5560385097699, 575.4274496875612, 578.5284992730926, 36937.81531092344, 38545.22909541811, 38590.22819543611, 38700.41949370762, 38767.80616096916, 38235.42646860299, 38607.0, 38652.0, 38665.22669546607, 38689.80655096721, 7408.777736667908, 7586.127595326525, 7736.0, 7741.57421341826, 7745.070591529025, 7317.890231646529, 7564.243575642447, 7568.318851303382, 7586.544807311579, 9617.519124043805, 9605.423674579513, 9661.903380966205, 9663.661771837988, 9671.129598336149, 9676.355019646677, 9847.0, 9923.206143508574, 9931.50342482873, 9934.602615895355, 9935.701928942071, 9777.41335519864, 9843.950780246125, 9851.852222216601, 9861.457619830906, 9861.852072218851, 35745.64254357449, 36066.45900311497, 36100.27799444023, 36104.63895361039, 36109.81945090284, 2949.1594895454905, 3004.459197344477, 3062.448759223339, 3154.858031388593, 3322.8670853165845, 24844.627330590054, 25164.119255826143, 25435.745642543523, 25545.489090218278, 28712.425751484854, 3311.93376132476, 3459.930801383958, 3484.3553942520716, 3501.1947252132154, 3606.278744251134, 193484.0, 246017.0, 246166.0, 246798.0, 247612.0, 31446.37107257842, 32241.35517289688, 32334.19164520906, 53404.0, 54261.72869135708, 32366.838165809022, 32678.18304542358, 32814.83592582022, 32820.343593128004, 32865.67134328674, 13672.0, 13803.447862085604, 13812.792808107886, 13815.171089734447, 13816.93091534556, 11390.601328953448, 11450.54197832094, 11504.36725980079, 11509.712257193638, 11520.308781473139, 7084.326988936146, 7219.458540609476, 7469.385714999707, 7655.808604784814, 7698.153203147649, 3040.133561934882, 3057.602511673468, 3063.7395821355435, 3084.3677046205476, 3114.76639252057, 812.4597142899905, 892.4154678685471, 900.5407242306471, 912.8950170730318, 968.9563969621383, 25895.74104258971, 27117.186484405498, 27284.31789205246, 27464.725352746216, 27473.31316717098, 920.406337912043, 943.5423819447562, 981.906718861707, 983.8671779309844, 1011.8431643095332, 13731.519396821062, 14528.709425811425, 14561.635959100895, 14640.267986600627, 15416.691666166615, 329455.0, 330448.0, 331660.0, 332307.0, 332907.0, 47570.5242947573, 47871.521284787406, 47925.0, 47995.76002119967, 48056.759716201894, 1136.8294755786533, 1155.763068570941, 1169.6491052684162, 1173.3136115372602, 1174.137009298148, 27003.729962700123, 27586.448271034868, 28000.43999120047, 28195.718042820128, 28633.570496442153, 39375.21249574935, 40110.39834402428, 40135.1972960545, 40161.0, 40228.597714022486, 297474.0, 298759.0, 299698.0, 299914.0, 300176.0, 23801.072822984013, 24142.0, 24307.513849723262, 24319.51360972806, 24335.75664243406, 38164.80917595505, 38762.0, 38897.80551097226, 39505.209895802494, 39546.406803897386, 32965.67034329626, 33069.33861322808, 33298.66701333052, 33555.328893422484, 33642.15894602556, 32644.673553264165, 33009.0, 33637.663623363456, 34363.82818085894, 34462.48306275358, 32801.17997049997, 33180.83409582936, 33405.83297083499, 33644.83177584096, 33736.49395259024, 28385.29036774097, 30428.087157385315, 30520.847395762878, 30560.694393055786, 30884.53828278457, 23511.41221469477, 23874.88062559676, 24020.759792401852, 24343.29596928198, 24363.26910192697], "value": 16124.661667001566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.8048229615342, 319.6611591712783, 324.336731384319, 326.6358010817938, 343.510497541004, 12982.870171298284, 13529.864701352984, 15663.843361566382, 16066.437674681389, 16925.984440933553, 16229.350825966976, 16399.180040997962, 16461.176941152924, 16575.336986520553, 16587.17064146791, 4277.615014648681, 4804.087223427555, 5035.823746168885, 5038.697678139305, 5040.067587496325, 5782.971085144568, 5866.472017518422, 5881.970590147043, 5905.852353691149, 5914.4381283777975, 4987.725675087869, 5236.371635403757, 5836.2996440427205, 5845.649261044329, 5855.824325270249, 5275.762590683428, 5305.946940530623, 5308.787648494055, 5311.521963023347, 5315.388730296027, 4987.625928055374, 5125.103106956268, 5140.974295128501, 5142.948570514284, 5178.0, 11148.665540033811, 11308.321500709984, 11322.716932076682, 11381.487833047533, 12716.872831271661, 1719.6904557179703, 1738.5132162994382, 1763.4885883094016, 2040.1941233212797, 2180.4112889519897, 8005.199480052006, 8122.63448144829, 8122.878156827653, 8529.232369086812, 8539.701110461167, 1667.608112093657, 1687.0805411051006, 1695.127009590062, 1705.4201571465637, 1723.7155869281678, 66181.66909165471, 69114.65442672804, 70496.0, 71350.0, 71942.28057719408, 9296.256299496024, 9340.206082483064, 9575.186109180659, 9596.376235544667, 9887.159591434665, 12786.808197877039, 12878.742425151444, 12879.42042608085, 12893.0, 12896.742065158644, 7112.395446387011, 7255.238199988925, 7306.890396644055, 7374.410047196211, 7426.101296819105, 7126.857462850714, 7129.964350178216, 7370.373518250902, 7399.223081576464, 7403.7408690695565, 3980.044789250559, 3983.1237127831832, 4026.255142798592, 4069.0, 4109.773962432095, 1712.4177779555012, 1752.1677203328318, 1799.5411170151528, 1837.0906401331426, 1844.2069909938855, 753.1376573823052, 774.7288449042902, 816.2612835383987, 853.7492573380028, 857.3141486810526, 15503.457378991907, 15602.375904963674, 15929.601759955862, 16418.6716265674, 16908.57728556796, 822.2065706593166, 824.8968878890139, 840.0759164918663, 852.5225873510853, 860.0883063952231, 8730.563471826383, 8796.34027447944, 9157.992620811705, 9356.0, 10049.196064314838, 367773.0, 390158.0, 406984.0, 407618.0, 409953.0, 46850.53149468462, 47935.5206447938, 57360.0, 77124.0, 81273.59363203146, 900.6622516556291, 903.336048004716, 905.7509184974053, 924.0528458330131, 925.2597921662643, 15385.307661155499, 15448.536543903701, 15987.760183597024, 16263.67472650564, 16323.102229377499, 36554.268914621025, 37423.0, 38100.0, 38348.2330353397, 38879.0, 46371.304430432894, 48147.277790832464, 49399.07211134687, 51812.740936296585, 51953.48046519638, 6500.902486462802, 6552.803415897531, 6994.33553812387, 7090.220075791762, 7280.3083707047745, 9394.577244023898, 11589.6523104307, 11702.35637039971, 11830.231034982698, 11896.821547676618, 10228.693139205836, 10245.0, 10259.7435064121, 10399.480025998519, 10479.94760026195, 10240.180785537288, 10254.179665626882, 10339.327943683636, 10425.53085111187, 10458.58165673395, 10119.190464762949, 10193.490325483548, 10557.0, 10579.788404232026, 10851.240413171317, 6859.828504287233, 6873.2783057778215, 6963.408110310477, 7020.894686579603, 7125.1093613298335, 9381.249500040118, 9784.315097943361, 10125.89874101279, 10165.13596344319, 10237.283390162616], "value": 7817.341184733634, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.0744441668749, 1329.9867001329987, 1367.5692156970556, 1427.32915529701, 1628.9918550407247, 5955.821325360241, 6684.398404143626, 6955.165380154376, 6967.4077703395205, 7068.929310706892, 6894.586324820514, 6962.199347075088, 6972.337627925339, 6992.720291188359, 6993.265707100757, 2054.2296638760427, 2071.5649713560097, 2072.6062048210865, 2077.3041031254547, 2078.7817279185692, 1982.3161009451717, 2041.897375417273, 2042.213747707136, 2049.2929939171036, 2057.670772676372, 1955.5795503966644, 1969.3894892583273, 1971.5859669469428, 1974.2892558678864, 1978.4262563856464, 2017.5561376497146, 2030.1270453704901, 2031.2484380779058, 2036.134642776814, 2046.3860841747417, 1991.2831380702935, 2023.9190432382686, 2030.604032213719, 2034.888081155536, 2043.2542122125467, 6792.728290868359, 6857.759978400732, 6882.03651488792, 6927.965360173167, 6991.335823096798, 4113.691473139526, 4248.532661407243, 4248.872533823959, 4287.549807270254, 4294.141171765659, 2652.6949400818958, 2823.435312937421, 2885.797994140411, 2898.2754311422145, 2898.68114507404, 887.9866801997975, 892.0989800301677, 903.1781079217881, 932.9067093290685, 940.5767404667859, 9103.499307538083, 9248.491332976751, 9257.074292570756, 9258.213051890598, 9264.629414823467, 3525.4888041233876, 3528.3648943190474, 3674.338619048597, 3733.4132993477665, 3733.4773131761576, 7398.371138453184, 7457.0, 7459.738909138154, 7474.476786624884, 7479.326860582573, 4106.630403263661, 4111.588841115924, 4111.773852438145, 4113.629773320416, 4116.526599441043, 3399.5750531183603, 3508.245727168671, 3518.7199753545333, 3825.5218097737784, 3827.8086095695103, 2744.31392151962, 2830.235836324181, 3016.0, 3018.079485756821, 3019.9245018874703, 862.7498025572513, 871.4248595926784, 872.3283072034498, 875.5797217335714, 875.9080296568895, 703.9964800175966, 831.584207896052, 837.6942416018231, 839.1189251286125, 844.5777111444278, 4619.676622636451, 4765.26138448541, 4822.903541929142, 4852.708837469763, 5084.059449001947, 379.618483424157, 380.8419505905018, 381.372642003902, 389.76614031580823, 860.4622111180512, 3308.801471911693, 3346.8159251240927, 3379.831008449568, 3422.9486557701653, 3580.695640870503, 7999.600019998977, 8196.959015204886, 8355.791105222417, 8359.373047021498, 8360.916390836013, 8315.251627353568, 8318.8336233275, 8328.750137495885, 8343.16568343173, 8348.582570871433, 6201.56589038772, 6379.266384365857, 6506.41442270198, 6660.96669516659, 6682.5322227444585, 4638.976805115953, 4862.367892173995, 4935.679180853233, 4968.751562421792, 5196.376434827845, 7724.0731112266885, 7759.379249659901, 7769.339606133542, 7810.843783124419, 7840.764777056697, 7370.0, 7639.159692433716, 7656.272654097852, 7779.4554381192775, 7863.842723145391, 5227.869303267449, 5389.326334208224, 5686.829395118153, 5769.307683078057, 5827.271591051119, 6543.345665433419, 6747.021681856201, 6747.763828265987, 6752.358525940028, 6755.6622168892345, 5988.820335389945, 6031.969840150771, 6045.939540604538, 6088.665123418077, 6198.535109866688, 5954.374790647093, 6008.789692360921, 6071.696415179135, 6075.574709770273, 6152.7538898445355, 5598.692071936082, 5695.629784064023, 5697.259356283656, 5701.486866182064, 5702.144678298288, 3997.92004159921, 4004.7597144170277, 4017.176478821776, 4082.795860207037, 4163.562825903236, 4095.201435720006, 4135.875923722293, 4220.430241917302, 4223.598758117974, 4229.767362795076], "value": 3651.6280095110787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.2622787334829, 270.90382914065503, 278.76862204370366, 280.62676640068713, 282.72010709397705, 4600.654950878681, 4800.855974320776, 4839.0, 4846.176150054491, 4873.269009648555, 4602.59408038052, 4713.410823647044, 4715.740634265114, 4725.173094708421, 4753.572178503934, 3726.962730372702, 3731.6641502264924, 3749.1751814600743, 3788.450674652174, 3792.4880141180934, 3585.713142948558, 3747.9812600937094, 3765.6234376562397, 3773.622637736232, 3774.0942173878348, 3471.861125554987, 3699.408094704848, 3715.7956312402807, 3732.42147467143, 3749.4750734897134, 3711.925761484782, 3713.771736957831, 3716.907077323075, 3717.2565486902727, 3722.441633754945, 3269.397994982465, 3271.1167984644253, 3271.623763267231, 3281.36013477372, 3282.425575524274, 4609.469910960249, 4654.627629789643, 4655.324977878188, 4704.811807527695, 4736.455307639631, 4217.957820421787, 4222.9577704223175, 4229.598188172149, 4231.4710661167355, 4235.49174099107, 4973.5523802857915, 4977.178765503688, 4995.350604421438, 5010.298558201855, 5013.072581572421, 3469.202083520779, 3542.3446662367546, 3560.430331147004, 3566.4472006838723, 3569.464580312948, 5201.40183878855, 5205.687658740488, 5218.66078704883, 5224.608154388436, 5236.973815130938, 3635.909102272464, 3636.0, 3638.2541578976247, 3650.361186792301, 3651.3062518121474, 3682.655830621857, 3708.332500149999, 3709.5919448860604, 3712.387456069718, 3728.6830619397656, 4137.441445404832, 4192.086499882614, 4223.68322375823, 4252.744835309892, 4265.104328091135, 4951.579115775199, 4974.328465657162, 4982.576480999083, 4983.90032199354, 4990.925136122961, 1200.2558413783336, 1224.3755684600917, 1229.8193734015267, 1249.09440655524, 1258.3708145927037, 823.9412355123637, 826.3017750001239, 831.4470876866816, 834.7120243515977, 854.6495936665937, 4317.136572685413, 4327.935080973788, 4354.346847972829, 4378.365137055172, 4378.452693413324, 4990.850274491771, 5009.5491405773655, 5016.720736212243, 5025.623078269145, 5042.39491261051, 4230.090530535949, 4289.957100429018, 4307.759964818277, 4323.740575565476, 4358.455193100863, 2621.829581077224, 2624.8319497823286, 2646.623755647053, 2649.3509090273005, 2660.6009098634972, 4667.0, 4693.741844198534, 4695.43654761424, 4704.670673052853, 4718.4809670936165, 4920.335754673145, 5014.874628134253, 5056.9494305057215, 5079.212722028092, 5090.847274581768, 4610.5389461054965, 4624.26011838111, 4655.627549796008, 4674.135284972291, 4679.602233810164, 4921.286413469955, 4947.901041979212, 4948.19390922318, 4955.900881982268, 4960.528749768766, 4607.953920460753, 4842.7820748065715, 4867.172580661225, 4876.171050921423, 4891.872035664497, 4643.4892161862845, 4677.836275730333, 4679.741435293866, 4679.789409476513, 4698.815051001301, 3522.7710198836994, 3529.2059286660296, 3558.1994051338243, 3565.821708914492, 3575.910602234965, 4777.737224452689, 4953.306537084739, 4953.975230123826, 4963.205887058053, 4965.708915682021, 4790.5448982346625, 4790.784414701417, 4792.3530323407285, 4804.6876952997945, 4848.684835485823, 4779.545943135397, 4810.302506136661, 4831.0, 4832.63755218353, 4862.367892173995, 4581.762924010565, 4724.6534737601, 4749.0, 4753.809847606057, 4757.477607165673, 4802.27965805132, 4807.879803004953, 4810.42274926997, 4855.587275081658, 4856.39295088114, 4713.552212539803, 4722.716637001791, 4728.865072382535, 4738.31294462308, 4756.215224488059], "value": 3696.2674886133377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9846003849904, 619.498206452773, 637.1907677249891, 645.2643985856125, 693.7641201991322, 11715.414229288534, 12504.374781260945, 12522.123451358408, 12546.937265313672, 12557.058220633455, 11483.368414737186, 11607.593734219305, 11611.593594224203, 11615.883841161585, 11627.47676354564, 604.6795198544778, 621.7264403662397, 744.4342299852098, 753.41986670264, 758.8899609556638, 763.6525380951654, 769.6844293839526, 769.8421823526164, 770.2528547309129, 770.4837758701656, 803.1887793328751, 803.7106641609016, 804.1516200408566, 804.1797366685977, 804.5373910001744, 642.1587720086654, 661.137215933207, 784.8979632647777, 799.0371602219312, 800.1998001998002, 580.4021857486796, 588.808637192914, 592.9495992840614, 593.6764463367432, 593.8248216776061, 11150.832737508943, 11169.16231282649, 11187.552497900075, 11188.66434006981, 11189.608363707232, 11908.58319958806, 11981.400929953468, 12091.879081209252, 12274.447649855778, 12383.69040773988, 11015.83476247857, 11083.889161108447, 11312.773744525146, 11387.658370248906, 11799.823002654966, 3955.1891862168186, 3972.0, 3984.1035766952496, 4048.109415928491, 4067.8576249831112, 54005.729971349894, 54229.45770542323, 54857.45142548563, 55868.0, 56045.71977140088, 9534.380265282734, 9573.712788616353, 9746.902530974741, 9761.853572196424, 9852.655157069468, 18084.728729069073, 18111.366102186625, 18148.818511814712, 18228.63542729138, 18388.816111838976, 6194.38056194377, 6448.709808058648, 6493.4415740222, 6537.477001839841, 6623.768168114093, 3423.7774544654517, 3463.8960831175104, 3516.9648303517147, 3605.85576576934, 3729.310077635646, 2751.55975043992, 2822.0969289827467, 2835.943281134366, 2838.318803487148, 2851.3726980064353, 497.34847349971653, 503.0768539729637, 505.07571144804916, 512.8410192840231, 516.5970542976485, 468.8199870601661, 545.0434487474457, 573.7160105747598, 602.4547784255255, 603.432773193197, 7381.594012329373, 7456.40348772097, 7806.451935131023, 7855.960720196363, 7942.563159026309, 527.3355571979333, 575.8741660054583, 606.8664893723374, 614.1678026274424, 614.6619359352338, 3499.9475007874903, 3604.441311596707, 3712.6658600725523, 3718.3492888744363, 3734.234481931252, 54514.45485545173, 56139.438605613424, 56383.0, 62239.0, 66578.0, 38172.23655526874, 56436.717816411474, 57323.42676573181, 57581.71209143927, 58690.706546466994, 35254.11864703403, 36554.81722591423, 50183.74908125436, 51300.0, 53506.0, 7809.548557322271, 8123.0, 8267.669293228204, 8333.791655208668, 8356.456830306011, 31712.365752684356, 35949.0, 35991.64008359883, 36164.45753313755, 37248.44127338146, 43720.78139609282, 45838.77080614575, 49334.50665493443, 49699.254511183084, 51985.7400712994, 10357.896421035693, 10800.621978230723, 10800.729981750519, 10877.184211184034, 11132.332060076422, 11804.70488237801, 11808.0, 11876.82184767212, 11899.940500297444, 12296.631101066982, 10952.507137179005, 10967.50646220938, 11045.155924332437, 11307.660770176908, 11331.773364532499, 10912.672619821418, 10956.34261944286, 11227.607033753779, 11363.375014373958, 11463.942680286546, 10051.69844904654, 10107.191424686154, 10129.139023183112, 10188.949055254676, 10779.568817247222, 9351.766205844637, 9428.858567121635, 9585.760355991157, 9848.556814943202, 9875.753106172404, 8893.866592000995, 9609.663661772083, 9748.610055597697, 9749.268804839807, 9813.656522021694], "value": 5986.790961761487, "unit": "score"}], "name": "dromaeo_css", "value": 6012.09973350807, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 116.0, 116.0, 115.0, 115.0, 117.0, 116.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 130.0, 173.0, 130.0, 129.0, 129.0, 130.0, 161.0, 137.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 113.0, 76.0, 78.0, 78.0, 76.0, 103.0, 78.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 110.0, 85.0, 84.0, 84.0, 105.0, 84.0, 83.0, 107.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 118.0, 117.0, 117.0, 116.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 64.0, 65.0, 64.0, 67.0, 67.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 67.0, 67.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 93.0, 83.0, 83.0, 93.0, 94.0, 84.0, 93.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 147.0, 148.0, 148.0, 159.0, 152.0, 153.0, 143.0, 187.0, 142.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 178.0, 177.0, 179.0, 181.0, 177.0, 180.0, 176.0, 182.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 70.0, 69.0, 73.0, 69.0, 69.0, 69.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1559.6, "alertThreshold": 2.0}]} 14:38:02 INFO - Return code: 0 14:38:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:02 INFO - # TBPL SUCCESS # 14:38:02 INFO - Running post-action listener: _resource_record_post_action 14:38:02 INFO - [mozharness: 2016-11-14 22:38:02.599501Z] Finished run-tests step (success) 14:38:02 INFO - Running post-run listener: _resource_record_post_run 14:38:02 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399790080; Read time: 16; Write time: 399956 14:38:02 INFO - TinderboxPrint: CPU usage
13.1% 14:38:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:38:02 INFO - TinderboxPrint: I/O write bytes / time
399,790,080 / 399,956 14:38:02 INFO - TinderboxPrint: CPU idle
8,357.3 (86.8%) 14:38:02 INFO - TinderboxPrint: CPU user
1,214.0 (12.6%) 14:38:02 INFO - TinderboxPrint: Swap in / out
0 / 0 14:38:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110809088; Read time: 0; Write time: 116620 14:38:02 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 288559104; Read time: 0; Write time: 283336 14:38:03 INFO - Running post-run listener: _upload_blobber_files 14:38:03 INFO - Blob upload gear active. 14:38:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:03 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 14:38:03 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:38:03 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:38:03 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:04 INFO - (blobuploader) - INFO - Done attempting. 14:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:05 INFO - (blobuploader) - INFO - Done attempting. 14:38:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:08 INFO - (blobuploader) - INFO - Done attempting. 14:38:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:08 INFO - Return code: 0 14:38:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/de6ed6f04ec31e706ad2631de7a6e92ea2b2504631f658f7e2cae37f504e2cab27bd6e4b57d743f76da273484edc7e46043f209ffb98c269800267058ceaa270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f13876a298539943dd4c96a874492f945f65741d2e9b330200b41d1ea6ae7c89b64c17c726ef615ab5c4b11ea1028d21ef881d7574e3b7e64d0cbb9191d38fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9c85ffaf297f9815971eb0b92b0f0903c9f388a5ad47d99c9798fcb6e61dcd492f08087b39fd185d6ff8278748b954a3fb51e0cb24ea1af0b55c7e1d1d021c43"} 14:38:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:08 INFO - Contents: 14:38:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/de6ed6f04ec31e706ad2631de7a6e92ea2b2504631f658f7e2cae37f504e2cab27bd6e4b57d743f76da273484edc7e46043f209ffb98c269800267058ceaa270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f13876a298539943dd4c96a874492f945f65741d2e9b330200b41d1ea6ae7c89b64c17c726ef615ab5c4b11ea1028d21ef881d7574e3b7e64d0cbb9191d38fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9c85ffaf297f9815971eb0b92b0f0903c9f388a5ad47d99c9798fcb6e61dcd492f08087b39fd185d6ff8278748b954a3fb51e0cb24ea1af0b55c7e1d1d021c43"} 14:38:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:08 INFO - Copying logs to upload dir... 14:38:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.160010 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-14 14:38:07.770323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 14:38:07.774000) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/de6ed6f04ec31e706ad2631de7a6e92ea2b2504631f658f7e2cae37f504e2cab27bd6e4b57d743f76da273484edc7e46043f209ffb98c269800267058ceaa270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f13876a298539943dd4c96a874492f945f65741d2e9b330200b41d1ea6ae7c89b64c17c726ef615ab5c4b11ea1028d21ef881d7574e3b7e64d0cbb9191d38fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9c85ffaf297f9815971eb0b92b0f0903c9f388a5ad47d99c9798fcb6e61dcd492f08087b39fd185d6ff8278748b954a3fb51e0cb24ea1af0b55c7e1d1d021c43"} build_url:https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011815 build_url: 'https://queue.taskcluster.net/v1/task/ELLbtei-RdCmYPHl03TH5g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/de6ed6f04ec31e706ad2631de7a6e92ea2b2504631f658f7e2cae37f504e2cab27bd6e4b57d743f76da273484edc7e46043f209ffb98c269800267058ceaa270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/f13876a298539943dd4c96a874492f945f65741d2e9b330200b41d1ea6ae7c89b64c17c726ef615ab5c4b11ea1028d21ef881d7574e3b7e64d0cbb9191d38fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9c85ffaf297f9815971eb0b92b0f0903c9f388a5ad47d99c9798fcb6e61dcd492f08087b39fd185d6ff8278748b954a3fb51e0cb24ea1af0b55c7e1d1d021c43"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 14:38:07.799907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:38:07.800240) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479161838.484364-909377847 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 14:38:07.883508) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 14:38:07.883833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 14:38:07.884151) ========= ========= Total master_lag: 0.17 =========