builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1470367136.87 results: success (0) buildid: 20160804173002 builduid: b98337d5f41e4cd7ae1712513204fe83 revision: fff9d624dca283235c916d8769786e04f5622282 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:56.868970) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:56.869447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:56.869761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:56.897302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:56.897632) ========= 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=745a4373a2a16df560f216e000000264-1470365941.719288-957611573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 20:18:56-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.6M=0s 2016-08-04 20:18:56 (33.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:57.030479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:57.030834) ========= 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=745a4373a2a16df560f216e000000264-1470365941.719288-957611573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:57.084184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 20:18:57.084590) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fff9d624dca283235c916d8769786e04f5622282 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fff9d624dca283235c916d8769786e04f5622282 --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=745a4373a2a16df560f216e000000264-1470365941.719288-957611573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 20:18:57,113 truncating revision to first 12 chars 2016-08-04 20:18:57,113 Setting DEBUG logging. 2016-08-04 20:18:57,113 attempt 1/10 2016-08-04 20:18:57,113 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fff9d624dca2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 20:18:58,282 unpacking tar archive at: fx-team-fff9d624dca2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.582226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-04 20:18:58.681191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:58.681549) ========= script_repo_revision: fff9d624dca283235c916d8769786e04f5622282 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:58.682379) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:58.682688) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 20:18:58.694288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 20:18:58.694712) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=745a4373a2a16df560f216e000000264-1470365941.719288-957611573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:18:58 INFO - MultiFileLogger online at 20160804 20:18:58 in /builds/slave/test 20:18:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:18:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:18:58 INFO - {'append_to_log': False, 20:18:58 INFO - 'base_work_dir': '/builds/slave/test', 20:18:58 INFO - 'blob_upload_branch': 'Fx-Team', 20:18:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:18:58 INFO - 'branch': 'Fx-Team', 20:18:58 INFO - 'buildbot_json_path': 'buildprops.json', 20:18:58 INFO - 'config_files': ('talos/linux_config.py',), 20:18:58 INFO - 'default_actions': ('clobber', 20:18:58 INFO - 'read-buildbot-config', 20:18:58 INFO - 'download-and-extract', 20:18:58 INFO - 'populate-webroot', 20:18:58 INFO - 'create-virtualenv', 20:18:58 INFO - 'install', 20:18:58 INFO - 'run-tests'), 20:18:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:18:58 INFO - 'download_minidump_stackwalk': True, 20:18:58 INFO - 'download_symbols': 'ondemand', 20:18:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:18:58 INFO - 'tooltool.py': '/tools/tooltool.py', 20:18:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:18:58 INFO - '/tools/misc-python/virtualenv.py')}, 20:18:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:18:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:18:58 INFO - 'installer_path': 'installer.exe', 20:18:58 INFO - 'log_level': 'info', 20:18:58 INFO - 'log_name': 'talos', 20:18:58 INFO - 'log_to_console': True, 20:18:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:18:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:18:58 INFO - 'opt_config_files': (), 20:18:58 INFO - 'pip_index': False, 20:18:58 INFO - 'sps_profile': False, 20:18:58 INFO - 'sps_profile_interval': 0, 20:18:58 INFO - 'suite': 'dromaeojs', 20:18:58 INFO - 'system_bits': '32', 20:18:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:18:58 INFO - 'title': 'talos-linux64-ix-032', 20:18:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:18:58 INFO - 'use_talos_json': True, 20:18:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:18:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:18:58 INFO - 'work_dir': 'build'} 20:18:58 INFO - [mozharness: 2016-08-05 03:18:58.818115Z] Running clobber step. 20:18:58 INFO - Running pre-action listener: _resource_record_pre_action 20:18:58 INFO - Running main action method: clobber 20:18:58 INFO - rmtree: /builds/slave/test/build 20:18:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:18:59 INFO - Running post-action listener: _resource_record_post_action 20:18:59 INFO - [mozharness: 2016-08-05 03:18:59.266187Z] Finished clobber step (success) 20:18:59 INFO - [mozharness: 2016-08-05 03:18:59.266287Z] Running read-buildbot-config step. 20:18:59 INFO - Running pre-action listener: _resource_record_pre_action 20:18:59 INFO - Running main action method: read_buildbot_config 20:18:59 INFO - Using buildbot properties: 20:18:59 INFO - { 20:18:59 INFO - "project": "", 20:18:59 INFO - "product": "firefox", 20:18:59 INFO - "script_repo_revision": "production", 20:18:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:18:59 INFO - "repository": "", 20:18:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:18:59 INFO - "buildid": "20160804173002", 20:18:59 INFO - "pgo_build": "True", 20:18:59 INFO - "basedir": "/builds/slave/test", 20:18:59 INFO - "buildnumber": 1422, 20:18:59 INFO - "slavename": "talos-linux64-ix-032", 20:18:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:18:59 INFO - "platform": "ubuntu64_hw", 20:18:59 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:18:59 INFO - "branch": "fx-team", 20:18:59 INFO - "repo_path": "integration/fx-team", 20:18:59 INFO - "revision": "fff9d624dca283235c916d8769786e04f5622282", 20:18:59 INFO - "stage_platform": "linux64-pgo", 20:18:59 INFO - "builduid": "b98337d5f41e4cd7ae1712513204fe83", 20:18:59 INFO - "slavebuilddir": "test" 20:18:59 INFO - } 20:18:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:18:59 INFO - Running post-action listener: _resource_record_post_action 20:18:59 INFO - [mozharness: 2016-08-05 03:18:59.268713Z] Finished read-buildbot-config step (success) 20:18:59 INFO - [mozharness: 2016-08-05 03:18:59.268801Z] Running download-and-extract step. 20:18:59 INFO - Running pre-action listener: _resource_record_pre_action 20:18:59 INFO - Running main action method: download_and_extract 20:18:59 INFO - mkdir: /builds/slave/test/build/tests 20:18:59 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')]} 20:18:59 INFO - trying https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:59 INFO - Downloading https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:18:59 INFO - Downloaded 1361 bytes. 20:18:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:18:59 INFO - Using the following test package requirements: 20:18:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:18:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:18:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'jsshell-linux-x86_64.zip'], 20:18:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:18:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:18:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:18:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:18:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:18:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:18:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:18:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:18:59 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')]} 20:18:59 INFO - trying https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:18:59 INFO - Downloading https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:19:00 INFO - Downloaded 21820898 bytes. 20:19:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:19:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:19:02 INFO - Return code: 0 20:19:02 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:02 INFO - trying https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:19:03 INFO - Downloaded 21820898 bytes. 20:19:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:19:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:19:04 INFO - Return code: 0 20:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:04 INFO - trying https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:19:04 INFO - Downloading https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:19:05 INFO - Downloaded 14413723 bytes. 20:19:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:19:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:19:05 INFO - Return code: 0 20:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:05 INFO - trying https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:19:05 INFO - Downloading https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:19:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:19:06 INFO - Downloaded 59363080 bytes. 20:19:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:19:06 INFO - mkdir: /builds/slave/test/properties 20:19:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:19:06 INFO - Writing to file /builds/slave/test/properties/build_url 20:19:06 INFO - Contents: 20:19:06 INFO - build_url:https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:19:07 INFO - Running post-action listener: _resource_record_post_action 20:19:07 INFO - Running post-action listener: set_extra_try_arguments 20:19:07 INFO - [mozharness: 2016-08-05 03:19:07.606971Z] Finished download-and-extract step (success) 20:19:07 INFO - [mozharness: 2016-08-05 03:19:07.607206Z] Running populate-webroot step. 20:19:07 INFO - Running pre-action listener: _resource_record_pre_action 20:19:07 INFO - Running main action method: populate_webroot 20:19:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:19:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:19:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:19:07 INFO - '--tppagecycles', 20:19:07 INFO - '7'], 20:19:07 INFO - 'tests': ['tsvgm']}}, 20:19:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:19:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:19:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:19:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:19:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['damp', 'tps']}, 20:19:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'tests': ['damp', 'tps']}, 20:19:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['dromaeo_dom']}, 20:19:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:19:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['basic_compositor_video']}, 20:19:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:19:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['a11yr', 20:19:07 INFO - 'ts_paint', 20:19:07 INFO - 'tpaint', 20:19:07 INFO - 'sessionrestore', 20:19:07 INFO - 'sessionrestore_no_auto_restore', 20:19:07 INFO - 'tabpaint']}, 20:19:07 INFO - 'other-e10s': {'tests': ['a11yr', 20:19:07 INFO - 'ts_paint', 20:19:07 INFO - 'tpaint', 20:19:07 INFO - 'sessionrestore', 20:19:07 INFO - 'sessionrestore_no_auto_restore', 20:19:07 INFO - 'tabpaint']}, 20:19:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:19:07 INFO - 'ts_paint', 20:19:07 INFO - 'tpaint', 20:19:07 INFO - 'sessionrestore', 20:19:07 INFO - 'sessionrestore_no_auto_restore', 20:19:07 INFO - 'tabpaint']}, 20:19:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:19:07 INFO - 'ts_paint', 20:19:07 INFO - 'tpaint', 20:19:07 INFO - 'sessionrestore', 20:19:07 INFO - 'sessionrestore_no_auto_restore', 20:19:07 INFO - 'tabpaint']}, 20:19:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['a11yr', 20:19:07 INFO - 'ts_paint', 20:19:07 INFO - 'tpaint', 20:19:07 INFO - 'sessionrestore', 20:19:07 INFO - 'sessionrestore_no_auto_restore', 20:19:07 INFO - 'tabpaint']}, 20:19:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['a11yr', 20:19:07 INFO - 'ts_paint', 20:19:07 INFO - 'tpaint', 20:19:07 INFO - 'sessionrestore', 20:19:07 INFO - 'sessionrestore_no_auto_restore', 20:19:07 INFO - 'tabpaint']}, 20:19:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['tsvgx', 20:19:07 INFO - 'tsvgr_opacity', 20:19:07 INFO - 'tart', 20:19:07 INFO - 'tscrollx', 20:19:07 INFO - 'cart']}, 20:19:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:19:07 INFO - 'tsvgr_opacity', 20:19:07 INFO - 'tart', 20:19:07 INFO - 'tscrollx', 20:19:07 INFO - 'cart']}, 20:19:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'talos_options': ['--disable-e10s'], 20:19:07 INFO - 'tests': ['tp5o']}, 20:19:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'tests': ['tp5o']}, 20:19:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'talos_options': ['--disable-e10s', 20:19:07 INFO - '--xperf_path', 20:19:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:07 INFO - 'tests': ['tp5n']}, 20:19:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:07 INFO - 'talos_options': ['--xperf_path', 20:19:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:07 INFO - 'tests': ['tp5n']}}, 20:19:07 INFO - 'talos.zip': {'path': '', 20:19:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:19:07 INFO - Running post-action listener: _resource_record_post_action 20:19:07 INFO - [mozharness: 2016-08-05 03:19:07.624253Z] Finished populate-webroot step (success) 20:19:07 INFO - [mozharness: 2016-08-05 03:19:07.624343Z] Running create-virtualenv step. 20:19:07 INFO - Running pre-action listener: _resource_record_pre_action 20:19:07 INFO - Running main action method: create_virtualenv 20:19:07 INFO - Creating virtualenv /builds/slave/test/build/venv 20:19:07 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 20:19:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:19:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:19:07 INFO - Using real prefix '/usr' 20:19:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:19:08 INFO - Installing distribute.............................................................................................................................................................................................done. 20:19:10 INFO - Installing pip.................done. 20:19:10 INFO - Return code: 0 20:19:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:10 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:10 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 20:19:10 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 20:19:10 INFO - Using env: {'DISPLAY': ':0', 20:19:10 INFO - 'HOME': '/home/cltbld', 20:19:10 INFO - 'LANG': 'en_US.UTF-8', 20:19:10 INFO - 'LANGUAGE': 'en_US:en', 20:19:10 INFO - 'LOGNAME': 'cltbld', 20:19:10 INFO - 'MAIL': '/var/mail/cltbld', 20:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:10 INFO - 'MOZ_NO_REMOTE': '1', 20:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:10 INFO - 'NO_EM_RESTART': '1', 20:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:10 INFO - 'PWD': '/builds/slave/test', 20:19:10 INFO - 'SHELL': '/bin/bash', 20:19:10 INFO - 'SHLVL': '1', 20:19:10 INFO - 'TERM': 'linux', 20:19:10 INFO - 'TMOUT': '86400', 20:19:10 INFO - 'USER': 'cltbld', 20:19:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:10 INFO - '_': '/tools/buildbot/bin/python'} 20:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:10 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 20:19:10 INFO - Cleaning up... 20:19:10 INFO - Return code: 0 20:19:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:10 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:10 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 20:19:10 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 20:19:10 INFO - Using env: {'DISPLAY': ':0', 20:19:10 INFO - 'HOME': '/home/cltbld', 20:19:10 INFO - 'LANG': 'en_US.UTF-8', 20:19:10 INFO - 'LANGUAGE': 'en_US:en', 20:19:10 INFO - 'LOGNAME': 'cltbld', 20:19:10 INFO - 'MAIL': '/var/mail/cltbld', 20:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:10 INFO - 'MOZ_NO_REMOTE': '1', 20:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:10 INFO - 'NO_EM_RESTART': '1', 20:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:10 INFO - 'PWD': '/builds/slave/test', 20:19:10 INFO - 'SHELL': '/bin/bash', 20:19:10 INFO - 'SHLVL': '1', 20:19:10 INFO - 'TERM': 'linux', 20:19:10 INFO - 'TMOUT': '86400', 20:19:10 INFO - 'USER': 'cltbld', 20:19:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:10 INFO - '_': '/tools/buildbot/bin/python'} 20:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:10 INFO - Downloading/unpacking psutil>=3.1.1 20:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:12 INFO - Installing collected packages: psutil 20:19:12 INFO - Running setup.py install for psutil 20:19:12 INFO - building 'psutil._psutil_linux' extension 20:19:12 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 20:19:12 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 20:19:12 INFO - building 'psutil._psutil_posix' extension 20:19:12 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 20:19:12 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 20:19:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:13 INFO - Successfully installed psutil 20:19:13 INFO - Cleaning up... 20:19:15 INFO - Return code: 0 20:19:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:19:15 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')]} 20:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:15 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')]} 20:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:15 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:15 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 20:19:15 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 20:19:15 INFO - Using env: {'DISPLAY': ':0', 20:19:15 INFO - 'HOME': '/home/cltbld', 20:19:15 INFO - 'LANG': 'en_US.UTF-8', 20:19:15 INFO - 'LANGUAGE': 'en_US:en', 20:19:15 INFO - 'LOGNAME': 'cltbld', 20:19:15 INFO - 'MAIL': '/var/mail/cltbld', 20:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:15 INFO - 'MOZ_NO_REMOTE': '1', 20:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:15 INFO - 'NO_EM_RESTART': '1', 20:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:15 INFO - 'PWD': '/builds/slave/test', 20:19:15 INFO - 'SHELL': '/bin/bash', 20:19:15 INFO - 'SHLVL': '1', 20:19:15 INFO - 'TERM': 'linux', 20:19:15 INFO - 'TMOUT': '86400', 20:19:15 INFO - 'USER': 'cltbld', 20:19:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:15 INFO - '_': '/tools/buildbot/bin/python'} 20:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:19:16 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 20:19:16 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 20:19:16 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 20:19:16 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 20:19:16 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 20:19:16 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 20:19:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:19:17 INFO - Installing collected packages: mozsystemmonitor 20:19:17 INFO - Running setup.py install for mozsystemmonitor 20:19:18 INFO - Successfully installed mozsystemmonitor 20:19:18 INFO - Cleaning up... 20:19:18 INFO - Return code: 0 20:19:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:18 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:18 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 20:19:18 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 20:19:18 INFO - Using env: {'DISPLAY': ':0', 20:19:18 INFO - 'HOME': '/home/cltbld', 20:19:18 INFO - 'LANG': 'en_US.UTF-8', 20:19:18 INFO - 'LANGUAGE': 'en_US:en', 20:19:18 INFO - 'LOGNAME': 'cltbld', 20:19:18 INFO - 'MAIL': '/var/mail/cltbld', 20:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:18 INFO - 'MOZ_NO_REMOTE': '1', 20:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:18 INFO - 'NO_EM_RESTART': '1', 20:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:18 INFO - 'PWD': '/builds/slave/test', 20:19:18 INFO - 'SHELL': '/bin/bash', 20:19:18 INFO - 'SHLVL': '1', 20:19:18 INFO - 'TERM': 'linux', 20:19:18 INFO - 'TMOUT': '86400', 20:19:18 INFO - 'USER': 'cltbld', 20:19:18 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:18 INFO - '_': '/tools/buildbot/bin/python'} 20:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:18 INFO - Downloading/unpacking jsonschema==2.5.1 20:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:19:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:19:20 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 20:19:20 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 20:19:20 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 20:19:20 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 20:19:20 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 20:19:20 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 20:19:20 INFO - Downloading functools32-3.2.3-2.tar.gz 20:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:19:20 INFO - warning: no files found matching '*.txt' 20:19:20 INFO - no previously-included directories found matching 'build' 20:19:20 INFO - no previously-included directories found matching 'dist' 20:19:20 INFO - no previously-included directories found matching '.git*' 20:19:20 INFO - Installing collected packages: jsonschema, functools32 20:19:20 INFO - Running setup.py install for functools32 20:19:20 INFO - warning: no files found matching '*.txt' 20:19:20 INFO - no previously-included directories found matching 'build' 20:19:20 INFO - no previously-included directories found matching 'dist' 20:19:20 INFO - no previously-included directories found matching '.git*' 20:19:20 INFO - Successfully installed jsonschema functools32 20:19:20 INFO - Cleaning up... 20:19:20 INFO - Return code: 0 20:19:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:19:20 INFO - Using env: {'DISPLAY': ':0', 20:19:20 INFO - 'HOME': '/home/cltbld', 20:19:20 INFO - 'LANG': 'en_US.UTF-8', 20:19:20 INFO - 'LANGUAGE': 'en_US:en', 20:19:20 INFO - 'LOGNAME': 'cltbld', 20:19:20 INFO - 'MAIL': '/var/mail/cltbld', 20:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:20 INFO - 'MOZ_NO_REMOTE': '1', 20:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:20 INFO - 'NO_EM_RESTART': '1', 20:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:20 INFO - 'PWD': '/builds/slave/test', 20:19:20 INFO - 'SHELL': '/bin/bash', 20:19:20 INFO - 'SHLVL': '1', 20:19:20 INFO - 'TERM': 'linux', 20:19:20 INFO - 'TMOUT': '86400', 20:19:20 INFO - 'USER': 'cltbld', 20:19:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:20 INFO - '_': '/tools/buildbot/bin/python'} 20:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:19:20 INFO - Cleaning up... 20:19:20 INFO - Return code: 0 20:19:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:19: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')]} 20:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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')]} 20:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:19:20 INFO - Using env: {'DISPLAY': ':0', 20:19:20 INFO - 'HOME': '/home/cltbld', 20:19:20 INFO - 'LANG': 'en_US.UTF-8', 20:19:20 INFO - 'LANGUAGE': 'en_US:en', 20:19:20 INFO - 'LOGNAME': 'cltbld', 20:19:20 INFO - 'MAIL': '/var/mail/cltbld', 20:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:20 INFO - 'MOZ_NO_REMOTE': '1', 20:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:20 INFO - 'NO_EM_RESTART': '1', 20:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:20 INFO - 'PWD': '/builds/slave/test', 20:19:20 INFO - 'SHELL': '/bin/bash', 20:19:20 INFO - 'SHLVL': '1', 20:19:20 INFO - 'TERM': 'linux', 20:19:20 INFO - 'TMOUT': '86400', 20:19:20 INFO - 'USER': 'cltbld', 20:19:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:20 INFO - '_': '/tools/buildbot/bin/python'} 20:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:21 INFO - Downloading/unpacking blobuploader==1.2.4 20:19:21 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 20:19:21 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 20:19:21 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 20:19:21 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 20:19:21 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 20:19:21 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 20:19:22 INFO - Downloading blobuploader-1.2.4.tar.gz 20:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:19:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:19:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:23 INFO - Downloading docopt-0.6.1.tar.gz 20:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:19:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:19:23 INFO - Running setup.py install for blobuploader 20:19:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:19:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:19:23 INFO - Running setup.py install for requests 20:19:24 INFO - Running setup.py install for docopt 20:19:24 INFO - Successfully installed blobuploader requests docopt 20:19:24 INFO - Cleaning up... 20:19:24 INFO - Return code: 0 20:19:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:24 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')]} 20:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:24 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')]} 20:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:24 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:24 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 20:19:24 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 20:19:24 INFO - Using env: {'DISPLAY': ':0', 20:19:24 INFO - 'HOME': '/home/cltbld', 20:19:24 INFO - 'LANG': 'en_US.UTF-8', 20:19:24 INFO - 'LANGUAGE': 'en_US:en', 20:19:24 INFO - 'LOGNAME': 'cltbld', 20:19:24 INFO - 'MAIL': '/var/mail/cltbld', 20:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:24 INFO - 'MOZ_NO_REMOTE': '1', 20:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:24 INFO - 'NO_EM_RESTART': '1', 20:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:24 INFO - 'PWD': '/builds/slave/test', 20:19:24 INFO - 'SHELL': '/bin/bash', 20:19:24 INFO - 'SHLVL': '1', 20:19:24 INFO - 'TERM': 'linux', 20:19:24 INFO - 'TMOUT': '86400', 20:19:24 INFO - 'USER': 'cltbld', 20:19:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:24 INFO - '_': '/tools/buildbot/bin/python'} 20:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:24 INFO - Running setup.py (path:/tmp/pip-fDO5Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:24 INFO - Running setup.py (path:/tmp/pip-pZz4XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:24 INFO - Running setup.py (path:/tmp/pip-oypI4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:24 INFO - Running setup.py (path:/tmp/pip-Myr8DE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:24 INFO - Running setup.py (path:/tmp/pip-TdU2I5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:24 INFO - Running setup.py (path:/tmp/pip-Y3ZhB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:24 INFO - Running setup.py (path:/tmp/pip-hUeeDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:25 INFO - Running setup.py (path:/tmp/pip-PX6Hou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:25 INFO - Running setup.py (path:/tmp/pip-Igl1XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:25 INFO - Running setup.py (path:/tmp/pip-f8tD0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:25 INFO - Running setup.py (path:/tmp/pip-N0kGui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:25 INFO - Running setup.py (path:/tmp/pip-jGYOoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:25 INFO - Running setup.py (path:/tmp/pip-E6I5wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:25 INFO - Running setup.py (path:/tmp/pip-DY7ddK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:25 INFO - Running setup.py (path:/tmp/pip-flW_63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:25 INFO - Running setup.py (path:/tmp/pip-lPK7wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:25 INFO - Running setup.py (path:/tmp/pip-rerc_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:19:25 INFO - Running setup.py install for manifestparser 20:19:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:19:25 INFO - Running setup.py install for mozcrash 20:19:25 INFO - Running setup.py install for mozdebug 20:19:26 INFO - Running setup.py install for mozdevice 20:19:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Running setup.py install for mozfile 20:19:26 INFO - Running setup.py install for mozhttpd 20:19:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Running setup.py install for mozinfo 20:19:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Running setup.py install for mozInstall 20:19:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Running setup.py install for mozleak 20:19:26 INFO - Running setup.py install for mozlog 20:19:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Running setup.py install for moznetwork 20:19:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:19:26 INFO - Running setup.py install for mozprocess 20:19:27 INFO - Running setup.py install for mozprofile 20:19:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:19:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:19:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:19:27 INFO - Running setup.py install for mozrunner 20:19:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:19:27 INFO - Running setup.py install for mozscreenshot 20:19:27 INFO - Running setup.py install for moztest 20:19:27 INFO - Running setup.py install for mozversion 20:19:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:19:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:19:27 INFO - Cleaning up... 20:19:27 INFO - Return code: 0 20:19:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:27 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:27 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 20:19:27 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 20:19:27 INFO - Using env: {'DISPLAY': ':0', 20:19:27 INFO - 'HOME': '/home/cltbld', 20:19:27 INFO - 'LANG': 'en_US.UTF-8', 20:19:27 INFO - 'LANGUAGE': 'en_US:en', 20:19:27 INFO - 'LOGNAME': 'cltbld', 20:19:27 INFO - 'MAIL': '/var/mail/cltbld', 20:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:27 INFO - 'MOZ_NO_REMOTE': '1', 20:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:27 INFO - 'NO_EM_RESTART': '1', 20:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:27 INFO - 'PWD': '/builds/slave/test', 20:19:27 INFO - 'SHELL': '/bin/bash', 20:19:27 INFO - 'SHLVL': '1', 20:19:27 INFO - 'TERM': 'linux', 20:19:27 INFO - 'TMOUT': '86400', 20:19:27 INFO - 'USER': 'cltbld', 20:19:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:27 INFO - '_': '/tools/buildbot/bin/python'} 20:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:27 INFO - Running setup.py (path:/tmp/pip-hvC6j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:27 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)) 20:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:27 INFO - Running setup.py (path:/tmp/pip-UfBIW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:19:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:27 INFO - Running setup.py (path:/tmp/pip-L4ANk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:28 INFO - Running setup.py (path:/tmp/pip-deR4Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:28 INFO - Running setup.py (path:/tmp/pip-KZgaDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:28 INFO - Running setup.py (path:/tmp/pip-IVb5BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:28 INFO - Running setup.py (path:/tmp/pip-384fzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:28 INFO - Running setup.py (path:/tmp/pip-voGJYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:28 INFO - Running setup.py (path:/tmp/pip-4CRv_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:28 INFO - Running setup.py (path:/tmp/pip-Agpaoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:28 INFO - Running setup.py (path:/tmp/pip-spGvCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:28 INFO - Running setup.py (path:/tmp/pip-NDrUNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:28 INFO - Running setup.py (path:/tmp/pip-DAHkAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:28 INFO - Running setup.py (path:/tmp/pip-1wG8ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:28 INFO - Running setup.py (path:/tmp/pip-Zl9NeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:28 INFO - Running setup.py (path:/tmp/pip-hv15jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:28 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)) 20:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:28 INFO - Running setup.py (path:/tmp/pip-6I1eJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:29 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)) 20:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:19:29 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)) 20:19:29 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)) 20:19:29 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)) 20:19:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:19:29 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 20:19:29 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 20:19:29 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 20:19:29 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 20:19:29 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 20:19:29 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 20:19:30 INFO - Downloading blessings-1.6.tar.gz 20:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:19:31 INFO - Installing collected packages: blessings 20:19:31 INFO - Running setup.py install for blessings 20:19:31 INFO - Successfully installed blessings 20:19:31 INFO - Cleaning up... 20:19:31 INFO - Return code: 0 20:19:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:31 INFO - Reading from file tmpfile_stdout 20:19:31 INFO - Current package versions: 20:19:31 INFO - argparse == 1.2.1 20:19:31 INFO - blessings == 1.6 20:19:31 INFO - blobuploader == 1.2.4 20:19:31 INFO - docopt == 0.6.1 20:19:31 INFO - functools32 == 3.2.3-2 20:19:31 INFO - jsonschema == 2.5.1 20:19:31 INFO - manifestparser == 1.1 20:19:31 INFO - mozInstall == 1.12 20:19:31 INFO - mozcrash == 0.17 20:19:31 INFO - mozdebug == 0.1 20:19:31 INFO - mozdevice == 0.48 20:19:31 INFO - mozfile == 1.2 20:19:31 INFO - mozhttpd == 0.7 20:19:31 INFO - mozinfo == 0.9 20:19:31 INFO - mozleak == 0.1 20:19:31 INFO - mozlog == 3.3 20:19:31 INFO - moznetwork == 0.27 20:19:31 INFO - mozprocess == 0.23 20:19:31 INFO - mozprofile == 0.28 20:19:31 INFO - mozrunner == 6.12 20:19:31 INFO - mozscreenshot == 0.1 20:19:31 INFO - mozsystemmonitor == 0.3 20:19:31 INFO - moztest == 0.7 20:19:31 INFO - mozversion == 1.4 20:19:31 INFO - psutil == 3.1.1 20:19:31 INFO - requests == 1.2.3 20:19:31 INFO - wsgiref == 0.1.2 20:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:31 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')]} 20:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:31 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')]} 20:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:31 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:31 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 20:19:31 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 20:19:31 INFO - Using env: {'DISPLAY': ':0', 20:19:31 INFO - 'HOME': '/home/cltbld', 20:19:31 INFO - 'LANG': 'en_US.UTF-8', 20:19:31 INFO - 'LANGUAGE': 'en_US:en', 20:19:31 INFO - 'LOGNAME': 'cltbld', 20:19:31 INFO - 'MAIL': '/var/mail/cltbld', 20:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:31 INFO - 'MOZ_NO_REMOTE': '1', 20:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:31 INFO - 'NO_EM_RESTART': '1', 20:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:31 INFO - 'PWD': '/builds/slave/test', 20:19:31 INFO - 'SHELL': '/bin/bash', 20:19:31 INFO - 'SHLVL': '1', 20:19:31 INFO - 'TERM': 'linux', 20:19:31 INFO - 'TMOUT': '86400', 20:19:31 INFO - 'USER': 'cltbld', 20:19:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:31 INFO - '_': '/tools/buildbot/bin/python'} 20:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 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)) 20:19:31 INFO - Cleaning up... 20:19:31 INFO - Return code: 0 20:19:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:19:31 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')]} 20:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:31 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')]} 20:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:31 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 0xb4f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcb28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe10180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, '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': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', '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 20:19:31 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 20:19:31 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 20:19:31 INFO - Using env: {'DISPLAY': ':0', 20:19:31 INFO - 'HOME': '/home/cltbld', 20:19:31 INFO - 'LANG': 'en_US.UTF-8', 20:19:31 INFO - 'LANGUAGE': 'en_US:en', 20:19:31 INFO - 'LOGNAME': 'cltbld', 20:19:31 INFO - 'MAIL': '/var/mail/cltbld', 20:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:31 INFO - 'MOZ_NO_REMOTE': '1', 20:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:31 INFO - 'NO_EM_RESTART': '1', 20:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:31 INFO - 'PWD': '/builds/slave/test', 20:19:31 INFO - 'SHELL': '/bin/bash', 20:19:31 INFO - 'SHLVL': '1', 20:19:31 INFO - 'TERM': 'linux', 20:19:31 INFO - 'TMOUT': '86400', 20:19:31 INFO - 'USER': 'cltbld', 20:19:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:31 INFO - '_': '/tools/buildbot/bin/python'} 20:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:19:31 INFO - Cleaning up... 20:19:31 INFO - Return code: 0 20:19:31 INFO - Running post-action listener: _resource_record_post_action 20:19:31 INFO - Running post-action listener: _start_resource_monitoring 20:19:31 INFO - Starting resource monitoring. 20:19:31 INFO - [mozharness: 2016-08-05 03:19:31.856867Z] Finished create-virtualenv step (success) 20:19:31 INFO - [mozharness: 2016-08-05 03:19:31.857468Z] Running install step. 20:19:31 INFO - Running pre-action listener: _resource_record_pre_action 20:19:31 INFO - Running main action method: install 20:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:32 INFO - Reading from file tmpfile_stdout 20:19:32 INFO - Detecting whether we're running mozinstall >=1.0... 20:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:19:32 INFO - Reading from file tmpfile_stdout 20:19:32 INFO - Output received: 20:19:32 INFO - Usage: mozinstall [options] installer 20:19:32 INFO - Options: 20:19:32 INFO - -h, --help show this help message and exit 20:19:32 INFO - -d DEST, --destination=DEST 20:19:32 INFO - Directory to install application into. [default: 20:19:32 INFO - "/builds/slave/test"] 20:19:32 INFO - --app=APP Application being installed. [default: firefox] 20:19:32 INFO - mkdir: /builds/slave/test/build/application 20:19:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:19:48 INFO - Reading from file tmpfile_stdout 20:19:48 INFO - Output received: 20:19:48 INFO - /builds/slave/test/build/application/firefox/firefox 20:19:48 INFO - Running post-action listener: _resource_record_post_action 20:19:48 INFO - [mozharness: 2016-08-05 03:19:48.985606Z] Finished install step (success) 20:19:48 INFO - [mozharness: 2016-08-05 03:19:48.985854Z] Running run-tests step. 20:19:48 INFO - Running pre-action listener: _resource_record_pre_action 20:19:48 INFO - Running main action method: run_tests 20:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:19:48 INFO - Python 2.7.3 20:19:48 INFO - Return code: 0 20:19:48 INFO - grabbing minidump binary from tooltool 20:19: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')]} 20:19:48 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 0xe0e3b0>, '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 0xe0f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:19:48 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 20:19:48 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 20:19:48 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 20:19:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:19:49 INFO - Return code: 0 20:19:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:19:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:19:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:19:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:19:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 20:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 20:19:49 INFO - Using env: {'DISPLAY': ':0', 20:19:49 INFO - 'HOME': '/home/cltbld', 20:19:49 INFO - 'LANG': 'en_US.UTF-8', 20:19:49 INFO - 'LANGUAGE': 'en_US:en', 20:19:49 INFO - 'LOGNAME': 'cltbld', 20:19:49 INFO - 'MAIL': '/var/mail/cltbld', 20:19:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:19:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:49 INFO - 'MOZ_NO_REMOTE': '1', 20:19:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:19:49 INFO - 'NO_EM_RESTART': '1', 20:19:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:49 INFO - 'PWD': '/builds/slave/test', 20:19:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:19:49 INFO - 'SHELL': '/bin/bash', 20:19:49 INFO - 'SHLVL': '1', 20:19:49 INFO - 'TERM': 'linux', 20:19:49 INFO - 'TMOUT': '86400', 20:19:49 INFO - 'USER': 'cltbld', 20:19:49 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1470365941.719288-957611573', 20:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:49 INFO - '_': '/tools/buildbot/bin/python'} 20:19:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 20:19:49 INFO - mozversion application_buildid: 20160804173002 20:19:49 INFO - mozversion application_changeset: fff9d624dca283235c916d8769786e04f5622282 20:19:49 INFO - mozversion application_display_name: Nightly 20:19:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:19:49 INFO - mozversion application_name: Firefox 20:19:49 INFO - mozversion application_remotingname: firefox 20:19:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:19:49 INFO - mozversion application_vendor: Mozilla 20:19:49 INFO - mozversion application_version: 51.0a1 20:19:49 INFO - mozversion platform_buildid: 20160804173002 20:19:49 INFO - mozversion platform_changeset: fff9d624dca283235c916d8769786e04f5622282 20:19:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:19:49 INFO - mozversion platform_version: 51.0a1 20:19:49 INFO - using testdate: 1470367189 20:19:49 INFO - actual date: 1470367189 20:19:49 INFO - starting webserver on 'localhost:53975' 20:19:49 INFO - SUITE-START | Running 2 tests 20:19:49 INFO - TEST-START | dromaeo_css 20:19:49 INFO - operating with platform_type : linux_ 20:19:49 INFO - Initialising browser for dromaeo_css test... 20:19:49 INFO - TEST-INFO | started process 6645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbH4Wdm/profile http://localhost:53975/getInfo.html) 20:19:54 INFO - PROCESS | 6645 | __metrics Screen width/height:1600/1200 20:19:54 INFO - PROCESS | 6645 | colorDepth:24 20:19:54 INFO - PROCESS | 6645 | Browser inner width/height: 1024/697 20:19:54 INFO - PROCESS | 6645 | __metrics 20:19:55 INFO - PROCESS | 6645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:19:55 INFO - PROCESS | 6645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:55 INFO - PROCESS | 6645 | console.error: PushService: 20:19:55 INFO - PROCESS | 6645 | stateChangeProcessEnqueue: Error transitioning state 20:19:55 INFO - PROCESS | 6645 | UnknownError 20:19:56 INFO - TEST-INFO | 6645: exit 0 20:19:56 INFO - Browser initialized. 20:19:56 INFO - Running cycle 1/1 for dromaeo_css test... 20:19:56 INFO - TEST-INFO | started process 6729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbH4Wdm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:08 INFO - PROCESS | 6729 | RSS: Main: 156831744 20:20:08 INFO - PROCESS | 6729 | 20:20:59 INFO - PROCESS | 6729 | 1470367259782 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] 20:23:09 INFO - PROCESS | 6729 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53975/tests/dromaeo/cssquery-ext.html) 20:23:10 INFO - PROCESS | 6729 | RSS: Main: 273227776 20:23:10 INFO - PROCESS | 6729 | 20:26:12 INFO - PROCESS | 6729 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-ext.html (next: http://localhost:53975/tests/dromaeo/cssquery-jquery.html) 20:26:13 INFO - PROCESS | 6729 | RSS: Main: 253259776 20:26:13 INFO - PROCESS | 6729 | 20:29:15 INFO - PROCESS | 6729 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53975/tests/dromaeo/cssquery-mootools.html) 20:29:15 INFO - PROCESS | 6729 | RSS: Main: 188329984 20:29:15 INFO - PROCESS | 6729 | 20:32:17 INFO - PROCESS | 6729 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53975/tests/dromaeo/cssquery-prototype.html) 20:32:18 INFO - PROCESS | 6729 | RSS: Main: 185651200 20:32:18 INFO - PROCESS | 6729 | 20:35:21 INFO - PROCESS | 6729 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53975/tests/dromaeo/cssquery-yui.html) 20:35:21 INFO - PROCESS | 6729 | RSS: Main: 185892864 20:35:21 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | Cycle 1(1): loaded http://localhost:53975/tests/dromaeo/cssquery-yui.html (next: http://localhost:53975/tests/dromaeo/cssquery-dojo.html) 20:38:24 INFO - PROCESS | 6729 | RSS: Main: 273338368 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | __start_tp_report 20:38:24 INFO - PROCESS | 6729 | _x_x_mozilla_page_load 20:38:24 INFO - PROCESS | 6729 | _x_x_mozilla_page_load_details 20:38:24 INFO - PROCESS | 6729 | |i|pagename|runs| 20:38:24 INFO - PROCESS | 6729 | |0;dojo.html;2992.7156920092593;3006.5339872319796;3030.0000999670106;3033.1507177990156;3038.46826805309;5136.974315128428;5163.122269214233;5182.637215394924;5230.895382092356;5261.684298942067;5226.7909283628605;5248.370195576536;5284.365876094874;5289.761960711768;5338.813141540047;4725.8818529536775;4796.83211087612;4802.855914322576;4815.470298267188;4943.233798761198;4853.102176097415;4887.633427492934;4897.142999975008;4900.9754951225195;4923.433805112422;4688.812447502113;4734.4081989751285;4769.499202583731;4773.11697335994;4781.115493633689;4775.761211939389;4776.904461910777;4780.402449693788;4782.880427989293;4895.706257624518;4773.021530586221;4774.832880849153;4811.302361157647;4820.638452116105;4846.103470857903;5104.438511763703;5173.224016397533;5216.400113986902;5230.529252367267;5281.181416880389;5550.139728342114;5594.664320140804;5625.268715067056;5638.4925356718095;5648.8870222595315;5629.577781666391;5637.182608521742;5641.238432811559;5673.602847800656;5697;5052.520010598987;5213.687178769286;5265.157574788015;5270.5520030797425;5340.946590534045;5821.09772985188;5835.270591176103;5842.2405087338375;5848.5321174305955;5848.824535263949;5606.943930560724;5613.578981576398;5617.915731263953;5618.438156184349;5620.016497112989;5412.431694672082;5526.143447765603;5555.72221388937;5576.191452239403;5657.349404818417;5593.804216852391;5605.411431799603;5605.579581531401;5606.523445507178;5607.971960140173;5576.7211639417865;5607.691576963224;5609.382967873531;5616.775328986795;5617.522510586564;4154.667626589866;4219.135077309205;4220.53574106848;4263;4307.095509942885;3798.2973149967343;3800.3539398302355;3808.21931504041;3833.616638336144;3847.2882516734494;5257.974694934451;5262.131748261494;5262.368515778131;5263.34208223972;5310.415854256029;5500.22996780451;5594.524465420403;5623.803166889139;5624.128260119688;5710.828675139753;5332.573394128461;5364.8658783529945;5366.543843773245;5366.91949620756;5367.436419176009;4884.5603895649565;4895.975520122377;4903.4606193318705;4915.508449155127;4941.579965702884;5683.886322273532;5700.8859822803315;5714.857128571819;5715.48560629537;5791.797287094932;5531.446855314436;5541.972290138524;5543.113101903676;5546.057170280981;5551.944480555143;5752.482276595127;5752.712364381848;5754.942450575608;5759.596828222152;5760.452756988079;5396.271503347155;5479.726013699379;5491.725413729378;5521;5606.831795046155;5610.270664813548;5630.971845140748;5658.066419040812;5660.29246344207;5661.858453538694;5479.698616576126;5509;5527.613067085426;5535.474129957647;5536.469607005901;5365.3293338332705;5446.809361672323;5474.178873169057;5494.862628434321;5564.777408903598;5443.265159203457;5450.836474905759;5456.890862182813;5460.208269800936;5465.562754979672;5523.834284971457;5545.861353466195;5585.497305242548;5595.972020139873;5597.524210442158;5266.183741520071;5315.176147697113;5332.5467335276935;5372.650777699437;5386.245925570345 20:38:24 INFO - PROCESS | 6729 | |1;ext.html;592.5644651181381;622.334102510314;634.4702173684973;641.0928536121388;652.1717418878028;33321;33981.66018339816;35889.461658075146;36132.99999999996;44922.32616510755;43308.56691433085;47407.28889066667;47409.52590474094;47476.52523474764;47494.762526187405;8870.37907346486;8980.8652870207;8993.505357205351;9008.954955225248;9019.368644194908;8912.465252084896;9007.369484136114;9016.819663606724;9018;9019.052999435064;9048.502332371718;9062;9064.818703625924;9097.408668436563;9100.499472529009;8991.235744961654;9043.231325337354;9044.683436079706;9056.547172641374;9057.637694492212;8922;8981.595828187747;8987.37088403812;8992.955035224848;9001.864972025425;44189.558104418866;44486.77756611229;44635.55364446346;44688.55311446909;44691;3482.721382289411;3527.294541091792;3591.1381268495375;3617.674409303149;4069.918601627951;33739.15652108692;34753.82623086894;34773.65226347729;34863.65136348629;34919.476207856904;4316.201502721975;4347.869563913087;4405.471343438776;4408.6032257096695;4550.226461501553;358506;359219;359342;359354;359959;61970.38029619736;62547;62587.680047196496;62595;62605;63593.682031589546;64485.35514644793;64563;64582.354176458575;64603;15191.544253672408;15427.30577124032;15427.768583471257;15436.768448473282;15438.768418473732;12568.937155314165;12626;12630.242185468902;12633.620991370273;12635.494580216688;18263.269469221348;18690.71963920542;18694.158762855703;18925.810741892405;18967.52581185454;5980.342162362137;6127.785527506516;6277.937220627827;6287.748490060347;6471;1006.758377989292;1070.3952266969138;1078.7518870659792;1112.2158877991158;1161.7211869151342;31594.210144746565;32608;32695.346093078482;32765.344693106006;32887;1108.539955918301;1112.1325366214367;1122.5734220996133;1132.9263597866113;1148.4085695866636;17128;17375.131243437776;17386.21762020712;17511.12444377776;17525.298988040337;471050;473546;473916;474522;475119;61345;61556;61604.38395616076;61617.38382616206;61645.38354616486;1239.646700690299;1272.3638180909545;1341.9597412077653;1343.6372179511673;1363.8704323089291;31275.53086703747;35075.29849402946;35237.64762352344;35450.11374715653;35560.82219588885;52050.73974630103;52586;52604.21093683521;52654.47345526495;52683.20975185452;379966;380436;381615;381834;383217;43154.352684710386;43808.342874856266;45029.54970450384;45204.321935171654;45250.54749452463;49265.26102108399;49943.50056499388;50000;50554.74722626364;51130;41756;42476.78761606296;43464;44858.55141448674;45045;41926.37110443407;42186.36720449257;42394.78802605967;42980.785096074316;44297;42977.57022429736;43643;43825.34261986137;43869.34195986999;44011.55988440075;35786.463203051455;37049.10080044345;38140.809295953346;38490.80754596209;38941.80529097337;28751.424971500033;29098.854505727337;29194.854025729735;29322.706772931997;29629.407411852073 20:38:24 INFO - PROCESS | 6729 | |2;jquery.html;366.07565896112294;378.1831244511855;379.21880925293885;391.75906817307356;407.26895223074575;17575.1212439378;19355;19380.418587442364;19681.409557713272;20265.39203823884;16048.117353545551;16350.83649163508;16360.427385041527;17442.651146977085;20077.09653065612;5578.776848926058;5609.1305847593585;5803.274590676166;5812.070068788995;5819.738111784959;5558.610897237195;5667.0932650775885;5676.091825307952;5676.1769543416385;5677.460641239097;5505.9724701376435;5654.208410822488;5654.886902261952;5655.293088363955;5658.632188907728;5670.036093864053;5705.457981491772;5707.714614269291;5738.311402631711;5745.712714364265;5124.8206312778875;5137.075326441239;5143.305653736773;5144.202648589438;5442.9727851360885;23848.64227036596;24108.276751697478;24212.757872421404;24270.757292427028;24386.87806560956;2306.5156317173414;2360.5160942006846;2544.6183072539084;2809.4662014217233;2935.0754512328763;10241.539130739135;10290.845637315446;10347.00252789877;10796.298240614335;10937.070349020343;1834.5688763140652;1880.7178923161498;1924.2495426783566;1927.6530224559574;1946.3285166617636;80440;85544.14455855486;85756;86326.56836715776;88322.5583872083;11030.393328366856;11065.280756750786;11091.168162387854;11548.884511154782;11860.822087668692;15961.760573591406;15980.440684576217;16005.519834404986;16009.519714408587;16022.19889005545;7888.6450109744055;7900.012498437695;8299.253067223979;8346.248837604524;8422.073571907085;7832.882506762403;7909.485883417559;7941.205879412013;8080.797980050545;8148.837023259502;4771.570558649738;4888.120138375127;4917.950820491821;4981.726005069683;5028.673136246132;1808.1320965936425;1962.607478504305;1967.5671352302757;1968.5767559974674;1998;867.6139118092389;914.8627705844177;938.901415351392;948.0519480519481;1011.2870426349406;19658.508537286398;20289.391318260477;20346.89826550858;20397.490062748253;20550.28074017402;976.9267304952157;1008.7326858382535;1012;1020.7244044108049;1033.1373303291684;10467.466050991692;10585.311954722918;11175.273607215668;11231.21381503287;11377.317360958368;496427;497774;499833;511988;519681;91311.54344228236;92297;95068.52465737627;95767;98145.50927245319;975.5417046569927;1019.1133713669155;1032.143321043547;1039.5218199628105;1044.3264094659055;17397.391091311743;17612.64774704473;18039.639207216045;18129.45611631653;18244.08779561043;43960.780196098814;44647.55352446564;45337;45353;45484.31773523466;61000;61125;62084.37915620786;63138.68430657817;63478.68260658667;8590.355723320901;8744.169303916118;8989.146031127033;8998.325125615474;9010.369274150746;12660.104157858508;13869.861301386856;13881.861181388056;14116;14154.221517816208;11950.880491194977;12074.939625301817;12219.38903054826;12234.265944043385;12546.560870369492;11856.70358241051;12124.333161676192;12141.392930353624;12184.878151218374;12541.184822986477;12017.218880772722;12040.397980100784;12084;12187.57343493009;12565.74868502643;8755.168259015383;8834.116588341114;8894.86657700148;8966.641334346554;9029.683961061332;11356.829647555129;11808.468618912342;11900.940495297467;11911.463984120908;12295.385230738606 20:38:24 INFO - PROCESS | 6729 | |3;mootools.html;1300.7398520295944;1437.4322142753608;1499.8425165357637;1577.2113943028485;1753.8158493358205;8285.337173026159;8758.91241087589;8770.999999999993;8953.865692014626;8953.91046089539;8711.085336039703;8846.15961483658;8846.690365837198;8850.380473366868;8855.424397414163;2397.580423425898;2427.017058091467;2427.9757202428013;2428.162284012013;2430.3195105370523;2292.862428254302;2363.5036642305136;2363.5981883079917;2364.160722943356;2378.5956387414094;2313.063209400187;2314.7222333320024;2324.9186278480256;2336.8714720690355;2336.894839732208;2281.133169395636;2290.5533420982915;2297.0696867768665;2297.3452566018686;2339.2748248043163;2316.420894776306;2320.7447180810095;2324.1749179041367;2325.860448373103;2344.7069116360453;8709;8798.12018798115;8903.465792052497;8933;8979.640814367418;5028.4971502849785;5264.947350526484;5268.525832675077;5276.287701160332;5285;3350.547676063749;3429.382711111999;3480.7911525308564;3502.842372093262;3540.4689296605457;1175.4534141624185;1182.6806762174251;1182.9408529573486;1214.1986289049185;1219.5121951219494;12133.575324863676;12205.694857628541;12222.144449888512;12227.69430764238;12248.387580620933;4167.666586673059;4367.10474352757;4457.465104187519;4467.865964021084;4469.7988590513505;9631.277654175825;9635.22918166545;9635.614575417045;9641.517924103768;9652.613895444103;5019.874503137451;5024.949750502448;5025.271335656383;5037.596992240612;5041.369828771403;4096.365063415175;4190.350495673176;4246.723962942398;4621.584057434847;4705.741184234831;3653.397189463762;3685.6130106338983;3809.8857034289017;3832.559255685576;3939.1924655445564;1066.1790421375497;1093.4527643384522;1094.8850370710961;1110.6057349640762;1110.8722496912958;869.8651708984991;969.9418034917927;982.2387649571497;986.5215370545279;1008.1128606825946;5990.191324171268;6043.425874541911;6097.298810636745;6177;6369.936300637027;441.99779001104787;442.0738552732021;450.7746126936532;456.6597884576012;457.5653129526963;4188;4197.055662475918;4234.618884300427;4286.971126929577;4288.635465985364;10772;10979.945100274606;11111.333320000664;11120.165987550967;11167.38579378142;10411.167106631452;10912.236143469881;10912.890871091187;10925.562977480811;10945.398003109905;8184.6316915738935;8411.579421028924;8415.326773858076;8429.199226073513;8437.493750374997;6190.288116866438;6197.473214776614;6224.564280500503;6256.718447669957;6511.902321465087;10150.390976541432;10191.694249172537;10208.285420020527;10241.283110182514;10312.948435257777;9871.802563948824;10272.280940334404;10274.691759247235;10408.219383546113;10561.73595660084;6937.791866244021;7753.418493613114;7896.289333959971;8015.358771298165;8089.191080891864;8617.353698472514;8768.95615521944;8851;8866.778330541789;8886;7842.686292548234;7849.4897831640765;8015.358771298165;8185.8772118419465;8205.589720513832;7670.961645191738;7775.727849525239;7786.454948153575;7809.531428114331;7834.921650783419;6976;7074.469414794014;7119;7166.8924966124505;7174.569525828467;5277.656952298088;5431.674099553881;5469.480399362054;5510.972445137749;5574.442555744393;5505.559555235492;5512.944870551403;5606.495415412633;5657.773689052392;5658.915116273177 20:38:24 INFO - PROCESS | 6729 | |4;prototype.html;313.1279386907463;322.0644029095477;323.57449953311396;333.311711316132;336.72052196676776;5297.496737809912;5322.600804939626;5357.249985002098;5362.249285100089;5366.302380690515;5223.477652234775;5224.660397074197;5286.471352864712;5288.920666190001;5308.522232999029;3954.663853572443;4044.4944381952255;4109.28087584673;4168.97915510422;4179.644730197937;4130.690198235145;4130.958690413103;4131.739819355095;4141.151064031881;4147.4815648044;4080.9387859182134;4106.568810274923;4111.753294802306;4127.525334586516;4130.690198235129;3880.1463677990937;3908.530976282836;4105;4117;4138.689598280141;3633.2370202257557;3653.1780349421433;3655.422926836574;3656.4332528457867;3682.392405253157;5161.561267292284;5161.793528258865;5170.146925757245;5193.506616871391;5215.426303106693;4450.621697155746;4609.285560738091;4685.929711054337;4713.34013238147;4768.141734487791;5428.7557059932005;5435.83692489222;5450.383815768453;5457.699826509541;5483.4501956589975;3911.804409779528;3952.209558088365;3973.662238709713;3977.443157957888;3977.622125898035;5428.5928555358505;5585.385607583163;5626.859328516779;5652.717364131818;5726.742296596663;4018.0959284161413;4020.6783457323345;4021.6380525752825;4022.8390864365097;4028.5568587455355;4074.083331250504;4078.3678529827926;4089.9795501022304;4093.669557393859;4123.8556650517085;4575.862724118282;4622.538697858333;4667.253239481666;4681.765911704401;4718.905621887543;5461.317335333083;5463.180522921514;5474.835754927359;5488.121900495901;5502.504774570308;1350.898682598809;1366.2349084512705;1366.5695305978586;1370.5134677189453;1371.136184203945;854.7093988044095;873.2097451806126;908.5184852028435;928.6981730937472;935.756703257158;5139.177731563007;5306.893862122736;5310.814121505806;5312.335958005249;5326.280952071498;5542.196381524737;5577.768892443055;5627.606067575231;5627.943720562824;5659.745311460994;5085.262636917626;5307.734613269398;5334.426344228462;5355.544778693777;5367.865803354947;2952.512835382138;2993.536001919706;2995.5207166853197;2999.805012674169;3009.2627306309655;5869.7945571904775;5877.823665290048;5886.23478947734;5908.822735317862;5919.733611987384;5557.861053473695;5716.428357164334;5730.598858079894;5753.05074662676;5780.21967034445;5855.945929732689;5865.5600829937075;5878.911816322759;5889.116632505073;5927.407259274124;5358.356997160366;5612;5626.887462250814;5703.173039909273;5704.543636508986;5587.44125587438;5610.859728506657;5627.634203776742;5638.915416268677;5640.548756099584;5894.882102357843;5901.350851406256;5913.497352724895;5957.821265362046;5980.790672326448;3886.3587508060855;4027.174429242057;4030.0932290234464;4035.818388172598;4069.4506241656995;5651.491365777099;5668.348139963957;5670.489655930986;5679.488846003879;5687.658740475585;5488.560915126701;5613.635113717595;5625.718714064362;5636.689982051026;5659.377468478547;5489.094299440548;5489.286392768914;5519.847259568691;5527.281453411031;5543.946650136461;5432.9185062223305;5435.510804027656;5440;5459.0347474909795;5505.421930697219;5357.866053348697;5388.407275199804;5530.170474428868;5541.085720856014;5549.805756798492;5415.268938693226;5430.891382172255;5442.510174084351;5467.316585426822;5467.562594992471 20:38:24 INFO - PROCESS | 6729 | |5;yui.html;769.9114601820788;807.8246151849058;815.372163434156;834.9833003339934;850.3027517435702;14441.494547690832;15255.313510892009;15441;15442.150681712501;15459.227038648065;15478.69042619147;15562.221888905538;15577.221138943065;15597.14215718135;15701.607459813511;806.4919100966383;806.8628333183373;807.2694211738386;810.5460941872556;810.8580998325299;670.2158474584724;799.2926260259654;814.9592520373958;830.3357314148687;831.7504748575434;875.60160127142;877.9165979231994;882.2853488674194;882.4352414454754;882.6734108379876;869.4218344800731;871.6121326009928;871.7341210930664;872.5026734761188;872.6596627315353;506.9214271787879;612.3906712820727;616.7440512187437;629.6159342800888;633.4805459523193;15396;15403.152826594533;15410.768838467431;15455.149966751824;15497.380104795795;14233.928830355886;14551;14647.780283295759;14825.629359265997;14993.400263989428;13284.269365184911;13416.329183540784;13508.257045862474;13573.45706171752;13685;4437.977810110961;4491.932621010687;4559.019810740673;4616.676832621718;4659.138059459011;85824;86223.56888215519;87639;87692.12307876967;87787;11235.775284494428;11539.365334906493;11650;11937.582184623496;12116.15186936906;22208.444788880082;22243.666345004836;22276;22277.443063923532;22390.328290151323;8456.661733530713;8552.786180345542;8560;8571.914280857112;8583.914160858312;4470.888227794331;4551.635869130461;4589.977050114728;4634.212183928673;4647.55848194421;3308.156420112856;3377.3920694275266;3380.8478618462227;3388.4747864081105;3394.7963122212745;595.559286128262;599.8080614203413;602.8794241151787;604.9818505444844;617.139090968097;552.5993654600383;659.6404959297195;679.3851564334285;715.3669002932443;728.8250819803316;9392.577334019848;9720.902790971999;9740.415575065519;9741.366811157252;10015.949920250352;661.5501459007921;670.805466414744;701.4493622506308;705.6894966214952;708.1325376413852;4323.373110898902;4681.852484410367;4713.9764301178275;4842.975785121052;4853.174960256765;122522.38738806249;123939;126470.88232941342;127227;130309;104697.47651261695;105047.94952050534;106579;107650;109276;57654.4234557649;85860;93696;96882.51558742161;99021.99999999856;9916.305858589829;10204.693859184237;10441.164706823283;10459.163266938474;10466;53409.732951335;54003.72998135141;54309.45690543044;55421;55596.44403555913;76645.61677191578;78824;84924;85145;87856.560717196;12465.5013799447;12715.618531444072;12802.359882005676;13420.396082176521;14703;14425.567232983027;14865.777013344592;15087.245637717851;15128.848711512745;15339.358672774544;14032;14506.637334066732;14926.776098358316;15261.084334939938;15650.9217453912;14272.571822845332;14713.264336782904;14733;15018.549443516711;15033.624159396102;13730.88502103416;13749.587512374645;13888.930555347159;13910.58268251954;13967.790483142559;11174.888251117385;11308.547658093585;11516.30902145874;11876.584319548774;12024;10146.797064058825;11743.41282935867;12619.30593817349;12734.74530509366;12837.486500539873 20:38:24 INFO - PROCESS | 6729 | __end_tp_report 20:38:24 INFO - PROCESS | 6729 | __start_cc_report 20:38:24 INFO - PROCESS | 6729 | _x_x_mozilla_cycle_collect,1027 20:38:24 INFO - PROCESS | 6729 | __end_cc_report 20:38:24 INFO - PROCESS | 6729 | __startTimestamp1470368304880__endTimestamp 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | ------- Summary: start ------- 20:38:24 INFO - PROCESS | 6729 | Number of tests: 6 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | [#0] dojo.html Cycles:165 Average:5217.46 Median:5412.43 stddev:591.59 (10.9%) stddev-sans-first:567.07 20:38:24 INFO - PROCESS | 6729 | Values: 2992.7 3006.5 3030.0 3033.2 3038.5 5137.0 5163.1 5182.6 5230.9 5261.7 5226.8 5248.4 5284.4 5289.8 5338.8 4725.9 4796.8 4802.9 4815.5 4943.2 4853.1 4887.6 4897.1 4901.0 4923.4 4688.8 4734.4 4769.5 4773.1 4781.1 4775.8 4776.9 4780.4 4782.9 4895.7 4773.0 4774.8 4811.3 4820.6 4846.1 5104.4 5173.2 5216.4 5230.5 5281.2 5550.1 5594.7 5625.3 5638.5 5648.9 5629.6 5637.2 5641.2 5673.6 5697.0 5052.5 5213.7 5265.2 5270.6 5340.9 5821.1 5835.3 5842.2 5848.5 5848.8 5606.9 5613.6 5617.9 5618.4 5620.0 5412.4 5526.1 5555.7 5576.2 5657.3 5593.8 5605.4 5605.6 5606.5 5608.0 5576.7 5607.7 5609.4 5616.8 5617.5 4154.7 4219.1 4220.5 4263.0 4307.1 3798.3 3800.4 3808.2 3833.6 3847.3 5258.0 5262.1 5262.4 5263.3 5310.4 5500.2 5594.5 5623.8 5624.1 5710.8 5332.6 5364.9 5366.5 5366.9 5367.4 4884.6 4896.0 4903.5 4915.5 4941.6 5683.9 5700.9 5714.9 5715.5 5791.8 5531.4 5542.0 5543.1 5546.1 5551.9 5752.5 5752.7 5754.9 5759.6 5760.5 5396.3 5479.7 5491.7 5521.0 5606.8 5610.3 5631.0 5658.1 5660.3 5661.9 5479.7 5509.0 5527.6 5535.5 5536.5 5365.3 5446.8 5474.2 5494.9 5564.8 5443.3 5450.8 5456.9 5460.2 5465.6 5523.8 5545.9 5585.5 5596.0 5597.5 5266.2 5315.2 5332.5 5372.7 5386.2 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | [#1] ext.html Cycles:180 Average:58443.21 Median:23995.43 stddev:107463.54 (447.8%) stddev-sans-first:107677.22 20:38:24 INFO - PROCESS | 6729 | Values: 592.6 622.3 634.5 641.1 652.2 33321.0 33981.7 35889.5 36133.0 44922.3 43308.6 47407.3 47409.5 47476.5 47494.8 8870.4 8980.9 8993.5 9009.0 9019.4 8912.5 9007.4 9016.8 9018.0 9019.1 9048.5 9062.0 9064.8 9097.4 9100.5 8991.2 9043.2 9044.7 9056.5 9057.6 8922.0 8981.6 8987.4 8993.0 9001.9 44189.6 44486.8 44635.6 44688.6 44691.0 3482.7 3527.3 3591.1 3617.7 4069.9 33739.2 34753.8 34773.7 34863.7 34919.5 4316.2 4347.9 4405.5 4408.6 4550.2 358506.0 359219.0 359342.0 359354.0 359959.0 61970.4 62547.0 62587.7 62595.0 62605.0 63593.7 64485.4 64563.0 64582.4 64603.0 15191.5 15427.3 15427.8 15436.8 15438.8 12568.9 12626.0 12630.2 12633.6 12635.5 18263.3 18690.7 18694.2 18925.8 18967.5 5980.3 6127.8 6277.9 6287.7 6471.0 1006.8 1070.4 1078.8 1112.2 1161.7 31594.2 32608.0 32695.3 32765.3 32887.0 1108.5 1112.1 1122.6 1132.9 1148.4 17128.0 17375.1 17386.2 17511.1 17525.3 471050.0 473546.0 473916.0 474522.0 475119.0 61345.0 61556.0 61604.4 61617.4 61645.4 1239.6 1272.4 1342.0 1343.6 1363.9 31275.5 35075.3 35237.6 35450.1 35560.8 52050.7 52586.0 52604.2 52654.5 52683.2 379966.0 380436.0 381615.0 381834.0 383217.0 43154.4 43808.3 45029.5 45204.3 45250.5 49265.3 49943.5 50000.0 50554.7 51130.0 41756.0 42476.8 43464.0 44858.6 45045.0 41926.4 42186.4 42394.8 42980.8 44297.0 42977.6 43643.0 43825.3 43869.3 44011.6 35786.5 37049.1 38140.8 38490.8 38941.8 28751.4 29098.9 29194.9 29322.7 29629.4 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | [#2] jquery.html Cycles:180 Average:29954.16 Median:13465.75 stddev:83384.57 (619.2%) stddev-sans-first:83588.89 20:38:24 INFO - PROCESS | 6729 | Values: 366.1 378.2 379.2 391.8 407.3 17575.1 19355.0 19380.4 19681.4 20265.4 16048.1 16350.8 16360.4 17442.7 20077.1 5578.8 5609.1 5803.3 5812.1 5819.7 5558.6 5667.1 5676.1 5676.2 5677.5 5506.0 5654.2 5654.9 5655.3 5658.6 5670.0 5705.5 5707.7 5738.3 5745.7 5124.8 5137.1 5143.3 5144.2 5443.0 23848.6 24108.3 24212.8 24270.8 24386.9 2306.5 2360.5 2544.6 2809.5 2935.1 10241.5 10290.8 10347.0 10796.3 10937.1 1834.6 1880.7 1924.2 1927.7 1946.3 80440.0 85544.1 85756.0 86326.6 88322.6 11030.4 11065.3 11091.2 11548.9 11860.8 15961.8 15980.4 16005.5 16009.5 16022.2 7888.6 7900.0 8299.3 8346.2 8422.1 7832.9 7909.5 7941.2 8080.8 8148.8 4771.6 4888.1 4918.0 4981.7 5028.7 1808.1 1962.6 1967.6 1968.6 1998.0 867.6 914.9 938.9 948.1 1011.3 19658.5 20289.4 20346.9 20397.5 20550.3 976.9 1008.7 1012.0 1020.7 1033.1 10467.5 10585.3 11175.3 11231.2 11377.3 496427.0 497774.0 499833.0 511988.0 519681.0 91311.5 92297.0 95068.5 95767.0 98145.5 975.5 1019.1 1032.1 1039.5 1044.3 17397.4 17612.6 18039.6 18129.5 18244.1 43960.8 44647.6 45337.0 45353.0 45484.3 61000.0 61125.0 62084.4 63138.7 63478.7 8590.4 8744.2 8989.1 8998.3 9010.4 12660.1 13869.9 13881.9 14116.0 14154.2 11950.9 12074.9 12219.4 12234.3 12546.6 11856.7 12124.3 12141.4 12184.9 12541.2 12017.2 12040.4 12084.0 12187.6 12565.7 8755.2 8834.1 8894.9 8966.6 9029.7 11356.8 11808.5 11900.9 11911.5 12295.4 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | [#3] mootools.html Cycles:180 Average:5814.78 Median:453.72 stddev:3327.93 (733.5%) stddev-sans-first:3319.98 20:38:24 INFO - PROCESS | 6729 | Values: 1300.7 1437.4 1499.8 1577.2 1753.8 8285.3 8758.9 8771.0 8953.9 8953.9 8711.1 8846.2 8846.7 8850.4 8855.4 2397.6 2427.0 2428.0 2428.2 2430.3 2292.9 2363.5 2363.6 2364.2 2378.6 2313.1 2314.7 2324.9 2336.9 2336.9 2281.1 2290.6 2297.1 2297.3 2339.3 2316.4 2320.7 2324.2 2325.9 2344.7 8709.0 8798.1 8903.5 8933.0 8979.6 5028.5 5264.9 5268.5 5276.3 5285.0 3350.5 3429.4 3480.8 3502.8 3540.5 1175.5 1182.7 1182.9 1214.2 1219.5 12133.6 12205.7 12222.1 12227.7 12248.4 4167.7 4367.1 4457.5 4467.9 4469.8 9631.3 9635.2 9635.6 9641.5 9652.6 5019.9 5024.9 5025.3 5037.6 5041.4 4096.4 4190.4 4246.7 4621.6 4705.7 3653.4 3685.6 3809.9 3832.6 3939.2 1066.2 1093.5 1094.9 1110.6 1110.9 869.9 969.9 982.2 986.5 1008.1 5990.2 6043.4 6097.3 6177.0 6369.9 442.0 442.1 450.8 456.7 457.6 4188.0 4197.1 4234.6 4287.0 4288.6 10772.0 10979.9 11111.3 11120.2 11167.4 10411.2 10912.2 10912.9 10925.6 10945.4 8184.6 8411.6 8415.3 8429.2 8437.5 6190.3 6197.5 6224.6 6256.7 6511.9 10150.4 10191.7 10208.3 10241.3 10312.9 9871.8 10272.3 10274.7 10408.2 10561.7 6937.8 7753.4 7896.3 8015.4 8089.2 8617.4 8769.0 8851.0 8866.8 8886.0 7842.7 7849.5 8015.4 8185.9 8205.6 7671.0 7775.7 7786.5 7809.5 7834.9 6976.0 7074.5 7119.0 7166.9 7174.6 5277.7 5431.7 5469.5 5511.0 5574.4 5505.6 5512.9 5606.5 5657.8 5658.9 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | [#4] prototype.html Cycles:180 Average:4646.77 Median:5356.40 stddev:1374.86 (25.7%) stddev-sans-first:1339.69 20:38:24 INFO - PROCESS | 6729 | Values: 313.1 322.1 323.6 333.3 336.7 5297.5 5322.6 5357.2 5362.2 5366.3 5223.5 5224.7 5286.5 5288.9 5308.5 3954.7 4044.5 4109.3 4169.0 4179.6 4130.7 4131.0 4131.7 4141.2 4147.5 4080.9 4106.6 4111.8 4127.5 4130.7 3880.1 3908.5 4105.0 4117.0 4138.7 3633.2 3653.2 3655.4 3656.4 3682.4 5161.6 5161.8 5170.1 5193.5 5215.4 4450.6 4609.3 4685.9 4713.3 4768.1 5428.8 5435.8 5450.4 5457.7 5483.5 3911.8 3952.2 3973.7 3977.4 3977.6 5428.6 5585.4 5626.9 5652.7 5726.7 4018.1 4020.7 4021.6 4022.8 4028.6 4074.1 4078.4 4090.0 4093.7 4123.9 4575.9 4622.5 4667.3 4681.8 4718.9 5461.3 5463.2 5474.8 5488.1 5502.5 1350.9 1366.2 1366.6 1370.5 1371.1 854.7 873.2 908.5 928.7 935.8 5139.2 5306.9 5310.8 5312.3 5326.3 5542.2 5577.8 5627.6 5627.9 5659.7 5085.3 5307.7 5334.4 5355.5 5367.9 2952.5 2993.5 2995.5 2999.8 3009.3 5869.8 5877.8 5886.2 5908.8 5919.7 5557.9 5716.4 5730.6 5753.1 5780.2 5855.9 5865.6 5878.9 5889.1 5927.4 5358.4 5612.0 5626.9 5703.2 5704.5 5587.4 5610.9 5627.6 5638.9 5640.5 5894.9 5901.4 5913.5 5957.8 5980.8 3886.4 4027.2 4030.1 4035.8 4069.5 5651.5 5668.3 5670.5 5679.5 5687.7 5488.6 5613.6 5625.7 5636.7 5659.4 5489.1 5489.3 5519.8 5527.3 5543.9 5432.9 5435.5 5440.0 5459.0 5505.4 5357.9 5388.4 5530.2 5541.1 5549.8 5415.3 5430.9 5442.5 5467.3 5467.6 20:38:24 INFO - PROCESS | 6729 | 20:38:24 INFO - PROCESS | 6729 | [#5] yui.html Cycles:180 Average:22214.20 Median:4380.68 stddev:32607.56 (744.3%) stddev-sans-first:32659.27 20:38:24 INFO - PROCESS | 6729 | Values: 769.9 807.8 815.4 835.0 850.3 14441.5 15255.3 15441.0 15442.2 15459.2 15478.7 15562.2 15577.2 15597.1 15701.6 806.5 806.9 807.3 810.5 810.9 670.2 799.3 815.0 830.3 831.8 875.6 877.9 882.3 882.4 882.7 869.4 871.6 871.7 872.5 872.7 506.9 612.4 616.7 629.6 633.5 15396.0 15403.2 15410.8 15455.1 15497.4 14233.9 14551.0 14647.8 14825.6 14993.4 13284.3 13416.3 13508.3 13573.5 13685.0 4438.0 4491.9 4559.0 4616.7 4659.1 85824.0 86223.6 87639.0 87692.1 87787.0 11235.8 11539.4 11650.0 11937.6 12116.2 22208.4 22243.7 22276.0 22277.4 22390.3 8456.7 8552.8 8560.0 8571.9 8583.9 4470.9 4551.6 4590.0 4634.2 4647.6 3308.2 3377.4 3380.8 3388.5 3394.8 595.6 599.8 602.9 605.0 617.1 552.6 659.6 679.4 715.4 728.8 9392.6 9720.9 9740.4 9741.4 10015.9 661.6 670.8 701.4 705.7 708.1 4323.4 4681.9 4714.0 4843.0 4853.2 122522.4 123939.0 126470.9 127227.0 130309.0 104697.5 105047.9 106579.0 107650.0 109276.0 57654.4 85860.0 93696.0 96882.5 99022.0 9916.3 10204.7 10441.2 10459.2 10466.0 53409.7 54003.7 54309.5 55421.0 55596.4 76645.6 78824.0 84924.0 85145.0 87856.6 12465.5 12715.6 12802.4 13420.4 14703.0 14425.6 14865.8 15087.2 15128.8 15339.4 14032.0 14506.6 14926.8 15261.1 15650.9 14272.6 14713.3 14733.0 15018.5 15033.6 13730.9 13749.6 13888.9 13910.6 13967.8 11174.9 11308.5 11516.3 11876.6 12024.0 10146.8 11743.4 12619.3 12734.7 12837.5 20:38:24 INFO - PROCESS | 6729 | -------- Summary: end -------- 20:38:24 INFO - PROCESS | 6729 | 20:38:25 INFO - TEST-INFO | 6729: exit 0 20:38:25 INFO - TEST-OK | dromaeo_css | took 1116466ms 20:38:25 INFO - TEST-START | kraken 20:38:25 INFO - operating with platform_type : linux_ 20:38:25 INFO - Initialising browser for kraken test... 20:38:25 INFO - TEST-INFO | started process 6915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPI_qF/profile http://localhost:53975/getInfo.html) 20:38:30 INFO - PROCESS | 6915 | __metrics Screen width/height:1600/1200 20:38:30 INFO - PROCESS | 6915 | colorDepth:24 20:38:30 INFO - PROCESS | 6915 | Browser inner width/height: 1024/697 20:38:30 INFO - PROCESS | 6915 | __metrics 20:38:31 INFO - PROCESS | 6915 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:38:31 INFO - PROCESS | 6915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:38:31 INFO - PROCESS | 6915 | console.error: PushService: 20:38:31 INFO - PROCESS | 6915 | stateChangeProcessEnqueue: Error transitioning state 20:38:31 INFO - PROCESS | 6915 | UnknownError 20:38:32 INFO - TEST-INFO | 6915: exit 0 20:38:32 INFO - Browser initialized. 20:38:32 INFO - Running cycle 1/1 for kraken test... 20:38:32 INFO - TEST-INFO | started process 6995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPI_qF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:38:43 INFO - PROCESS | 6995 | RSS: Main: 156782592 20:38:43 INFO - PROCESS | 6995 | 20:38:46 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-beat-detection) 20:38:47 INFO - PROCESS | 6995 | RSS: Main: 212545536 20:38:47 INFO - PROCESS | 6995 | 20:38:49 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-dft) 20:38:50 INFO - PROCESS | 6995 | RSS: Main: 191500288 20:38:50 INFO - PROCESS | 6995 | 20:38:53 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-fft) 20:38:54 INFO - PROCESS | 6995 | RSS: Main: 269942784 20:38:54 INFO - PROCESS | 6995 | 20:38:56 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53975/tests/kraken/driver.html?testName=audio-oscillator) 20:38:57 INFO - PROCESS | 6995 | RSS: Main: 179896320 20:38:57 INFO - PROCESS | 6995 | 20:38:59 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:38:59 INFO - PROCESS | 6995 | RSS: Main: 184754176 20:38:59 INFO - PROCESS | 6995 | 20:39:02 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53975/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:03 INFO - PROCESS | 6995 | RSS: Main: 220418048 20:39:03 INFO - PROCESS | 6995 | 20:39:06 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53975/tests/kraken/driver.html?testName=imaging-desaturate) 20:39:07 INFO - PROCESS | 6995 | RSS: Main: 219860992 20:39:07 INFO - PROCESS | 6995 | 20:39:10 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53975/tests/kraken/driver.html?testName=json-parse-financial) 20:39:10 INFO - PROCESS | 6995 | RSS: Main: 219656192 20:39:10 INFO - PROCESS | 6995 | 20:39:12 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:39:12 INFO - PROCESS | 6995 | RSS: Main: 184094720 20:39:12 INFO - PROCESS | 6995 | 20:39:14 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:39:15 INFO - PROCESS | 6995 | RSS: Main: 188928000 20:39:15 INFO - PROCESS | 6995 | 20:39:17 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:39:17 INFO - PROCESS | 6995 | RSS: Main: 194617344 20:39:17 INFO - PROCESS | 6995 | 20:39:20 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:39:21 INFO - PROCESS | 6995 | RSS: Main: 193748992 20:39:21 INFO - PROCESS | 6995 | 20:39:23 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:39:24 INFO - PROCESS | 6995 | RSS: Main: 196665344 20:39:24 INFO - PROCESS | 6995 | 20:39:25 INFO - PROCESS | 6995 | Cycle 1(1): loaded http://localhost:53975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53975/tests/kraken/driver.html?testName=ai-astar) 20:39:26 INFO - PROCESS | 6995 | RSS: Main: 243462144 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | __start_tp_report 20:39:26 INFO - PROCESS | 6995 | _x_x_mozilla_page_load 20:39:26 INFO - PROCESS | 6995 | _x_x_mozilla_page_load_details 20:39:26 INFO - PROCESS | 6995 | |i|pagename|runs| 20:39:26 INFO - PROCESS | 6995 | |0;ai-astar;101;111;113;110;112;112;109;111;110;111 20:39:26 INFO - PROCESS | 6995 | |1;audio-beat-detection;146;116;119;175;118;120;143;117;160;118 20:39:26 INFO - PROCESS | 6995 | |2;audio-dft;161;161;161;164;161;161;161;160;162;161 20:39:26 INFO - PROCESS | 6995 | |3;audio-fft;73;75;75;124;75;75;75;75;103;75 20:39:26 INFO - PROCESS | 6995 | |4;audio-oscillator;85;83;115;84;84;83;122;84;84;129 20:39:26 INFO - PROCESS | 6995 | |5;imaging-gaussian-blur;116;116;117;117;117;116;116;117;118;118 20:39:26 INFO - PROCESS | 6995 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;147;147 20:39:26 INFO - PROCESS | 6995 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 20:39:26 INFO - PROCESS | 6995 | |8;json-parse-financial;49;50;52;50;49;49;52;49;49;49 20:39:26 INFO - PROCESS | 6995 | |9;json-stringify-tinderbox;59;59;59;59;59;59;60;60;59;60 20:39:26 INFO - PROCESS | 6995 | |10;stanford-crypto-aes;76;76;76;75;75;80;75;75;75;83 20:39:26 INFO - PROCESS | 6995 | |11;stanford-crypto-ccm;121;119;128;127;122;119;147;132;125;138 20:39:26 INFO - PROCESS | 6995 | |12;stanford-crypto-pbkdf2;159;155;155;158;155;162;159;156;161;154 20:39:26 INFO - PROCESS | 6995 | |13;stanford-crypto-sha256-iterative;64;62;65;62;63;62;64;64;62;61 20:39:26 INFO - PROCESS | 6995 | __end_tp_report 20:39:26 INFO - PROCESS | 6995 | __start_cc_report 20:39:26 INFO - PROCESS | 6995 | _x_x_mozilla_cycle_collect,1675 20:39:26 INFO - PROCESS | 6995 | __end_cc_report 20:39:26 INFO - PROCESS | 6995 | __startTimestamp1470368366178__endTimestamp 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | ------- Summary: start ------- 20:39:26 INFO - PROCESS | 6995 | Number of tests: 14 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:1.22 20:39:26 INFO - PROCESS | 6995 | Values: 101.0 111.0 113.0 110.0 112.0 112.0 109.0 111.0 110.0 111.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:131.50 stddev:21.40 (16.3%) stddev-sans-first:22.19 20:39:26 INFO - PROCESS | 6995 | Values: 146.0 116.0 119.0 175.0 118.0 120.0 143.0 117.0 160.0 118.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 20:39:26 INFO - PROCESS | 6995 | Values: 161.0 161.0 161.0 164.0 161.0 161.0 161.0 160.0 162.0 161.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:17.08 (22.8%) stddev-sans-first:17.77 20:39:26 INFO - PROCESS | 6995 | Values: 73.0 75.0 75.0 124.0 75.0 75.0 75.0 75.0 103.0 75.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:18.73 (22.3%) stddev-sans-first:19.49 20:39:26 INFO - PROCESS | 6995 | Values: 85.0 83.0 115.0 84.0 84.0 83.0 122.0 84.0 84.0 129.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 20:39:26 INFO - PROCESS | 6995 | Values: 116.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 118.0 118.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:39:26 INFO - PROCESS | 6995 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:39:26 INFO - PROCESS | 6995 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:49.50 stddev:1.23 (2.5%) stddev-sans-first:1.27 20:39:26 INFO - PROCESS | 6995 | Values: 49.0 50.0 52.0 50.0 49.0 49.0 52.0 49.0 49.0 49.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 20:39:26 INFO - PROCESS | 6995 | Values: 59.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 59.0 60.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.72 (3.6%) stddev-sans-first:2.87 20:39:26 INFO - PROCESS | 6995 | Values: 76.0 76.0 76.0 75.0 75.0 80.0 75.0 75.0 75.0 83.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.50 stddev:9.03 (7.1%) stddev-sans-first:9.23 20:39:26 INFO - PROCESS | 6995 | Values: 121.0 119.0 128.0 127.0 122.0 119.0 147.0 132.0 125.0 138.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.50 stddev:2.80 (1.8%) stddev-sans-first:2.91 20:39:26 INFO - PROCESS | 6995 | Values: 159.0 155.0 155.0 158.0 155.0 162.0 159.0 156.0 161.0 154.0 20:39:26 INFO - PROCESS | 6995 | 20:39:26 INFO - PROCESS | 6995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:1.29 (2.0%) stddev-sans-first:1.30 20:39:26 INFO - PROCESS | 6995 | Values: 64.0 62.0 65.0 62.0 63.0 62.0 64.0 64.0 62.0 61.0 20:39:26 INFO - PROCESS | 6995 | -------- Summary: end -------- 20:39:26 INFO - PROCESS | 6995 | 20:39:27 INFO - TEST-INFO | 6995: exit 0 20:39:27 INFO - TEST-OK | kraken | took 61556ms 20:39:27 INFO - SUITE-END | took 1178s 20:39:27 INFO - Completed test suite (00:19:38) 20:39:27 INFO - javascript benchmark 20:39:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2992.7156920092593, 3006.5339872319796, 3030.0000999670106, 3033.1507177990156, 3038.46826805309, 5136.974315128428, 5163.122269214233, 5182.637215394924, 5230.895382092356, 5261.684298942067, 5226.7909283628605, 5248.370195576536, 5284.365876094874, 5289.761960711768, 5338.813141540047, 4725.8818529536775, 4796.83211087612, 4802.855914322576, 4815.470298267188, 4943.233798761198, 4853.102176097415, 4887.633427492934, 4897.142999975008, 4900.9754951225195, 4923.433805112422, 4688.812447502113, 4734.4081989751285, 4769.499202583731, 4773.11697335994, 4781.115493633689, 4775.761211939389, 4776.904461910777, 4780.402449693788, 4782.880427989293, 4895.706257624518, 4773.021530586221, 4774.832880849153, 4811.302361157647, 4820.638452116105, 4846.103470857903, 5104.438511763703, 5173.224016397533, 5216.400113986902, 5230.529252367267, 5281.181416880389, 5550.139728342114, 5594.664320140804, 5625.268715067056, 5638.4925356718095, 5648.8870222595315, 5629.577781666391, 5637.182608521742, 5641.238432811559, 5673.602847800656, 5697.0, 5052.520010598987, 5213.687178769286, 5265.157574788015, 5270.5520030797425, 5340.946590534045, 5821.09772985188, 5835.270591176103, 5842.2405087338375, 5848.5321174305955, 5848.824535263949, 5606.943930560724, 5613.578981576398, 5617.915731263953, 5618.438156184349, 5620.016497112989, 5412.431694672082, 5526.143447765603, 5555.72221388937, 5576.191452239403, 5657.349404818417, 5593.804216852391, 5605.411431799603, 5605.579581531401, 5606.523445507178, 5607.971960140173, 5576.7211639417865, 5607.691576963224, 5609.382967873531, 5616.775328986795, 5617.522510586564, 4154.667626589866, 4219.135077309205, 4220.53574106848, 4263.0, 4307.095509942885, 3798.2973149967343, 3800.3539398302355, 3808.21931504041, 3833.616638336144, 3847.2882516734494, 5257.974694934451, 5262.131748261494, 5262.368515778131, 5263.34208223972, 5310.415854256029, 5500.22996780451, 5594.524465420403, 5623.803166889139, 5624.128260119688, 5710.828675139753, 5332.573394128461, 5364.8658783529945, 5366.543843773245, 5366.91949620756, 5367.436419176009, 4884.5603895649565, 4895.975520122377, 4903.4606193318705, 4915.508449155127, 4941.579965702884, 5683.886322273532, 5700.8859822803315, 5714.857128571819, 5715.48560629537, 5791.797287094932, 5531.446855314436, 5541.972290138524, 5543.113101903676, 5546.057170280981, 5551.944480555143, 5752.482276595127, 5752.712364381848, 5754.942450575608, 5759.596828222152, 5760.452756988079, 5396.271503347155, 5479.726013699379, 5491.725413729378, 5521.0, 5606.831795046155, 5610.270664813548, 5630.971845140748, 5658.066419040812, 5660.29246344207, 5661.858453538694, 5479.698616576126, 5509.0, 5527.613067085426, 5535.474129957647, 5536.469607005901, 5365.3293338332705, 5446.809361672323, 5474.178873169057, 5494.862628434321, 5564.777408903598, 5443.265159203457, 5450.836474905759, 5456.890862182813, 5460.208269800936, 5465.562754979672, 5523.834284971457, 5545.861353466195, 5585.497305242548, 5595.972020139873, 5597.524210442158, 5266.183741520071, 5315.176147697113, 5332.5467335276935, 5372.650777699437, 5386.245925570345], "value": 5177.197956703041, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5644651181381, 622.334102510314, 634.4702173684973, 641.0928536121388, 652.1717418878028, 33321.0, 33981.66018339816, 35889.461658075146, 36132.99999999996, 44922.32616510755, 43308.56691433085, 47407.28889066667, 47409.52590474094, 47476.52523474764, 47494.762526187405, 8870.37907346486, 8980.8652870207, 8993.505357205351, 9008.954955225248, 9019.368644194908, 8912.465252084896, 9007.369484136114, 9016.819663606724, 9018.0, 9019.052999435064, 9048.502332371718, 9062.0, 9064.818703625924, 9097.408668436563, 9100.499472529009, 8991.235744961654, 9043.231325337354, 9044.683436079706, 9056.547172641374, 9057.637694492212, 8922.0, 8981.595828187747, 8987.37088403812, 8992.955035224848, 9001.864972025425, 44189.558104418866, 44486.77756611229, 44635.55364446346, 44688.55311446909, 44691.0, 3482.721382289411, 3527.294541091792, 3591.1381268495375, 3617.674409303149, 4069.918601627951, 33739.15652108692, 34753.82623086894, 34773.65226347729, 34863.65136348629, 34919.476207856904, 4316.201502721975, 4347.869563913087, 4405.471343438776, 4408.6032257096695, 4550.226461501553, 358506.0, 359219.0, 359342.0, 359354.0, 359959.0, 61970.38029619736, 62547.0, 62587.680047196496, 62595.0, 62605.0, 63593.682031589546, 64485.35514644793, 64563.0, 64582.354176458575, 64603.0, 15191.544253672408, 15427.30577124032, 15427.768583471257, 15436.768448473282, 15438.768418473732, 12568.937155314165, 12626.0, 12630.242185468902, 12633.620991370273, 12635.494580216688, 18263.269469221348, 18690.71963920542, 18694.158762855703, 18925.810741892405, 18967.52581185454, 5980.342162362137, 6127.785527506516, 6277.937220627827, 6287.748490060347, 6471.0, 1006.758377989292, 1070.3952266969138, 1078.7518870659792, 1112.2158877991158, 1161.7211869151342, 31594.210144746565, 32608.0, 32695.346093078482, 32765.344693106006, 32887.0, 1108.539955918301, 1112.1325366214367, 1122.5734220996133, 1132.9263597866113, 1148.4085695866636, 17128.0, 17375.131243437776, 17386.21762020712, 17511.12444377776, 17525.298988040337, 471050.0, 473546.0, 473916.0, 474522.0, 475119.0, 61345.0, 61556.0, 61604.38395616076, 61617.38382616206, 61645.38354616486, 1239.646700690299, 1272.3638180909545, 1341.9597412077653, 1343.6372179511673, 1363.8704323089291, 31275.53086703747, 35075.29849402946, 35237.64762352344, 35450.11374715653, 35560.82219588885, 52050.73974630103, 52586.0, 52604.21093683521, 52654.47345526495, 52683.20975185452, 379966.0, 380436.0, 381615.0, 381834.0, 383217.0, 43154.352684710386, 43808.342874856266, 45029.54970450384, 45204.321935171654, 45250.54749452463, 49265.26102108399, 49943.50056499388, 50000.0, 50554.74722626364, 51130.0, 41756.0, 42476.78761606296, 43464.0, 44858.55141448674, 45045.0, 41926.37110443407, 42186.36720449257, 42394.78802605967, 42980.785096074316, 44297.0, 42977.57022429736, 43643.0, 43825.34261986137, 43869.34195986999, 44011.55988440075, 35786.463203051455, 37049.10080044345, 38140.809295953346, 38490.80754596209, 38941.80529097337, 28751.424971500033, 29098.854505727337, 29194.854025729735, 29322.706772931997, 29629.407411852073], "value": 20575.20895384616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.07565896112294, 378.1831244511855, 379.21880925293885, 391.75906817307356, 407.26895223074575, 17575.1212439378, 19355.0, 19380.418587442364, 19681.409557713272, 20265.39203823884, 16048.117353545551, 16350.83649163508, 16360.427385041527, 17442.651146977085, 20077.09653065612, 5578.776848926058, 5609.1305847593585, 5803.274590676166, 5812.070068788995, 5819.738111784959, 5558.610897237195, 5667.0932650775885, 5676.091825307952, 5676.1769543416385, 5677.460641239097, 5505.9724701376435, 5654.208410822488, 5654.886902261952, 5655.293088363955, 5658.632188907728, 5670.036093864053, 5705.457981491772, 5707.714614269291, 5738.311402631711, 5745.712714364265, 5124.8206312778875, 5137.075326441239, 5143.305653736773, 5144.202648589438, 5442.9727851360885, 23848.64227036596, 24108.276751697478, 24212.757872421404, 24270.757292427028, 24386.87806560956, 2306.5156317173414, 2360.5160942006846, 2544.6183072539084, 2809.4662014217233, 2935.0754512328763, 10241.539130739135, 10290.845637315446, 10347.00252789877, 10796.298240614335, 10937.070349020343, 1834.5688763140652, 1880.7178923161498, 1924.2495426783566, 1927.6530224559574, 1946.3285166617636, 80440.0, 85544.14455855486, 85756.0, 86326.56836715776, 88322.5583872083, 11030.393328366856, 11065.280756750786, 11091.168162387854, 11548.884511154782, 11860.822087668692, 15961.760573591406, 15980.440684576217, 16005.519834404986, 16009.519714408587, 16022.19889005545, 7888.6450109744055, 7900.012498437695, 8299.253067223979, 8346.248837604524, 8422.073571907085, 7832.882506762403, 7909.485883417559, 7941.205879412013, 8080.797980050545, 8148.837023259502, 4771.570558649738, 4888.120138375127, 4917.950820491821, 4981.726005069683, 5028.673136246132, 1808.1320965936425, 1962.607478504305, 1967.5671352302757, 1968.5767559974674, 1998.0, 867.6139118092389, 914.8627705844177, 938.901415351392, 948.0519480519481, 1011.2870426349406, 19658.508537286398, 20289.391318260477, 20346.89826550858, 20397.490062748253, 20550.28074017402, 976.9267304952157, 1008.7326858382535, 1012.0, 1020.7244044108049, 1033.1373303291684, 10467.466050991692, 10585.311954722918, 11175.273607215668, 11231.21381503287, 11377.317360958368, 496427.0, 497774.0, 499833.0, 511988.0, 519681.0, 91311.54344228236, 92297.0, 95068.52465737627, 95767.0, 98145.50927245319, 975.5417046569927, 1019.1133713669155, 1032.143321043547, 1039.5218199628105, 1044.3264094659055, 17397.391091311743, 17612.64774704473, 18039.639207216045, 18129.45611631653, 18244.08779561043, 43960.780196098814, 44647.55352446564, 45337.0, 45353.0, 45484.31773523466, 61000.0, 61125.0, 62084.37915620786, 63138.68430657817, 63478.68260658667, 8590.355723320901, 8744.169303916118, 8989.146031127033, 8998.325125615474, 9010.369274150746, 12660.104157858508, 13869.861301386856, 13881.861181388056, 14116.0, 14154.221517816208, 11950.880491194977, 12074.939625301817, 12219.38903054826, 12234.265944043385, 12546.560870369492, 11856.70358241051, 12124.333161676192, 12141.392930353624, 12184.878151218374, 12541.184822986477, 12017.218880772722, 12040.397980100784, 12084.0, 12187.57343493009, 12565.74868502643, 8755.168259015383, 8834.116588341114, 8894.86657700148, 8966.641334346554, 9029.683961061332, 11356.829647555129, 11808.468618912342, 11900.940495297467, 11911.463984120908, 12295.385230738606], "value": 9379.477947172607, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.7398520295944, 1437.4322142753608, 1499.8425165357637, 1577.2113943028485, 1753.8158493358205, 8285.337173026159, 8758.91241087589, 8770.999999999993, 8953.865692014626, 8953.91046089539, 8711.085336039703, 8846.15961483658, 8846.690365837198, 8850.380473366868, 8855.424397414163, 2397.580423425898, 2427.017058091467, 2427.9757202428013, 2428.162284012013, 2430.3195105370523, 2292.862428254302, 2363.5036642305136, 2363.5981883079917, 2364.160722943356, 2378.5956387414094, 2313.063209400187, 2314.7222333320024, 2324.9186278480256, 2336.8714720690355, 2336.894839732208, 2281.133169395636, 2290.5533420982915, 2297.0696867768665, 2297.3452566018686, 2339.2748248043163, 2316.420894776306, 2320.7447180810095, 2324.1749179041367, 2325.860448373103, 2344.7069116360453, 8709.0, 8798.12018798115, 8903.465792052497, 8933.0, 8979.640814367418, 5028.4971502849785, 5264.947350526484, 5268.525832675077, 5276.287701160332, 5285.0, 3350.547676063749, 3429.382711111999, 3480.7911525308564, 3502.842372093262, 3540.4689296605457, 1175.4534141624185, 1182.6806762174251, 1182.9408529573486, 1214.1986289049185, 1219.5121951219494, 12133.575324863676, 12205.694857628541, 12222.144449888512, 12227.69430764238, 12248.387580620933, 4167.666586673059, 4367.10474352757, 4457.465104187519, 4467.865964021084, 4469.7988590513505, 9631.277654175825, 9635.22918166545, 9635.614575417045, 9641.517924103768, 9652.613895444103, 5019.874503137451, 5024.949750502448, 5025.271335656383, 5037.596992240612, 5041.369828771403, 4096.365063415175, 4190.350495673176, 4246.723962942398, 4621.584057434847, 4705.741184234831, 3653.397189463762, 3685.6130106338983, 3809.8857034289017, 3832.559255685576, 3939.1924655445564, 1066.1790421375497, 1093.4527643384522, 1094.8850370710961, 1110.6057349640762, 1110.8722496912958, 869.8651708984991, 969.9418034917927, 982.2387649571497, 986.5215370545279, 1008.1128606825946, 5990.191324171268, 6043.425874541911, 6097.298810636745, 6177.0, 6369.936300637027, 441.99779001104787, 442.0738552732021, 450.7746126936532, 456.6597884576012, 457.5653129526963, 4188.0, 4197.055662475918, 4234.618884300427, 4286.971126929577, 4288.635465985364, 10772.0, 10979.945100274606, 11111.333320000664, 11120.165987550967, 11167.38579378142, 10411.167106631452, 10912.236143469881, 10912.890871091187, 10925.562977480811, 10945.398003109905, 8184.6316915738935, 8411.579421028924, 8415.326773858076, 8429.199226073513, 8437.493750374997, 6190.288116866438, 6197.473214776614, 6224.564280500503, 6256.718447669957, 6511.902321465087, 10150.390976541432, 10191.694249172537, 10208.285420020527, 10241.283110182514, 10312.948435257777, 9871.802563948824, 10272.280940334404, 10274.691759247235, 10408.219383546113, 10561.73595660084, 6937.791866244021, 7753.418493613114, 7896.289333959971, 8015.358771298165, 8089.191080891864, 8617.353698472514, 8768.95615521944, 8851.0, 8866.778330541789, 8886.0, 7842.686292548234, 7849.4897831640765, 8015.358771298165, 8185.8772118419465, 8205.589720513832, 7670.961645191738, 7775.727849525239, 7786.454948153575, 7809.531428114331, 7834.921650783419, 6976.0, 7074.469414794014, 7119.0, 7166.8924966124505, 7174.569525828467, 5277.656952298088, 5431.674099553881, 5469.480399362054, 5510.972445137749, 5574.442555744393, 5505.559555235492, 5512.944870551403, 5606.495415412633, 5657.773689052392, 5658.915116273177], "value": 4555.91543101832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.1279386907463, 322.0644029095477, 323.57449953311396, 333.311711316132, 336.72052196676776, 5297.496737809912, 5322.600804939626, 5357.249985002098, 5362.249285100089, 5366.302380690515, 5223.477652234775, 5224.660397074197, 5286.471352864712, 5288.920666190001, 5308.522232999029, 3954.663853572443, 4044.4944381952255, 4109.28087584673, 4168.97915510422, 4179.644730197937, 4130.690198235145, 4130.958690413103, 4131.739819355095, 4141.151064031881, 4147.4815648044, 4080.9387859182134, 4106.568810274923, 4111.753294802306, 4127.525334586516, 4130.690198235129, 3880.1463677990937, 3908.530976282836, 4105.0, 4117.0, 4138.689598280141, 3633.2370202257557, 3653.1780349421433, 3655.422926836574, 3656.4332528457867, 3682.392405253157, 5161.561267292284, 5161.793528258865, 5170.146925757245, 5193.506616871391, 5215.426303106693, 4450.621697155746, 4609.285560738091, 4685.929711054337, 4713.34013238147, 4768.141734487791, 5428.7557059932005, 5435.83692489222, 5450.383815768453, 5457.699826509541, 5483.4501956589975, 3911.804409779528, 3952.209558088365, 3973.662238709713, 3977.443157957888, 3977.622125898035, 5428.5928555358505, 5585.385607583163, 5626.859328516779, 5652.717364131818, 5726.742296596663, 4018.0959284161413, 4020.6783457323345, 4021.6380525752825, 4022.8390864365097, 4028.5568587455355, 4074.083331250504, 4078.3678529827926, 4089.9795501022304, 4093.669557393859, 4123.8556650517085, 4575.862724118282, 4622.538697858333, 4667.253239481666, 4681.765911704401, 4718.905621887543, 5461.317335333083, 5463.180522921514, 5474.835754927359, 5488.121900495901, 5502.504774570308, 1350.898682598809, 1366.2349084512705, 1366.5695305978586, 1370.5134677189453, 1371.136184203945, 854.7093988044095, 873.2097451806126, 908.5184852028435, 928.6981730937472, 935.756703257158, 5139.177731563007, 5306.893862122736, 5310.814121505806, 5312.335958005249, 5326.280952071498, 5542.196381524737, 5577.768892443055, 5627.606067575231, 5627.943720562824, 5659.745311460994, 5085.262636917626, 5307.734613269398, 5334.426344228462, 5355.544778693777, 5367.865803354947, 2952.512835382138, 2993.536001919706, 2995.5207166853197, 2999.805012674169, 3009.2627306309655, 5869.7945571904775, 5877.823665290048, 5886.23478947734, 5908.822735317862, 5919.733611987384, 5557.861053473695, 5716.428357164334, 5730.598858079894, 5753.05074662676, 5780.21967034445, 5855.945929732689, 5865.5600829937075, 5878.911816322759, 5889.116632505073, 5927.407259274124, 5358.356997160366, 5612.0, 5626.887462250814, 5703.173039909273, 5704.543636508986, 5587.44125587438, 5610.859728506657, 5627.634203776742, 5638.915416268677, 5640.548756099584, 5894.882102357843, 5901.350851406256, 5913.497352724895, 5957.821265362046, 5980.790672326448, 3886.3587508060855, 4027.174429242057, 4030.0932290234464, 4035.818388172598, 4069.4506241656995, 5651.491365777099, 5668.348139963957, 5670.489655930986, 5679.488846003879, 5687.658740475585, 5488.560915126701, 5613.635113717595, 5625.718714064362, 5636.689982051026, 5659.377468478547, 5489.094299440548, 5489.286392768914, 5519.847259568691, 5527.281453411031, 5543.946650136461, 5432.9185062223305, 5435.510804027656, 5440.0, 5459.0347474909795, 5505.421930697219, 5357.866053348697, 5388.407275199804, 5530.170474428868, 5541.085720856014, 5549.805756798492, 5415.268938693226, 5430.891382172255, 5442.510174084351, 5467.316585426822, 5467.562594992471], "value": 4202.4851213130105, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.9114601820788, 807.8246151849058, 815.372163434156, 834.9833003339934, 850.3027517435702, 14441.494547690832, 15255.313510892009, 15441.0, 15442.150681712501, 15459.227038648065, 15478.69042619147, 15562.221888905538, 15577.221138943065, 15597.14215718135, 15701.607459813511, 806.4919100966383, 806.8628333183373, 807.2694211738386, 810.5460941872556, 810.8580998325299, 670.2158474584724, 799.2926260259654, 814.9592520373958, 830.3357314148687, 831.7504748575434, 875.60160127142, 877.9165979231994, 882.2853488674194, 882.4352414454754, 882.6734108379876, 869.4218344800731, 871.6121326009928, 871.7341210930664, 872.5026734761188, 872.6596627315353, 506.9214271787879, 612.3906712820727, 616.7440512187437, 629.6159342800888, 633.4805459523193, 15396.0, 15403.152826594533, 15410.768838467431, 15455.149966751824, 15497.380104795795, 14233.928830355886, 14551.0, 14647.780283295759, 14825.629359265997, 14993.400263989428, 13284.269365184911, 13416.329183540784, 13508.257045862474, 13573.45706171752, 13685.0, 4437.977810110961, 4491.932621010687, 4559.019810740673, 4616.676832621718, 4659.138059459011, 85824.0, 86223.56888215519, 87639.0, 87692.12307876967, 87787.0, 11235.775284494428, 11539.365334906493, 11650.0, 11937.582184623496, 12116.15186936906, 22208.444788880082, 22243.666345004836, 22276.0, 22277.443063923532, 22390.328290151323, 8456.661733530713, 8552.786180345542, 8560.0, 8571.914280857112, 8583.914160858312, 4470.888227794331, 4551.635869130461, 4589.977050114728, 4634.212183928673, 4647.55848194421, 3308.156420112856, 3377.3920694275266, 3380.8478618462227, 3388.4747864081105, 3394.7963122212745, 595.559286128262, 599.8080614203413, 602.8794241151787, 604.9818505444844, 617.139090968097, 552.5993654600383, 659.6404959297195, 679.3851564334285, 715.3669002932443, 728.8250819803316, 9392.577334019848, 9720.902790971999, 9740.415575065519, 9741.366811157252, 10015.949920250352, 661.5501459007921, 670.805466414744, 701.4493622506308, 705.6894966214952, 708.1325376413852, 4323.373110898902, 4681.852484410367, 4713.9764301178275, 4842.975785121052, 4853.174960256765, 122522.38738806249, 123939.0, 126470.88232941342, 127227.0, 130309.0, 104697.47651261695, 105047.94952050534, 106579.0, 107650.0, 109276.0, 57654.4234557649, 85860.0, 93696.0, 96882.51558742161, 99021.99999999856, 9916.305858589829, 10204.693859184237, 10441.164706823283, 10459.163266938474, 10466.0, 53409.732951335, 54003.72998135141, 54309.45690543044, 55421.0, 55596.44403555913, 76645.61677191578, 78824.0, 84924.0, 85145.0, 87856.560717196, 12465.5013799447, 12715.618531444072, 12802.359882005676, 13420.396082176521, 14703.0, 14425.567232983027, 14865.777013344592, 15087.245637717851, 15128.848711512745, 15339.358672774544, 14032.0, 14506.637334066732, 14926.776098358316, 15261.084334939938, 15650.9217453912, 14272.571822845332, 14713.264336782904, 14733.0, 15018.549443516711, 15033.624159396102, 13730.88502103416, 13749.587512374645, 13888.930555347159, 13910.58268251954, 13967.790483142559, 11174.888251117385, 11308.547658093585, 11516.30902145874, 11876.584319548774, 12024.0, 10146.797064058825, 11743.41282935867, 12619.30593817349, 12734.74530509366, 12837.486500539873], "value": 7809.746597204726, "unit": "score"}], "name": "dromaeo_css", "value": 7284.460392837543, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 113.0, 110.0, 112.0, 112.0, 109.0, 111.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 119.0, 175.0, 118.0, 120.0, 143.0, 117.0, 160.0, 118.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 164.0, 161.0, 161.0, 161.0, 160.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 124.0, 75.0, 75.0, 75.0, 75.0, 103.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 115.0, 84.0, 84.0, 83.0, 122.0, 84.0, 84.0, 129.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 52.0, 50.0, 49.0, 49.0, 52.0, 49.0, 49.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 75.0, 75.0, 80.0, 75.0, 75.0, 75.0, 83.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 128.0, 127.0, 122.0, 119.0, 147.0, 132.0, 125.0, 138.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 155.0, 158.0, 155.0, 162.0, 159.0, 156.0, 161.0, 154.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 62.0, 63.0, 62.0, 64.0, 64.0, 62.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1474.3999999999999, "alertThreshold": 2.0}]} 20:39:27 INFO - Return code: 0 20:39:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:39:27 INFO - # TBPL SUCCESS # 20:39:27 INFO - Running post-action listener: _resource_record_post_action 20:39:27 INFO - [mozharness: 2016-08-05 03:39:27.477516Z] Finished run-tests step (success) 20:39:27 INFO - Running post-run listener: _resource_record_post_run 20:39:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 196608; Write bytes: 302342144; Read time: 44; Write time: 452056 20:39:27 INFO - TinderboxPrint: CPU usage
13.0% 20:39:27 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 44 20:39:27 INFO - TinderboxPrint: I/O write bytes / time
302,342,144 / 452,056 20:39:27 INFO - TinderboxPrint: CPU idle
8,301.6 (87.0%) 20:39:27 INFO - TinderboxPrint: CPU user
1,187.3 (12.4%) 20:39:27 INFO - TinderboxPrint: Swap in / out
0 / 0 20:39:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14077952; Read time: 0; Write time: 2484 20:39:27 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 192512; Write bytes: 284762112; Read time: 36; Write time: 448972 20:39:28 INFO - Running post-run listener: _upload_blobber_files 20:39:28 INFO - Blob upload gear active. 20:39:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:39:28 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 20:39:28 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:39:28 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:39:28 INFO - (blobuploader) - INFO - Open directory for files ... 20:39:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:39:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:39:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:32 INFO - (blobuploader) - INFO - Done attempting. 20:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:39:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:32 INFO - (blobuploader) - INFO - Done attempting. 20:39:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:39:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:39:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:39:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:39:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:39:33 INFO - (blobuploader) - INFO - Done attempting. 20:39:33 INFO - (blobuploader) - INFO - Iteration through files over. 20:39:33 INFO - Return code: 0 20:39:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:39:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:39:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cad2d3c35222b56461a20a4684fcd55098e3f3db7d09b4e0896f2932e1d400806953f2a1d9ff1ddf2bca71a0f52208327147f402ea9b89a74f5ea2c2dce73bb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e8fd072fa980ec887dd7d9fd94ecb5261e809307951702e0921d9b51273ca61309226a2c04d2227c80f7c928b0642a717a9ece2ff70424c56b9f5fb07333beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3286c76673d423022ed7b5ea8d21dd7e84469faf922c8d3d2b0b97945b9d4f6e95f6c6e9a52781144eaf6c82edd1d3f720c2189011bbbb165c613731efb9dd21"} 20:39:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:39:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:39:33 INFO - Contents: 20:39:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cad2d3c35222b56461a20a4684fcd55098e3f3db7d09b4e0896f2932e1d400806953f2a1d9ff1ddf2bca71a0f52208327147f402ea9b89a74f5ea2c2dce73bb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e8fd072fa980ec887dd7d9fd94ecb5261e809307951702e0921d9b51273ca61309226a2c04d2227c80f7c928b0642a717a9ece2ff70424c56b9f5fb07333beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3286c76673d423022ed7b5ea8d21dd7e84469faf922c8d3d2b0b97945b9d4f6e95f6c6e9a52781144eaf6c82edd1d3f720c2189011bbbb165c613731efb9dd21"} 20:39:33 INFO - Running post-run listener: copy_logs_to_upload_dir 20:39:33 INFO - Copying logs to upload dir... 20:39:33 INFO - mkdir: /builds/slave/test/build/upload/logs 20:39:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.825535 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-04 20:39:33.768778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 20:39:33.773806) ========= 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=745a4373a2a16df560f216e000000264-1470365941.719288-957611573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cad2d3c35222b56461a20a4684fcd55098e3f3db7d09b4e0896f2932e1d400806953f2a1d9ff1ddf2bca71a0f52208327147f402ea9b89a74f5ea2c2dce73bb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e8fd072fa980ec887dd7d9fd94ecb5261e809307951702e0921d9b51273ca61309226a2c04d2227c80f7c928b0642a717a9ece2ff70424c56b9f5fb07333beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3286c76673d423022ed7b5ea8d21dd7e84469faf922c8d3d2b0b97945b9d4f6e95f6c6e9a52781144eaf6c82edd1d3f720c2189011bbbb165c613731efb9dd21"} build_url:https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/TDOhmD_LRpyVUNxZO9pyiA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cad2d3c35222b56461a20a4684fcd55098e3f3db7d09b4e0896f2932e1d400806953f2a1d9ff1ddf2bca71a0f52208327147f402ea9b89a74f5ea2c2dce73bb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e8fd072fa980ec887dd7d9fd94ecb5261e809307951702e0921d9b51273ca61309226a2c04d2227c80f7c928b0642a717a9ece2ff70424c56b9f5fb07333beb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3286c76673d423022ed7b5ea8d21dd7e84469faf922c8d3d2b0b97945b9d4f6e95f6c6e9a52781144eaf6c82edd1d3f720c2189011bbbb165c613731efb9dd21"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 20:39:33.801372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 20:39:33.801756) ========= 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=745a4373a2a16df560f216e000000264-1470365941.719288-957611573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 20:39:33.851451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 20:39:33.851794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 20:39:33.852112) ========= ========= Total master_lag: 0.37 =========