builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1470747290.91 results: success (0) buildid: 20160809030200 builduid: 9c2134f6b9ba42ee8b6f2100208b21cd revision: 720b5d2c84d5b253d4dfde4897e13384dc97a46a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:50.909430) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:50.909799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:50.910170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:50.948653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:50.948889) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 05:54:51-- 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% 65.7M=0s 2016-08-09 05:54:51 (65.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145983 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.111118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.111427) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014583 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.161456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.161758) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720b5d2c84d5b253d4dfde4897e13384dc97a46a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 720b5d2c84d5b253d4dfde4897e13384dc97a46a --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=5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 05:54:51,259 truncating revision to first 12 chars 2016-08-09 05:54:51,259 Setting DEBUG logging. 2016-08-09 05:54:51,259 attempt 1/10 2016-08-09 05:54:51,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720b5d2c84d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 05:54:51,573 unpacking tar archive at: mozilla-central-720b5d2c84d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.718765 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.895941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.896231) ========= script_repo_revision: 720b5d2c84d5b253d4dfde4897e13384dc97a46a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.896604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.896865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:54:51.913059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-09 05:54:51.913355) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:52 INFO - MultiFileLogger online at 20160809 05:54:52 in /builds/slave/test 05:54:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:52 INFO - {'append_to_log': False, 05:54:52 INFO - 'base_work_dir': '/builds/slave/test', 05:54:52 INFO - 'blob_upload_branch': 'Firefox', 05:54:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:52 INFO - 'branch': 'Firefox', 05:54:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:52 INFO - 'config_files': ('talos/linux_config.py',), 05:54:52 INFO - 'default_actions': ('clobber', 05:54:52 INFO - 'read-buildbot-config', 05:54:52 INFO - 'download-and-extract', 05:54:52 INFO - 'populate-webroot', 05:54:52 INFO - 'create-virtualenv', 05:54:52 INFO - 'install', 05:54:52 INFO - 'run-tests'), 05:54:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:52 INFO - 'download_minidump_stackwalk': True, 05:54:52 INFO - 'download_symbols': 'ondemand', 05:54:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:52 INFO - 'installer_path': 'installer.exe', 05:54:52 INFO - 'log_level': 'info', 05:54:52 INFO - 'log_name': 'talos', 05:54:52 INFO - 'log_to_console': True, 05:54:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:52 INFO - 'opt_config_files': (), 05:54:52 INFO - 'pip_index': False, 05:54:52 INFO - 'sps_profile': False, 05:54:52 INFO - 'sps_profile_interval': 0, 05:54:52 INFO - 'suite': 'dromaeojs', 05:54:52 INFO - 'system_bits': '32', 05:54:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:52 INFO - 'title': 'talos-linux64-ix-011', 05:54:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:52 INFO - 'use_talos_json': True, 05:54:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:52 INFO - 'work_dir': 'build'} 05:54:52 INFO - [mozharness: 2016-08-09 12:54:52.104048Z] Running clobber step. 05:54:52 INFO - Running pre-action listener: _resource_record_pre_action 05:54:52 INFO - Running main action method: clobber 05:54:52 INFO - rmtree: /builds/slave/test/build 05:54:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:53 INFO - Running post-action listener: _resource_record_post_action 05:54:53 INFO - [mozharness: 2016-08-09 12:54:53.063670Z] Finished clobber step (success) 05:54:53 INFO - [mozharness: 2016-08-09 12:54:53.063769Z] Running read-buildbot-config step. 05:54:53 INFO - Running pre-action listener: _resource_record_pre_action 05:54:53 INFO - Running main action method: read_buildbot_config 05:54:53 INFO - Using buildbot properties: 05:54:53 INFO - { 05:54:53 INFO - "project": "", 05:54:53 INFO - "product": "firefox", 05:54:53 INFO - "script_repo_revision": "production", 05:54:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:54:53 INFO - "repository": "", 05:54:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:54:53 INFO - "buildid": "20160809030200", 05:54:53 INFO - "stage_platform": "linux64-pgo", 05:54:53 INFO - "basedir": "/builds/slave/test", 05:54:53 INFO - "nightly_build": "True", 05:54:53 INFO - "buildnumber": 520, 05:54:53 INFO - "slavename": "talos-linux64-ix-011", 05:54:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:54:53 INFO - "platform": "ubuntu64_hw", 05:54:53 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:53 INFO - "branch": "mozilla-central", 05:54:53 INFO - "repo_path": "mozilla-central", 05:54:53 INFO - "revision": "720b5d2c84d5b253d4dfde4897e13384dc97a46a", 05:54:53 INFO - "pgo_build": "True", 05:54:53 INFO - "builduid": "9c2134f6b9ba42ee8b6f2100208b21cd", 05:54:53 INFO - "slavebuilddir": "test" 05:54:53 INFO - } 05:54:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:54:53 INFO - Running post-action listener: _resource_record_post_action 05:54:53 INFO - [mozharness: 2016-08-09 12:54:53.066266Z] Finished read-buildbot-config step (success) 05:54:53 INFO - [mozharness: 2016-08-09 12:54:53.066354Z] Running download-and-extract step. 05:54:53 INFO - Running pre-action listener: _resource_record_pre_action 05:54:53 INFO - Running main action method: download_and_extract 05:54:53 INFO - mkdir: /builds/slave/test/build/tests 05:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:53 INFO - trying https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:53 INFO - Downloaded 1361 bytes. 05:54:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:54:53 INFO - Using the following test package requirements: 05:54:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'jsshell-linux-x86_64.zip'], 05:54:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:53 INFO - trying https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:54:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:54 INFO - Downloaded 21829221 bytes. 05:54:54 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'] 05:54:54 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 05:54:55 INFO - Return code: 0 05:54:55 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 05:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:55 INFO - trying https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:54:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:56 INFO - Downloaded 21829221 bytes. 05:54:56 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'] 05:54:56 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 05:54:57 INFO - Return code: 0 05:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:54:57 INFO - trying https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:57 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:58 INFO - Downloaded 14413723 bytes. 05:54:58 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'] 05:54:58 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 05:54:59 INFO - Return code: 0 05:54: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')]} 05:54:59 INFO - trying https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:54:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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 05:55:01 INFO - Downloaded 59978942 bytes. 05:55:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:01 INFO - mkdir: /builds/slave/test/properties 05:55:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:55:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:55:01 INFO - Contents: 05:55:01 INFO - build_url:https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:55:01 INFO - Running post-action listener: _resource_record_post_action 05:55:01 INFO - Running post-action listener: set_extra_try_arguments 05:55:01 INFO - [mozharness: 2016-08-09 12:55:01.751463Z] Finished download-and-extract step (success) 05:55:01 INFO - [mozharness: 2016-08-09 12:55:01.751784Z] Running populate-webroot step. 05:55:01 INFO - Running pre-action listener: _resource_record_pre_action 05:55:01 INFO - Running main action method: populate_webroot 05:55:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:55:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:55:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:55:01 INFO - '--tppagecycles', 05:55:01 INFO - '7'], 05:55:01 INFO - 'tests': ['tsvgm']}}, 05:55:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:55:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:55:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:55:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:55:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:55:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['damp', 'tps']}, 05:55:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'tests': ['damp', 'tps']}, 05:55:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['dromaeo_dom']}, 05:55:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:55:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['basic_compositor_video']}, 05:55:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:55:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['a11yr', 05:55:01 INFO - 'ts_paint', 05:55:01 INFO - 'tpaint', 05:55:01 INFO - 'sessionrestore', 05:55:01 INFO - 'sessionrestore_no_auto_restore', 05:55:01 INFO - 'tabpaint']}, 05:55:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:55:01 INFO - 'ts_paint', 05:55:01 INFO - 'tpaint', 05:55:01 INFO - 'sessionrestore', 05:55:01 INFO - 'sessionrestore_no_auto_restore', 05:55:01 INFO - 'tabpaint']}, 05:55:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:55:01 INFO - 'ts_paint', 05:55:01 INFO - 'tpaint', 05:55:01 INFO - 'sessionrestore', 05:55:01 INFO - 'sessionrestore_no_auto_restore', 05:55:01 INFO - 'tabpaint']}, 05:55:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:55:01 INFO - 'ts_paint', 05:55:01 INFO - 'tpaint', 05:55:01 INFO - 'sessionrestore', 05:55:01 INFO - 'sessionrestore_no_auto_restore', 05:55:01 INFO - 'tabpaint']}, 05:55:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['a11yr', 05:55:01 INFO - 'ts_paint', 05:55:01 INFO - 'tpaint', 05:55:01 INFO - 'sessionrestore', 05:55:01 INFO - 'sessionrestore_no_auto_restore', 05:55:01 INFO - 'tabpaint']}, 05:55:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['a11yr', 05:55:01 INFO - 'ts_paint', 05:55:01 INFO - 'tpaint', 05:55:01 INFO - 'sessionrestore', 05:55:01 INFO - 'sessionrestore_no_auto_restore', 05:55:01 INFO - 'tabpaint']}, 05:55:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['tsvgx', 05:55:01 INFO - 'tsvgr_opacity', 05:55:01 INFO - 'tart', 05:55:01 INFO - 'tscrollx', 05:55:01 INFO - 'cart']}, 05:55:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:55:01 INFO - 'tsvgr_opacity', 05:55:01 INFO - 'tart', 05:55:01 INFO - 'tscrollx', 05:55:01 INFO - 'cart']}, 05:55:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'talos_options': ['--disable-e10s'], 05:55:01 INFO - 'tests': ['tp5o']}, 05:55:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'tests': ['tp5o']}, 05:55:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'talos_options': ['--disable-e10s', 05:55:01 INFO - '--xperf_path', 05:55:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:01 INFO - 'tests': ['tp5n']}, 05:55:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:55:01 INFO - 'talos_options': ['--xperf_path', 05:55:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:55:01 INFO - 'tests': ['tp5n']}}, 05:55:01 INFO - 'talos.zip': {'path': '', 05:55:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:55:01 INFO - Running post-action listener: _resource_record_post_action 05:55:01 INFO - [mozharness: 2016-08-09 12:55:01.772130Z] Finished populate-webroot step (success) 05:55:01 INFO - [mozharness: 2016-08-09 12:55:01.772218Z] Running create-virtualenv step. 05:55:01 INFO - Running pre-action listener: _resource_record_pre_action 05:55:01 INFO - Running main action method: create_virtualenv 05:55:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:55:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:55:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:55:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:55:01 INFO - Using real prefix '/usr' 05:55:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:55:02 INFO - Installing distribute.............................................................................................................................................................................................done. 05:55:04 INFO - Installing pip.................done. 05:55:04 INFO - Return code: 0 05:55:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:55:04 INFO - Using env: {'DISPLAY': ':0', 05:55:04 INFO - 'HOME': '/home/cltbld', 05:55:04 INFO - 'LANG': 'en_US.UTF-8', 05:55:04 INFO - 'LANGUAGE': 'en_US:en', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MAIL': '/var/mail/cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SHLVL': '1', 05:55:04 INFO - 'TERM': 'linux', 05:55:04 INFO - 'TMOUT': '86400', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - '_': '/tools/buildbot/bin/python'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:55:04 INFO - Cleaning up... 05:55:04 INFO - Return code: 0 05:55:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:55:04 INFO - Using env: {'DISPLAY': ':0', 05:55:04 INFO - 'HOME': '/home/cltbld', 05:55:04 INFO - 'LANG': 'en_US.UTF-8', 05:55:04 INFO - 'LANGUAGE': 'en_US:en', 05:55:04 INFO - 'LOGNAME': 'cltbld', 05:55:04 INFO - 'MAIL': '/var/mail/cltbld', 05:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:04 INFO - 'MOZ_NO_REMOTE': '1', 05:55:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:04 INFO - 'NO_EM_RESTART': '1', 05:55:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:04 INFO - 'PWD': '/builds/slave/test', 05:55:04 INFO - 'SHELL': '/bin/bash', 05:55:04 INFO - 'SHLVL': '1', 05:55:04 INFO - 'TERM': 'linux', 05:55:04 INFO - 'TMOUT': '86400', 05:55:04 INFO - 'USER': 'cltbld', 05:55:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:04 INFO - '_': '/tools/buildbot/bin/python'} 05:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:04 INFO - Downloading/unpacking psutil>=3.1.1 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:55:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:06 INFO - Installing collected packages: psutil 05:55:06 INFO - Running setup.py install for psutil 05:55:06 INFO - building 'psutil._psutil_linux' extension 05:55:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:55:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:55:07 INFO - building 'psutil._psutil_posix' extension 05:55:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:55:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:55:07 INFO - Successfully installed psutil 05:55:07 INFO - Cleaning up... 05:55:07 INFO - Return code: 0 05:55:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:55:07 INFO - Using env: {'DISPLAY': ':0', 05:55:07 INFO - 'HOME': '/home/cltbld', 05:55:07 INFO - 'LANG': 'en_US.UTF-8', 05:55:07 INFO - 'LANGUAGE': 'en_US:en', 05:55:07 INFO - 'LOGNAME': 'cltbld', 05:55:07 INFO - 'MAIL': '/var/mail/cltbld', 05:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:07 INFO - 'MOZ_NO_REMOTE': '1', 05:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:07 INFO - 'NO_EM_RESTART': '1', 05:55:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:07 INFO - 'PWD': '/builds/slave/test', 05:55:07 INFO - 'SHELL': '/bin/bash', 05:55:07 INFO - 'SHLVL': '1', 05:55:07 INFO - 'TERM': 'linux', 05:55:07 INFO - 'TMOUT': '86400', 05:55:07 INFO - 'USER': 'cltbld', 05:55:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:07 INFO - '_': '/tools/buildbot/bin/python'} 05:55:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:55:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:55:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:55:09 INFO - Installing collected packages: mozsystemmonitor 05:55:09 INFO - Running setup.py install for mozsystemmonitor 05:55:09 INFO - Successfully installed mozsystemmonitor 05:55:09 INFO - Cleaning up... 05:55:09 INFO - Return code: 0 05:55:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:55:09 INFO - Using env: {'DISPLAY': ':0', 05:55:09 INFO - 'HOME': '/home/cltbld', 05:55:09 INFO - 'LANG': 'en_US.UTF-8', 05:55:09 INFO - 'LANGUAGE': 'en_US:en', 05:55:09 INFO - 'LOGNAME': 'cltbld', 05:55:09 INFO - 'MAIL': '/var/mail/cltbld', 05:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:09 INFO - 'MOZ_NO_REMOTE': '1', 05:55:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:09 INFO - 'NO_EM_RESTART': '1', 05:55:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:09 INFO - 'PWD': '/builds/slave/test', 05:55:09 INFO - 'SHELL': '/bin/bash', 05:55:09 INFO - 'SHLVL': '1', 05:55:09 INFO - 'TERM': 'linux', 05:55:09 INFO - 'TMOUT': '86400', 05:55:09 INFO - 'USER': 'cltbld', 05:55:09 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:09 INFO - '_': '/tools/buildbot/bin/python'} 05:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:55:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:55:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:55:12 INFO - warning: no files found matching '*.txt' 05:55:12 INFO - no previously-included directories found matching 'build' 05:55:12 INFO - no previously-included directories found matching 'dist' 05:55:12 INFO - no previously-included directories found matching '.git*' 05:55:12 INFO - Installing collected packages: jsonschema, functools32 05:55:12 INFO - Running setup.py install for functools32 05:55:12 INFO - warning: no files found matching '*.txt' 05:55:12 INFO - no previously-included directories found matching 'build' 05:55:12 INFO - no previously-included directories found matching 'dist' 05:55:12 INFO - no previously-included directories found matching '.git*' 05:55:12 INFO - Successfully installed jsonschema functools32 05:55:12 INFO - Cleaning up... 05:55:12 INFO - Return code: 0 05:55:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:55:12 INFO - Using env: {'DISPLAY': ':0', 05:55:12 INFO - 'HOME': '/home/cltbld', 05:55:12 INFO - 'LANG': 'en_US.UTF-8', 05:55:12 INFO - 'LANGUAGE': 'en_US:en', 05:55:12 INFO - 'LOGNAME': 'cltbld', 05:55:12 INFO - 'MAIL': '/var/mail/cltbld', 05:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:12 INFO - 'MOZ_NO_REMOTE': '1', 05:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:12 INFO - 'NO_EM_RESTART': '1', 05:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:12 INFO - 'PWD': '/builds/slave/test', 05:55:12 INFO - 'SHELL': '/bin/bash', 05:55:12 INFO - 'SHLVL': '1', 05:55:12 INFO - 'TERM': 'linux', 05:55:12 INFO - 'TMOUT': '86400', 05:55:12 INFO - 'USER': 'cltbld', 05:55:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:12 INFO - '_': '/tools/buildbot/bin/python'} 05:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:55:12 INFO - Cleaning up... 05:55:12 INFO - Return code: 0 05:55:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:55:12 INFO - Using env: {'DISPLAY': ':0', 05:55:12 INFO - 'HOME': '/home/cltbld', 05:55:12 INFO - 'LANG': 'en_US.UTF-8', 05:55:12 INFO - 'LANGUAGE': 'en_US:en', 05:55:12 INFO - 'LOGNAME': 'cltbld', 05:55:12 INFO - 'MAIL': '/var/mail/cltbld', 05:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:12 INFO - 'MOZ_NO_REMOTE': '1', 05:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:12 INFO - 'NO_EM_RESTART': '1', 05:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:12 INFO - 'PWD': '/builds/slave/test', 05:55:12 INFO - 'SHELL': '/bin/bash', 05:55:12 INFO - 'SHLVL': '1', 05:55:12 INFO - 'TERM': 'linux', 05:55:12 INFO - 'TMOUT': '86400', 05:55:12 INFO - 'USER': 'cltbld', 05:55:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:12 INFO - '_': '/tools/buildbot/bin/python'} 05:55:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:55:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:55:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:55:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:55:15 INFO - Downloading docopt-0.6.1.tar.gz 05:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:55:15 INFO - Installing collected packages: blobuploader, requests, docopt 05:55:15 INFO - Running setup.py install for blobuploader 05:55:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:55:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:55:15 INFO - Running setup.py install for requests 05:55:15 INFO - Running setup.py install for docopt 05:55:15 INFO - Successfully installed blobuploader requests docopt 05:55:15 INFO - Cleaning up... 05:55:15 INFO - Return code: 0 05:55:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55: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')]} 05:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55: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')]} 05:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:15 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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:55:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:55:15 INFO - Using env: {'DISPLAY': ':0', 05:55:15 INFO - 'HOME': '/home/cltbld', 05:55:15 INFO - 'LANG': 'en_US.UTF-8', 05:55:15 INFO - 'LANGUAGE': 'en_US:en', 05:55:15 INFO - 'LOGNAME': 'cltbld', 05:55:15 INFO - 'MAIL': '/var/mail/cltbld', 05:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:15 INFO - 'MOZ_NO_REMOTE': '1', 05:55:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:15 INFO - 'NO_EM_RESTART': '1', 05:55:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:15 INFO - 'PWD': '/builds/slave/test', 05:55:15 INFO - 'SHELL': '/bin/bash', 05:55:15 INFO - 'SHLVL': '1', 05:55:15 INFO - 'TERM': 'linux', 05:55:15 INFO - 'TMOUT': '86400', 05:55:15 INFO - 'USER': 'cltbld', 05:55:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:15 INFO - '_': '/tools/buildbot/bin/python'} 05:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:16 INFO - Running setup.py (path:/tmp/pip-xSBgyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:16 INFO - Running setup.py (path:/tmp/pip-PEtigK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:16 INFO - Running setup.py (path:/tmp/pip-ZlJa3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:16 INFO - Running setup.py (path:/tmp/pip-N2xZwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:16 INFO - Running setup.py (path:/tmp/pip-2CfZwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:16 INFO - Running setup.py (path:/tmp/pip-h0QpLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:16 INFO - Running setup.py (path:/tmp/pip-An6759-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:16 INFO - Running setup.py (path:/tmp/pip-WozHFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:16 INFO - Running setup.py (path:/tmp/pip-X6Z6Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:16 INFO - Running setup.py (path:/tmp/pip-9GA0Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:16 INFO - Running setup.py (path:/tmp/pip-e0qTDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:16 INFO - Running setup.py (path:/tmp/pip-S8NTNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:16 INFO - Running setup.py (path:/tmp/pip-B6wsMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:17 INFO - Running setup.py (path:/tmp/pip-pQI9kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:17 INFO - Running setup.py (path:/tmp/pip-rrFQXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:17 INFO - Running setup.py (path:/tmp/pip-MKsKp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:17 INFO - Running setup.py (path:/tmp/pip-OKTypl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:55:17 INFO - Running setup.py install for manifestparser 05:55:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:55:17 INFO - Running setup.py install for mozcrash 05:55:17 INFO - Running setup.py install for mozdebug 05:55:17 INFO - Running setup.py install for mozdevice 05:55:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:55:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:55:17 INFO - Running setup.py install for mozfile 05:55:17 INFO - Running setup.py install for mozhttpd 05:55:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:55:17 INFO - Running setup.py install for mozinfo 05:55:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Running setup.py install for mozInstall 05:55:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Running setup.py install for mozleak 05:55:18 INFO - Running setup.py install for mozlog 05:55:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Running setup.py install for moznetwork 05:55:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Running setup.py install for mozprocess 05:55:18 INFO - Running setup.py install for mozprofile 05:55:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Running setup.py install for mozrunner 05:55:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:55:18 INFO - Running setup.py install for mozscreenshot 05:55:18 INFO - Running setup.py install for moztest 05:55:19 INFO - Running setup.py install for mozversion 05:55:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:55:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:55:19 INFO - Cleaning up... 05:55:19 INFO - Return code: 0 05:55:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:19 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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:55:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:55:19 INFO - Using env: {'DISPLAY': ':0', 05:55:19 INFO - 'HOME': '/home/cltbld', 05:55:19 INFO - 'LANG': 'en_US.UTF-8', 05:55:19 INFO - 'LANGUAGE': 'en_US:en', 05:55:19 INFO - 'LOGNAME': 'cltbld', 05:55:19 INFO - 'MAIL': '/var/mail/cltbld', 05:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:19 INFO - 'MOZ_NO_REMOTE': '1', 05:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:19 INFO - 'NO_EM_RESTART': '1', 05:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:19 INFO - 'PWD': '/builds/slave/test', 05:55:19 INFO - 'SHELL': '/bin/bash', 05:55:19 INFO - 'SHLVL': '1', 05:55:19 INFO - 'TERM': 'linux', 05:55:19 INFO - 'TMOUT': '86400', 05:55:19 INFO - 'USER': 'cltbld', 05:55:19 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:19 INFO - '_': '/tools/buildbot/bin/python'} 05:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:55:19 INFO - Running setup.py (path:/tmp/pip-KGQTTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:55:19 INFO - Running setup.py (path:/tmp/pip-p1qVs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:55:19 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)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:55:19 INFO - Running setup.py (path:/tmp/pip-tbrvdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:55:19 INFO - Running setup.py (path:/tmp/pip-cBb0l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:55:19 INFO - Running setup.py (path:/tmp/pip-PdGdPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:55:19 INFO - Running setup.py (path:/tmp/pip-DUAf8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:55:19 INFO - Running setup.py (path:/tmp/pip-GrGTYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:55:19 INFO - Running setup.py (path:/tmp/pip-yBCpbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:55:19 INFO - Running setup.py (path:/tmp/pip-pr8mDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:55:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:55:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:55:19 INFO - Running setup.py (path:/tmp/pip-ZEISFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:55:20 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)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:55:20 INFO - Running setup.py (path:/tmp/pip-E9e5_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:55:20 INFO - Running setup.py (path:/tmp/pip-I085jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:55:20 INFO - Running setup.py (path:/tmp/pip-CgtzJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:55:20 INFO - Running setup.py (path:/tmp/pip-_wILkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:55:20 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)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:20 INFO - Running setup.py (path:/tmp/pip-36U1cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:55:20 INFO - Running setup.py (path:/tmp/pip-9LFLf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:55:20 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)) 05:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:55:20 INFO - Running setup.py (path:/tmp/pip-kLiUkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:55:20 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)) 05:55:20 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)) 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:55:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55: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 05:55:22 INFO - Downloading blessings-1.6.tar.gz 05:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:55:22 INFO - Installing collected packages: blessings 05:55:22 INFO - Running setup.py install for blessings 05:55:22 INFO - Successfully installed blessings 05:55:22 INFO - Cleaning up... 05:55:22 INFO - Return code: 0 05:55:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:55:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:22 INFO - Reading from file tmpfile_stdout 05:55:22 INFO - Current package versions: 05:55:22 INFO - argparse == 1.2.1 05:55:22 INFO - blessings == 1.6 05:55:22 INFO - blobuploader == 1.2.4 05:55:22 INFO - docopt == 0.6.1 05:55:22 INFO - functools32 == 3.2.3-2 05:55:22 INFO - jsonschema == 2.5.1 05:55:22 INFO - manifestparser == 1.1 05:55:22 INFO - mozInstall == 1.12 05:55:22 INFO - mozcrash == 0.17 05:55:22 INFO - mozdebug == 0.1 05:55:22 INFO - mozdevice == 0.48 05:55:22 INFO - mozfile == 1.2 05:55:22 INFO - mozhttpd == 0.7 05:55:22 INFO - mozinfo == 0.9 05:55:22 INFO - mozleak == 0.1 05:55:22 INFO - mozlog == 3.3 05:55:22 INFO - moznetwork == 0.27 05:55:22 INFO - mozprocess == 0.23 05:55:22 INFO - mozprofile == 0.28 05:55:22 INFO - mozrunner == 6.12 05:55:22 INFO - mozscreenshot == 0.1 05:55:22 INFO - mozsystemmonitor == 0.3 05:55:22 INFO - moztest == 0.7 05:55:22 INFO - mozversion == 1.4 05:55:22 INFO - psutil == 3.1.1 05:55:22 INFO - requests == 1.2.3 05:55:22 INFO - wsgiref == 0.1.2 05:55:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:22 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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:55:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:55:22 INFO - Using env: {'DISPLAY': ':0', 05:55:22 INFO - 'HOME': '/home/cltbld', 05:55:22 INFO - 'LANG': 'en_US.UTF-8', 05:55:22 INFO - 'LANGUAGE': 'en_US:en', 05:55:22 INFO - 'LOGNAME': 'cltbld', 05:55:22 INFO - 'MAIL': '/var/mail/cltbld', 05:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:22 INFO - 'MOZ_NO_REMOTE': '1', 05:55:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:22 INFO - 'NO_EM_RESTART': '1', 05:55:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:22 INFO - 'PWD': '/builds/slave/test', 05:55:22 INFO - 'SHELL': '/bin/bash', 05:55:22 INFO - 'SHLVL': '1', 05:55:22 INFO - 'TERM': 'linux', 05:55:22 INFO - 'TMOUT': '86400', 05:55:22 INFO - 'USER': 'cltbld', 05:55:22 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:22 INFO - '_': '/tools/buildbot/bin/python'} 05:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:55:23 INFO - Cleaning up... 05:55:23 INFO - Return code: 0 05:55:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:55:23 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 0x166f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1930180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, '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': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:55:23 INFO - Using env: {'DISPLAY': ':0', 05:55:23 INFO - 'HOME': '/home/cltbld', 05:55:23 INFO - 'LANG': 'en_US.UTF-8', 05:55:23 INFO - 'LANGUAGE': 'en_US:en', 05:55:23 INFO - 'LOGNAME': 'cltbld', 05:55:23 INFO - 'MAIL': '/var/mail/cltbld', 05:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:23 INFO - 'MOZ_NO_REMOTE': '1', 05:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:23 INFO - 'NO_EM_RESTART': '1', 05:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:23 INFO - 'PWD': '/builds/slave/test', 05:55:23 INFO - 'SHELL': '/bin/bash', 05:55:23 INFO - 'SHLVL': '1', 05:55:23 INFO - 'TERM': 'linux', 05:55:23 INFO - 'TMOUT': '86400', 05:55:23 INFO - 'USER': 'cltbld', 05:55:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:23 INFO - '_': '/tools/buildbot/bin/python'} 05:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:55:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:55:23 INFO - Cleaning up... 05:55:23 INFO - Return code: 0 05:55:23 INFO - Running post-action listener: _resource_record_post_action 05:55:23 INFO - Running post-action listener: _start_resource_monitoring 05:55:23 INFO - Starting resource monitoring. 05:55:23 INFO - [mozharness: 2016-08-09 12:55:23.389754Z] Finished create-virtualenv step (success) 05:55:23 INFO - [mozharness: 2016-08-09 12:55:23.390193Z] Running install step. 05:55:23 INFO - Running pre-action listener: _resource_record_pre_action 05:55:23 INFO - Running main action method: install 05:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:55:23 INFO - Reading from file tmpfile_stdout 05:55:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:55:23 INFO - Reading from file tmpfile_stdout 05:55:23 INFO - Output received: 05:55:23 INFO - Usage: mozinstall [options] installer 05:55:23 INFO - Options: 05:55:23 INFO - -h, --help show this help message and exit 05:55:23 INFO - -d DEST, --destination=DEST 05:55:23 INFO - Directory to install application into. [default: 05:55:23 INFO - "/builds/slave/test"] 05:55:23 INFO - --app=APP Application being installed. [default: firefox] 05:55:23 INFO - mkdir: /builds/slave/test/build/application 05:55:23 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'] 05:55:23 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 05:55:40 INFO - Reading from file tmpfile_stdout 05:55:40 INFO - Output received: 05:55:40 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:40 INFO - Running post-action listener: _resource_record_post_action 05:55:40 INFO - [mozharness: 2016-08-09 12:55:40.773439Z] Finished install step (success) 05:55:40 INFO - [mozharness: 2016-08-09 12:55:40.773693Z] Running run-tests step. 05:55:40 INFO - Running pre-action listener: _resource_record_pre_action 05:55:40 INFO - Running main action method: run_tests 05:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:40 INFO - Python 2.7.3 05:55:40 INFO - Return code: 0 05:55:40 INFO - grabbing minidump binary from tooltool 05:55:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:55:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e3b0>, '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 0x192f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:55:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:55:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:55:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:40 INFO - Return code: 0 05:55:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:55:40 INFO - Using env: {'DISPLAY': ':0', 05:55:40 INFO - 'HOME': '/home/cltbld', 05:55:40 INFO - 'LANG': 'en_US.UTF-8', 05:55:40 INFO - 'LANGUAGE': 'en_US:en', 05:55:40 INFO - 'LOGNAME': 'cltbld', 05:55:40 INFO - 'MAIL': '/var/mail/cltbld', 05:55:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:40 INFO - 'MOZ_NO_REMOTE': '1', 05:55:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:40 INFO - 'NO_EM_RESTART': '1', 05:55:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:40 INFO - 'PWD': '/builds/slave/test', 05:55:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:40 INFO - 'SHELL': '/bin/bash', 05:55:40 INFO - 'SHLVL': '1', 05:55:40 INFO - 'TERM': 'linux', 05:55:40 INFO - 'TMOUT': '86400', 05:55:40 INFO - 'USER': 'cltbld', 05:55:40 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935', 05:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:40 INFO - '_': '/tools/buildbot/bin/python'} 05:55:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:55:41 INFO - mozversion application_buildid: 20160809030200 05:55:41 INFO - mozversion application_changeset: 720b5d2c84d5b253d4dfde4897e13384dc97a46a 05:55:41 INFO - mozversion application_display_name: Nightly 05:55:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:41 INFO - mozversion application_name: Firefox 05:55:41 INFO - mozversion application_remotingname: firefox 05:55:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:41 INFO - mozversion application_vendor: Mozilla 05:55:41 INFO - mozversion application_version: 51.0a1 05:55:41 INFO - mozversion platform_buildid: 20160809030200 05:55:41 INFO - mozversion platform_changeset: 720b5d2c84d5b253d4dfde4897e13384dc97a46a 05:55:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:41 INFO - mozversion platform_version: 51.0a1 05:55:41 INFO - using testdate: 1470747341 05:55:41 INFO - actual date: 1470747341 05:55:41 INFO - starting webserver on 'localhost:46117' 05:55:41 INFO - SUITE-START | Running 2 tests 05:55:41 INFO - TEST-START | dromaeo_css 05:55:41 INFO - operating with platform_type : linux_ 05:55:41 INFO - Initialising browser for dromaeo_css test... 05:55:41 INFO - TEST-INFO | started process 17282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUY1wZ/profile http://localhost:46117/getInfo.html) 05:55:46 INFO - PROCESS | 17282 | __metrics Screen width/height:1600/1200 05:55:46 INFO - PROCESS | 17282 | colorDepth:24 05:55:46 INFO - PROCESS | 17282 | Browser inner width/height: 1024/697 05:55:46 INFO - PROCESS | 17282 | __metrics 05:55:47 INFO - PROCESS | 17282 | 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" 05:55:47 INFO - PROCESS | 17282 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:47 INFO - PROCESS | 17282 | console.error: PushService: 05:55:47 INFO - PROCESS | 17282 | stateChangeProcessEnqueue: Error transitioning state 05:55:47 INFO - PROCESS | 17282 | UnknownError 05:55:48 INFO - TEST-INFO | 17282: exit 0 05:55:48 INFO - Browser initialized. 05:55:48 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:48 INFO - TEST-INFO | started process 17362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUY1wZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:59 INFO - PROCESS | 17362 | RSS: Main: 156475392 05:55:59 INFO - PROCESS | 17362 | 05:56:51 INFO - PROCESS | 17362 | 1470747411509 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] 05:59:01 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46117/tests/dromaeo/cssquery-ext.html) 05:59:02 INFO - PROCESS | 17362 | RSS: Main: 287924224 05:59:02 INFO - PROCESS | 17362 | 06:02:04 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-ext.html (next: http://localhost:46117/tests/dromaeo/cssquery-jquery.html) 06:02:05 INFO - PROCESS | 17362 | RSS: Main: 253591552 06:02:05 INFO - PROCESS | 17362 | 06:05:07 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46117/tests/dromaeo/cssquery-mootools.html) 06:05:07 INFO - PROCESS | 17362 | RSS: Main: 184713216 06:05:07 INFO - PROCESS | 17362 | 06:08:09 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46117/tests/dromaeo/cssquery-prototype.html) 06:08:10 INFO - PROCESS | 17362 | RSS: Main: 242425856 06:08:10 INFO - PROCESS | 17362 | 06:11:13 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46117/tests/dromaeo/cssquery-yui.html) 06:11:13 INFO - PROCESS | 17362 | RSS: Main: 188039168 06:11:13 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | Cycle 1(1): loaded http://localhost:46117/tests/dromaeo/cssquery-yui.html (next: http://localhost:46117/tests/dromaeo/cssquery-dojo.html) 06:14:16 INFO - PROCESS | 17362 | RSS: Main: 277000192 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | __start_tp_report 06:14:16 INFO - PROCESS | 17362 | _x_x_mozilla_page_load 06:14:16 INFO - PROCESS | 17362 | _x_x_mozilla_page_load_details 06:14:16 INFO - PROCESS | 17362 | |i|pagename|runs| 06:14:16 INFO - PROCESS | 17362 | |0;dojo.html;3048.3141293209023;3058.424911170746;3061.142879993602;3100.2714362124884;3116.812991220527;5217.765200565974;5227.660202086871;5319.494648008438;5411.134218525031;5422.240886275925;5329.920051199226;5354.250404943311;5369.677819330843;5392.56859451244;5405.891882162355;4835.903281934359;4861.951380486185;4889.119958407486;4897.142999975008;5002.224655178435;4910.140725373063;4913.754312284389;4919.77860996256;4934.062528119646;4956.983818317236;4800.759962001921;4817.78319975602;4875.293082503053;4877.756112194376;4915.262710593403;4829.9275510867365;4835.830745923911;4848.2727590861305;4912.410510738734;4957.752112394366;4831;4860.270959356089;4860.878478038042;4904.068227036887;4921.114199444099;5173.3016042834115;5247.47525247476;5300.628955973083;5369.167778994262;5370.301860758115;5663.122216056518;5715.057015592464;5715.31416230055;5716.056850619642;5717.313922329306;5735.311762588516;5747.683877386742;5749.913751293734;5759.280089988752;5766.250387449605;5196.1166601677805;5326.6005049621435;5352.090144675414;5380.7309634518115;5385.784568617211;5918.615290006136;5918.852028699317;5919.881602367928;5962.821115366546;5964.284285885721;5708.942910570924;5712.371639119777;5712.400197979152;5714.685692286881;5717.885642287131;5573.219749235111;5588.776448941997;5634.070378387521;5645.23789288449;5778.682172480554;5647.632903861236;5658.91511627326;5667.744951477193;5668.688222147739;5710.400407957188;5617.9438205618235;5663.915041274302;5668.461496157858;5670.943290567124;5676.602637815396;4297.67767417445;4363.083752412029;4363.7381757094045;4423.8230470781455;4435.778211089432;3960;3979.880603581897;3979.9403008954887;3980.024893901013;3982.26328129297;5375.650582712111;5421.539169170585;5427.864303392446;5429.239906413105;5438.91841622376;5753.510951569164;5775.768969241183;5776.1624564437925;5783.277090363705;5824.592278540462;5373.435789242073;5402.135658294654;5418.458154184629;5425.941941321405;5451.318585176853;4817.78319975602;4843;4928.950710492921;4987.4015118185325;5017.724025178651;5937.376575459601;5940.55445841555;5942.554308426886;5973.820785376446;5992.310884248367;5624.831255062355;5666.603337766317;5671.631343962794;5672.517835983987;5684.886302274014;5865.3254875689845;5931.1992880960515;5935.881282374415;5939.732712027882;5973.581849270509;5630.071038278638;5636.239107720406;5643.830685079454;5685.573581981451;5690.8577285566535;5742.36833948257;5742.942570574241;5750.769969201185;5752.33848107473;5757.827265182052;5433.402325744244;5501.889962200814;5571.192177134212;5630.521405680399;5632.85917852057;5629.380768115586;5642.746076426489;5648.265725455664;5659.434056594472;5672.858178545569;5516.365617953987;5536.446355364431;5563.972180139235;5585.972070139624;5592.7203639817035;5498.862528436821;5567.66594004361;5589.692566908859;5638.041532939328;5720.799772007959;5533.723313834373;5539.944600554104;5541.224228607917;5587.329520457572;5593.692346920959 06:14:16 INFO - PROCESS | 17362 | |1;ext.html;561.5252318864015;567.7161419290358;572.5677113779096;584.1588113117111;610.2432983100954;45559.31661025083;46189.53810461894;46406.535934640684;46424.30363544545;50400.49599504004;47462.288065679044;48120;48169.51830481703;48193.759031204885;48243;9221.631134754602;9373.578188981512;9382.155605995458;9383.343165978384;9387.295952803566;9167.083291670813;9263.703081568587;9266;9266.305027122993;9268.629254829832;9301.534923253845;9336;9338.346315757899;9371.156595906366;9372.437653740762;9242.353035287533;9256.67601633943;9275.814483710321;9282.675106371245;9286.489243091628;9178.495182764946;9244.768880777967;9250.491222982733;9250.629974801;9258.444493330355;43415.348769768476;43696;43762.56237437617;43871.34192987108;44058.33912491315;3576.7317451191266;3735.2902948439983;3777.6411240932066;3911.5306163260307;4338.891527711801;33885;34415.82792086049;34667.65332346669;34825.65174348249;35263.29473410543;4446.244138496431;4525.140223357552;4531.841385551523;4578.267477203664;4687.695299805502;258479;258579;258631;258713.7064314685;259105;60923.69538152369;60973.69513152406;61029.694851525455;61075;61527;64228.67885660542;64405.355946440875;64465;64496;64627.35372646213;16833;17108.572285692957;17169.227384767717;17184.484465466056;17186.398476053277;13181.934090329487;13263.469461221635;13269.336533173302;13272.800907986388;13291.069625126342;16564.254608542644;18148;18155.818441815678;18370.265189392274;18419.447416577525;6116.235470566179;6211.720472578745;6253.91615694467;6327.746890124436;6367;950.2872845365976;1001.1090129784498;1014.9949250253849;1024.6977141743203;1067.423591260726;33270.16824579357;33548;33969.49045764316;34047.31905361879;34412.82793586016;908.318760929303;1091.1979694924382;1133.7052366384635;1138.7437826488974;1197.658667279821;16515.504534863972;17273.481795546155;17319;17353.132343382782;17438.912805436146;516421;517752;518073;520786;523052;60283.69858150681;60322.09516857251;60432.395676043554;60499.09251361233;60509;1242.739024804783;1305.28209484783;1337.304601607159;1372.5196181336653;1398.9020768546104;33247.50128748119;34591.481127783605;34724.65275347315;35397.82301088478;35425;51934;52274;52297.21554176766;52353;52364;402464;404414;404434;404502;404694;28745.85627071935;29860.850695746383;29914.401711966075;31364.529532057495;31473.37053258876;49722.502774971785;49833.25250121324;50763;50820.237696435324;51568.22647660213;41883.37174942439;42376.364354535326;42528.78735606426;44369;44534.109317812814;41990;42388.576114239695;42503.574964249965;42866.78566607147;44611;42970.1405971885;44121;44129.55870441383;44285.557144428145;44470.777646111565;36018.63981360153;36862.26275474422;38158.427623585114;38342.23315533618;38614.613853862225;28963;29367;29376.26559336034;29478.852605736833;29492.705072948997 06:14:16 INFO - PROCESS | 17362 | |2;jquery.html;377.31893931453715;382.83920753283616;404.0968435546554;411.7303166425991;413.3881854854815;14399.136051836897;17768.200430980603;19765.308214212506;19844.107015184316;19862.20551177951;19644.31244906425;19651.901740491277;19727.90136049321;19842.20631174751;19933.601327973432;5640.294963129609;5726.599138060348;5802.912956305659;5923.940760592382;5924.022536281508;5803.071508558632;5880.794172203974;5887.646741195521;5892.234009578749;5892.823215303526;5646.632968857011;5779.566532510057;5825.533957283428;5860.208871802295;5869.413058694117;5771.163181338703;5800.651960882318;5809.709514524278;5811.883762324751;5814.273215848019;5196.818111366084;5205.739713014372;5431.945680543184;5448.046591846451;5535.363433205152;14266;14346.856531434656;14446.927765361106;21487.892560537097;23533;2262.6266666000092;2284.5202507473286;2291.194091340023;2295.91964281251;2301.9309420717404;11024.834627480594;11040.061594764455;11401;13451.86548134516;15543.689126217525;1902.8192321729414;1941.7475728155391;1991.3727175939532;2002.7596688397487;2044.2947183221765;59263.40736592622;70064.29935700628;79812;84919.57540212321;88464.55767721185;11222.158338124673;11247.550097996153;11286.54853805855;11367.09063274936;11629.88370116288;16180;16207.837921620869;16226;16234.18829058566;16256.75614865778;8044.316233120133;8157.510549366938;8188.5496297703;8203.915936044308;8238.711645092393;7679.539227646359;7790.1041380241995;7960.761177164694;7977.162397948132;8011.278984891388;4845.176320025604;4918.458969513351;4940.901181976412;4994.576545684463;5036.244563315532;1987.8906660133832;2046.2224354745101;2056.7120603115577;2060.958780824375;2082.2607974169255;878.8549889268327;961.8364877970762;988.7182153086336;990.4453506036642;1057.9682609521726;20023.29918452847;20468.79531204669;20484.897575512026;20494.282700105425;20585.485362865747;979.583676937313;998.1615443027891;1027.9691609251734;1029.7940411917646;1049.197364016528;9456.763580910532;11287.820982759658;11309.377984210783;11331.773364532828;11428.371439570737;489499;493713;495751;504346;507727;57837.71081144567;75022.62488687522;92199;93846.53076734573;94215.52892235632;959.0840747086515;976.4678250353575;998.0668075349571;1000.2298230362726;1006.8942761010135;17565.560860978578;17808.807948343907;18362.357317493825;18431.631367372847;18781.624367512846;45707.77146114248;45737.542624573325;45887.54112458833;46994.29508557443;46998.53001469941;61040;62021;62511;62878;63280.36719632929;8779.648814047367;8898.288136949159;8942.68700595476;9007.909920900707;9199.77000574991;10105.343152695345;13450.327483625584;13560.05079644455;13830.723385532032;14320.427182912566;11678.299302041565;11765;11845.466953987263;12171.330576818005;12340.50637974507;11643.12676549279;11715.297082175097;11779.469923853618;11864.466099025392;11946.581869634869;11532.481038353462;11925.4037298133;12056.095792815398;12632.557860474839;12871.806922895978;8050.355971522147;8372.832543348977;9051.185393314634;9296.349255552046;9353.25173986093;5983.012802887649;11264.15518836107;12406.751864962831;12712.474503059691;12723.300218487702 06:14:16 INFO - PROCESS | 17362 | |3;mootools.html;1341.5841089262324;1484.2430360516137;1537.9461718839843;1661.2524364036178;1788.141691987846;8811.251043661288;9145.77135571611;9190.218831399323;9436.433813971167;9451.669191578296;9242.445453272792;9334.579943902523;9389.953050234739;9395.060493950601;9397.62409503619;2460.483298507316;2490.6762120924345;2491.2401717476164;2491.402063504764;2492.9252122436355;2378.4172877645;2464.4824586836694;2471.7651823076867;2472.7156377016604;2475.616279476684;2399.7960173385195;2419.4677171022436;2456.435019945414;2459.557279689655;2461.593837016899;2400.6639070530055;2419.9516009679883;2423.1155628195756;2431.4407686232266;2432.7567243275707;2354.128972280267;2365.053978408633;2366.02992772964;2374.5013547155118;2376.346504711201;9264.583093760797;9359.15767580921;9361.625534978593;9429.858552121723;9547.188488978445;5512.862178445531;5659.8585035374035;5668.801591944262;5672.886542269172;5675.517581005578;3605.3330133925306;3684.336819372512;3756.6243375662216;3807.4859893914245;3808.866689665876;1205.9698507537382;1221.1377649085127;1224.9142560020803;1249.6188662457946;1252.2674235572201;13022;13028.739425211537;13103.672408189872;13109.86890131096;13110.672233194056;4691.856741711428;4782.187028205144;4795.736234507136;4874.122657921608;4934.7285899275885;10295.691129265984;10297.897021029694;10305;10305.484725763681;10315.381077135396;5457.181422786613;5472.589555783332;5491.176323551419;5491.862703432446;5517.062099443024;4226.5773422657485;4557.886052848639;4664.224542847336;5022.196448568212;5131.461196574381;3962.5244970603712;3974.2647610192207;4070.4911886014247;4085.0604360997136;4093.9795301023305;1205.2523840431409;1238.3684320996356;1249.7562975219926;1251.268008215186;1263.3493750718387;817.7791996161003;954.1412728544227;979.8677178580942;1007.4106647611083;1021.9437930913871;6062.393760623902;6177.722002509898;6190.071489276645;6284.905726414107;6486.286508484063;493.73585131954235;496.6895690193629;503.89922015596295;514.3981541596341;514.7080827123871;4306.612404883513;4317.309230523101;4416.823327066945;4508.661850361236;4514.210013247669;11455.713607159887;11911.285322880482;11929.28424294545;11935.343556104497;11974.700632484257;11031.172662050378;11747.236429632047;11796.410179490991;11813.645590632295;11892.702682433008;8413.368997325226;8829.779255518664;8836;8850.247728942983;8853.911460885309;6434.163558737521;6454.1609590752905;6540.574862633914;6582.341765823379;6735.4611631070375;10675.572977081141;10880.347179169275;10885.258358662893;11013.394263315595;11030.172737044593;10005.449700266556;11155.219134660496;11203.663890083311;11294.096472282034;11323;8103.027636683636;8321.667133314842;8390.119037500974;8527.275181609633;8551.016633087274;9084.727458176265;9100.726978190665;9120;9189.586468608795;9222.123898229658;8249.558094953665;8282.585870706562;8317.83364332722;8396.538190399586;8447.45091569046;7894.447388682966;7935.365170786438;8055.436119471581;8055.476394034369;8130.552819594979;7120.786376408716;7256.528325658815;7259.782206533812;7263.055802745609;7266.600336981517;4926.211806111005;5095.439501654889;5171.379434467737;5198.558122559473;5346.866328341823;5249.921251181312;5336.012837625051;5405.189221616789;5542.3626282977975;5646.153077038312 06:14:16 INFO - PROCESS | 17362 | |4;prototype.html;328.9394122626678;337.1756056441999;345.0614329025052;345.97763608536775;352.39564147487073;5192.948785229832;5196.714180720059;5212.895742085166;5222.34720659918;5237.816676416326;5169.922451163236;5184.403793563742;5213.1919552469335;5219.373675158977;5230.8692282692955;4144.150449157931;4162.7918604069755;4163.7293575917465;4164.833406663745;4208;3737.5423584801947;3894.7926142895653;4113.9794301028605;4150.252954468195;4154.210699967011;4068.8982775430554;4081.4081958116053;4089.6114869087537;4111.527174374955;4127.855525056623;3950.802459876995;4145.253854306224;4146.709730318879;4147.979260103711;4149.585041495841;3493.1092571394133;3583.2475180212186;3591.5331006969186;3600.5499312585926;3626.6373362663785;5036.597072234213;5039.3196918415915;5040.747962601892;5080.288759573663;5139.7687104080405;4649.488556258809;4659.673822832403;4668.696534725232;4669.696469729491;4684.320773487825;5133.230015497668;5371.14061750122;5376.973115134439;5408.513233808976;5409.377921538995;3921.372580387153;3925.3523168677134;3934.429507721393;3939.6454319111417;3944.073142811437;5285.891797005993;5458.727063646841;5685.886282274373;5701.71491425427;5713.228714123582;3872.9225415491533;3978.741381810173;4014.3777714454304;4014.578469260744;4019.296623091006;4051.0682543015273;4055.41196526502;4062.2484840304637;4064.861838685173;4067.593240675909;4648.721076735406;4649.279361698942;4651.3023046543285;4653.115907977541;4690.296455531698;5359.892802144013;5384.326959130109;5436.510714035756;5463.399026107125;5470.507654311052;1367.8974076944269;1383.1078954074565;1383.833939927195;1384.2940100548792;1384.532395660603;873.7160422862595;909.7589138878203;910.5902343945252;930.6277489004317;932.8367535681228;4680.672352935262;4683.1336202802595;4686.789094490756;4743.335932969387;4744.410622441452;4961.858772482349;4974.726390048582;4976.60655016596;4977.257959714071;5001.949980500149;4746.928796068062;4753.667243293005;4769.497608253389;4769.73766442849;4934.481879402683;2928.677845437;2945.867435965387;2954.1432984434273;2955.3350496138196;2975.8512074396194;5813.157092221604;5826.155207494974;5833.7083145842535;5837.591368604157;5852.882942341214;5518.227448157261;5606.495415412633;5646.927083854054;5665.677072400296;5731.312242530839;5547.639403438763;5676.659400435905;5745.88508229833;5838.095095260242;5843.883122337445;5571.303587051619;5584.636998595241;5591.30108736408;5610.242617246783;5635.690037047838;5304.761285742228;5482.451754824486;5485.670859748428;5550.167474878801;5574.9163762542785;5793.929217514724;5796.971015145066;5804.984127777707;5821.155932389865;5834.94165058344;4011.618896204856;4032.798360082043;4036.616521430459;4062.1672557125125;4075.470188875427;5521.282233309644;5564.55483561306;5565.638233514808;5587.385387607441;5674.914876276776;5417.674939503642;5428.59285553593;5437.891242175056;5491.478309560585;5500.532454741232;5277;5426.945730542644;5456.345238571397;5482.945170548243;5518.530924871431;5310.221075939604;5387.515123638891;5390.892182156256;5397.973010134924;5405.027165084794;5454.836354909359;5473.534749546333;5474.151506516497;5475.397706252229;5514;5099.592032637454;5328;5335.519803217729;5352.678839269656;5355.758990845344 06:14:16 INFO - PROCESS | 17362 | |5;yui.html;764.3503022430932;807.6607824713619;838.6704782015397;865.2472349056326;886.2422628652502;16053.839461605381;17124.48626541206;17409.12749396351;17511.737323940135;17653.558661033465;15582.142982135978;15725.135117568529;15832.287547060381;15851;15864.603384915354;816.0166998766501;831.1148626712562;833.7540425574471;834.1616675241374;834.5076404921095;668.36505319946;794.7099308752322;827.6937533112757;828.2380210206625;831.1688311688312;884.0938038510546;889.3952112563454;889.4885440871492;889.915458031486;889.9777505562348;878.2403221213636;883.9204471597587;884.8407286688393;884.8628462588309;885.0574138542431;501.4008260129147;601.629997551507;623.0654018971543;623.4171050068201;626.9843253918689;15091.698166036727;15185.620359490991;15190.088594684354;15209.771853422208;15216.315265813066;14276.57170284893;14651.340689668883;15074.170920599363;15156.24218789056;15289.6177595561;13516.459341626323;13640.181589104686;13702.52041178564;13946.372413241428;14114.294285285798;4492.8876778080485;4568.406107206075;4653.627709783209;4685.88285292867;4795.71225726454;89125.10874891233;89429.55285223597;89667.55166224192;90779;91122.5443872783;12003.51985920571;12011.159218854596;12014.63956081319;12153;12327.6918077047;23109.19117830868;23186;23303.30090097266;23323.650145247833;23984.64023039656;8593.695775038928;8748.387612867165;8835.381523293436;8884.067172946876;8948.194662480408;4695.483496815347;4712.858614241578;4750.667453278237;4788.95211047892;4803.735794531264;3319.93360132796;3411.778234414755;3413.74396920232;3419.5212670226188;3427.1260828488575;615.6860001399318;624.2446639566176;655.2333769489709;681.6387314723205;687.5805758487319;681.5637991685326;686.4405509509834;709.5742554467279;712.7782423446098;761.7143571160815;9889.357191782512;10468.842967355497;10521.421321827373;10886;10941.56233750641;741.7366834773685;757.5984728094119;763.8052296664315;779.9727009554638;788.9526628402314;5059;5354.680633673599;5366.329208848894;5390.535223038612;5404.162354834928;69461.3053869465;109353.45323273333;129523;131928;134067;64141.67929160324;65209.673951629935;68691.65654171698;76175.61912190403;101750.4912475433;61773;98430.5078474603;101820;103375;103733.48133259437;10064.144547713526;10364.74088147772;10389.272750907667;10517.488381844143;10528.631497897537;57255.71372143113;57412.42587574238;58119.4188058114;58363;59331.40668593259;76536.61731691306;83364.58317708372;83705;84373;87501.31241469285;13035.47858085704;13148.934255328662;13159;13190.802137967747;13618.659533511742;14253.216073116078;14573.198474084027;14575.635609109857;14930.328135234158;15545.922270388575;13963.30183490801;14010.299485025911;14123.929380353033;14381.856181438052;14612.269386530419;13924.721505570034;14071.085379450304;14127.64680882945;14175.64560885986;14708.41166353334;13749.175049497062;13888;14079.929600351932;14199.64500887486;14510.056846304957;11227.887721122685;11293.43532823372;11708.590199342982;11725.355105469282;11802.173847830569;10047.799044019224;11720.824187637363;11919.761604767682;12094.879051209375;12212.694682633006 06:14:16 INFO - PROCESS | 17362 | __end_tp_report 06:14:16 INFO - PROCESS | 17362 | __start_cc_report 06:14:16 INFO - PROCESS | 17362 | _x_x_mozilla_cycle_collect,1160 06:14:16 INFO - PROCESS | 17362 | __end_cc_report 06:14:16 INFO - PROCESS | 17362 | __startTimestamp1470748456802__endTimestamp 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | ------- Summary: start ------- 06:14:16 INFO - PROCESS | 17362 | Number of tests: 6 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | [#0] dojo.html Cycles:165 Average:5323.44 Median:5541.22 stddev:602.10 (10.9%) stddev-sans-first:576.89 06:14:16 INFO - PROCESS | 17362 | Values: 3048.3 3058.4 3061.1 3100.3 3116.8 5217.8 5227.7 5319.5 5411.1 5422.2 5329.9 5354.3 5369.7 5392.6 5405.9 4835.9 4862.0 4889.1 4897.1 5002.2 4910.1 4913.8 4919.8 4934.1 4957.0 4800.8 4817.8 4875.3 4877.8 4915.3 4829.9 4835.8 4848.3 4912.4 4957.8 4831.0 4860.3 4860.9 4904.1 4921.1 5173.3 5247.5 5300.6 5369.2 5370.3 5663.1 5715.1 5715.3 5716.1 5717.3 5735.3 5747.7 5749.9 5759.3 5766.3 5196.1 5326.6 5352.1 5380.7 5385.8 5918.6 5918.9 5919.9 5962.8 5964.3 5708.9 5712.4 5712.4 5714.7 5717.9 5573.2 5588.8 5634.1 5645.2 5778.7 5647.6 5658.9 5667.7 5668.7 5710.4 5617.9 5663.9 5668.5 5670.9 5676.6 4297.7 4363.1 4363.7 4423.8 4435.8 3960.0 3979.9 3979.9 3980.0 3982.3 5375.7 5421.5 5427.9 5429.2 5438.9 5753.5 5775.8 5776.2 5783.3 5824.6 5373.4 5402.1 5418.5 5425.9 5451.3 4817.8 4843.0 4929.0 4987.4 5017.7 5937.4 5940.6 5942.6 5973.8 5992.3 5624.8 5666.6 5671.6 5672.5 5684.9 5865.3 5931.2 5935.9 5939.7 5973.6 5630.1 5636.2 5643.8 5685.6 5690.9 5742.4 5742.9 5750.8 5752.3 5757.8 5433.4 5501.9 5571.2 5630.5 5632.9 5629.4 5642.7 5648.3 5659.4 5672.9 5516.4 5536.4 5564.0 5586.0 5592.7 5498.9 5567.7 5589.7 5638.0 5720.8 5533.7 5539.9 5541.2 5587.3 5593.7 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | [#1] ext.html Cycles:180 Average:57514.24 Median:44089.67 stddev:108050.41 (245.1%) stddev-sans-first:108268.91 06:14:16 INFO - PROCESS | 17362 | Values: 561.5 567.7 572.6 584.2 610.2 45559.3 46189.5 46406.5 46424.3 50400.5 47462.3 48120.0 48169.5 48193.8 48243.0 9221.6 9373.6 9382.2 9383.3 9387.3 9167.1 9263.7 9266.0 9266.3 9268.6 9301.5 9336.0 9338.3 9371.2 9372.4 9242.4 9256.7 9275.8 9282.7 9286.5 9178.5 9244.8 9250.5 9250.6 9258.4 43415.3 43696.0 43762.6 43871.3 44058.3 3576.7 3735.3 3777.6 3911.5 4338.9 33885.0 34415.8 34667.7 34825.7 35263.3 4446.2 4525.1 4531.8 4578.3 4687.7 258479.0 258579.0 258631.0 258713.7 259105.0 60923.7 60973.7 61029.7 61075.0 61527.0 64228.7 64405.4 64465.0 64496.0 64627.4 16833.0 17108.6 17169.2 17184.5 17186.4 13181.9 13263.5 13269.3 13272.8 13291.1 16564.3 18148.0 18155.8 18370.3 18419.4 6116.2 6211.7 6253.9 6327.7 6367.0 950.3 1001.1 1015.0 1024.7 1067.4 33270.2 33548.0 33969.5 34047.3 34412.8 908.3 1091.2 1133.7 1138.7 1197.7 16515.5 17273.5 17319.0 17353.1 17438.9 516421.0 517752.0 518073.0 520786.0 523052.0 60283.7 60322.1 60432.4 60499.1 60509.0 1242.7 1305.3 1337.3 1372.5 1398.9 33247.5 34591.5 34724.7 35397.8 35425.0 51934.0 52274.0 52297.2 52353.0 52364.0 402464.0 404414.0 404434.0 404502.0 404694.0 28745.9 29860.9 29914.4 31364.5 31473.4 49722.5 49833.3 50763.0 50820.2 51568.2 41883.4 42376.4 42528.8 44369.0 44534.1 41990.0 42388.6 42503.6 42866.8 44611.0 42970.1 44121.0 44129.6 44285.6 44470.8 36018.6 36862.3 38158.4 38342.2 38614.6 28963.0 29367.0 29376.3 29478.9 29492.7 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | [#2] jquery.html Cycles:180 Average:29122.71 Median:393.47 stddev:81954.35 (20828.7%) stddev-sans-first:82155.83 06:14:16 INFO - PROCESS | 17362 | Values: 377.3 382.8 404.1 411.7 413.4 14399.1 17768.2 19765.3 19844.1 19862.2 19644.3 19651.9 19727.9 19842.2 19933.6 5640.3 5726.6 5802.9 5923.9 5924.0 5803.1 5880.8 5887.6 5892.2 5892.8 5646.6 5779.6 5825.5 5860.2 5869.4 5771.2 5800.7 5809.7 5811.9 5814.3 5196.8 5205.7 5431.9 5448.0 5535.4 14266.0 14346.9 14446.9 21487.9 23533.0 2262.6 2284.5 2291.2 2295.9 2301.9 11024.8 11040.1 11401.0 13451.9 15543.7 1902.8 1941.7 1991.4 2002.8 2044.3 59263.4 70064.3 79812.0 84919.6 88464.6 11222.2 11247.6 11286.5 11367.1 11629.9 16180.0 16207.8 16226.0 16234.2 16256.8 8044.3 8157.5 8188.5 8203.9 8238.7 7679.5 7790.1 7960.8 7977.2 8011.3 4845.2 4918.5 4940.9 4994.6 5036.2 1987.9 2046.2 2056.7 2061.0 2082.3 878.9 961.8 988.7 990.4 1058.0 20023.3 20468.8 20484.9 20494.3 20585.5 979.6 998.2 1028.0 1029.8 1049.2 9456.8 11287.8 11309.4 11331.8 11428.4 489499.0 493713.0 495751.0 504346.0 507727.0 57837.7 75022.6 92199.0 93846.5 94215.5 959.1 976.5 998.1 1000.2 1006.9 17565.6 17808.8 18362.4 18431.6 18781.6 45707.8 45737.5 45887.5 46994.3 46998.5 61040.0 62021.0 62511.0 62878.0 63280.4 8779.6 8898.3 8942.7 9007.9 9199.8 10105.3 13450.3 13560.1 13830.7 14320.4 11678.3 11765.0 11845.5 12171.3 12340.5 11643.1 11715.3 11779.5 11864.5 11946.6 11532.5 11925.4 12056.1 12632.6 12871.8 8050.4 8372.8 9051.2 9296.3 9353.3 5983.0 11264.2 12406.8 12712.5 12723.3 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | [#3] mootools.html Cycles:180 Average:6124.00 Median:4737.02 stddev:3552.35 (75.0%) stddev-sans-first:3544.13 06:14:16 INFO - PROCESS | 17362 | Values: 1341.6 1484.2 1537.9 1661.3 1788.1 8811.3 9145.8 9190.2 9436.4 9451.7 9242.4 9334.6 9390.0 9395.1 9397.6 2460.5 2490.7 2491.2 2491.4 2492.9 2378.4 2464.5 2471.8 2472.7 2475.6 2399.8 2419.5 2456.4 2459.6 2461.6 2400.7 2420.0 2423.1 2431.4 2432.8 2354.1 2365.1 2366.0 2374.5 2376.3 9264.6 9359.2 9361.6 9429.9 9547.2 5512.9 5659.9 5668.8 5672.9 5675.5 3605.3 3684.3 3756.6 3807.5 3808.9 1206.0 1221.1 1224.9 1249.6 1252.3 13022.0 13028.7 13103.7 13109.9 13110.7 4691.9 4782.2 4795.7 4874.1 4934.7 10295.7 10297.9 10305.0 10305.5 10315.4 5457.2 5472.6 5491.2 5491.9 5517.1 4226.6 4557.9 4664.2 5022.2 5131.5 3962.5 3974.3 4070.5 4085.1 4094.0 1205.3 1238.4 1249.8 1251.3 1263.3 817.8 954.1 979.9 1007.4 1021.9 6062.4 6177.7 6190.1 6284.9 6486.3 493.7 496.7 503.9 514.4 514.7 4306.6 4317.3 4416.8 4508.7 4514.2 11455.7 11911.3 11929.3 11935.3 11974.7 11031.2 11747.2 11796.4 11813.6 11892.7 8413.4 8829.8 8836.0 8850.2 8853.9 6434.2 6454.2 6540.6 6582.3 6735.5 10675.6 10880.3 10885.3 11013.4 11030.2 10005.4 11155.2 11203.7 11294.1 11323.0 8103.0 8321.7 8390.1 8527.3 8551.0 9084.7 9100.7 9120.0 9189.6 9222.1 8249.6 8282.6 8317.8 8396.5 8447.5 7894.4 7935.4 8055.4 8055.5 8130.6 7120.8 7256.5 7259.8 7263.1 7266.6 4926.2 5095.4 5171.4 5198.6 5346.9 5249.9 5336.0 5405.2 5542.4 5646.2 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | [#4] prototype.html Cycles:180 Average:4552.58 Median:5136.50 stddev:1327.11 (25.8%) stddev-sans-first:1292.42 06:14:16 INFO - PROCESS | 17362 | Values: 328.9 337.2 345.1 346.0 352.4 5192.9 5196.7 5212.9 5222.3 5237.8 5169.9 5184.4 5213.2 5219.4 5230.9 4144.2 4162.8 4163.7 4164.8 4208.0 3737.5 3894.8 4114.0 4150.3 4154.2 4068.9 4081.4 4089.6 4111.5 4127.9 3950.8 4145.3 4146.7 4148.0 4149.6 3493.1 3583.2 3591.5 3600.5 3626.6 5036.6 5039.3 5040.7 5080.3 5139.8 4649.5 4659.7 4668.7 4669.7 4684.3 5133.2 5371.1 5377.0 5408.5 5409.4 3921.4 3925.4 3934.4 3939.6 3944.1 5285.9 5458.7 5685.9 5701.7 5713.2 3872.9 3978.7 4014.4 4014.6 4019.3 4051.1 4055.4 4062.2 4064.9 4067.6 4648.7 4649.3 4651.3 4653.1 4690.3 5359.9 5384.3 5436.5 5463.4 5470.5 1367.9 1383.1 1383.8 1384.3 1384.5 873.7 909.8 910.6 930.6 932.8 4680.7 4683.1 4686.8 4743.3 4744.4 4961.9 4974.7 4976.6 4977.3 5001.9 4746.9 4753.7 4769.5 4769.7 4934.5 2928.7 2945.9 2954.1 2955.3 2975.9 5813.2 5826.2 5833.7 5837.6 5852.9 5518.2 5606.5 5646.9 5665.7 5731.3 5547.6 5676.7 5745.9 5838.1 5843.9 5571.3 5584.6 5591.3 5610.2 5635.7 5304.8 5482.5 5485.7 5550.2 5574.9 5793.9 5797.0 5805.0 5821.2 5834.9 4011.6 4032.8 4036.6 4062.2 4075.5 5521.3 5564.6 5565.6 5587.4 5674.9 5417.7 5428.6 5437.9 5491.5 5500.5 5277.0 5426.9 5456.3 5482.9 5518.5 5310.2 5387.5 5390.9 5398.0 5405.0 5454.8 5473.5 5474.2 5475.4 5514.0 5099.6 5328.0 5335.5 5352.7 5355.8 06:14:16 INFO - PROCESS | 17362 | 06:14:16 INFO - PROCESS | 17362 | [#5] yui.html Cycles:180 Average:21549.78 Median:3423.32 stddev:30776.42 (899.0%) stddev-sans-first:30823.18 06:14:16 INFO - PROCESS | 17362 | Values: 764.4 807.7 838.7 865.2 886.2 16053.8 17124.5 17409.1 17511.7 17653.6 15582.1 15725.1 15832.3 15851.0 15864.6 816.0 831.1 833.8 834.2 834.5 668.4 794.7 827.7 828.2 831.2 884.1 889.4 889.5 889.9 890.0 878.2 883.9 884.8 884.9 885.1 501.4 601.6 623.1 623.4 627.0 15091.7 15185.6 15190.1 15209.8 15216.3 14276.6 14651.3 15074.2 15156.2 15289.6 13516.5 13640.2 13702.5 13946.4 14114.3 4492.9 4568.4 4653.6 4685.9 4795.7 89125.1 89429.6 89667.6 90779.0 91122.5 12003.5 12011.2 12014.6 12153.0 12327.7 23109.2 23186.0 23303.3 23323.7 23984.6 8593.7 8748.4 8835.4 8884.1 8948.2 4695.5 4712.9 4750.7 4789.0 4803.7 3319.9 3411.8 3413.7 3419.5 3427.1 615.7 624.2 655.2 681.6 687.6 681.6 686.4 709.6 712.8 761.7 9889.4 10468.8 10521.4 10886.0 10941.6 741.7 757.6 763.8 780.0 789.0 5059.0 5354.7 5366.3 5390.5 5404.2 69461.3 109353.5 129523.0 131928.0 134067.0 64141.7 65209.7 68691.7 76175.6 101750.5 61773.0 98430.5 101820.0 103375.0 103733.5 10064.1 10364.7 10389.3 10517.5 10528.6 57255.7 57412.4 58119.4 58363.0 59331.4 76536.6 83364.6 83705.0 84373.0 87501.3 13035.5 13148.9 13159.0 13190.8 13618.7 14253.2 14573.2 14575.6 14930.3 15545.9 13963.3 14010.3 14123.9 14381.9 14612.3 13924.7 14071.1 14127.6 14175.6 14708.4 13749.2 13888.0 14079.9 14199.6 14510.1 11227.9 11293.4 11708.6 11725.4 11802.2 10047.8 11720.8 11919.8 12094.9 12212.7 06:14:16 INFO - PROCESS | 17362 | -------- Summary: end -------- 06:14:16 INFO - PROCESS | 17362 | 06:14:17 INFO - TEST-INFO | 17362: exit 0 06:14:17 INFO - TEST-OK | dromaeo_css | took 1116694ms 06:14:17 INFO - TEST-START | kraken 06:14:17 INFO - operating with platform_type : linux_ 06:14:17 INFO - Initialising browser for kraken test... 06:14:17 INFO - TEST-INFO | started process 17552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMW3KWR/profile http://localhost:46117/getInfo.html) 06:14:22 INFO - PROCESS | 17552 | __metrics Screen width/height:1600/1200 06:14:22 INFO - PROCESS | 17552 | colorDepth:24 06:14:22 INFO - PROCESS | 17552 | Browser inner width/height: 1024/697 06:14:22 INFO - PROCESS | 17552 | __metrics 06:14:23 INFO - PROCESS | 17552 | 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" 06:14:23 INFO - PROCESS | 17552 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:24 INFO - PROCESS | 17552 | console.error: PushService: 06:14:24 INFO - PROCESS | 17552 | stateChangeProcessEnqueue: Error transitioning state 06:14:24 INFO - PROCESS | 17552 | UnknownError 06:14:24 INFO - TEST-INFO | 17552: exit 0 06:14:24 INFO - Browser initialized. 06:14:24 INFO - Running cycle 1/1 for kraken test... 06:14:24 INFO - TEST-INFO | started process 17632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMW3KWR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:36 INFO - PROCESS | 17632 | RSS: Main: 156893184 06:14:36 INFO - PROCESS | 17632 | 06:14:38 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:39 INFO - PROCESS | 17632 | RSS: Main: 213463040 06:14:39 INFO - PROCESS | 17632 | 06:14:42 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-dft) 06:14:42 INFO - PROCESS | 17632 | RSS: Main: 192409600 06:14:42 INFO - PROCESS | 17632 | 06:14:46 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-fft) 06:14:46 INFO - PROCESS | 17632 | RSS: Main: 269553664 06:14:46 INFO - PROCESS | 17632 | 06:14:48 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46117/tests/kraken/driver.html?testName=audio-oscillator) 06:14:49 INFO - PROCESS | 17632 | RSS: Main: 179359744 06:14:49 INFO - PROCESS | 17632 | 06:14:51 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:52 INFO - PROCESS | 17632 | RSS: Main: 184737792 06:14:52 INFO - PROCESS | 17632 | 06:14:55 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:55 INFO - PROCESS | 17632 | RSS: Main: 219291648 06:14:55 INFO - PROCESS | 17632 | 06:14:59 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46117/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:59 INFO - PROCESS | 17632 | RSS: Main: 219697152 06:14:59 INFO - PROCESS | 17632 | 06:15:02 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46117/tests/kraken/driver.html?testName=json-parse-financial) 06:15:03 INFO - PROCESS | 17632 | RSS: Main: 220016640 06:15:03 INFO - PROCESS | 17632 | 06:15:04 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:15:05 INFO - PROCESS | 17632 | RSS: Main: 182411264 06:15:05 INFO - PROCESS | 17632 | 06:15:06 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:15:07 INFO - PROCESS | 17632 | RSS: Main: 190345216 06:15:07 INFO - PROCESS | 17632 | 06:15:09 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:15:10 INFO - PROCESS | 17632 | RSS: Main: 195166208 06:15:10 INFO - PROCESS | 17632 | 06:15:12 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:15:13 INFO - PROCESS | 17632 | RSS: Main: 188051456 06:15:13 INFO - PROCESS | 17632 | 06:15:16 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:15:16 INFO - PROCESS | 17632 | RSS: Main: 192524288 06:15:16 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | Cycle 1(1): loaded http://localhost:46117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46117/tests/kraken/driver.html?testName=ai-astar) 06:15:18 INFO - PROCESS | 17632 | RSS: Main: 243380224 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | __start_tp_report 06:15:18 INFO - PROCESS | 17632 | _x_x_mozilla_page_load 06:15:18 INFO - PROCESS | 17632 | _x_x_mozilla_page_load_details 06:15:18 INFO - PROCESS | 17632 | |i|pagename|runs| 06:15:18 INFO - PROCESS | 17632 | |0;ai-astar;101;110;111;110;111;111;110;109;110;111 06:15:18 INFO - PROCESS | 17632 | |1;audio-beat-detection;142;116;120;186;122;118;149;116;166;116 06:15:18 INFO - PROCESS | 17632 | |2;audio-dft;161;160;160;161;161;161;161;162;159;162 06:15:18 INFO - PROCESS | 17632 | |3;audio-fft;73;73;74;122;76;77;75;74;103;76 06:15:18 INFO - PROCESS | 17632 | |4;audio-oscillator;83;83;122;84;83;82;121;83;83;134 06:15:18 INFO - PROCESS | 17632 | |5;imaging-gaussian-blur;116;116;117;117;116;117;116;117;116;116 06:15:18 INFO - PROCESS | 17632 | |6;imaging-darkroom;145;145;145;145;146;147;145;146;145;145 06:15:18 INFO - PROCESS | 17632 | |7;imaging-desaturate;96;96;96;95;97;95;96;95;96;96 06:15:18 INFO - PROCESS | 17632 | |8;json-parse-financial;51;51;52;51;51;51;60;52;50;51 06:15:18 INFO - PROCESS | 17632 | |9;json-stringify-tinderbox;60;60;60;61;61;62;61;60;61;60 06:15:18 INFO - PROCESS | 17632 | |10;stanford-crypto-aes;76;75;75;75;74;75;74;83;81;80 06:15:18 INFO - PROCESS | 17632 | |11;stanford-crypto-ccm;120;127;129;131;120;132;119;120;148;122 06:15:18 INFO - PROCESS | 17632 | |12;stanford-crypto-pbkdf2;157;160;164;158;156;159;161;157;157;155 06:15:18 INFO - PROCESS | 17632 | |13;stanford-crypto-sha256-iterative;61;64;63;61;69;61;63;61;65;60 06:15:18 INFO - PROCESS | 17632 | __end_tp_report 06:15:18 INFO - PROCESS | 17632 | __start_cc_report 06:15:18 INFO - PROCESS | 17632 | _x_x_mozilla_cycle_collect,1752 06:15:18 INFO - PROCESS | 17632 | __end_cc_report 06:15:18 INFO - PROCESS | 17632 | __startTimestamp1470748518642__endTimestamp 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | ------- Summary: start ------- 06:15:18 INFO - PROCESS | 17632 | Number of tests: 14 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.03 (2.7%) stddev-sans-first:0.71 06:15:18 INFO - PROCESS | 17632 | Values: 101.0 110.0 111.0 110.0 111.0 111.0 110.0 109.0 110.0 111.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:132.00 stddev:24.88 (18.9%) stddev-sans-first:26.27 06:15:18 INFO - PROCESS | 17632 | Values: 142.0 116.0 120.0 186.0 122.0 118.0 149.0 116.0 166.0 116.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:15:18 INFO - PROCESS | 17632 | Values: 161.0 160.0 160.0 161.0 161.0 161.0 161.0 162.0 159.0 162.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#3] audio-fft Cycles:10 Average:82.30 Median:74.50 stddev:16.59 (22.3%) stddev-sans-first:17.25 06:15:18 INFO - PROCESS | 17632 | Values: 73.0 73.0 74.0 122.0 76.0 77.0 75.0 74.0 103.0 76.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:83.00 stddev:20.90 (25.2%) stddev-sans-first:21.64 06:15:18 INFO - PROCESS | 17632 | Values: 83.0 83.0 122.0 84.0 83.0 82.0 121.0 83.0 83.0 134.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:15:18 INFO - PROCESS | 17632 | Values: 116.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 06:15:18 INFO - PROCESS | 17632 | Values: 145.0 145.0 145.0 145.0 146.0 147.0 145.0 146.0 145.0 145.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:15:18 INFO - PROCESS | 17632 | Values: 96.0 96.0 96.0 95.0 97.0 95.0 96.0 95.0 96.0 96.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:51.00 stddev:2.87 (5.6%) stddev-sans-first:3.02 06:15:18 INFO - PROCESS | 17632 | Values: 51.0 51.0 52.0 51.0 51.0 51.0 60.0 52.0 50.0 51.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 06:15:18 INFO - PROCESS | 17632 | Values: 60.0 60.0 60.0 61.0 61.0 62.0 61.0 60.0 61.0 60.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:75.50 stddev:3.26 (4.3%) stddev-sans-first:3.44 06:15:18 INFO - PROCESS | 17632 | Values: 76.0 75.0 75.0 75.0 74.0 75.0 74.0 83.0 81.0 80.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:128.00 stddev:8.95 (7.0%) stddev-sans-first:9.15 06:15:18 INFO - PROCESS | 17632 | Values: 120.0 127.0 129.0 131.0 120.0 132.0 119.0 120.0 148.0 122.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:158.50 stddev:2.67 (1.7%) stddev-sans-first:2.79 06:15:18 INFO - PROCESS | 17632 | Values: 157.0 160.0 164.0 158.0 156.0 159.0 161.0 157.0 157.0 155.0 06:15:18 INFO - PROCESS | 17632 | 06:15:18 INFO - PROCESS | 17632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:2.70 (4.3%) stddev-sans-first:2.78 06:15:18 INFO - PROCESS | 17632 | Values: 61.0 64.0 63.0 61.0 69.0 61.0 63.0 61.0 65.0 60.0 06:15:18 INFO - PROCESS | 17632 | -------- Summary: end -------- 06:15:18 INFO - PROCESS | 17632 | 06:15:19 INFO - TEST-INFO | 17632: exit 0 06:15:19 INFO - TEST-OK | kraken | took 62004ms 06:15:19 INFO - SUITE-END | took 1178s 06:15:19 INFO - Completed test suite (00:19:38) 06:15:19 INFO - javascript benchmark 06:15:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.3141293209023, 3058.424911170746, 3061.142879993602, 3100.2714362124884, 3116.812991220527, 5217.765200565974, 5227.660202086871, 5319.494648008438, 5411.134218525031, 5422.240886275925, 5329.920051199226, 5354.250404943311, 5369.677819330843, 5392.56859451244, 5405.891882162355, 4835.903281934359, 4861.951380486185, 4889.119958407486, 4897.142999975008, 5002.224655178435, 4910.140725373063, 4913.754312284389, 4919.77860996256, 4934.062528119646, 4956.983818317236, 4800.759962001921, 4817.78319975602, 4875.293082503053, 4877.756112194376, 4915.262710593403, 4829.9275510867365, 4835.830745923911, 4848.2727590861305, 4912.410510738734, 4957.752112394366, 4831.0, 4860.270959356089, 4860.878478038042, 4904.068227036887, 4921.114199444099, 5173.3016042834115, 5247.47525247476, 5300.628955973083, 5369.167778994262, 5370.301860758115, 5663.122216056518, 5715.057015592464, 5715.31416230055, 5716.056850619642, 5717.313922329306, 5735.311762588516, 5747.683877386742, 5749.913751293734, 5759.280089988752, 5766.250387449605, 5196.1166601677805, 5326.6005049621435, 5352.090144675414, 5380.7309634518115, 5385.784568617211, 5918.615290006136, 5918.852028699317, 5919.881602367928, 5962.821115366546, 5964.284285885721, 5708.942910570924, 5712.371639119777, 5712.400197979152, 5714.685692286881, 5717.885642287131, 5573.219749235111, 5588.776448941997, 5634.070378387521, 5645.23789288449, 5778.682172480554, 5647.632903861236, 5658.91511627326, 5667.744951477193, 5668.688222147739, 5710.400407957188, 5617.9438205618235, 5663.915041274302, 5668.461496157858, 5670.943290567124, 5676.602637815396, 4297.67767417445, 4363.083752412029, 4363.7381757094045, 4423.8230470781455, 4435.778211089432, 3960.0, 3979.880603581897, 3979.9403008954887, 3980.024893901013, 3982.26328129297, 5375.650582712111, 5421.539169170585, 5427.864303392446, 5429.239906413105, 5438.91841622376, 5753.510951569164, 5775.768969241183, 5776.1624564437925, 5783.277090363705, 5824.592278540462, 5373.435789242073, 5402.135658294654, 5418.458154184629, 5425.941941321405, 5451.318585176853, 4817.78319975602, 4843.0, 4928.950710492921, 4987.4015118185325, 5017.724025178651, 5937.376575459601, 5940.55445841555, 5942.554308426886, 5973.820785376446, 5992.310884248367, 5624.831255062355, 5666.603337766317, 5671.631343962794, 5672.517835983987, 5684.886302274014, 5865.3254875689845, 5931.1992880960515, 5935.881282374415, 5939.732712027882, 5973.581849270509, 5630.071038278638, 5636.239107720406, 5643.830685079454, 5685.573581981451, 5690.8577285566535, 5742.36833948257, 5742.942570574241, 5750.769969201185, 5752.33848107473, 5757.827265182052, 5433.402325744244, 5501.889962200814, 5571.192177134212, 5630.521405680399, 5632.85917852057, 5629.380768115586, 5642.746076426489, 5648.265725455664, 5659.434056594472, 5672.858178545569, 5516.365617953987, 5536.446355364431, 5563.972180139235, 5585.972070139624, 5592.7203639817035, 5498.862528436821, 5567.66594004361, 5589.692566908859, 5638.041532939328, 5720.799772007959, 5533.723313834373, 5539.944600554104, 5541.224228607917, 5587.329520457572, 5593.692346920959], "value": 5282.790111436623, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.5252318864015, 567.7161419290358, 572.5677113779096, 584.1588113117111, 610.2432983100954, 45559.31661025083, 46189.53810461894, 46406.535934640684, 46424.30363544545, 50400.49599504004, 47462.288065679044, 48120.0, 48169.51830481703, 48193.759031204885, 48243.0, 9221.631134754602, 9373.578188981512, 9382.155605995458, 9383.343165978384, 9387.295952803566, 9167.083291670813, 9263.703081568587, 9266.0, 9266.305027122993, 9268.629254829832, 9301.534923253845, 9336.0, 9338.346315757899, 9371.156595906366, 9372.437653740762, 9242.353035287533, 9256.67601633943, 9275.814483710321, 9282.675106371245, 9286.489243091628, 9178.495182764946, 9244.768880777967, 9250.491222982733, 9250.629974801, 9258.444493330355, 43415.348769768476, 43696.0, 43762.56237437617, 43871.34192987108, 44058.33912491315, 3576.7317451191266, 3735.2902948439983, 3777.6411240932066, 3911.5306163260307, 4338.891527711801, 33885.0, 34415.82792086049, 34667.65332346669, 34825.65174348249, 35263.29473410543, 4446.244138496431, 4525.140223357552, 4531.841385551523, 4578.267477203664, 4687.695299805502, 258479.0, 258579.0, 258631.0, 258713.7064314685, 259105.0, 60923.69538152369, 60973.69513152406, 61029.694851525455, 61075.0, 61527.0, 64228.67885660542, 64405.355946440875, 64465.0, 64496.0, 64627.35372646213, 16833.0, 17108.572285692957, 17169.227384767717, 17184.484465466056, 17186.398476053277, 13181.934090329487, 13263.469461221635, 13269.336533173302, 13272.800907986388, 13291.069625126342, 16564.254608542644, 18148.0, 18155.818441815678, 18370.265189392274, 18419.447416577525, 6116.235470566179, 6211.720472578745, 6253.91615694467, 6327.746890124436, 6367.0, 950.2872845365976, 1001.1090129784498, 1014.9949250253849, 1024.6977141743203, 1067.423591260726, 33270.16824579357, 33548.0, 33969.49045764316, 34047.31905361879, 34412.82793586016, 908.318760929303, 1091.1979694924382, 1133.7052366384635, 1138.7437826488974, 1197.658667279821, 16515.504534863972, 17273.481795546155, 17319.0, 17353.132343382782, 17438.912805436146, 516421.0, 517752.0, 518073.0, 520786.0, 523052.0, 60283.69858150681, 60322.09516857251, 60432.395676043554, 60499.09251361233, 60509.0, 1242.739024804783, 1305.28209484783, 1337.304601607159, 1372.5196181336653, 1398.9020768546104, 33247.50128748119, 34591.481127783605, 34724.65275347315, 35397.82301088478, 35425.0, 51934.0, 52274.0, 52297.21554176766, 52353.0, 52364.0, 402464.0, 404414.0, 404434.0, 404502.0, 404694.0, 28745.85627071935, 29860.850695746383, 29914.401711966075, 31364.529532057495, 31473.37053258876, 49722.502774971785, 49833.25250121324, 50763.0, 50820.237696435324, 51568.22647660213, 41883.37174942439, 42376.364354535326, 42528.78735606426, 44369.0, 44534.109317812814, 41990.0, 42388.576114239695, 42503.574964249965, 42866.78566607147, 44611.0, 42970.1405971885, 44121.0, 44129.55870441383, 44285.557144428145, 44470.777646111565, 36018.63981360153, 36862.26275474422, 38158.427623585114, 38342.23315533618, 38614.613853862225, 28963.0, 29367.0, 29376.26559336034, 29478.852605736833, 29492.705072948997], "value": 20508.102434117092, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.31893931453715, 382.83920753283616, 404.0968435546554, 411.7303166425991, 413.3881854854815, 14399.136051836897, 17768.200430980603, 19765.308214212506, 19844.107015184316, 19862.20551177951, 19644.31244906425, 19651.901740491277, 19727.90136049321, 19842.20631174751, 19933.601327973432, 5640.294963129609, 5726.599138060348, 5802.912956305659, 5923.940760592382, 5924.022536281508, 5803.071508558632, 5880.794172203974, 5887.646741195521, 5892.234009578749, 5892.823215303526, 5646.632968857011, 5779.566532510057, 5825.533957283428, 5860.208871802295, 5869.413058694117, 5771.163181338703, 5800.651960882318, 5809.709514524278, 5811.883762324751, 5814.273215848019, 5196.818111366084, 5205.739713014372, 5431.945680543184, 5448.046591846451, 5535.363433205152, 14266.0, 14346.856531434656, 14446.927765361106, 21487.892560537097, 23533.0, 2262.6266666000092, 2284.5202507473286, 2291.194091340023, 2295.91964281251, 2301.9309420717404, 11024.834627480594, 11040.061594764455, 11401.0, 13451.86548134516, 15543.689126217525, 1902.8192321729414, 1941.7475728155391, 1991.3727175939532, 2002.7596688397487, 2044.2947183221765, 59263.40736592622, 70064.29935700628, 79812.0, 84919.57540212321, 88464.55767721185, 11222.158338124673, 11247.550097996153, 11286.54853805855, 11367.09063274936, 11629.88370116288, 16180.0, 16207.837921620869, 16226.0, 16234.18829058566, 16256.75614865778, 8044.316233120133, 8157.510549366938, 8188.5496297703, 8203.915936044308, 8238.711645092393, 7679.539227646359, 7790.1041380241995, 7960.761177164694, 7977.162397948132, 8011.278984891388, 4845.176320025604, 4918.458969513351, 4940.901181976412, 4994.576545684463, 5036.244563315532, 1987.8906660133832, 2046.2224354745101, 2056.7120603115577, 2060.958780824375, 2082.2607974169255, 878.8549889268327, 961.8364877970762, 988.7182153086336, 990.4453506036642, 1057.9682609521726, 20023.29918452847, 20468.79531204669, 20484.897575512026, 20494.282700105425, 20585.485362865747, 979.583676937313, 998.1615443027891, 1027.9691609251734, 1029.7940411917646, 1049.197364016528, 9456.763580910532, 11287.820982759658, 11309.377984210783, 11331.773364532828, 11428.371439570737, 489499.0, 493713.0, 495751.0, 504346.0, 507727.0, 57837.71081144567, 75022.62488687522, 92199.0, 93846.53076734573, 94215.52892235632, 959.0840747086515, 976.4678250353575, 998.0668075349571, 1000.2298230362726, 1006.8942761010135, 17565.560860978578, 17808.807948343907, 18362.357317493825, 18431.631367372847, 18781.624367512846, 45707.77146114248, 45737.542624573325, 45887.54112458833, 46994.29508557443, 46998.53001469941, 61040.0, 62021.0, 62511.0, 62878.0, 63280.36719632929, 8779.648814047367, 8898.288136949159, 8942.68700595476, 9007.909920900707, 9199.77000574991, 10105.343152695345, 13450.327483625584, 13560.05079644455, 13830.723385532032, 14320.427182912566, 11678.299302041565, 11765.0, 11845.466953987263, 12171.330576818005, 12340.50637974507, 11643.12676549279, 11715.297082175097, 11779.469923853618, 11864.466099025392, 11946.581869634869, 11532.481038353462, 11925.4037298133, 12056.095792815398, 12632.557860474839, 12871.806922895978, 8050.355971522147, 8372.832543348977, 9051.185393314634, 9296.349255552046, 9353.25173986093, 5983.012802887649, 11264.15518836107, 12406.751864962831, 12712.474503059691, 12723.300218487702], "value": 9307.442123387675, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.5841089262324, 1484.2430360516137, 1537.9461718839843, 1661.2524364036178, 1788.141691987846, 8811.251043661288, 9145.77135571611, 9190.218831399323, 9436.433813971167, 9451.669191578296, 9242.445453272792, 9334.579943902523, 9389.953050234739, 9395.060493950601, 9397.62409503619, 2460.483298507316, 2490.6762120924345, 2491.2401717476164, 2491.402063504764, 2492.9252122436355, 2378.4172877645, 2464.4824586836694, 2471.7651823076867, 2472.7156377016604, 2475.616279476684, 2399.7960173385195, 2419.4677171022436, 2456.435019945414, 2459.557279689655, 2461.593837016899, 2400.6639070530055, 2419.9516009679883, 2423.1155628195756, 2431.4407686232266, 2432.7567243275707, 2354.128972280267, 2365.053978408633, 2366.02992772964, 2374.5013547155118, 2376.346504711201, 9264.583093760797, 9359.15767580921, 9361.625534978593, 9429.858552121723, 9547.188488978445, 5512.862178445531, 5659.8585035374035, 5668.801591944262, 5672.886542269172, 5675.517581005578, 3605.3330133925306, 3684.336819372512, 3756.6243375662216, 3807.4859893914245, 3808.866689665876, 1205.9698507537382, 1221.1377649085127, 1224.9142560020803, 1249.6188662457946, 1252.2674235572201, 13022.0, 13028.739425211537, 13103.672408189872, 13109.86890131096, 13110.672233194056, 4691.856741711428, 4782.187028205144, 4795.736234507136, 4874.122657921608, 4934.7285899275885, 10295.691129265984, 10297.897021029694, 10305.0, 10305.484725763681, 10315.381077135396, 5457.181422786613, 5472.589555783332, 5491.176323551419, 5491.862703432446, 5517.062099443024, 4226.5773422657485, 4557.886052848639, 4664.224542847336, 5022.196448568212, 5131.461196574381, 3962.5244970603712, 3974.2647610192207, 4070.4911886014247, 4085.0604360997136, 4093.9795301023305, 1205.2523840431409, 1238.3684320996356, 1249.7562975219926, 1251.268008215186, 1263.3493750718387, 817.7791996161003, 954.1412728544227, 979.8677178580942, 1007.4106647611083, 1021.9437930913871, 6062.393760623902, 6177.722002509898, 6190.071489276645, 6284.905726414107, 6486.286508484063, 493.73585131954235, 496.6895690193629, 503.89922015596295, 514.3981541596341, 514.7080827123871, 4306.612404883513, 4317.309230523101, 4416.823327066945, 4508.661850361236, 4514.210013247669, 11455.713607159887, 11911.285322880482, 11929.28424294545, 11935.343556104497, 11974.700632484257, 11031.172662050378, 11747.236429632047, 11796.410179490991, 11813.645590632295, 11892.702682433008, 8413.368997325226, 8829.779255518664, 8836.0, 8850.247728942983, 8853.911460885309, 6434.163558737521, 6454.1609590752905, 6540.574862633914, 6582.341765823379, 6735.4611631070375, 10675.572977081141, 10880.347179169275, 10885.258358662893, 11013.394263315595, 11030.172737044593, 10005.449700266556, 11155.219134660496, 11203.663890083311, 11294.096472282034, 11323.0, 8103.027636683636, 8321.667133314842, 8390.119037500974, 8527.275181609633, 8551.016633087274, 9084.727458176265, 9100.726978190665, 9120.0, 9189.586468608795, 9222.123898229658, 8249.558094953665, 8282.585870706562, 8317.83364332722, 8396.538190399586, 8447.45091569046, 7894.447388682966, 7935.365170786438, 8055.436119471581, 8055.476394034369, 8130.552819594979, 7120.786376408716, 7256.528325658815, 7259.782206533812, 7263.055802745609, 7266.600336981517, 4926.211806111005, 5095.439501654889, 5171.379434467737, 5198.558122559473, 5346.866328341823, 5249.921251181312, 5336.012837625051, 5405.189221616789, 5542.3626282977975, 5646.153077038312], "value": 4788.930023330966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.9394122626678, 337.1756056441999, 345.0614329025052, 345.97763608536775, 352.39564147487073, 5192.948785229832, 5196.714180720059, 5212.895742085166, 5222.34720659918, 5237.816676416326, 5169.922451163236, 5184.403793563742, 5213.1919552469335, 5219.373675158977, 5230.8692282692955, 4144.150449157931, 4162.7918604069755, 4163.7293575917465, 4164.833406663745, 4208.0, 3737.5423584801947, 3894.7926142895653, 4113.9794301028605, 4150.252954468195, 4154.210699967011, 4068.8982775430554, 4081.4081958116053, 4089.6114869087537, 4111.527174374955, 4127.855525056623, 3950.802459876995, 4145.253854306224, 4146.709730318879, 4147.979260103711, 4149.585041495841, 3493.1092571394133, 3583.2475180212186, 3591.5331006969186, 3600.5499312585926, 3626.6373362663785, 5036.597072234213, 5039.3196918415915, 5040.747962601892, 5080.288759573663, 5139.7687104080405, 4649.488556258809, 4659.673822832403, 4668.696534725232, 4669.696469729491, 4684.320773487825, 5133.230015497668, 5371.14061750122, 5376.973115134439, 5408.513233808976, 5409.377921538995, 3921.372580387153, 3925.3523168677134, 3934.429507721393, 3939.6454319111417, 3944.073142811437, 5285.891797005993, 5458.727063646841, 5685.886282274373, 5701.71491425427, 5713.228714123582, 3872.9225415491533, 3978.741381810173, 4014.3777714454304, 4014.578469260744, 4019.296623091006, 4051.0682543015273, 4055.41196526502, 4062.2484840304637, 4064.861838685173, 4067.593240675909, 4648.721076735406, 4649.279361698942, 4651.3023046543285, 4653.115907977541, 4690.296455531698, 5359.892802144013, 5384.326959130109, 5436.510714035756, 5463.399026107125, 5470.507654311052, 1367.8974076944269, 1383.1078954074565, 1383.833939927195, 1384.2940100548792, 1384.532395660603, 873.7160422862595, 909.7589138878203, 910.5902343945252, 930.6277489004317, 932.8367535681228, 4680.672352935262, 4683.1336202802595, 4686.789094490756, 4743.335932969387, 4744.410622441452, 4961.858772482349, 4974.726390048582, 4976.60655016596, 4977.257959714071, 5001.949980500149, 4746.928796068062, 4753.667243293005, 4769.497608253389, 4769.73766442849, 4934.481879402683, 2928.677845437, 2945.867435965387, 2954.1432984434273, 2955.3350496138196, 2975.8512074396194, 5813.157092221604, 5826.155207494974, 5833.7083145842535, 5837.591368604157, 5852.882942341214, 5518.227448157261, 5606.495415412633, 5646.927083854054, 5665.677072400296, 5731.312242530839, 5547.639403438763, 5676.659400435905, 5745.88508229833, 5838.095095260242, 5843.883122337445, 5571.303587051619, 5584.636998595241, 5591.30108736408, 5610.242617246783, 5635.690037047838, 5304.761285742228, 5482.451754824486, 5485.670859748428, 5550.167474878801, 5574.9163762542785, 5793.929217514724, 5796.971015145066, 5804.984127777707, 5821.155932389865, 5834.94165058344, 4011.618896204856, 4032.798360082043, 4036.616521430459, 4062.1672557125125, 4075.470188875427, 5521.282233309644, 5564.55483561306, 5565.638233514808, 5587.385387607441, 5674.914876276776, 5417.674939503642, 5428.59285553593, 5437.891242175056, 5491.478309560585, 5500.532454741232, 5277.0, 5426.945730542644, 5456.345238571397, 5482.945170548243, 5518.530924871431, 5310.221075939604, 5387.515123638891, 5390.892182156256, 5397.973010134924, 5405.027165084794, 5454.836354909359, 5473.534749546333, 5474.151506516497, 5475.397706252229, 5514.0, 5099.592032637454, 5328.0, 5335.519803217729, 5352.678839269656, 5355.758990845344], "value": 4133.980129609737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [764.3503022430932, 807.6607824713619, 838.6704782015397, 865.2472349056326, 886.2422628652502, 16053.839461605381, 17124.48626541206, 17409.12749396351, 17511.737323940135, 17653.558661033465, 15582.142982135978, 15725.135117568529, 15832.287547060381, 15851.0, 15864.603384915354, 816.0166998766501, 831.1148626712562, 833.7540425574471, 834.1616675241374, 834.5076404921095, 668.36505319946, 794.7099308752322, 827.6937533112757, 828.2380210206625, 831.1688311688312, 884.0938038510546, 889.3952112563454, 889.4885440871492, 889.915458031486, 889.9777505562348, 878.2403221213636, 883.9204471597587, 884.8407286688393, 884.8628462588309, 885.0574138542431, 501.4008260129147, 601.629997551507, 623.0654018971543, 623.4171050068201, 626.9843253918689, 15091.698166036727, 15185.620359490991, 15190.088594684354, 15209.771853422208, 15216.315265813066, 14276.57170284893, 14651.340689668883, 15074.170920599363, 15156.24218789056, 15289.6177595561, 13516.459341626323, 13640.181589104686, 13702.52041178564, 13946.372413241428, 14114.294285285798, 4492.8876778080485, 4568.406107206075, 4653.627709783209, 4685.88285292867, 4795.71225726454, 89125.10874891233, 89429.55285223597, 89667.55166224192, 90779.0, 91122.5443872783, 12003.51985920571, 12011.159218854596, 12014.63956081319, 12153.0, 12327.6918077047, 23109.19117830868, 23186.0, 23303.30090097266, 23323.650145247833, 23984.64023039656, 8593.695775038928, 8748.387612867165, 8835.381523293436, 8884.067172946876, 8948.194662480408, 4695.483496815347, 4712.858614241578, 4750.667453278237, 4788.95211047892, 4803.735794531264, 3319.93360132796, 3411.778234414755, 3413.74396920232, 3419.5212670226188, 3427.1260828488575, 615.6860001399318, 624.2446639566176, 655.2333769489709, 681.6387314723205, 687.5805758487319, 681.5637991685326, 686.4405509509834, 709.5742554467279, 712.7782423446098, 761.7143571160815, 9889.357191782512, 10468.842967355497, 10521.421321827373, 10886.0, 10941.56233750641, 741.7366834773685, 757.5984728094119, 763.8052296664315, 779.9727009554638, 788.9526628402314, 5059.0, 5354.680633673599, 5366.329208848894, 5390.535223038612, 5404.162354834928, 69461.3053869465, 109353.45323273333, 129523.0, 131928.0, 134067.0, 64141.67929160324, 65209.673951629935, 68691.65654171698, 76175.61912190403, 101750.4912475433, 61773.0, 98430.5078474603, 101820.0, 103375.0, 103733.48133259437, 10064.144547713526, 10364.74088147772, 10389.272750907667, 10517.488381844143, 10528.631497897537, 57255.71372143113, 57412.42587574238, 58119.4188058114, 58363.0, 59331.40668593259, 76536.61731691306, 83364.58317708372, 83705.0, 84373.0, 87501.31241469285, 13035.47858085704, 13148.934255328662, 13159.0, 13190.802137967747, 13618.659533511742, 14253.216073116078, 14573.198474084027, 14575.635609109857, 14930.328135234158, 15545.922270388575, 13963.30183490801, 14010.299485025911, 14123.929380353033, 14381.856181438052, 14612.269386530419, 13924.721505570034, 14071.085379450304, 14127.64680882945, 14175.64560885986, 14708.41166353334, 13749.175049497062, 13888.0, 14079.929600351932, 14199.64500887486, 14510.056846304957, 11227.887721122685, 11293.43532823372, 11708.590199342982, 11725.355105469282, 11802.173847830569, 10047.799044019224, 11720.824187637363, 11919.761604767682, 12094.879051209375, 12212.694682633006], "value": 7913.458011011764, "unit": "score"}], "name": "dromaeo_css", "value": 7352.580171761236, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 109.0, 110.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 120.0, 186.0, 122.0, 118.0, 149.0, 116.0, 166.0, 116.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 159.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 122.0, 76.0, 77.0, 75.0, 74.0, 103.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 122.0, 84.0, 83.0, 82.0, 121.0, 83.0, 83.0, 134.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 146.0, 147.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 51.0, 51.0, 60.0, 52.0, 50.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 75.0, 74.0, 75.0, 74.0, 83.0, 81.0, 80.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 127.0, 129.0, 131.0, 120.0, 132.0, 119.0, 120.0, 148.0, 122.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 164.0, 158.0, 156.0, 159.0, 161.0, 157.0, 157.0, 155.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 63.0, 61.0, 69.0, 61.0, 63.0, 61.0, 65.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1478.3999999999999, "alertThreshold": 2.0}]} 06:15:19 INFO - Return code: 0 06:15:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:15:19 INFO - # TBPL SUCCESS # 06:15:19 INFO - Running post-action listener: _resource_record_post_action 06:15:19 INFO - [mozharness: 2016-08-09 13:15:19.955026Z] Finished run-tests step (success) 06:15:19 INFO - Running post-run listener: _resource_record_post_run 06:15:20 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560058368; Read time: 12; Write time: 1043284 06:15:20 INFO - TinderboxPrint: CPU usage
13.1% 06:15:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:15:20 INFO - TinderboxPrint: I/O write bytes / time
560,058,368 / 1,043,284 06:15:20 INFO - TinderboxPrint: CPU idle
8,293.1 (86.9%) 06:15:20 INFO - TinderboxPrint: CPU user
1,196.3 (12.5%) 06:15:20 INFO - TinderboxPrint: Swap in / out
0 / 0 06:15:20 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 267034624; Read time: 0; Write time: 548772 06:15:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 292843520; Read time: 0; Write time: 494468 06:15:20 INFO - Running post-run listener: _upload_blobber_files 06:15:20 INFO - Blob upload gear active. 06:15:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:15:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:15:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:15:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:15:20 INFO - (blobuploader) - INFO - Open directory for files ... 06:15:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:15:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:21 INFO - (blobuploader) - INFO - Done attempting. 06:15:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:15:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:15:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:22 INFO - (blobuploader) - INFO - Done attempting. 06:15:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:15:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:15:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:15:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:15:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:15:26 INFO - (blobuploader) - INFO - Done attempting. 06:15:26 INFO - (blobuploader) - INFO - Iteration through files over. 06:15:26 INFO - Return code: 0 06:15:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:15:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:15:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f414344f51733516abded1a8eb50de15e9edcdc209ae6408ca36bb8659259bc7576be3731c5109d7b9329b75b6012c1646bec852da0d2babd591256efb12dab3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65110ce34bd069a364514cfe2c2976ed7df8cee9275c2a549763e219f6517bd67aea13bb361d357047f0420009e8f50ecba9adceac0ab1ff00700a36a2508682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb2b28c5377f86eaf5c9bb07965fc55a3f21361785920a72e1c3b135608e1cf608293438a38341197a88fa28e07e1333d297cc7f7d24f21ee501d02812f47d4f"} 06:15:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:15:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:15:26 INFO - Contents: 06:15:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f414344f51733516abded1a8eb50de15e9edcdc209ae6408ca36bb8659259bc7576be3731c5109d7b9329b75b6012c1646bec852da0d2babd591256efb12dab3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65110ce34bd069a364514cfe2c2976ed7df8cee9275c2a549763e219f6517bd67aea13bb361d357047f0420009e8f50ecba9adceac0ab1ff00700a36a2508682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb2b28c5377f86eaf5c9bb07965fc55a3f21361785920a72e1c3b135608e1cf608293438a38341197a88fa28e07e1333d297cc7f7d24f21ee501d02812f47d4f"} 06:15:26 INFO - Running post-run listener: copy_logs_to_upload_dir 06:15:26 INFO - Copying logs to upload dir... 06:15:26 INFO - mkdir: /builds/slave/test/build/upload/logs 06:15:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.163433 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-09 06:15:26.097276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 06:15:26.100580) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f414344f51733516abded1a8eb50de15e9edcdc209ae6408ca36bb8659259bc7576be3731c5109d7b9329b75b6012c1646bec852da0d2babd591256efb12dab3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65110ce34bd069a364514cfe2c2976ed7df8cee9275c2a549763e219f6517bd67aea13bb361d357047f0420009e8f50ecba9adceac0ab1ff00700a36a2508682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb2b28c5377f86eaf5c9bb07965fc55a3f21361785920a72e1c3b135608e1cf608293438a38341197a88fa28e07e1333d297cc7f7d24f21ee501d02812f47d4f"} build_url:https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/ZLlqA_-8ToKz51FHIbX6TA/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/Firefox/sha512/f414344f51733516abded1a8eb50de15e9edcdc209ae6408ca36bb8659259bc7576be3731c5109d7b9329b75b6012c1646bec852da0d2babd591256efb12dab3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/65110ce34bd069a364514cfe2c2976ed7df8cee9275c2a549763e219f6517bd67aea13bb361d357047f0420009e8f50ecba9adceac0ab1ff00700a36a2508682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb2b28c5377f86eaf5c9bb07965fc55a3f21361785920a72e1c3b135608e1cf608293438a38341197a88fa28e07e1333d297cc7f7d24f21ee501d02812f47d4f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 06:15:26.125675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 06:15:26.125972) ========= 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=5cf47e208febbcd81da23b2e0000026f-1470746354.190926-1537770935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 06:15:26.210758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 06:15:26.211058) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 06:15:26.211335) ========= ========= Total master_lag: 0.18 =========