builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1472209832.73 results: success (0) buildid: 20160826011017 builduid: f73c012d33a043acaeec5470223163a4 revision: 468244986b20a0bdf22a5e36b55ae43ac09599c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.725794) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.726654) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.727262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.744448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.744976) ========= 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=eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-26 04:10:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.0M=0s 2016-08-26 04:10:33 (67.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098162 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.860743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.861414) ========= 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=eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021080 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.913926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:32.914702) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 468244986b20a0bdf22a5e36b55ae43ac09599c8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 468244986b20a0bdf22a5e36b55ae43ac09599c8 --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=eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-26 04:10:33,437 truncating revision to first 12 chars 2016-08-26 04:10:33,437 Setting DEBUG logging. 2016-08-26 04:10:33,437 attempt 1/10 2016-08-26 04:10:33,437 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/468244986b20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-26 04:10:33,698 unpacking tar archive at: larch-468244986b20/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:33.478667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:33.479109) ========= script_repo_revision: 468244986b20a0bdf22a5e36b55ae43ac09599c8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:33.479661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:33.480018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-26 04:10:33.489544) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-26 04:10:33.489848) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:10:34 INFO - MultiFileLogger online at 20160826 04:10:34 in /builds/slave/test 04:10:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 04:10:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:10:34 INFO - {'append_to_log': False, 04:10:34 INFO - 'base_work_dir': '/builds/slave/test', 04:10:34 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 04:10:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:10:34 INFO - 'branch': 'Larch-Non-PGO', 04:10:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:10:34 INFO - 'config_files': ('talos/linux_config.py',), 04:10:34 INFO - 'default_actions': ('clobber', 04:10:34 INFO - 'read-buildbot-config', 04:10:34 INFO - 'download-and-extract', 04:10:34 INFO - 'populate-webroot', 04:10:34 INFO - 'create-virtualenv', 04:10:34 INFO - 'install', 04:10:34 INFO - 'run-tests'), 04:10:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:10:34 INFO - 'download_minidump_stackwalk': True, 04:10:34 INFO - 'download_symbols': 'ondemand', 04:10:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:10:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:10:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:10:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:10:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:10:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:10:34 INFO - 'installer_path': 'installer.exe', 04:10:34 INFO - 'log_level': 'info', 04:10:34 INFO - 'log_name': 'talos', 04:10:34 INFO - 'log_to_console': True, 04:10:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:10:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:10:34 INFO - 'opt_config_files': (), 04:10:34 INFO - 'pip_index': False, 04:10:34 INFO - 'sps_profile': False, 04:10:34 INFO - 'sps_profile_interval': 0, 04:10:34 INFO - 'suite': 'dromaeojs', 04:10:34 INFO - 'system_bits': '32', 04:10:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:10:34 INFO - 'title': 'talos-linux64-ix-010', 04:10:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:10:34 INFO - 'use_talos_json': True, 04:10:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:10:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:10:34 INFO - 'work_dir': 'build'} 04:10:34 INFO - [mozharness: 2016-08-26 11:10:34.111598Z] Running clobber step. 04:10:34 INFO - Running pre-action listener: _resource_record_pre_action 04:10:34 INFO - Running main action method: clobber 04:10:34 INFO - rmtree: /builds/slave/test/build 04:10:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:10:35 INFO - Running post-action listener: _resource_record_post_action 04:10:35 INFO - [mozharness: 2016-08-26 11:10:35.140841Z] Finished clobber step (success) 04:10:35 INFO - [mozharness: 2016-08-26 11:10:35.140942Z] Running read-buildbot-config step. 04:10:35 INFO - Running pre-action listener: _resource_record_pre_action 04:10:35 INFO - Running main action method: read_buildbot_config 04:10:35 INFO - Using buildbot properties: 04:10:35 INFO - { 04:10:35 INFO - "project": "", 04:10:35 INFO - "product": "firefox", 04:10:35 INFO - "script_repo_revision": "production", 04:10:35 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 04:10:35 INFO - "repository": "", 04:10:35 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 04:10:35 INFO - "buildid": "20160826011017", 04:10:35 INFO - "pgo_build": "False", 04:10:35 INFO - "basedir": "/builds/slave/test", 04:10:35 INFO - "buildnumber": 1, 04:10:35 INFO - "slavename": "talos-linux64-ix-010", 04:10:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:10:35 INFO - "platform": "ubuntu64_hw", 04:10:35 INFO - "scheduler": "tests-larch-linux64-talos", 04:10:35 INFO - "branch": "larch", 04:10:35 INFO - "repo_path": "projects/larch", 04:10:35 INFO - "revision": "468244986b20a0bdf22a5e36b55ae43ac09599c8", 04:10:35 INFO - "stage_platform": "linux64", 04:10:35 INFO - "builduid": "f73c012d33a043acaeec5470223163a4", 04:10:35 INFO - "slavebuilddir": "test" 04:10:35 INFO - } 04:10:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:10:35 INFO - Running post-action listener: _resource_record_post_action 04:10:35 INFO - [mozharness: 2016-08-26 11:10:35.143402Z] Finished read-buildbot-config step (success) 04:10:35 INFO - [mozharness: 2016-08-26 11:10:35.143489Z] Running download-and-extract step. 04:10:35 INFO - Running pre-action listener: _resource_record_pre_action 04:10:35 INFO - Running main action method: download_and_extract 04:10:35 INFO - mkdir: /builds/slave/test/build/tests 04:10:35 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')]} 04:10:35 INFO - trying https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:10:35 INFO - Downloading https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:35 INFO - Downloaded 1361 bytes. 04:10:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:10:35 INFO - Using the following test package requirements: 04:10:35 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:10:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:10:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'jsshell-linux-x86_64.zip'], 04:10:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:10:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:10:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:10:35 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:10:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:10:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:10:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:10:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:10:35 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')]} 04:10:35 INFO - trying https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:10:35 INFO - Downloading https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:36 INFO - Downloaded 20330692 bytes. 04:10:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 04:10:40 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 04:10: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')]} 04:10:40 INFO - trying https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:10:40 INFO - Downloading https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:41 INFO - Downloaded 20330692 bytes. 04:10:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 04:10:46 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')]} 04:10:46 INFO - trying https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:10:46 INFO - Downloading https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:47 INFO - Downloaded 14413981 bytes. 04:10:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 04:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:47 INFO - trying https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:10:47 INFO - Downloading https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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 04:10:48 INFO - Downloaded 55749184 bytes. 04:10:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:10:48 INFO - mkdir: /builds/slave/test/properties 04:10:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:10:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:10:48 INFO - Contents: 04:10:48 INFO - build_url:https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:10:49 INFO - Running post-action listener: _resource_record_post_action 04:10:49 INFO - Running post-action listener: set_extra_try_arguments 04:10:49 INFO - [mozharness: 2016-08-26 11:10:49.036909Z] Finished download-and-extract step (success) 04:10:49 INFO - [mozharness: 2016-08-26 11:10:49.037133Z] Running populate-webroot step. 04:10:49 INFO - Running pre-action listener: _resource_record_pre_action 04:10:49 INFO - Running main action method: populate_webroot 04:10:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:10:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:10:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:10:49 INFO - '--tppagecycles', 04:10:49 INFO - '7'], 04:10:49 INFO - 'tests': ['tsvgm']}}, 04:10:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:10:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:10:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:10:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:10:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:10:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['damp', 'tps']}, 04:10:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'tests': ['damp', 'tps']}, 04:10:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['dromaeo_dom']}, 04:10:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:10:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['basic_compositor_video']}, 04:10:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:10:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['a11yr', 04:10:49 INFO - 'ts_paint', 04:10:49 INFO - 'tpaint', 04:10:49 INFO - 'sessionrestore', 04:10:49 INFO - 'sessionrestore_no_auto_restore', 04:10:49 INFO - 'tabpaint']}, 04:10:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:10:49 INFO - 'ts_paint', 04:10:49 INFO - 'tpaint', 04:10:49 INFO - 'sessionrestore', 04:10:49 INFO - 'sessionrestore_no_auto_restore', 04:10:49 INFO - 'tabpaint']}, 04:10:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:10:49 INFO - 'ts_paint', 04:10:49 INFO - 'tpaint', 04:10:49 INFO - 'sessionrestore', 04:10:49 INFO - 'sessionrestore_no_auto_restore', 04:10:49 INFO - 'tabpaint']}, 04:10:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:10:49 INFO - 'ts_paint', 04:10:49 INFO - 'tpaint', 04:10:49 INFO - 'sessionrestore', 04:10:49 INFO - 'sessionrestore_no_auto_restore', 04:10:49 INFO - 'tabpaint']}, 04:10:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['a11yr', 04:10:49 INFO - 'ts_paint', 04:10:49 INFO - 'tpaint', 04:10:49 INFO - 'sessionrestore', 04:10:49 INFO - 'sessionrestore_no_auto_restore', 04:10:49 INFO - 'tabpaint']}, 04:10:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['a11yr', 04:10:49 INFO - 'ts_paint', 04:10:49 INFO - 'tpaint', 04:10:49 INFO - 'sessionrestore', 04:10:49 INFO - 'sessionrestore_no_auto_restore', 04:10:49 INFO - 'tabpaint']}, 04:10:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['tsvgx', 04:10:49 INFO - 'tsvgr_opacity', 04:10:49 INFO - 'tart', 04:10:49 INFO - 'tscrollx', 04:10:49 INFO - 'cart']}, 04:10:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:10:49 INFO - 'tsvgr_opacity', 04:10:49 INFO - 'tart', 04:10:49 INFO - 'tscrollx', 04:10:49 INFO - 'cart']}, 04:10:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'talos_options': ['--disable-e10s'], 04:10:49 INFO - 'tests': ['tp5o']}, 04:10:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'tests': ['tp5o']}, 04:10:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'talos_options': ['--disable-e10s', 04:10:49 INFO - '--xperf_path', 04:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:49 INFO - 'tests': ['tp5n']}, 04:10:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:10:49 INFO - 'talos_options': ['--xperf_path', 04:10:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:10:49 INFO - 'tests': ['tp5n']}}, 04:10:49 INFO - 'talos.zip': {'path': '', 04:10:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:10:49 INFO - Running post-action listener: _resource_record_post_action 04:10:49 INFO - [mozharness: 2016-08-26 11:10:49.058179Z] Finished populate-webroot step (success) 04:10:49 INFO - [mozharness: 2016-08-26 11:10:49.058267Z] Running create-virtualenv step. 04:10:49 INFO - Running pre-action listener: _resource_record_pre_action 04:10:49 INFO - Running main action method: create_virtualenv 04:10:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:10:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:10:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:10:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:10:49 INFO - Using real prefix '/usr' 04:10:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:10:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:10:51 INFO - Installing pip.................done. 04:10:51 INFO - Return code: 0 04:10:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:10:51 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')]} 04:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 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')]} 04:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:10:51 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 04:10:51 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 04:10:51 INFO - Using env: {'DISPLAY': ':0', 04:10:51 INFO - 'HOME': '/home/cltbld', 04:10:51 INFO - 'LANG': 'en_US.UTF-8', 04:10:51 INFO - 'LANGUAGE': 'en_US:en', 04:10:51 INFO - 'LOGNAME': 'cltbld', 04:10:51 INFO - 'MAIL': '/var/mail/cltbld', 04:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:51 INFO - 'MOZ_NO_REMOTE': '1', 04:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:51 INFO - 'NO_EM_RESTART': '1', 04:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:51 INFO - 'PWD': '/builds/slave/test', 04:10:51 INFO - 'SHELL': '/bin/bash', 04:10:51 INFO - 'SHLVL': '1', 04:10:51 INFO - 'TERM': 'linux', 04:10:51 INFO - 'TMOUT': '86400', 04:10:51 INFO - 'USER': 'cltbld', 04:10:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:51 INFO - '_': '/tools/buildbot/bin/python'} 04:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:51 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 04:10:51 INFO - Cleaning up... 04:10:51 INFO - Return code: 0 04:10:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:10:51 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')]} 04:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 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')]} 04:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:51 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:10:51 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 04:10:51 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 04:10:51 INFO - Using env: {'DISPLAY': ':0', 04:10:51 INFO - 'HOME': '/home/cltbld', 04:10:51 INFO - 'LANG': 'en_US.UTF-8', 04:10:51 INFO - 'LANGUAGE': 'en_US:en', 04:10:51 INFO - 'LOGNAME': 'cltbld', 04:10:51 INFO - 'MAIL': '/var/mail/cltbld', 04:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:51 INFO - 'MOZ_NO_REMOTE': '1', 04:10:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:51 INFO - 'NO_EM_RESTART': '1', 04:10:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:51 INFO - 'PWD': '/builds/slave/test', 04:10:51 INFO - 'SHELL': '/bin/bash', 04:10:51 INFO - 'SHLVL': '1', 04:10:51 INFO - 'TERM': 'linux', 04:10:51 INFO - 'TMOUT': '86400', 04:10:51 INFO - 'USER': 'cltbld', 04:10:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:51 INFO - '_': '/tools/buildbot/bin/python'} 04:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:52 INFO - Downloading/unpacking psutil>=3.1.1 04:10:52 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 04:10:52 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 04:10:52 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 04:10:52 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 04:10:52 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 04:10:52 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 04:10:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:54 INFO - Installing collected packages: psutil 04:10:54 INFO - Running setup.py install for psutil 04:10:54 INFO - building 'psutil._psutil_linux' extension 04:10:54 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 04:10:54 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 04:10:54 INFO - building 'psutil._psutil_posix' extension 04:10:54 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 04:10:54 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 04:10:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:10:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:10:54 INFO - Successfully installed psutil 04:10:54 INFO - Cleaning up... 04:10:54 INFO - Return code: 0 04:10:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:10:54 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')]} 04:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:54 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')]} 04:10:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:54 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:10:54 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 04:10:54 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 04:10:54 INFO - Using env: {'DISPLAY': ':0', 04:10:54 INFO - 'HOME': '/home/cltbld', 04:10:54 INFO - 'LANG': 'en_US.UTF-8', 04:10:54 INFO - 'LANGUAGE': 'en_US:en', 04:10:54 INFO - 'LOGNAME': 'cltbld', 04:10:54 INFO - 'MAIL': '/var/mail/cltbld', 04:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:54 INFO - 'MOZ_NO_REMOTE': '1', 04:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:54 INFO - 'NO_EM_RESTART': '1', 04:10:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:54 INFO - 'PWD': '/builds/slave/test', 04:10:54 INFO - 'SHELL': '/bin/bash', 04:10:54 INFO - 'SHLVL': '1', 04:10:54 INFO - 'TERM': 'linux', 04:10:54 INFO - 'TMOUT': '86400', 04:10:54 INFO - 'USER': 'cltbld', 04:10:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:54 INFO - '_': '/tools/buildbot/bin/python'} 04:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:10:54 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 04:10:54 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 04:10:54 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 04:10:54 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 04:10:54 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 04:10:54 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 04:10:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:10:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:10:56 INFO - Installing collected packages: mozsystemmonitor 04:10:56 INFO - Running setup.py install for mozsystemmonitor 04:10:56 INFO - Successfully installed mozsystemmonitor 04:10:56 INFO - Cleaning up... 04:10:56 INFO - Return code: 0 04:10:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:10:56 INFO - Using env: {'DISPLAY': ':0', 04:10:56 INFO - 'HOME': '/home/cltbld', 04:10:56 INFO - 'LANG': 'en_US.UTF-8', 04:10:56 INFO - 'LANGUAGE': 'en_US:en', 04:10:56 INFO - 'LOGNAME': 'cltbld', 04:10:56 INFO - 'MAIL': '/var/mail/cltbld', 04:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:56 INFO - 'MOZ_NO_REMOTE': '1', 04:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:56 INFO - 'NO_EM_RESTART': '1', 04:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:56 INFO - 'PWD': '/builds/slave/test', 04:10:56 INFO - 'SHELL': '/bin/bash', 04:10:56 INFO - 'SHLVL': '1', 04:10:56 INFO - 'TERM': 'linux', 04:10:56 INFO - 'TMOUT': '86400', 04:10:56 INFO - 'USER': 'cltbld', 04:10:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:56 INFO - '_': '/tools/buildbot/bin/python'} 04:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:10:57 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 04:10:57 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 04:10:57 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 04:10:57 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 04:10:57 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 04:10:57 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 04:10:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:10:59 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 04:10:59 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 04:10:59 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 04:10:59 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 04:10:59 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 04:10:59 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 04:10:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:59 INFO - warning: no files found matching '*.txt' 04:10:59 INFO - no previously-included directories found matching 'build' 04:10:59 INFO - no previously-included directories found matching 'dist' 04:10:59 INFO - no previously-included directories found matching '.git*' 04:10:59 INFO - Installing collected packages: jsonschema, functools32 04:10:59 INFO - Running setup.py install for functools32 04:10:59 INFO - warning: no files found matching '*.txt' 04:10:59 INFO - no previously-included directories found matching 'build' 04:10:59 INFO - no previously-included directories found matching 'dist' 04:10:59 INFO - no previously-included directories found matching '.git*' 04:10:59 INFO - Successfully installed jsonschema functools32 04:10:59 INFO - Cleaning up... 04:10:59 INFO - Return code: 0 04:10:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:59 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:10:59 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 04:10:59 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 04:10:59 INFO - Using env: {'DISPLAY': ':0', 04:10:59 INFO - 'HOME': '/home/cltbld', 04:10:59 INFO - 'LANG': 'en_US.UTF-8', 04:10:59 INFO - 'LANGUAGE': 'en_US:en', 04:10:59 INFO - 'LOGNAME': 'cltbld', 04:10:59 INFO - 'MAIL': '/var/mail/cltbld', 04:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:59 INFO - 'MOZ_NO_REMOTE': '1', 04:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:59 INFO - 'NO_EM_RESTART': '1', 04:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:59 INFO - 'PWD': '/builds/slave/test', 04:10:59 INFO - 'SHELL': '/bin/bash', 04:10:59 INFO - 'SHLVL': '1', 04:10:59 INFO - 'TERM': 'linux', 04:10:59 INFO - 'TMOUT': '86400', 04:10:59 INFO - 'USER': 'cltbld', 04:10:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:59 INFO - '_': '/tools/buildbot/bin/python'} 04:10:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:10:59 INFO - Cleaning up... 04:10:59 INFO - Return code: 0 04:10:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:10: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')]} 04:10:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10: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')]} 04:10:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:59 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:10:59 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 04:10:59 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 04:10:59 INFO - Using env: {'DISPLAY': ':0', 04:10:59 INFO - 'HOME': '/home/cltbld', 04:10:59 INFO - 'LANG': 'en_US.UTF-8', 04:10:59 INFO - 'LANGUAGE': 'en_US:en', 04:10:59 INFO - 'LOGNAME': 'cltbld', 04:10:59 INFO - 'MAIL': '/var/mail/cltbld', 04:10:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:59 INFO - 'MOZ_NO_REMOTE': '1', 04:10:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:59 INFO - 'NO_EM_RESTART': '1', 04:10:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:59 INFO - 'PWD': '/builds/slave/test', 04:10:59 INFO - 'SHELL': '/bin/bash', 04:10:59 INFO - 'SHLVL': '1', 04:10:59 INFO - 'TERM': 'linux', 04:10:59 INFO - 'TMOUT': '86400', 04:10:59 INFO - 'USER': 'cltbld', 04:10:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:10:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:59 INFO - '_': '/tools/buildbot/bin/python'} 04:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:11:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:11:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:11:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:11:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 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 04:11:02 INFO - Downloading docopt-0.6.1.tar.gz 04:11:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:11:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:11:02 INFO - Running setup.py install for blobuploader 04:11:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:11:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:11:02 INFO - Running setup.py install for requests 04:11:03 INFO - Running setup.py install for docopt 04:11:03 INFO - Successfully installed blobuploader requests docopt 04:11:03 INFO - Cleaning up... 04:11:03 INFO - Return code: 0 04:11:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:03 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')]} 04:11:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:03 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')]} 04:11:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:03 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:11:03 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 04:11:03 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 04:11:03 INFO - Using env: {'DISPLAY': ':0', 04:11:03 INFO - 'HOME': '/home/cltbld', 04:11:03 INFO - 'LANG': 'en_US.UTF-8', 04:11:03 INFO - 'LANGUAGE': 'en_US:en', 04:11:03 INFO - 'LOGNAME': 'cltbld', 04:11:03 INFO - 'MAIL': '/var/mail/cltbld', 04:11:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:03 INFO - 'MOZ_NO_REMOTE': '1', 04:11:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:03 INFO - 'NO_EM_RESTART': '1', 04:11:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:03 INFO - 'PWD': '/builds/slave/test', 04:11:03 INFO - 'SHELL': '/bin/bash', 04:11:03 INFO - 'SHLVL': '1', 04:11:03 INFO - 'TERM': 'linux', 04:11:03 INFO - 'TMOUT': '86400', 04:11:03 INFO - 'USER': 'cltbld', 04:11:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:11:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:03 INFO - '_': '/tools/buildbot/bin/python'} 04:11:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:03 INFO - Running setup.py (path:/tmp/pip-vR7Sre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:03 INFO - Running setup.py (path:/tmp/pip-MhqYfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:03 INFO - Running setup.py (path:/tmp/pip-mI6XPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:03 INFO - Running setup.py (path:/tmp/pip-TrAwtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:03 INFO - Running setup.py (path:/tmp/pip-NXXl0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:03 INFO - Running setup.py (path:/tmp/pip-XZkAV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:04 INFO - Running setup.py (path:/tmp/pip-gVedWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:04 INFO - Running setup.py (path:/tmp/pip-6aLzHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:04 INFO - Running setup.py (path:/tmp/pip-xN1L28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:04 INFO - Running setup.py (path:/tmp/pip-dYDOCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:04 INFO - Running setup.py (path:/tmp/pip-0BOBsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:04 INFO - Running setup.py (path:/tmp/pip-i5IhJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:04 INFO - Running setup.py (path:/tmp/pip-WIOQOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:04 INFO - Running setup.py (path:/tmp/pip-kWRETh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:04 INFO - Running setup.py (path:/tmp/pip-FyA4vO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:04 INFO - Running setup.py (path:/tmp/pip-be6SQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:04 INFO - Running setup.py (path:/tmp/pip-EHp93l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:11:04 INFO - Running setup.py install for manifestparser 04:11:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:11:04 INFO - Running setup.py install for mozcrash 04:11:05 INFO - Running setup.py install for mozdebug 04:11:05 INFO - Running setup.py install for mozdevice 04:11:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Running setup.py install for mozfile 04:11:05 INFO - Running setup.py install for mozhttpd 04:11:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Running setup.py install for mozinfo 04:11:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Running setup.py install for mozInstall 04:11:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Running setup.py install for mozleak 04:11:05 INFO - Running setup.py install for mozlog 04:11:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Running setup.py install for moznetwork 04:11:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:11:05 INFO - Running setup.py install for mozprocess 04:11:06 INFO - Running setup.py install for mozprofile 04:11:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:11:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:11:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:11:06 INFO - Running setup.py install for mozrunner 04:11:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:11:06 INFO - Running setup.py install for mozscreenshot 04:11:06 INFO - Running setup.py install for moztest 04:11:06 INFO - Running setup.py install for mozversion 04:11:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:11:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:11:06 INFO - Cleaning up... 04:11:06 INFO - Return code: 0 04:11:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:06 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')]} 04:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:06 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')]} 04:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:06 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:11:06 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 04:11:06 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 04:11:06 INFO - Using env: {'DISPLAY': ':0', 04:11:06 INFO - 'HOME': '/home/cltbld', 04:11:06 INFO - 'LANG': 'en_US.UTF-8', 04:11:06 INFO - 'LANGUAGE': 'en_US:en', 04:11:06 INFO - 'LOGNAME': 'cltbld', 04:11:06 INFO - 'MAIL': '/var/mail/cltbld', 04:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:06 INFO - 'MOZ_NO_REMOTE': '1', 04:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:06 INFO - 'NO_EM_RESTART': '1', 04:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:06 INFO - 'PWD': '/builds/slave/test', 04:11:06 INFO - 'SHELL': '/bin/bash', 04:11:06 INFO - 'SHLVL': '1', 04:11:06 INFO - 'TERM': 'linux', 04:11:06 INFO - 'TMOUT': '86400', 04:11:06 INFO - 'USER': 'cltbld', 04:11:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:06 INFO - '_': '/tools/buildbot/bin/python'} 04:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:11:06 INFO - Running setup.py (path:/tmp/pip-hui8y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:11:06 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)) 04:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:11:06 INFO - Running setup.py (path:/tmp/pip-HRtw8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:11:06 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)) 04:11:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:11:06 INFO - Running setup.py (path:/tmp/pip-s26rRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:11:07 INFO - Running setup.py (path:/tmp/pip-HJT345-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:11:07 INFO - Running setup.py (path:/tmp/pip-WHZQ2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:11:07 INFO - Running setup.py (path:/tmp/pip-2gDSTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:11:07 INFO - Running setup.py (path:/tmp/pip-WjrHET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:11:07 INFO - Running setup.py (path:/tmp/pip-YT_rSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:11:07 INFO - Running setup.py (path:/tmp/pip-6SEcnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:11:07 INFO - Running setup.py (path:/tmp/pip-xXpfu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:11:07 INFO - Running setup.py (path:/tmp/pip-IkOBcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:11:07 INFO - Running setup.py (path:/tmp/pip-rq3Mu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:11:07 INFO - Running setup.py (path:/tmp/pip-0SyMSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:11:07 INFO - Running setup.py (path:/tmp/pip-8XvB2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:07 INFO - Running setup.py (path:/tmp/pip-xO0BkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:11:07 INFO - Running setup.py (path:/tmp/pip-glBXLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:11:07 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)) 04:11:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:11:07 INFO - Running setup.py (path:/tmp/pip-yN3QEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:11:08 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)) 04:11:08 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)) 04:11:08 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)) 04:11:08 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)) 04:11:08 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)) 04:11:08 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)) 04:11:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:11:08 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 04:11:08 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 04:11:08 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 04:11:08 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 04:11:08 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 04:11:08 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 04:11:09 INFO - Downloading blessings-1.6.tar.gz 04:11:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:11:10 INFO - Installing collected packages: blessings 04:11:10 INFO - Running setup.py install for blessings 04:11:10 INFO - Successfully installed blessings 04:11:10 INFO - Cleaning up... 04:11:10 INFO - Return code: 0 04:11:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:10 INFO - Reading from file tmpfile_stdout 04:11:10 INFO - Current package versions: 04:11:10 INFO - argparse == 1.2.1 04:11:10 INFO - blessings == 1.6 04:11:10 INFO - blobuploader == 1.2.4 04:11:10 INFO - docopt == 0.6.1 04:11:10 INFO - functools32 == 3.2.3-2 04:11:10 INFO - jsonschema == 2.5.1 04:11:10 INFO - manifestparser == 1.1 04:11:10 INFO - mozInstall == 1.12 04:11:10 INFO - mozcrash == 0.17 04:11:10 INFO - mozdebug == 0.1 04:11:10 INFO - mozdevice == 0.48 04:11:10 INFO - mozfile == 1.2 04:11:10 INFO - mozhttpd == 0.7 04:11:10 INFO - mozinfo == 0.9 04:11:10 INFO - mozleak == 0.1 04:11:10 INFO - mozlog == 3.3 04:11:10 INFO - moznetwork == 0.27 04:11:10 INFO - mozprocess == 0.23 04:11:10 INFO - mozprofile == 0.28 04:11:10 INFO - mozrunner == 6.12 04:11:10 INFO - mozscreenshot == 0.1 04:11:10 INFO - mozsystemmonitor == 0.3 04:11:10 INFO - moztest == 0.7 04:11:10 INFO - mozversion == 1.4 04:11:10 INFO - psutil == 3.1.1 04:11:10 INFO - requests == 1.2.3 04:11:10 INFO - wsgiref == 0.1.2 04:11:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:10 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 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:11:10 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 04:11:10 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 04:11:10 INFO - Using env: {'DISPLAY': ':0', 04:11:10 INFO - 'HOME': '/home/cltbld', 04:11:10 INFO - 'LANG': 'en_US.UTF-8', 04:11:10 INFO - 'LANGUAGE': 'en_US:en', 04:11:10 INFO - 'LOGNAME': 'cltbld', 04:11:10 INFO - 'MAIL': '/var/mail/cltbld', 04:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:10 INFO - 'MOZ_NO_REMOTE': '1', 04:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:10 INFO - 'NO_EM_RESTART': '1', 04:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:10 INFO - 'PWD': '/builds/slave/test', 04:11:10 INFO - 'SHELL': '/bin/bash', 04:11:10 INFO - 'SHLVL': '1', 04:11:10 INFO - 'TERM': 'linux', 04:11:10 INFO - 'TMOUT': '86400', 04:11:10 INFO - 'USER': 'cltbld', 04:11:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:10 INFO - '_': '/tools/buildbot/bin/python'} 04:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 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)) 04:11:10 INFO - Cleaning up... 04:11:10 INFO - Return code: 0 04:11:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:11:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbce4fcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, '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': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', '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 04:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:11:10 INFO - Using env: {'DISPLAY': ':0', 04:11:10 INFO - 'HOME': '/home/cltbld', 04:11:10 INFO - 'LANG': 'en_US.UTF-8', 04:11:10 INFO - 'LANGUAGE': 'en_US:en', 04:11:10 INFO - 'LOGNAME': 'cltbld', 04:11:10 INFO - 'MAIL': '/var/mail/cltbld', 04:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:10 INFO - 'MOZ_NO_REMOTE': '1', 04:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:10 INFO - 'NO_EM_RESTART': '1', 04:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:10 INFO - 'PWD': '/builds/slave/test', 04:11:10 INFO - 'SHELL': '/bin/bash', 04:11:10 INFO - 'SHLVL': '1', 04:11:10 INFO - 'TERM': 'linux', 04:11:10 INFO - 'TMOUT': '86400', 04:11:10 INFO - 'USER': 'cltbld', 04:11:10 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:10 INFO - '_': '/tools/buildbot/bin/python'} 04:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:11:10 INFO - Cleaning up... 04:11:10 INFO - Return code: 0 04:11:10 INFO - Running post-action listener: _resource_record_post_action 04:11:10 INFO - Running post-action listener: _start_resource_monitoring 04:11:10 INFO - Starting resource monitoring. 04:11:10 INFO - [mozharness: 2016-08-26 11:11:10.904599Z] Finished create-virtualenv step (success) 04:11:10 INFO - [mozharness: 2016-08-26 11:11:10.905100Z] Running install step. 04:11:10 INFO - Running pre-action listener: _resource_record_pre_action 04:11:10 INFO - Running main action method: install 04:11:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:11:11 INFO - Reading from file tmpfile_stdout 04:11:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:11:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:11:11 INFO - Reading from file tmpfile_stdout 04:11:11 INFO - Output received: 04:11:11 INFO - Usage: mozinstall [options] installer 04:11:11 INFO - Options: 04:11:11 INFO - -h, --help show this help message and exit 04:11:11 INFO - -d DEST, --destination=DEST 04:11:11 INFO - Directory to install application into. [default: 04:11:11 INFO - "/builds/slave/test"] 04:11:11 INFO - --app=APP Application being installed. [default: firefox] 04:11:11 INFO - mkdir: /builds/slave/test/build/application 04:11:11 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'] 04:11:11 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 04:11:27 INFO - Reading from file tmpfile_stdout 04:11:27 INFO - Output received: 04:11:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:11:27 INFO - Running post-action listener: _resource_record_post_action 04:11:27 INFO - [mozharness: 2016-08-26 11:11:27.337770Z] Finished install step (success) 04:11:27 INFO - [mozharness: 2016-08-26 11:11:27.338018Z] Running run-tests step. 04:11:27 INFO - Running pre-action listener: _resource_record_pre_action 04:11:27 INFO - Running main action method: run_tests 04:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:11:27 INFO - Python 2.7.3 04:11:27 INFO - Return code: 0 04:11:27 INFO - grabbing minidump binary from tooltool 04:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:27 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 0x109c090>, '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 0x109f9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:11:27 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 04:11:27 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 04:11:27 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 04:11:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:11:27 INFO - Return code: 0 04:11:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:11:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:11:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:11:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:11:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 04:11:27 INFO - Using env: {'DISPLAY': ':0', 04:11:27 INFO - 'HOME': '/home/cltbld', 04:11:27 INFO - 'LANG': 'en_US.UTF-8', 04:11:27 INFO - 'LANGUAGE': 'en_US:en', 04:11:27 INFO - 'LOGNAME': 'cltbld', 04:11:27 INFO - 'MAIL': '/var/mail/cltbld', 04:11:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:11:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:11:27 INFO - 'MOZ_NO_REMOTE': '1', 04:11:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:11:27 INFO - 'NO_EM_RESTART': '1', 04:11:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:11:27 INFO - 'PWD': '/builds/slave/test', 04:11:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:11:27 INFO - 'SHELL': '/bin/bash', 04:11:27 INFO - 'SHLVL': '1', 04:11:27 INFO - 'TERM': 'linux', 04:11:27 INFO - 'TMOUT': '86400', 04:11:27 INFO - 'USER': 'cltbld', 04:11:27 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633', 04:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:11:27 INFO - '_': '/tools/buildbot/bin/python'} 04:11:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:11:27 INFO - mozversion application_buildid: 20160826011017 04:11:27 INFO - mozversion application_changeset: 468244986b20a0bdf22a5e36b55ae43ac09599c8 04:11:27 INFO - mozversion application_display_name: Nightly 04:11:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:11:27 INFO - mozversion application_name: Firefox 04:11:27 INFO - mozversion application_remotingname: firefox 04:11:27 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 04:11:27 INFO - mozversion application_vendor: Mozilla 04:11:27 INFO - mozversion application_version: 51.0a1 04:11:27 INFO - mozversion platform_buildid: 20160826011017 04:11:27 INFO - mozversion platform_changeset: 468244986b20a0bdf22a5e36b55ae43ac09599c8 04:11:27 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 04:11:27 INFO - mozversion platform_version: 51.0a1 04:11:27 INFO - using testdate: 1472209887 04:11:27 INFO - actual date: 1472209887 04:11:27 INFO - starting webserver on 'localhost:47981' 04:11:27 INFO - SUITE-START | Running 2 tests 04:11:27 INFO - TEST-START | dromaeo_css 04:11:27 INFO - operating with platform_type : linux_ 04:11:27 INFO - Initialising browser for dromaeo_css test... 04:11:27 INFO - TEST-INFO | started process 25305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLd4VaH/profile http://localhost:47981/getInfo.html) 04:11:32 INFO - PROCESS | 25305 | __metrics Screen width/height:1600/1200 04:11:32 INFO - PROCESS | 25305 | colorDepth:24 04:11:32 INFO - PROCESS | 25305 | Browser inner width/height: 1024/697 04:11:32 INFO - PROCESS | 25305 | __metrics 04:11:33 INFO - PROCESS | 25305 | 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" 04:11:33 INFO - PROCESS | 25305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:11:34 INFO - TEST-INFO | 25305: exit 0 04:11:34 INFO - Browser initialized. 04:11:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:11:34 INFO - TEST-INFO | started process 25386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLd4VaH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:47 INFO - PROCESS | 25386 | RSS: Main: 177725440 04:11:47 INFO - PROCESS | 25386 | 04:12:38 INFO - PROCESS | 25386 | 1472209958260 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] 04:14:51 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:47981/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47981/tests/dromaeo/cssquery-ext.html) 04:14:52 INFO - PROCESS | 25386 | RSS: Main: 270057472 04:14:52 INFO - PROCESS | 25386 | 04:17:55 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:47981/tests/dromaeo/cssquery-ext.html (next: http://localhost:47981/tests/dromaeo/cssquery-jquery.html) 04:17:55 INFO - PROCESS | 25386 | RSS: Main: 267067392 04:17:55 INFO - PROCESS | 25386 | 04:20:57 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:47981/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47981/tests/dromaeo/cssquery-mootools.html) 04:20:58 INFO - PROCESS | 25386 | RSS: Main: 220655616 04:20:58 INFO - PROCESS | 25386 | 04:24:00 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:47981/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47981/tests/dromaeo/cssquery-prototype.html) 04:24:01 INFO - PROCESS | 25386 | RSS: Main: 219734016 04:24:01 INFO - PROCESS | 25386 | 04:27:04 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:47981/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47981/tests/dromaeo/cssquery-yui.html) 04:27:05 INFO - PROCESS | 25386 | RSS: Main: 223617024 04:27:05 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:47981/tests/dromaeo/cssquery-yui.html (next: http://localhost:47981/tests/dromaeo/cssquery-dojo.html) 04:30:08 INFO - PROCESS | 25386 | RSS: Main: 315985920 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | __start_tp_report 04:30:08 INFO - PROCESS | 25386 | _x_x_mozilla_page_load 04:30:08 INFO - PROCESS | 25386 | _x_x_mozilla_page_load_details 04:30:08 INFO - PROCESS | 25386 | |i|pagename|runs| 04:30:08 INFO - PROCESS | 25386 | |0;dojo.html;2561.244432892297;2589.7539733725303;2608.5043841670094;2629.829061111028;2637.4856902903944;4588.242939914914;4698.45967713713;4745.54917282858;4745.833895813647;4821.614270858332;4503.076869241814;4707.552782485658;4751.16854550454;4781.90436191276;4819.710817350961;4390.934135987963;4410.75740834254;4420.027593929346;4439.378487011805;4483;4389.758563279002;4439.889002774924;4461.152381047591;4473.261911784552;4484.215262329096;4217.093324935154;4264.957350426487;4272.444582204324;4302.65578753699;4362.105768317488;4279.144171165748;4302.5052119006405;4310.030243195288;4355.216061108999;4373.343998400233;4333.414988976511;4337.327714204272;4345.630621397185;4362.258416069276;4362.781860906942;4513.323001549761;4619.722816631013;4650;4741.810327586927;4743.241081426955;5089.949100508985;5091.516305950929;5103.311053007834;5103.617228707862;5110.97444512775;5082.466341034212;5105.132127538291;5113.411957624883;5128.743562821881;5133.743312834344;4530.909381812346;4652.116097941381;4704.976475117603;4711.057788442326;4766.880827979294;5213.087709650872;5220.9738951305;5231.058409486329;5236.109861323508;5240.973795131;4986.127427700138;5005.224190250517;5005.4744251853035;5010.423801262901;5010.69935803853;4879.26810978349;4962.652614316963;4997.225430058346;5008.824691135866;5090.2364645303505;4976.576990955737;5016.54851063406;5016.749162541858;5017.297578339036;5021.874453138627;4988.850334489971;4996.575291100225;4997.825076122391;4997.875053123701;5002.624803139779;4068.5524592294823;4103.2409004334295;4103.261412945639;4153.646940010133;4225.9577404226175;3605.080704420356;3640.4539319102346;3667.1932174921476;3681.742278040565;3743.1765011697385;4362.541933096979;4364.54172311909;4368.170047690992;4369.934450983238;4372.103718737651;4899.4365647950945;4989.451160372429;4992.550670439605;4998.150314446553;5009.123403404463;4293.0984493256765;4316.352547117957;4323.63249123828;4366.8034938427845;4374.825006999685;4475.70907890986;4479.440069991251;4479.932801007987;4480.14877173336;4483.843065492692;4642.442906851199;4725.054989002145;4756.381670382828;4761.738104404291;4763.404574428197;4950.752462376795;5001.874953126201;5008.6744361616375;5076.36545431821;5079.949200507947;4791.592714619296;4795.880102997314;4806.975965120152;4808.639352048541;4810.855674329776;4826.565609095198;5008.9499105009945;5009.799608015638;5014.749262536786;5020.949790502048;4959.429665588504;4977.477364876636;5037.445880953019;5042.268871013609;5069.898602028013;4902.362692849907;4928.211486162197;4936.654434189572;4937.753112344297;4940.505949405175;4766.761661916959;4929;4943.530364615356;4952.851414457572;4954.9752251238515;4726.1492931272705;4730.810767569396;4785.904281914272;4843.2735089735415;4859.781309840995;4926.581240594446;4928.433230178575;4954.677945933647;4960.70235785854;4965.205567109245;4675.76621168947;4735.952640473552;4840;4847.927281090857;4850.708957462563 04:30:08 INFO - PROCESS | 25386 | |1;ext.html;563.9069553523667;567.6168586204313;578.9305283365995;581.0354811013718;581.0528837994069;38169.80915095424;39973.60026399739;40107.59892401079;43573.78213108938;43659.78170109145;41352.37971430423;41753.791231043804;41857.79071104648;41859.58140418595;41952.370714439305;7511.8497630047505;7637.694492220332;7642.350400215961;7642.541447513139;7647.655855486489;7689.615519224017;7749.845003099935;7767.456278060538;7767.805804854867;7768.223177682243;7769.844603107935;7772.805679857992;7790.376769858426;7817.179196184404;7827.412944029192;7675.50109242903;7681.57751323677;7684.462087653867;7703.845923081563;7705.8844117338285;7611.65747541362;7677.654505547263;7685.269899359552;7745.186755390716;7746.9225307746765;38079.715217086785;38350.61649383498;38459;38483.23033539342;38489.23021539554;2639.7228291029355;2668.759811616964;2710.2953232159584;3063.724264816155;3071.109378280296;28366.29084272889;29125.56311655327;29250.707492925012;29715.257118571993;30118.096457106323;3112.828794416306;3129.9843500782576;3171.1437911763924;3232.7252183564424;3245.432049391347;186704;186813;186878;187257;187619;43332.350014749805;43349.349759753;43429;43453.78273108614;43504.78247608805;29021.85489072541;55732;55855;55898.441015590135;55971;13147.0797044206;13622.795658065137;13656.317184140753;13704.10923289983;13711.588652340446;10262.230332725076;10302.124319432782;10313.74215644615;10317.071463568314;10322.948385258025;18075.186616602285;18117.45647630573;18124.818751812578;18135.72796408055;18243.36148234832;6695.691637118007;6819.885835391045;6832.59004459734;6970.477214208853;7059.647017649097;789.9763007109796;872.5419154943705;893.4817805672694;903.8824952756231;984.1192133041031;27157.864210679214;27930.720692793217;28248.29379265535;28335.43329133447;29017.274568135967;943.4622265308845;949.7103383468109;965.232640051161;968.9176420004237;1014.8173328800887;14295;14942;15115.622109447351;15523.146226957626;15582.376704931903;399002;404718;405531;406802;407489;50003;50627;50698.23952640713;50776.492235077174;50776.74611626992;1038.6209033702796;1043.869516310446;1076.278893141597;1123.6797512708838;1149.2357582207906;26957.46085078248;29148.708512915447;29549.409011820073;29578.704212957597;30113.849430753584;42671.786641066596;43272;43313.133737325705;43332;43378;286616;288206;289767;289845;291703;22343.44141396478;22597.661035084817;22598.209062682727;23072.653910191024;23893.641595375735;41876.371854421595;41941.161176776906;42347;42519.3622095675;42566;34797.652023479444;35373.9184332464;35538.64461355354;35635.46546801748;35653;34269.48595771015;34782.47826282658;34812.47781283232;34965.825170873984;35106.82446587751;34734;34832.65167348294;34837.82581087078;35474.11314717153;35758.64241357553;29661.85169074141;32418.189545261557;32510.187245319055;32707.182320442178;32762.83618581892;22960.54078918379;23028.884855575616;23121.61270323786;23440.413989649714;23559 04:30:08 INFO - PROCESS | 25386 | |2;jquery.html;337.87968114462916;350.43754773588375;354.1606392848948;361.6961752128212;380.0896852039366;12630.873691263085;15609.84390156098;15775.921120394381;16367.345306187768;17343.04613246271;11965.521379144824;12092.093093018015;14149.29253537324;16353.182340882968;16435.753463698053;4485.910281794362;4923.335349727786;5098.541131298182;5147.845564633067;5153.458886816887;4995.625328100407;5065.316182315377;5070.290159377671;5074.416442109149;5075;4872.366592343008;5010.348654674887;5033.043721692885;5049.091163590552;5049.6212784041345;5053.292539044518;5099.311592934962;5099.796008159669;5102.260172275037;5104.234364845266;4442.067165895166;4492.640588752892;4543.068670922453;4562.6121779648765;4563.520830312803;20986;21344.46638834026;21359.359219223446;21393.144274229013;21483.67774483384;1705.7526658634429;1790.3017823049022;2237.8433509654333;2428.5287379221177;2450.497647982177;13123.475060997549;13139.408726607326;13236.735265294641;13271.270080145589;13947.442102315896;1717.4933394648608;1743.9564010899703;1766;1772.3619496981075;1786;67100.32899671038;69843;70735.29264707338;71513;71529.64235178843;9370.10983956523;9611.231101511863;9641.758956026155;9766.0467906419;10099.94950025245;13109.475620975245;13135;13146.4084116215;13153.671158221121;13155.934220329029;6724.899126513106;6970.895436568456;7014.92985070153;7190.316919892602;7193.352598266077;6621.172353455818;6688.130543029375;6841.076454678654;6862.691178896962;6874.2094659113845;5911.645301281937;6036;6065.188997024341;6109.11417844419;6230.844228894314;1718.905460199676;1748.1696194307601;1766.2316892151955;1787.3922866225546;1812.709966405395;849.8130411309502;864.8529749942525;872.3283072034498;890.2166093837382;978.471625322318;16501.669966600602;16906;16974.32102715902;18074.3673971413;18391.50561393331;807.7415227127262;818.4925346285341;844.151627614256;875.7810547363159;916.564631799903;9233.492157931243;9702.611895524242;9859.753506162404;9886.406815591088;10021.79956400868;409282;415531;416042;429158;429192;48445.5155448441;70833;75687;78434;82207;881.1452890696015;887.6937456577599;912.589334799343;914.1772404835568;915.4507295622707;15190.240487975336;15299.61750956235;15352.385904564138;15975.281112350205;16147.596310092342;37255.76465412084;37507;37816.24367512689;38501.80749096349;38759.6124038756;49914;50487;50701.74649126731;50816;51013.744931275105;7189.712411503481;7481.326680598555;7492.700291988477;7544.811379715332;7633.465657403928;10053.648122315684;10633.627823026158;11166.38584877807;11592.47833847462;12280.201786884181;9636;9764.902350976683;10182.694519164437;10481;10542.156627469938;4840.806367745392;7606.771796846104;9145.405548639317;10155.187584993331;10746.24776265654;9872.950635246778;9923.45421001823;10167.313372617262;10271.229657775846;10425.426601536989;6398.1362516059735;6705.664716764045;6799.558028728117;7062.540934839219;7364.3372096511575;8038.959805200937;10087.495625218857;10095;10216.591336346462;10919.290246133976 04:30:08 INFO - PROCESS | 25386 | |3;mootools.html;1170.496686424837;1335.1455068755995;1377.2562816079317;1414.2645824171432;1630.315267587613;6659.966700166498;7400.148982866972;7662.501937374067;7667.769966900995;7832.06015278166;7607.657655405506;7671.117821450535;7686.346660533847;7687.884681729764;7688.500247483909;2077.771445141037;2110.02938648222;2117.4282943605217;2124.097258665061;2125.436759258798;2050.928217512387;2097.8216851567636;2116.947076323089;2118.608057509358;2126.5959467701164;2049.6515592349338;2092.4141240452695;2100.24391219161;2101.4011006863047;2122.3314655883423;2070.0477780221117;2079.740032495938;2083.718697975769;2085.18677715691;2088.04993727855;2027.1080724481328;2068.98965505173;2098.2865825619365;2099.3177217404404;2102.653062244743;7301.4523910706375;7369.115706115301;7509.399248060196;7513.323800857895;7521.699132034712;4168.083021735244;4296.334068219399;4312.245357062501;4320.870373888788;4321.2653848845775;2783.4154827486254;2933.7946343755943;2980.806247593921;2993;2999.9400011999855;882.5587206396801;895.789489469974;896.1441823058963;899.1008991008991;908.1463424381061;9743.951280243624;9746.220302375792;9810.509474526245;9833.557489913042;9836.655717049869;3640.908977275589;3837.4819399381286;3952.940705889414;3959.1289916218384;3967.444557761916;7858.528488290721;7859.960700196462;7861.331786798072;7863.764087077397;7882.054153501616;4310.267254566731;4310.3103503439925;4312.223799716081;4321.351797230441;4321.870343889688;3548.1129717570607;3891.2606604745006;3987.7806720630065;3989.6209860063245;4058.3100872851687;3313.6520665330277;3395.7283417326553;3453.740969427303;3463.619001909788;3543.919104673048;976.7021058577202;990.980180396388;1000.2398177385239;1008.7679833638305;1008.8284991551454;606.4996377988177;743.3347154296874;771.5139462138817;780.2782426255691;783.4672422752583;4877.317175595419;5169.3796744390165;5188.299579556787;5228.947710522846;5307.681539107666;833.6790335720791;837.7738010737189;874.1084094223856;895.9328050396247;897.52879738138;3434.3131373725355;3445.982770086184;3475.965240347615;3569.8572057117426;3575.3028159509167;8952.597133128895;9310.348275620641;9535.2371810255;9583.904160958302;9690.030996900254;9531.38046027006;9579.568919398504;9601.90398096024;9605.18355939739;9625.32622716403;7244.203137654854;7254.238304977901;7400.407967362598;7433.182349941502;7458.366038886756;5113.488651134857;5121.206213036985;5159.922601161061;5203.791848326025;5215.843524694265;8678.305735541015;8704.521251331238;8787.384883058381;8853.645854165761;8894.510801905957;8763.649454021768;8985.685501007434;9033.638654453749;9043.23132533742;9108.316876234441;5683.232763576864;6199.473044791243;6313.621182729051;6314.179156709598;6838.247792742894;7049.929500705132;7160.820979475555;7355.7057717690695;7357.5953322567775;7361.889571656537;6395.232572091193;6472.5145614080075;6561.278259391368;6667.49993750461;6677.499187561049;6226.937730622817;6283.59156654816;6331.366863313632;6347.619142851444;6435.678216089083;5812.622179558315;5945.881082378415;5949.988501954592;5950.583459157818;5952.494038006818;4376.584224498668;4425.446819147606;4467.329900514948;4522.163399771053;4614.054118905549;4379.167958087953;4456.487503937089;4516.187086324362;4521.819127234874;4545.090981803586 04:30:08 INFO - PROCESS | 25386 | |4;prototype.html;290.3945274103494;293.5611261164558;298.28263027419064;302.8985289927874;303.2963524622876;4609.170349337122;4661.9067618647605;4684.391029166212;4695.272232803916;4758.785854636541;4608.308753686941;4611.953880461195;4619.930701039487;4688.335640847501;4689.718616882989;3702.648248416396;3703.907402314937;3706.2031663192406;3707.5550933887835;3712.740108192421;3579.463080537927;3704.6105262105925;3710.888673339804;3712.480252764615;3720.1257704439436;3619.963800361989;3660.3594370985106;3663.19409729859;3673.1184515716304;3673.2286219893854;3655.4151335786146;3659.5846741150713;3659.79871107089;3673.1368128489785;3703.0742314421395;3064.1114076917665;3157.431662300785;3259.3318369734147;3262.5970832542;3266.1181481;4358.5205627380965;4502.379143508334;4509.526499717548;4515.187266292066;4515.75163366018;4121.9381709274385;4125.278076336659;4126.154138401621;4129.091599848059;4161.209370219679;4522.81141795037;4589.173948689235;4805.1590971579835;4808.711477311337;4812.759362031919;3415.6072051714123;3494.5457090578316;3513.139280876176;3513.4554144107706;3514.3674138655033;4984.127777638899;4987.62592805541;4992.625553083497;4992.850214493535;4997;3599.1721903962234;3602.3875941090078;3603.675669189733;3614.6746792788776;3649.7810131392202;3553.3248682750195;3630;3631.8365673544754;3674.5223120994633;3709.9072523186596;4112.115895082572;4113.526944401372;4115.9588404116175;4127.236461254617;4134.37984302351;4781.9043619128115;4795.650131435572;4815.518448155157;4824.914394261263;4832.975835120802;1222.2971791220084;1241.6155986075642;1244.2721008210117;1258.1318889965894;1259.4017841525385;811.9350451963828;825.8141918068386;828.9253967142865;831.1480732249372;832.8042909916165;3878.3406820840523;3892.708046896494;3900.8439662413753;3901.9609803902167;3904.2777086239134;4367.344898265285;4371.868843934687;4373.934390984138;4400.809413175486;4430.645548356124;3842.1376074823875;3880.3791393376923;3897.590752970954;3900.556793986243;3905.964919296389;2223.2663221136986;2305.7233132024267;2318.431984163891;2333.6849525314205;2337.2170322941665;4191;4199.223143718422;4200.390943313202;4484.798184081659;4574.885627859264;4990.351254336913;5021.171506701427;5043.2435134730085;5050.49495050492;5055.797768089235;4713.457952335457;4732.0772449372735;4732.881677958009;4736.502667219961;4739.834105806281;4782.928256076092;4864.391951006124;4889.657723959289;4928.507149285043;4948.727819969936;4829.2997515359375;4849.393825771778;4855.36880205571;4873.878153046202;4876.463589005278;4715.339852420595;4720.504347043511;4727.57451829337;4731.9763401184155;4744.952550474451;3543.822808859495;3643.7267204959203;3646.197836475971;3649.5073165122367;3654.616265292106;4949.430815456269;4961.578265847444;4970.204767237225;4971.458847757062;4980.136421557547;4829.6860704055525;4834.806607735792;4835.20219163834;4839.370881785346;4851.854444366533;4597.908041839211;4836.032793441255;4844.947682959712;4845;4846.418429788448;4703.529647035269;4745.667803253739;4752.3584316116885;4753.83361582343;4755.857324280277;4814.325994360863;4833.758312084452;4859.149648811514;4860.274602516056;4871.098846713369;4577.771111444481;4713.787879545497;4732.266498692708;4757.381540399726;4787.593054590398 04:30:08 INFO - PROCESS | 25386 | |5;yui.html;560.1429812387048;580.2340909998801;590.0618017352409;638.3616383616384;649.169063598594;11918.76162476751;12573.748525029494;12603.747925041494;12916.612501624943;12970.351482425887;11656.358900260482;12168.269903805778;12295.446704898279;12321.568745093924;12327.506899724023;726.7093162734922;749.6551586270322;749.966251518683;757.0650246945019;759.8746206875859;738.6380673469988;741.2587412587412;741.5587725303436;741.933226009659;742.0798210219316;779.7309928074806;783.0134031120772;787.4763282417185;788.0464637788283;791.3510921044746;783.1307248953657;788.184229322654;788.7949133225374;789.0294937227185;789.0491957191571;569.504531057978;571.8027280588232;573.9024365857772;573.9139129130622;574.307958909513;10853.837192442119;10880.401577913211;10893.727656808564;10900.618478353219;10902.727431814188;10605.84091238632;10644.680659580225;10807.243492955497;10813.351198928089;10892.509837057352;9199.58601862911;9282.303827212985;9422.717318480456;9537.618495260182;9779.266555008402;3205.054508919851;3236.1909522619344;3269.29710112327;3278.1476816027766;3385.136790118504;64954;65228;65782.3421765781;66319.33680663229;67076.32923670749;7922.128565857751;7994.120646728855;8023.438359314792;8058.1538938411795;8134.3085837703275;15995.280212390471;16004.91997540005;16118.032918024956;16122.113283769271;16526.504204873632;6630.834229144213;6666.400023997863;6735.259121496631;6838;7000.719971201197;3435.278591495814;3496.091016335771;3534.3814832404228;3537.646235376442;3584.372734771405;2629.198094581171;2700.824446410977;2726.850023248701;2730.726927307293;2743.670759508872;464.4078799530558;475.12576858580377;491.28027439800866;497.0903247057948;499.9550040496373;525.519149977766;527.5937528103339;527.9683219006872;550.2544052808466;550.6475855452513;7693.192214817475;7713.575753333621;7878.645460954271;7968.282854543119;8097.311728503026;487.60747598183804;517.428241792821;523.5314393617691;524.5384062025394;534.4308311648082;3775.339315619756;3856.2480316338606;3940.940885886714;3965.8810235692977;3977.6618987386396;98657;100286.49856750816;101514;103308;104598;88760.5561972186;89494.55252723694;90480.5475972616;90522.54738726265;91588;73048;78292.21707782963;80755.59622201852;81740.59129704432;82726.58636706899;6938.306169383021;6978.581285122909;7311.488195826241;7344.375728063174;7754.573498457639;31502.684973150892;39832.60167398289;42365;42680.57319426766;44907.77546112249;38186.427203592524;38686.419703703905;51139.488605113474;52135.739321303154;53344;10076.798464030824;10354.689359319233;10589.841152382874;10653.467326633483;10868.565257389615;12232.22632718233;12421.19262247951;12734.299613520974;13473.124246923919;13611.591652250449;11515.424228788359;11621.418929053345;12123.939380303042;12431.751364972832;12433.191842530206;10807.405592692163;11423.409755561828;11436.714082148013;11522.827157592475;11775.293482391084;11044.889551104387;11191.944040279746;11613;11740.941295293469;11954.701132471759;8841.469511829311;9246.214071803972;9385.765355866159;9563.330566860253;10135.138513226459;9645.131938125602;9938.155256803253;9940.353876997971;9951.303408761318;9971.800563988825 04:30:08 INFO - PROCESS | 25386 | __end_tp_report 04:30:08 INFO - PROCESS | 25386 | __start_cc_report 04:30:08 INFO - PROCESS | 25386 | _x_x_mozilla_cycle_collect,958 04:30:08 INFO - PROCESS | 25386 | __end_cc_report 04:30:08 INFO - PROCESS | 25386 | __startTimestamp1472211008389__endTimestamp 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | ------- Summary: start ------- 04:30:08 INFO - PROCESS | 25386 | Number of tests: 6 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | [#0] dojo.html Cycles:165 Average:4651.85 Median:4781.90 stddev:498.80 (10.4%) stddev-sans-first:472.60 04:30:08 INFO - PROCESS | 25386 | Values: 2561.2 2589.8 2608.5 2629.8 2637.5 4588.2 4698.5 4745.5 4745.8 4821.6 4503.1 4707.6 4751.2 4781.9 4819.7 4390.9 4410.8 4420.0 4439.4 4483.0 4389.8 4439.9 4461.2 4473.3 4484.2 4217.1 4265.0 4272.4 4302.7 4362.1 4279.1 4302.5 4310.0 4355.2 4373.3 4333.4 4337.3 4345.6 4362.3 4362.8 4513.3 4619.7 4650.0 4741.8 4743.2 5089.9 5091.5 5103.3 5103.6 5111.0 5082.5 5105.1 5113.4 5128.7 5133.7 4530.9 4652.1 4705.0 4711.1 4766.9 5213.1 5221.0 5231.1 5236.1 5241.0 4986.1 5005.2 5005.5 5010.4 5010.7 4879.3 4962.7 4997.2 5008.8 5090.2 4976.6 5016.5 5016.7 5017.3 5021.9 4988.9 4996.6 4997.8 4997.9 5002.6 4068.6 4103.2 4103.3 4153.6 4226.0 3605.1 3640.5 3667.2 3681.7 3743.2 4362.5 4364.5 4368.2 4369.9 4372.1 4899.4 4989.5 4992.6 4998.2 5009.1 4293.1 4316.4 4323.6 4366.8 4374.8 4475.7 4479.4 4479.9 4480.1 4483.8 4642.4 4725.1 4756.4 4761.7 4763.4 4950.8 5001.9 5008.7 5076.4 5079.9 4791.6 4795.9 4807.0 4808.6 4810.9 4826.6 5008.9 5009.8 5014.7 5020.9 4959.4 4977.5 5037.4 5042.3 5069.9 4902.4 4928.2 4936.7 4937.8 4940.5 4766.8 4929.0 4943.5 4952.9 4955.0 4726.1 4730.8 4785.9 4843.3 4859.8 4926.6 4928.4 4954.7 4960.7 4965.2 4675.8 4736.0 4840.0 4847.9 4850.7 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | [#1] ext.html Cycles:180 Average:44837.95 Median:35705.82 stddev:81060.43 (227.0%) stddev-sans-first:81219.67 04:30:08 INFO - PROCESS | 25386 | Values: 563.9 567.6 578.9 581.0 581.1 38169.8 39973.6 40107.6 43573.8 43659.8 41352.4 41753.8 41857.8 41859.6 41952.4 7511.8 7637.7 7642.4 7642.5 7647.7 7689.6 7749.8 7767.5 7767.8 7768.2 7769.8 7772.8 7790.4 7817.2 7827.4 7675.5 7681.6 7684.5 7703.8 7705.9 7611.7 7677.7 7685.3 7745.2 7746.9 38079.7 38350.6 38459.0 38483.2 38489.2 2639.7 2668.8 2710.3 3063.7 3071.1 28366.3 29125.6 29250.7 29715.3 30118.1 3112.8 3130.0 3171.1 3232.7 3245.4 186704.0 186813.0 186878.0 187257.0 187619.0 43332.4 43349.3 43429.0 43453.8 43504.8 29021.9 55732.0 55855.0 55898.4 55971.0 13147.1 13622.8 13656.3 13704.1 13711.6 10262.2 10302.1 10313.7 10317.1 10322.9 18075.2 18117.5 18124.8 18135.7 18243.4 6695.7 6819.9 6832.6 6970.5 7059.6 790.0 872.5 893.5 903.9 984.1 27157.9 27930.7 28248.3 28335.4 29017.3 943.5 949.7 965.2 968.9 1014.8 14295.0 14942.0 15115.6 15523.1 15582.4 399002.0 404718.0 405531.0 406802.0 407489.0 50003.0 50627.0 50698.2 50776.5 50776.7 1038.6 1043.9 1076.3 1123.7 1149.2 26957.5 29148.7 29549.4 29578.7 30113.8 42671.8 43272.0 43313.1 43332.0 43378.0 286616.0 288206.0 289767.0 289845.0 291703.0 22343.4 22597.7 22598.2 23072.7 23893.6 41876.4 41941.2 42347.0 42519.4 42566.0 34797.7 35373.9 35538.6 35635.5 35653.0 34269.5 34782.5 34812.5 34965.8 35106.8 34734.0 34832.7 34837.8 35474.1 35758.6 29661.9 32418.2 32510.2 32707.2 32762.8 22960.5 23028.9 23121.6 23440.4 23559.0 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | [#2] jquery.html Cycles:180 Average:24912.69 Median:26643.16 stddev:69107.66 (259.4%) stddev-sans-first:69276.89 04:30:08 INFO - PROCESS | 25386 | Values: 337.9 350.4 354.2 361.7 380.1 12630.9 15609.8 15775.9 16367.3 17343.0 11965.5 12092.1 14149.3 16353.2 16435.8 4485.9 4923.3 5098.5 5147.8 5153.5 4995.6 5065.3 5070.3 5074.4 5075.0 4872.4 5010.3 5033.0 5049.1 5049.6 5053.3 5099.3 5099.8 5102.3 5104.2 4442.1 4492.6 4543.1 4562.6 4563.5 20986.0 21344.5 21359.4 21393.1 21483.7 1705.8 1790.3 2237.8 2428.5 2450.5 13123.5 13139.4 13236.7 13271.3 13947.4 1717.5 1744.0 1766.0 1772.4 1786.0 67100.3 69843.0 70735.3 71513.0 71529.6 9370.1 9611.2 9641.8 9766.0 10099.9 13109.5 13135.0 13146.4 13153.7 13155.9 6724.9 6970.9 7014.9 7190.3 7193.4 6621.2 6688.1 6841.1 6862.7 6874.2 5911.6 6036.0 6065.2 6109.1 6230.8 1718.9 1748.2 1766.2 1787.4 1812.7 849.8 864.9 872.3 890.2 978.5 16501.7 16906.0 16974.3 18074.4 18391.5 807.7 818.5 844.2 875.8 916.6 9233.5 9702.6 9859.8 9886.4 10021.8 409282.0 415531.0 416042.0 429158.0 429192.0 48445.5 70833.0 75687.0 78434.0 82207.0 881.1 887.7 912.6 914.2 915.5 15190.2 15299.6 15352.4 15975.3 16147.6 37255.8 37507.0 37816.2 38501.8 38759.6 49914.0 50487.0 50701.7 50816.0 51013.7 7189.7 7481.3 7492.7 7544.8 7633.5 10053.6 10633.6 11166.4 11592.5 12280.2 9636.0 9764.9 10182.7 10481.0 10542.2 4840.8 7606.8 9145.4 10155.2 10746.2 9873.0 9923.5 10167.3 10271.2 10425.4 6398.1 6705.7 6799.6 7062.5 7364.3 8039.0 10087.5 10095.0 10216.6 10919.3 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | [#3] mootools.html Cycles:180 Average:4931.86 Median:5947.93 stddev:2772.34 (46.6%) stddev-sans-first:2765.71 04:30:08 INFO - PROCESS | 25386 | Values: 1170.5 1335.1 1377.3 1414.3 1630.3 6660.0 7400.1 7662.5 7667.8 7832.1 7607.7 7671.1 7686.3 7687.9 7688.5 2077.8 2110.0 2117.4 2124.1 2125.4 2050.9 2097.8 2116.9 2118.6 2126.6 2049.7 2092.4 2100.2 2101.4 2122.3 2070.0 2079.7 2083.7 2085.2 2088.0 2027.1 2069.0 2098.3 2099.3 2102.7 7301.5 7369.1 7509.4 7513.3 7521.7 4168.1 4296.3 4312.2 4320.9 4321.3 2783.4 2933.8 2980.8 2993.0 2999.9 882.6 895.8 896.1 899.1 908.1 9744.0 9746.2 9810.5 9833.6 9836.7 3640.9 3837.5 3952.9 3959.1 3967.4 7858.5 7860.0 7861.3 7863.8 7882.1 4310.3 4310.3 4312.2 4321.4 4321.9 3548.1 3891.3 3987.8 3989.6 4058.3 3313.7 3395.7 3453.7 3463.6 3543.9 976.7 991.0 1000.2 1008.8 1008.8 606.5 743.3 771.5 780.3 783.5 4877.3 5169.4 5188.3 5228.9 5307.7 833.7 837.8 874.1 895.9 897.5 3434.3 3446.0 3476.0 3569.9 3575.3 8952.6 9310.3 9535.2 9583.9 9690.0 9531.4 9579.6 9601.9 9605.2 9625.3 7244.2 7254.2 7400.4 7433.2 7458.4 5113.5 5121.2 5159.9 5203.8 5215.8 8678.3 8704.5 8787.4 8853.6 8894.5 8763.6 8985.7 9033.6 9043.2 9108.3 5683.2 6199.5 6313.6 6314.2 6838.2 7049.9 7160.8 7355.7 7357.6 7361.9 6395.2 6472.5 6561.3 6667.5 6677.5 6226.9 6283.6 6331.4 6347.6 6435.7 5812.6 5945.9 5950.0 5950.6 5952.5 4376.6 4425.4 4467.3 4522.2 4614.1 4379.2 4456.5 4516.2 4521.8 4545.1 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | [#4] prototype.html Cycles:180 Average:3976.89 Median:4505.95 stddev:1149.44 (25.5%) stddev-sans-first:1118.87 04:30:08 INFO - PROCESS | 25386 | Values: 290.4 293.6 298.3 302.9 303.3 4609.2 4661.9 4684.4 4695.3 4758.8 4608.3 4612.0 4619.9 4688.3 4689.7 3702.6 3703.9 3706.2 3707.6 3712.7 3579.5 3704.6 3710.9 3712.5 3720.1 3620.0 3660.4 3663.2 3673.1 3673.2 3655.4 3659.6 3659.8 3673.1 3703.1 3064.1 3157.4 3259.3 3262.6 3266.1 4358.5 4502.4 4509.5 4515.2 4515.8 4121.9 4125.3 4126.2 4129.1 4161.2 4522.8 4589.2 4805.2 4808.7 4812.8 3415.6 3494.5 3513.1 3513.5 3514.4 4984.1 4987.6 4992.6 4992.9 4997.0 3599.2 3602.4 3603.7 3614.7 3649.8 3553.3 3630.0 3631.8 3674.5 3709.9 4112.1 4113.5 4116.0 4127.2 4134.4 4781.9 4795.7 4815.5 4824.9 4833.0 1222.3 1241.6 1244.3 1258.1 1259.4 811.9 825.8 828.9 831.1 832.8 3878.3 3892.7 3900.8 3902.0 3904.3 4367.3 4371.9 4373.9 4400.8 4430.6 3842.1 3880.4 3897.6 3900.6 3906.0 2223.3 2305.7 2318.4 2333.7 2337.2 4191.0 4199.2 4200.4 4484.8 4574.9 4990.4 5021.2 5043.2 5050.5 5055.8 4713.5 4732.1 4732.9 4736.5 4739.8 4782.9 4864.4 4889.7 4928.5 4948.7 4829.3 4849.4 4855.4 4873.9 4876.5 4715.3 4720.5 4727.6 4732.0 4745.0 3543.8 3643.7 3646.2 3649.5 3654.6 4949.4 4961.6 4970.2 4971.5 4980.1 4829.7 4834.8 4835.2 4839.4 4851.9 4597.9 4836.0 4844.9 4845.0 4846.4 4703.5 4745.7 4752.4 4753.8 4755.9 4814.3 4833.8 4859.1 4860.3 4871.1 4577.8 4713.8 4732.3 4757.4 4787.6 04:30:08 INFO - PROCESS | 25386 | 04:30:08 INFO - PROCESS | 25386 | [#5] yui.html Cycles:180 Average:17298.37 Median:26329.64 stddev:26025.95 (98.8%) stddev-sans-first:26068.61 04:30:08 INFO - PROCESS | 25386 | Values: 560.1 580.2 590.1 638.4 649.2 11918.8 12573.7 12603.7 12916.6 12970.4 11656.4 12168.3 12295.4 12321.6 12327.5 726.7 749.7 750.0 757.1 759.9 738.6 741.3 741.6 741.9 742.1 779.7 783.0 787.5 788.0 791.4 783.1 788.2 788.8 789.0 789.0 569.5 571.8 573.9 573.9 574.3 10853.8 10880.4 10893.7 10900.6 10902.7 10605.8 10644.7 10807.2 10813.4 10892.5 9199.6 9282.3 9422.7 9537.6 9779.3 3205.1 3236.2 3269.3 3278.1 3385.1 64954.0 65228.0 65782.3 66319.3 67076.3 7922.1 7994.1 8023.4 8058.2 8134.3 15995.3 16004.9 16118.0 16122.1 16526.5 6630.8 6666.4 6735.3 6838.0 7000.7 3435.3 3496.1 3534.4 3537.6 3584.4 2629.2 2700.8 2726.9 2730.7 2743.7 464.4 475.1 491.3 497.1 500.0 525.5 527.6 528.0 550.3 550.6 7693.2 7713.6 7878.6 7968.3 8097.3 487.6 517.4 523.5 524.5 534.4 3775.3 3856.2 3940.9 3965.9 3977.7 98657.0 100286.5 101514.0 103308.0 104598.0 88760.6 89494.6 90480.5 90522.5 91588.0 73048.0 78292.2 80755.6 81740.6 82726.6 6938.3 6978.6 7311.5 7344.4 7754.6 31502.7 39832.6 42365.0 42680.6 44907.8 38186.4 38686.4 51139.5 52135.7 53344.0 10076.8 10354.7 10589.8 10653.5 10868.6 12232.2 12421.2 12734.3 13473.1 13611.6 11515.4 11621.4 12123.9 12431.8 12433.2 10807.4 11423.4 11436.7 11522.8 11775.3 11044.9 11191.9 11613.0 11740.9 11954.7 8841.5 9246.2 9385.8 9563.3 10135.1 9645.1 9938.2 9940.4 9951.3 9971.8 04:30:08 INFO - PROCESS | 25386 | -------- Summary: end -------- 04:30:08 INFO - PROCESS | 25386 | 04:30:09 INFO - TEST-INFO | 25386: exit 0 04:30:09 INFO - TEST-OK | dromaeo_css | took 1121777ms 04:30:09 INFO - TEST-START | kraken 04:30:09 INFO - operating with platform_type : linux_ 04:30:09 INFO - Initialising browser for kraken test... 04:30:09 INFO - TEST-INFO | started process 25692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxX6evo/profile http://localhost:47981/getInfo.html) 04:30:14 INFO - PROCESS | 25692 | __metrics Screen width/height:1600/1200 04:30:14 INFO - PROCESS | 25692 | colorDepth:24 04:30:14 INFO - PROCESS | 25692 | Browser inner width/height: 1024/697 04:30:14 INFO - PROCESS | 25692 | __metrics 04:30:15 INFO - PROCESS | 25692 | 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" 04:30:15 INFO - PROCESS | 25692 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:30:15 INFO - PROCESS | 25692 | console.error: PushService: 04:30:15 INFO - PROCESS | 25692 | stateChangeProcessEnqueue: Error transitioning state 04:30:15 INFO - PROCESS | 25692 | UnknownError 04:30:16 INFO - TEST-INFO | 25692: exit 0 04:30:16 INFO - Browser initialized. 04:30:16 INFO - Running cycle 1/1 for kraken test... 04:30:16 INFO - TEST-INFO | started process 25770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxX6evo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:29 INFO - PROCESS | 25770 | RSS: Main: 177295360 04:30:29 INFO - PROCESS | 25770 | 04:30:31 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47981/tests/kraken/driver.html?testName=audio-beat-detection) 04:30:32 INFO - PROCESS | 25770 | RSS: Main: 237834240 04:30:32 INFO - PROCESS | 25770 | 04:30:35 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47981/tests/kraken/driver.html?testName=audio-dft) 04:30:36 INFO - PROCESS | 25770 | RSS: Main: 228659200 04:30:36 INFO - PROCESS | 25770 | 04:30:39 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47981/tests/kraken/driver.html?testName=audio-fft) 04:30:40 INFO - PROCESS | 25770 | RSS: Main: 304672768 04:30:40 INFO - PROCESS | 25770 | 04:30:42 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47981/tests/kraken/driver.html?testName=audio-oscillator) 04:30:42 INFO - PROCESS | 25770 | RSS: Main: 212676608 04:30:42 INFO - PROCESS | 25770 | 04:30:45 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47981/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:30:45 INFO - PROCESS | 25770 | RSS: Main: 215404544 04:30:45 INFO - PROCESS | 25770 | 04:30:48 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47981/tests/kraken/driver.html?testName=imaging-darkroom) 04:30:49 INFO - PROCESS | 25770 | RSS: Main: 252399616 04:30:49 INFO - PROCESS | 25770 | 04:30:53 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47981/tests/kraken/driver.html?testName=imaging-desaturate) 04:30:53 INFO - PROCESS | 25770 | RSS: Main: 246116352 04:30:53 INFO - PROCESS | 25770 | 04:30:56 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47981/tests/kraken/driver.html?testName=json-parse-financial) 04:30:57 INFO - PROCESS | 25770 | RSS: Main: 249974784 04:30:57 INFO - PROCESS | 25770 | 04:30:59 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47981/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:30:59 INFO - PROCESS | 25770 | RSS: Main: 213417984 04:30:59 INFO - PROCESS | 25770 | 04:31:01 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:31:02 INFO - PROCESS | 25770 | RSS: Main: 220692480 04:31:02 INFO - PROCESS | 25770 | 04:31:04 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:31:05 INFO - PROCESS | 25770 | RSS: Main: 225251328 04:31:05 INFO - PROCESS | 25770 | 04:31:07 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:31:08 INFO - PROCESS | 25770 | RSS: Main: 219787264 04:31:08 INFO - PROCESS | 25770 | 04:31:11 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:31:12 INFO - PROCESS | 25770 | RSS: Main: 223014912 04:31:12 INFO - PROCESS | 25770 | 04:31:13 INFO - PROCESS | 25770 | Cycle 1(1): loaded http://localhost:47981/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47981/tests/kraken/driver.html?testName=ai-astar) 04:31:14 INFO - PROCESS | 25770 | RSS: Main: 275718144 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | __start_tp_report 04:31:14 INFO - PROCESS | 25770 | _x_x_mozilla_page_load 04:31:14 INFO - PROCESS | 25770 | _x_x_mozilla_page_load_details 04:31:14 INFO - PROCESS | 25770 | |i|pagename|runs| 04:31:14 INFO - PROCESS | 25770 | |0;ai-astar;104;116;113;115;116;114;124;114;115;114 04:31:14 INFO - PROCESS | 25770 | |1;audio-beat-detection;155;129;155;190;124;148;147;123;177;122 04:31:14 INFO - PROCESS | 25770 | |2;audio-dft;161;162;162;160;161;161;162;161;162;163 04:31:14 INFO - PROCESS | 25770 | |3;audio-fft;76;78;76;176;78;77;76;77;171;77 04:31:14 INFO - PROCESS | 25770 | |4;audio-oscillator;88;86;155;89;87;87;140;86;87;145 04:31:14 INFO - PROCESS | 25770 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;117;118;118 04:31:14 INFO - PROCESS | 25770 | |6;imaging-darkroom;147;147;146;146;148;146;146;146;146;146 04:31:14 INFO - PROCESS | 25770 | |7;imaging-desaturate;95;95;95;98;94;95;95;95;95;94 04:31:14 INFO - PROCESS | 25770 | |8;json-parse-financial;65;65;65;65;66;71;66;66;65;66 04:31:14 INFO - PROCESS | 25770 | |9;json-stringify-tinderbox;66;66;65;67;66;66;67;67;67;67 04:31:14 INFO - PROCESS | 25770 | |10;stanford-crypto-aes;83;84;82;91;92;82;91;83;88;82 04:31:14 INFO - PROCESS | 25770 | |11;stanford-crypto-ccm;134;133;132;131;132;135;134;129;153;133 04:31:14 INFO - PROCESS | 25770 | |12;stanford-crypto-pbkdf2;172;173;176;178;174;173;173;172;173;171 04:31:14 INFO - PROCESS | 25770 | |13;stanford-crypto-sha256-iterative;70;73;69;69;68;69;70;68;69;68 04:31:14 INFO - PROCESS | 25770 | __end_tp_report 04:31:14 INFO - PROCESS | 25770 | __start_cc_report 04:31:14 INFO - PROCESS | 25770 | _x_x_mozilla_cycle_collect,2008 04:31:14 INFO - PROCESS | 25770 | __end_cc_report 04:31:14 INFO - PROCESS | 25770 | __startTimestamp1472211074156__endTimestamp 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | ------- Summary: start ------- 04:31:14 INFO - PROCESS | 25770 | Number of tests: 14 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:4.81 (4.2%) stddev-sans-first:3.28 04:31:14 INFO - PROCESS | 25770 | Values: 104.0 116.0 113.0 115.0 116.0 114.0 124.0 114.0 115.0 114.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:151.50 stddev:23.41 (15.5%) stddev-sans-first:24.65 04:31:14 INFO - PROCESS | 25770 | Values: 155.0 129.0 155.0 190.0 124.0 148.0 147.0 123.0 177.0 122.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 04:31:14 INFO - PROCESS | 25770 | Values: 161.0 162.0 162.0 160.0 161.0 161.0 162.0 161.0 162.0 163.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#3] audio-fft Cycles:10 Average:96.20 Median:77.00 stddev:40.76 (52.9%) stddev-sans-first:42.58 04:31:14 INFO - PROCESS | 25770 | Values: 76.0 78.0 76.0 176.0 78.0 77.0 76.0 77.0 171.0 77.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:87.00 stddev:28.99 (33.3%) stddev-sans-first:30.09 04:31:14 INFO - PROCESS | 25770 | Values: 88.0 86.0 155.0 89.0 87.0 87.0 140.0 86.0 87.0 145.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:31:14 INFO - PROCESS | 25770 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 04:31:14 INFO - PROCESS | 25770 | Values: 147.0 147.0 146.0 146.0 148.0 146.0 146.0 146.0 146.0 146.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.10 (1.2%) stddev-sans-first:1.17 04:31:14 INFO - PROCESS | 25770 | Values: 95.0 95.0 95.0 98.0 94.0 95.0 95.0 95.0 95.0 94.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.83 (2.8%) stddev-sans-first:1.90 04:31:14 INFO - PROCESS | 25770 | Values: 65.0 65.0 65.0 65.0 66.0 71.0 66.0 66.0 65.0 66.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 04:31:14 INFO - PROCESS | 25770 | Values: 66.0 66.0 65.0 67.0 66.0 66.0 67.0 67.0 67.0 67.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:4.21 (4.9%) stddev-sans-first:4.34 04:31:14 INFO - PROCESS | 25770 | Values: 83.0 84.0 82.0 91.0 92.0 82.0 91.0 83.0 88.0 82.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:133.50 stddev:6.69 (5.0%) stddev-sans-first:7.09 04:31:14 INFO - PROCESS | 25770 | Values: 134.0 133.0 132.0 131.0 132.0 135.0 134.0 129.0 153.0 133.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:173.00 stddev:2.07 (1.2%) stddev-sans-first:2.12 04:31:14 INFO - PROCESS | 25770 | Values: 172.0 173.0 176.0 178.0 174.0 173.0 173.0 172.0 173.0 171.0 04:31:14 INFO - PROCESS | 25770 | 04:31:14 INFO - PROCESS | 25770 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.56 04:31:14 INFO - PROCESS | 25770 | Values: 70.0 73.0 69.0 69.0 68.0 69.0 70.0 68.0 69.0 68.0 04:31:14 INFO - PROCESS | 25770 | -------- Summary: end -------- 04:31:14 INFO - PROCESS | 25770 | 04:31:15 INFO - TEST-INFO | 25770: exit 0 04:31:15 INFO - TEST-OK | kraken | took 66119ms 04:31:15 INFO - SUITE-END | took 1187s 04:31:15 INFO - Completed test suite (00:19:48) 04:31:15 INFO - javascript benchmark 04:31:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.244432892297, 2589.7539733725303, 2608.5043841670094, 2629.829061111028, 2637.4856902903944, 4588.242939914914, 4698.45967713713, 4745.54917282858, 4745.833895813647, 4821.614270858332, 4503.076869241814, 4707.552782485658, 4751.16854550454, 4781.90436191276, 4819.710817350961, 4390.934135987963, 4410.75740834254, 4420.027593929346, 4439.378487011805, 4483.0, 4389.758563279002, 4439.889002774924, 4461.152381047591, 4473.261911784552, 4484.215262329096, 4217.093324935154, 4264.957350426487, 4272.444582204324, 4302.65578753699, 4362.105768317488, 4279.144171165748, 4302.5052119006405, 4310.030243195288, 4355.216061108999, 4373.343998400233, 4333.414988976511, 4337.327714204272, 4345.630621397185, 4362.258416069276, 4362.781860906942, 4513.323001549761, 4619.722816631013, 4650.0, 4741.810327586927, 4743.241081426955, 5089.949100508985, 5091.516305950929, 5103.311053007834, 5103.617228707862, 5110.97444512775, 5082.466341034212, 5105.132127538291, 5113.411957624883, 5128.743562821881, 5133.743312834344, 4530.909381812346, 4652.116097941381, 4704.976475117603, 4711.057788442326, 4766.880827979294, 5213.087709650872, 5220.9738951305, 5231.058409486329, 5236.109861323508, 5240.973795131, 4986.127427700138, 5005.224190250517, 5005.4744251853035, 5010.423801262901, 5010.69935803853, 4879.26810978349, 4962.652614316963, 4997.225430058346, 5008.824691135866, 5090.2364645303505, 4976.576990955737, 5016.54851063406, 5016.749162541858, 5017.297578339036, 5021.874453138627, 4988.850334489971, 4996.575291100225, 4997.825076122391, 4997.875053123701, 5002.624803139779, 4068.5524592294823, 4103.2409004334295, 4103.261412945639, 4153.646940010133, 4225.9577404226175, 3605.080704420356, 3640.4539319102346, 3667.1932174921476, 3681.742278040565, 3743.1765011697385, 4362.541933096979, 4364.54172311909, 4368.170047690992, 4369.934450983238, 4372.103718737651, 4899.4365647950945, 4989.451160372429, 4992.550670439605, 4998.150314446553, 5009.123403404463, 4293.0984493256765, 4316.352547117957, 4323.63249123828, 4366.8034938427845, 4374.825006999685, 4475.70907890986, 4479.440069991251, 4479.932801007987, 4480.14877173336, 4483.843065492692, 4642.442906851199, 4725.054989002145, 4756.381670382828, 4761.738104404291, 4763.404574428197, 4950.752462376795, 5001.874953126201, 5008.6744361616375, 5076.36545431821, 5079.949200507947, 4791.592714619296, 4795.880102997314, 4806.975965120152, 4808.639352048541, 4810.855674329776, 4826.565609095198, 5008.9499105009945, 5009.799608015638, 5014.749262536786, 5020.949790502048, 4959.429665588504, 4977.477364876636, 5037.445880953019, 5042.268871013609, 5069.898602028013, 4902.362692849907, 4928.211486162197, 4936.654434189572, 4937.753112344297, 4940.505949405175, 4766.761661916959, 4929.0, 4943.530364615356, 4952.851414457572, 4954.9752251238515, 4726.1492931272705, 4730.810767569396, 4785.904281914272, 4843.2735089735415, 4859.781309840995, 4926.581240594446, 4928.433230178575, 4954.677945933647, 4960.70235785854, 4965.205567109245, 4675.76621168947, 4735.952640473552, 4840.0, 4847.927281090857, 4850.708957462563], "value": 4619.238747443852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.9069553523667, 567.6168586204313, 578.9305283365995, 581.0354811013718, 581.0528837994069, 38169.80915095424, 39973.60026399739, 40107.59892401079, 43573.78213108938, 43659.78170109145, 41352.37971430423, 41753.791231043804, 41857.79071104648, 41859.58140418595, 41952.370714439305, 7511.8497630047505, 7637.694492220332, 7642.350400215961, 7642.541447513139, 7647.655855486489, 7689.615519224017, 7749.845003099935, 7767.456278060538, 7767.805804854867, 7768.223177682243, 7769.844603107935, 7772.805679857992, 7790.376769858426, 7817.179196184404, 7827.412944029192, 7675.50109242903, 7681.57751323677, 7684.462087653867, 7703.845923081563, 7705.8844117338285, 7611.65747541362, 7677.654505547263, 7685.269899359552, 7745.186755390716, 7746.9225307746765, 38079.715217086785, 38350.61649383498, 38459.0, 38483.23033539342, 38489.23021539554, 2639.7228291029355, 2668.759811616964, 2710.2953232159584, 3063.724264816155, 3071.109378280296, 28366.29084272889, 29125.56311655327, 29250.707492925012, 29715.257118571993, 30118.096457106323, 3112.828794416306, 3129.9843500782576, 3171.1437911763924, 3232.7252183564424, 3245.432049391347, 186704.0, 186813.0, 186878.0, 187257.0, 187619.0, 43332.350014749805, 43349.349759753, 43429.0, 43453.78273108614, 43504.78247608805, 29021.85489072541, 55732.0, 55855.0, 55898.441015590135, 55971.0, 13147.0797044206, 13622.795658065137, 13656.317184140753, 13704.10923289983, 13711.588652340446, 10262.230332725076, 10302.124319432782, 10313.74215644615, 10317.071463568314, 10322.948385258025, 18075.186616602285, 18117.45647630573, 18124.818751812578, 18135.72796408055, 18243.36148234832, 6695.691637118007, 6819.885835391045, 6832.59004459734, 6970.477214208853, 7059.647017649097, 789.9763007109796, 872.5419154943705, 893.4817805672694, 903.8824952756231, 984.1192133041031, 27157.864210679214, 27930.720692793217, 28248.29379265535, 28335.43329133447, 29017.274568135967, 943.4622265308845, 949.7103383468109, 965.232640051161, 968.9176420004237, 1014.8173328800887, 14295.0, 14942.0, 15115.622109447351, 15523.146226957626, 15582.376704931903, 399002.0, 404718.0, 405531.0, 406802.0, 407489.0, 50003.0, 50627.0, 50698.23952640713, 50776.492235077174, 50776.74611626992, 1038.6209033702796, 1043.869516310446, 1076.278893141597, 1123.6797512708838, 1149.2357582207906, 26957.46085078248, 29148.708512915447, 29549.409011820073, 29578.704212957597, 30113.849430753584, 42671.786641066596, 43272.0, 43313.133737325705, 43332.0, 43378.0, 286616.0, 288206.0, 289767.0, 289845.0, 291703.0, 22343.44141396478, 22597.661035084817, 22598.209062682727, 23072.653910191024, 23893.641595375735, 41876.371854421595, 41941.161176776906, 42347.0, 42519.3622095675, 42566.0, 34797.652023479444, 35373.9184332464, 35538.64461355354, 35635.46546801748, 35653.0, 34269.48595771015, 34782.47826282658, 34812.47781283232, 34965.825170873984, 35106.82446587751, 34734.0, 34832.65167348294, 34837.82581087078, 35474.11314717153, 35758.64241357553, 29661.85169074141, 32418.189545261557, 32510.187245319055, 32707.182320442178, 32762.83618581892, 22960.54078918379, 23028.884855575616, 23121.61270323786, 23440.413989649714, 23559.0], "value": 16953.545001009254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.87968114462916, 350.43754773588375, 354.1606392848948, 361.6961752128212, 380.0896852039366, 12630.873691263085, 15609.84390156098, 15775.921120394381, 16367.345306187768, 17343.04613246271, 11965.521379144824, 12092.093093018015, 14149.29253537324, 16353.182340882968, 16435.753463698053, 4485.910281794362, 4923.335349727786, 5098.541131298182, 5147.845564633067, 5153.458886816887, 4995.625328100407, 5065.316182315377, 5070.290159377671, 5074.416442109149, 5075.0, 4872.366592343008, 5010.348654674887, 5033.043721692885, 5049.091163590552, 5049.6212784041345, 5053.292539044518, 5099.311592934962, 5099.796008159669, 5102.260172275037, 5104.234364845266, 4442.067165895166, 4492.640588752892, 4543.068670922453, 4562.6121779648765, 4563.520830312803, 20986.0, 21344.46638834026, 21359.359219223446, 21393.144274229013, 21483.67774483384, 1705.7526658634429, 1790.3017823049022, 2237.8433509654333, 2428.5287379221177, 2450.497647982177, 13123.475060997549, 13139.408726607326, 13236.735265294641, 13271.270080145589, 13947.442102315896, 1717.4933394648608, 1743.9564010899703, 1766.0, 1772.3619496981075, 1786.0, 67100.32899671038, 69843.0, 70735.29264707338, 71513.0, 71529.64235178843, 9370.10983956523, 9611.231101511863, 9641.758956026155, 9766.0467906419, 10099.94950025245, 13109.475620975245, 13135.0, 13146.4084116215, 13153.671158221121, 13155.934220329029, 6724.899126513106, 6970.895436568456, 7014.92985070153, 7190.316919892602, 7193.352598266077, 6621.172353455818, 6688.130543029375, 6841.076454678654, 6862.691178896962, 6874.2094659113845, 5911.645301281937, 6036.0, 6065.188997024341, 6109.11417844419, 6230.844228894314, 1718.905460199676, 1748.1696194307601, 1766.2316892151955, 1787.3922866225546, 1812.709966405395, 849.8130411309502, 864.8529749942525, 872.3283072034498, 890.2166093837382, 978.471625322318, 16501.669966600602, 16906.0, 16974.32102715902, 18074.3673971413, 18391.50561393331, 807.7415227127262, 818.4925346285341, 844.151627614256, 875.7810547363159, 916.564631799903, 9233.492157931243, 9702.611895524242, 9859.753506162404, 9886.406815591088, 10021.79956400868, 409282.0, 415531.0, 416042.0, 429158.0, 429192.0, 48445.5155448441, 70833.0, 75687.0, 78434.0, 82207.0, 881.1452890696015, 887.6937456577599, 912.589334799343, 914.1772404835568, 915.4507295622707, 15190.240487975336, 15299.61750956235, 15352.385904564138, 15975.281112350205, 16147.596310092342, 37255.76465412084, 37507.0, 37816.24367512689, 38501.80749096349, 38759.6124038756, 49914.0, 50487.0, 50701.74649126731, 50816.0, 51013.744931275105, 7189.712411503481, 7481.326680598555, 7492.700291988477, 7544.811379715332, 7633.465657403928, 10053.648122315684, 10633.627823026158, 11166.38584877807, 11592.47833847462, 12280.201786884181, 9636.0, 9764.902350976683, 10182.694519164437, 10481.0, 10542.156627469938, 4840.806367745392, 7606.771796846104, 9145.405548639317, 10155.187584993331, 10746.24776265654, 9872.950635246778, 9923.45421001823, 10167.313372617262, 10271.229657775846, 10425.426601536989, 6398.1362516059735, 6705.664716764045, 6799.558028728117, 7062.540934839219, 7364.3372096511575, 8038.959805200937, 10087.495625218857, 10095.0, 10216.591336346462, 10919.290246133976], "value": 8124.147951604215, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1170.496686424837, 1335.1455068755995, 1377.2562816079317, 1414.2645824171432, 1630.315267587613, 6659.966700166498, 7400.148982866972, 7662.501937374067, 7667.769966900995, 7832.06015278166, 7607.657655405506, 7671.117821450535, 7686.346660533847, 7687.884681729764, 7688.500247483909, 2077.771445141037, 2110.02938648222, 2117.4282943605217, 2124.097258665061, 2125.436759258798, 2050.928217512387, 2097.8216851567636, 2116.947076323089, 2118.608057509358, 2126.5959467701164, 2049.6515592349338, 2092.4141240452695, 2100.24391219161, 2101.4011006863047, 2122.3314655883423, 2070.0477780221117, 2079.740032495938, 2083.718697975769, 2085.18677715691, 2088.04993727855, 2027.1080724481328, 2068.98965505173, 2098.2865825619365, 2099.3177217404404, 2102.653062244743, 7301.4523910706375, 7369.115706115301, 7509.399248060196, 7513.323800857895, 7521.699132034712, 4168.083021735244, 4296.334068219399, 4312.245357062501, 4320.870373888788, 4321.2653848845775, 2783.4154827486254, 2933.7946343755943, 2980.806247593921, 2993.0, 2999.9400011999855, 882.5587206396801, 895.789489469974, 896.1441823058963, 899.1008991008991, 908.1463424381061, 9743.951280243624, 9746.220302375792, 9810.509474526245, 9833.557489913042, 9836.655717049869, 3640.908977275589, 3837.4819399381286, 3952.940705889414, 3959.1289916218384, 3967.444557761916, 7858.528488290721, 7859.960700196462, 7861.331786798072, 7863.764087077397, 7882.054153501616, 4310.267254566731, 4310.3103503439925, 4312.223799716081, 4321.351797230441, 4321.870343889688, 3548.1129717570607, 3891.2606604745006, 3987.7806720630065, 3989.6209860063245, 4058.3100872851687, 3313.6520665330277, 3395.7283417326553, 3453.740969427303, 3463.619001909788, 3543.919104673048, 976.7021058577202, 990.980180396388, 1000.2398177385239, 1008.7679833638305, 1008.8284991551454, 606.4996377988177, 743.3347154296874, 771.5139462138817, 780.2782426255691, 783.4672422752583, 4877.317175595419, 5169.3796744390165, 5188.299579556787, 5228.947710522846, 5307.681539107666, 833.6790335720791, 837.7738010737189, 874.1084094223856, 895.9328050396247, 897.52879738138, 3434.3131373725355, 3445.982770086184, 3475.965240347615, 3569.8572057117426, 3575.3028159509167, 8952.597133128895, 9310.348275620641, 9535.2371810255, 9583.904160958302, 9690.030996900254, 9531.38046027006, 9579.568919398504, 9601.90398096024, 9605.18355939739, 9625.32622716403, 7244.203137654854, 7254.238304977901, 7400.407967362598, 7433.182349941502, 7458.366038886756, 5113.488651134857, 5121.206213036985, 5159.922601161061, 5203.791848326025, 5215.843524694265, 8678.305735541015, 8704.521251331238, 8787.384883058381, 8853.645854165761, 8894.510801905957, 8763.649454021768, 8985.685501007434, 9033.638654453749, 9043.23132533742, 9108.316876234441, 5683.232763576864, 6199.473044791243, 6313.621182729051, 6314.179156709598, 6838.247792742894, 7049.929500705132, 7160.820979475555, 7355.7057717690695, 7357.5953322567775, 7361.889571656537, 6395.232572091193, 6472.5145614080075, 6561.278259391368, 6667.49993750461, 6677.499187561049, 6226.937730622817, 6283.59156654816, 6331.366863313632, 6347.619142851444, 6435.678216089083, 5812.622179558315, 5945.881082378415, 5949.988501954592, 5950.583459157818, 5952.494038006818, 4376.584224498668, 4425.446819147606, 4467.329900514948, 4522.163399771053, 4614.054118905549, 4379.167958087953, 4456.487503937089, 4516.187086324362, 4521.819127234874, 4545.090981803586], "value": 3957.815222189473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.3945274103494, 293.5611261164558, 298.28263027419064, 302.8985289927874, 303.2963524622876, 4609.170349337122, 4661.9067618647605, 4684.391029166212, 4695.272232803916, 4758.785854636541, 4608.308753686941, 4611.953880461195, 4619.930701039487, 4688.335640847501, 4689.718616882989, 3702.648248416396, 3703.907402314937, 3706.2031663192406, 3707.5550933887835, 3712.740108192421, 3579.463080537927, 3704.6105262105925, 3710.888673339804, 3712.480252764615, 3720.1257704439436, 3619.963800361989, 3660.3594370985106, 3663.19409729859, 3673.1184515716304, 3673.2286219893854, 3655.4151335786146, 3659.5846741150713, 3659.79871107089, 3673.1368128489785, 3703.0742314421395, 3064.1114076917665, 3157.431662300785, 3259.3318369734147, 3262.5970832542, 3266.1181481, 4358.5205627380965, 4502.379143508334, 4509.526499717548, 4515.187266292066, 4515.75163366018, 4121.9381709274385, 4125.278076336659, 4126.154138401621, 4129.091599848059, 4161.209370219679, 4522.81141795037, 4589.173948689235, 4805.1590971579835, 4808.711477311337, 4812.759362031919, 3415.6072051714123, 3494.5457090578316, 3513.139280876176, 3513.4554144107706, 3514.3674138655033, 4984.127777638899, 4987.62592805541, 4992.625553083497, 4992.850214493535, 4997.0, 3599.1721903962234, 3602.3875941090078, 3603.675669189733, 3614.6746792788776, 3649.7810131392202, 3553.3248682750195, 3630.0, 3631.8365673544754, 3674.5223120994633, 3709.9072523186596, 4112.115895082572, 4113.526944401372, 4115.9588404116175, 4127.236461254617, 4134.37984302351, 4781.9043619128115, 4795.650131435572, 4815.518448155157, 4824.914394261263, 4832.975835120802, 1222.2971791220084, 1241.6155986075642, 1244.2721008210117, 1258.1318889965894, 1259.4017841525385, 811.9350451963828, 825.8141918068386, 828.9253967142865, 831.1480732249372, 832.8042909916165, 3878.3406820840523, 3892.708046896494, 3900.8439662413753, 3901.9609803902167, 3904.2777086239134, 4367.344898265285, 4371.868843934687, 4373.934390984138, 4400.809413175486, 4430.645548356124, 3842.1376074823875, 3880.3791393376923, 3897.590752970954, 3900.556793986243, 3905.964919296389, 2223.2663221136986, 2305.7233132024267, 2318.431984163891, 2333.6849525314205, 2337.2170322941665, 4191.0, 4199.223143718422, 4200.390943313202, 4484.798184081659, 4574.885627859264, 4990.351254336913, 5021.171506701427, 5043.2435134730085, 5050.49495050492, 5055.797768089235, 4713.457952335457, 4732.0772449372735, 4732.881677958009, 4736.502667219961, 4739.834105806281, 4782.928256076092, 4864.391951006124, 4889.657723959289, 4928.507149285043, 4948.727819969936, 4829.2997515359375, 4849.393825771778, 4855.36880205571, 4873.878153046202, 4876.463589005278, 4715.339852420595, 4720.504347043511, 4727.57451829337, 4731.9763401184155, 4744.952550474451, 3543.822808859495, 3643.7267204959203, 3646.197836475971, 3649.5073165122367, 3654.616265292106, 4949.430815456269, 4961.578265847444, 4970.204767237225, 4971.458847757062, 4980.136421557547, 4829.6860704055525, 4834.806607735792, 4835.20219163834, 4839.370881785346, 4851.854444366533, 4597.908041839211, 4836.032793441255, 4844.947682959712, 4845.0, 4846.418429788448, 4703.529647035269, 4745.667803253739, 4752.3584316116885, 4753.83361582343, 4755.857324280277, 4814.325994360863, 4833.758312084452, 4859.149648811514, 4860.274602516056, 4871.098846713369, 4577.771111444481, 4713.787879545497, 4732.266498692708, 4757.381540399726, 4787.593054590398], "value": 3615.6728833319607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1429812387048, 580.2340909998801, 590.0618017352409, 638.3616383616384, 649.169063598594, 11918.76162476751, 12573.748525029494, 12603.747925041494, 12916.612501624943, 12970.351482425887, 11656.358900260482, 12168.269903805778, 12295.446704898279, 12321.568745093924, 12327.506899724023, 726.7093162734922, 749.6551586270322, 749.966251518683, 757.0650246945019, 759.8746206875859, 738.6380673469988, 741.2587412587412, 741.5587725303436, 741.933226009659, 742.0798210219316, 779.7309928074806, 783.0134031120772, 787.4763282417185, 788.0464637788283, 791.3510921044746, 783.1307248953657, 788.184229322654, 788.7949133225374, 789.0294937227185, 789.0491957191571, 569.504531057978, 571.8027280588232, 573.9024365857772, 573.9139129130622, 574.307958909513, 10853.837192442119, 10880.401577913211, 10893.727656808564, 10900.618478353219, 10902.727431814188, 10605.84091238632, 10644.680659580225, 10807.243492955497, 10813.351198928089, 10892.509837057352, 9199.58601862911, 9282.303827212985, 9422.717318480456, 9537.618495260182, 9779.266555008402, 3205.054508919851, 3236.1909522619344, 3269.29710112327, 3278.1476816027766, 3385.136790118504, 64954.0, 65228.0, 65782.3421765781, 66319.33680663229, 67076.32923670749, 7922.128565857751, 7994.120646728855, 8023.438359314792, 8058.1538938411795, 8134.3085837703275, 15995.280212390471, 16004.91997540005, 16118.032918024956, 16122.113283769271, 16526.504204873632, 6630.834229144213, 6666.400023997863, 6735.259121496631, 6838.0, 7000.719971201197, 3435.278591495814, 3496.091016335771, 3534.3814832404228, 3537.646235376442, 3584.372734771405, 2629.198094581171, 2700.824446410977, 2726.850023248701, 2730.726927307293, 2743.670759508872, 464.4078799530558, 475.12576858580377, 491.28027439800866, 497.0903247057948, 499.9550040496373, 525.519149977766, 527.5937528103339, 527.9683219006872, 550.2544052808466, 550.6475855452513, 7693.192214817475, 7713.575753333621, 7878.645460954271, 7968.282854543119, 8097.311728503026, 487.60747598183804, 517.428241792821, 523.5314393617691, 524.5384062025394, 534.4308311648082, 3775.339315619756, 3856.2480316338606, 3940.940885886714, 3965.8810235692977, 3977.6618987386396, 98657.0, 100286.49856750816, 101514.0, 103308.0, 104598.0, 88760.5561972186, 89494.55252723694, 90480.5475972616, 90522.54738726265, 91588.0, 73048.0, 78292.21707782963, 80755.59622201852, 81740.59129704432, 82726.58636706899, 6938.306169383021, 6978.581285122909, 7311.488195826241, 7344.375728063174, 7754.573498457639, 31502.684973150892, 39832.60167398289, 42365.0, 42680.57319426766, 44907.77546112249, 38186.427203592524, 38686.419703703905, 51139.488605113474, 52135.739321303154, 53344.0, 10076.798464030824, 10354.689359319233, 10589.841152382874, 10653.467326633483, 10868.565257389615, 12232.22632718233, 12421.19262247951, 12734.299613520974, 13473.124246923919, 13611.591652250449, 11515.424228788359, 11621.418929053345, 12123.939380303042, 12431.751364972832, 12433.191842530206, 10807.405592692163, 11423.409755561828, 11436.714082148013, 11522.827157592475, 11775.293482391084, 11044.889551104387, 11191.944040279746, 11613.0, 11740.941295293469, 11954.701132471759, 8841.469511829311, 9246.214071803972, 9385.765355866159, 9563.330566860253, 10135.138513226459, 9645.131938125602, 9938.155256803253, 9940.353876997971, 9951.303408761318, 9971.800563988825], "value": 6180.933078165755, "unit": "score"}], "name": "dromaeo_css", "value": 6190.512670344672, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 115.0, 116.0, 114.0, 124.0, 114.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 155.0, 190.0, 124.0, 148.0, 147.0, 123.0, 177.0, 122.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 176.0, 78.0, 77.0, 76.0, 77.0, 171.0, 77.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 155.0, 89.0, 87.0, 87.0, 140.0, 86.0, 87.0, 145.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 71.0, 66.0, 66.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 82.0, 91.0, 92.0, 82.0, 91.0, 83.0, 88.0, 82.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 132.0, 131.0, 132.0, 135.0, 134.0, 129.0, 153.0, 133.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 176.0, 178.0, 174.0, 173.0, 173.0, 172.0, 173.0, 171.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 69.0, 69.0, 68.0, 69.0, 70.0, 68.0, 69.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1579.0, "alertThreshold": 2.0}]} 04:31:15 INFO - Return code: 0 04:31:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:31:15 INFO - # TBPL SUCCESS # 04:31:15 INFO - Running post-action listener: _resource_record_post_action 04:31:15 INFO - [mozharness: 2016-08-26 11:31:15.931859Z] Finished run-tests step (success) 04:31:15 INFO - Running post-run listener: _resource_record_post_run 04:31:16 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 403677184; Read time: 0; Write time: 492668 04:31:16 INFO - TinderboxPrint: CPU usage
13.3% 04:31:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:31:16 INFO - TinderboxPrint: I/O write bytes / time
403,677,184 / 492,668 04:31:16 INFO - TinderboxPrint: CPU idle
8,328.5 (86.7%) 04:31:16 INFO - TinderboxPrint: CPU user
1,207.5 (12.6%) 04:31:16 INFO - TinderboxPrint: Swap in / out
0 / 0 04:31:16 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114282496; Read time: 0; Write time: 198028 04:31:16 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289394688; Read time: 0; Write time: 294640 04:31:16 INFO - Running post-run listener: _upload_blobber_files 04:31:16 INFO - Blob upload gear active. 04:31:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:31:16 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 04:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:31:16 INFO - (blobuploader) - INFO - Open directory for files ... 04:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:17 INFO - (blobuploader) - INFO - Done attempting. 04:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:21 INFO - (blobuploader) - INFO - Done attempting. 04:31:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:31:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:31:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:31:21 INFO - (blobuploader) - INFO - Done attempting. 04:31:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:31:21 INFO - Return code: 0 04:31:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:31:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:31:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/78ac59cd44dead5235ccbd0cf8211672c8b1d1f5dd6009bb8d269a9f7d1163830961856256792da3efda1d16f911a1b778499cca48fa8c4e1588179b8b613913", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5666f615694a4ea15948dcd5fad0ea2517fb1beabe8a36ebb007bdcc66d5e27001479b3525542536343d91eed02964e56021ddc822b8836fa842bc1aa7a0984d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/52de275f8ae282ed73f7a38a8737779521111cb19a5351359da02e391d27eadd1ef9f6f40109d9a2de75c0272b8e1c944989e4a77b4b93bba46cc88cfd6c50af"} 04:31:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:31:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:31:21 INFO - Contents: 04:31:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/78ac59cd44dead5235ccbd0cf8211672c8b1d1f5dd6009bb8d269a9f7d1163830961856256792da3efda1d16f911a1b778499cca48fa8c4e1588179b8b613913", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5666f615694a4ea15948dcd5fad0ea2517fb1beabe8a36ebb007bdcc66d5e27001479b3525542536343d91eed02964e56021ddc822b8836fa842bc1aa7a0984d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/52de275f8ae282ed73f7a38a8737779521111cb19a5351359da02e391d27eadd1ef9f6f40109d9a2de75c0272b8e1c944989e4a77b4b93bba46cc88cfd6c50af"} 04:31:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:31:21 INFO - Copying logs to upload dir... 04:31:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:31:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.956814 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-26 04:31:21.456723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 04:31:21.460433) ========= 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=eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/78ac59cd44dead5235ccbd0cf8211672c8b1d1f5dd6009bb8d269a9f7d1163830961856256792da3efda1d16f911a1b778499cca48fa8c4e1588179b8b613913", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5666f615694a4ea15948dcd5fad0ea2517fb1beabe8a36ebb007bdcc66d5e27001479b3525542536343d91eed02964e56021ddc822b8836fa842bc1aa7a0984d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/52de275f8ae282ed73f7a38a8737779521111cb19a5351359da02e391d27eadd1ef9f6f40109d9a2de75c0272b8e1c944989e4a77b4b93bba46cc88cfd6c50af"} build_url:https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/P-tpO5RsR4Ob6OndhNho0Q/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/Larch-Non-PGO/sha512/78ac59cd44dead5235ccbd0cf8211672c8b1d1f5dd6009bb8d269a9f7d1163830961856256792da3efda1d16f911a1b778499cca48fa8c4e1588179b8b613913", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5666f615694a4ea15948dcd5fad0ea2517fb1beabe8a36ebb007bdcc66d5e27001479b3525542536343d91eed02964e56021ddc822b8836fa842bc1aa7a0984d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/52de275f8ae282ed73f7a38a8737779521111cb19a5351359da02e391d27eadd1ef9f6f40109d9a2de75c0272b8e1c944989e4a77b4b93bba46cc88cfd6c50af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-26 04:31:21.485530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:31:21.485848) ========= 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=eca2ab57546de7b41f256b19000001ef-1472209832.450535-1733524633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-26 04:31:21.568928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 04:31:21.569255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-26 04:31:21.569543) ========= ========= Total master_lag: 0.17 =========