builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1467329452.33 results: success (0) buildid: 20160630133123 builduid: 3d3cdada0c264602875780d2d302e6be revision: 7339ed5e03791159421bc91995ebc7160d4976b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.331240) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.331726) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.332064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.348959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.349670) ========= 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=232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 16:30:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.1M=0s 2016-06-30 16:30:52 (71.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.068914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.437778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.438422) ========= 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=232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015956 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:52.489904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 16:30:52.490313) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7339ed5e03791159421bc91995ebc7160d4976b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7339ed5e03791159421bc91995ebc7160d4976b2 --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=232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 16:30:52,612 truncating revision to first 12 chars 2016-06-30 16:30:52,612 Setting DEBUG logging. 2016-06-30 16:30:52,613 attempt 1/10 2016-06-30 16:30:52,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7339ed5e0379?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 16:30:52,918 unpacking tar archive at: mozilla-inbound-7339ed5e0379/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646718 ========= master_lag: 0.58 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 16:30:53.713155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:53.713610) ========= script_repo_revision: 7339ed5e03791159421bc91995ebc7160d4976b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:53.714115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:53.714423) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 16:30:53.800043) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-30 16:30:53.800452) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:30:54 INFO - MultiFileLogger online at 20160630 16:30:54 in /builds/slave/test 16:30:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:30:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:54 INFO - {'append_to_log': False, 16:30:54 INFO - 'base_work_dir': '/builds/slave/test', 16:30:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:30:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:54 INFO - 'branch': 'Mozilla-Inbound', 16:30:54 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:54 INFO - 'config_files': ('talos/linux_config.py',), 16:30:54 INFO - 'default_actions': ('clobber', 16:30:54 INFO - 'read-buildbot-config', 16:30:54 INFO - 'download-and-extract', 16:30:54 INFO - 'populate-webroot', 16:30:54 INFO - 'create-virtualenv', 16:30:54 INFO - 'install', 16:30:54 INFO - 'run-tests'), 16:30:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:54 INFO - 'download_minidump_stackwalk': True, 16:30:54 INFO - 'download_symbols': 'ondemand', 16:30:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:54 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:54 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:54 INFO - 'installer_path': 'installer.exe', 16:30:54 INFO - 'log_level': 'info', 16:30:54 INFO - 'log_name': 'talos', 16:30:54 INFO - 'log_to_console': True, 16:30:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:30:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:30:54 INFO - 'opt_config_files': (), 16:30:54 INFO - 'pip_index': False, 16:30:54 INFO - 'sps_profile': False, 16:30:54 INFO - 'sps_profile_interval': 0, 16:30:54 INFO - 'suite': 'dromaeojs', 16:30:54 INFO - 'system_bits': '32', 16:30:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:54 INFO - 'title': 'talos-linux64-ix-025', 16:30:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:54 INFO - 'use_talos_json': True, 16:30:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:54 INFO - 'work_dir': 'build'} 16:30:54 INFO - ##### 16:30:54 INFO - ##### Running clobber step. 16:30:54 INFO - ##### 16:30:54 INFO - Running pre-action listener: _resource_record_pre_action 16:30:54 INFO - Running main action method: clobber 16:30:54 INFO - rmtree: /builds/slave/test/build 16:30:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:54 INFO - Running post-action listener: _resource_record_post_action 16:30:54 INFO - ##### 16:30:54 INFO - ##### Finished clobber step (success) 16:30:54 INFO - ##### 16:30:54 INFO - ##### 16:30:54 INFO - ##### Running read-buildbot-config step. 16:30:54 INFO - ##### 16:30:54 INFO - Running pre-action listener: _resource_record_pre_action 16:30:54 INFO - Running main action method: read_buildbot_config 16:30:54 INFO - Using buildbot properties: 16:30:54 INFO - { 16:30:54 INFO - "project": "", 16:30:54 INFO - "product": "firefox", 16:30:54 INFO - "script_repo_revision": "production", 16:30:54 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:30:54 INFO - "repository": "", 16:30:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:30:54 INFO - "buildid": "20160630133123", 16:30:54 INFO - "pgo_build": "True", 16:30:54 INFO - "basedir": "/builds/slave/test", 16:30:54 INFO - "buildnumber": 2005, 16:30:54 INFO - "slavename": "talos-linux64-ix-025", 16:30:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:30:54 INFO - "platform": "ubuntu64_hw", 16:30:54 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:30:54 INFO - "branch": "mozilla-inbound", 16:30:54 INFO - "repo_path": "integration/mozilla-inbound", 16:30:54 INFO - "revision": "7339ed5e03791159421bc91995ebc7160d4976b2", 16:30:54 INFO - "stage_platform": "linux64-pgo", 16:30:54 INFO - "builduid": "3d3cdada0c264602875780d2d302e6be", 16:30:54 INFO - "slavebuilddir": "test" 16:30:54 INFO - } 16:30:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:30:54 INFO - Running post-action listener: _resource_record_post_action 16:30:54 INFO - ##### 16:30:54 INFO - ##### Finished read-buildbot-config step (success) 16:30:54 INFO - ##### 16:30:54 INFO - ##### 16:30:54 INFO - ##### Running download-and-extract step. 16:30:54 INFO - ##### 16:30:54 INFO - Running pre-action listener: _resource_record_pre_action 16:30:54 INFO - Running main action method: download_and_extract 16:30:54 INFO - mkdir: /builds/slave/test/build/tests 16:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:54 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:30:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:30:55 INFO - Downloaded 1361 bytes. 16:30:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:30:55 INFO - Using the following test package requirements: 16:30:55 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:30:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:30:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:30:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'jsshell-linux-x86_64.zip'], 16:30:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:30:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:30:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:30:55 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:30:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:30:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:30:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:30:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:55 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:30:56 INFO - Downloaded 24270357 bytes. 16:30:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:30:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:30:57 INFO - Return code: 0 16:30:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:30:57 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:30:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:30:59 INFO - Downloaded 24270357 bytes. 16:30:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:30:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:31:01 INFO - Return code: 0 16:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:01 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:31:02 INFO - Downloaded 14405242 bytes. 16:31:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:31:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:31:02 INFO - Return code: 0 16:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:02 INFO - https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:31:03 INFO - Downloaded 60316065 bytes. 16:31:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:03 INFO - mkdir: /builds/slave/test/properties 16:31:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:03 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:03 INFO - Contents: 16:31:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:04 INFO - Running post-action listener: _resource_record_post_action 16:31:04 INFO - Running post-action listener: set_extra_try_arguments 16:31:04 INFO - ##### 16:31:04 INFO - ##### Finished download-and-extract step (success) 16:31:04 INFO - ##### 16:31:04 INFO - ##### 16:31:04 INFO - ##### Running populate-webroot step. 16:31:04 INFO - ##### 16:31:04 INFO - Running pre-action listener: _resource_record_pre_action 16:31:04 INFO - Running main action method: populate_webroot 16:31:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:04 INFO - '--tppagecycles', 16:31:04 INFO - '7'], 16:31:04 INFO - 'tests': ['tsvgm']}}, 16:31:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['damp', 'tps']}, 16:31:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'tests': ['damp', 'tps']}, 16:31:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['dromaeo_dom']}, 16:31:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['basic_compositor_video']}, 16:31:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:31:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['a11yr', 16:31:04 INFO - 'ts_paint', 16:31:04 INFO - 'tpaint', 16:31:04 INFO - 'sessionrestore', 16:31:04 INFO - 'sessionrestore_no_auto_restore', 16:31:04 INFO - 'tabpaint']}, 16:31:04 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:04 INFO - 'ts_paint', 16:31:04 INFO - 'tpaint', 16:31:04 INFO - 'sessionrestore', 16:31:04 INFO - 'sessionrestore_no_auto_restore', 16:31:04 INFO - 'tabpaint']}, 16:31:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:04 INFO - 'ts_paint', 16:31:04 INFO - 'tpaint', 16:31:04 INFO - 'sessionrestore', 16:31:04 INFO - 'sessionrestore_no_auto_restore', 16:31:04 INFO - 'tabpaint']}, 16:31:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:04 INFO - 'ts_paint', 16:31:04 INFO - 'tpaint', 16:31:04 INFO - 'sessionrestore', 16:31:04 INFO - 'sessionrestore_no_auto_restore', 16:31:04 INFO - 'tabpaint']}, 16:31:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['a11yr', 16:31:04 INFO - 'ts_paint', 16:31:04 INFO - 'tpaint', 16:31:04 INFO - 'sessionrestore', 16:31:04 INFO - 'sessionrestore_no_auto_restore', 16:31:04 INFO - 'tabpaint']}, 16:31:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['a11yr', 16:31:04 INFO - 'ts_paint', 16:31:04 INFO - 'tpaint', 16:31:04 INFO - 'sessionrestore', 16:31:04 INFO - 'sessionrestore_no_auto_restore', 16:31:04 INFO - 'tabpaint']}, 16:31:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['tsvgx', 16:31:04 INFO - 'tsvgr_opacity', 16:31:04 INFO - 'tart', 16:31:04 INFO - 'tscrollx', 16:31:04 INFO - 'cart']}, 16:31:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:04 INFO - 'tsvgr_opacity', 16:31:04 INFO - 'tart', 16:31:04 INFO - 'tscrollx', 16:31:04 INFO - 'cart']}, 16:31:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'talos_options': ['--disable-e10s'], 16:31:04 INFO - 'tests': ['tp5o']}, 16:31:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'tests': ['tp5o']}, 16:31:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'talos_options': ['--disable-e10s', 16:31:04 INFO - '--xperf_path', 16:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:04 INFO - 'tests': ['tp5n']}, 16:31:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:04 INFO - 'talos_options': ['--xperf_path', 16:31:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:04 INFO - 'tests': ['tp5n']}}, 16:31:04 INFO - 'talos.zip': {'path': '', 16:31:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:04 INFO - Running post-action listener: _resource_record_post_action 16:31:04 INFO - ##### 16:31:04 INFO - ##### Finished populate-webroot step (success) 16:31:04 INFO - ##### 16:31:04 INFO - ##### 16:31:04 INFO - ##### Running create-virtualenv step. 16:31:04 INFO - ##### 16:31:04 INFO - Running pre-action listener: _resource_record_pre_action 16:31:04 INFO - Running main action method: create_virtualenv 16:31:04 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:04 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 16:31:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:04 INFO - Using real prefix '/usr' 16:31:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:05 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:07 INFO - Installing pip.................done. 16:31:07 INFO - Return code: 0 16:31:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:31:07 INFO - Using env: {'DISPLAY': ':0', 16:31:07 INFO - 'HOME': '/home/cltbld', 16:31:07 INFO - 'LANG': 'en_US.UTF-8', 16:31:07 INFO - 'LANGUAGE': 'en_US:en', 16:31:07 INFO - 'LOGNAME': 'cltbld', 16:31:07 INFO - 'MAIL': '/var/mail/cltbld', 16:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:07 INFO - 'MOZ_NO_REMOTE': '1', 16:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:07 INFO - 'NO_EM_RESTART': '1', 16:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:07 INFO - 'PWD': '/builds/slave/test', 16:31:07 INFO - 'SHELL': '/bin/bash', 16:31:07 INFO - 'SHLVL': '1', 16:31:07 INFO - 'TERM': 'linux', 16:31:07 INFO - 'TMOUT': '86400', 16:31:07 INFO - 'USER': 'cltbld', 16:31:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:07 INFO - '_': '/tools/buildbot/bin/python'} 16:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:07 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 16:31:07 INFO - Cleaning up... 16:31:07 INFO - Return code: 0 16:31:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:31:07 INFO - Using env: {'DISPLAY': ':0', 16:31:07 INFO - 'HOME': '/home/cltbld', 16:31:07 INFO - 'LANG': 'en_US.UTF-8', 16:31:07 INFO - 'LANGUAGE': 'en_US:en', 16:31:07 INFO - 'LOGNAME': 'cltbld', 16:31:07 INFO - 'MAIL': '/var/mail/cltbld', 16:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:07 INFO - 'MOZ_NO_REMOTE': '1', 16:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:07 INFO - 'NO_EM_RESTART': '1', 16:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:07 INFO - 'PWD': '/builds/slave/test', 16:31:07 INFO - 'SHELL': '/bin/bash', 16:31:07 INFO - 'SHLVL': '1', 16:31:07 INFO - 'TERM': 'linux', 16:31:07 INFO - 'TMOUT': '86400', 16:31:07 INFO - 'USER': 'cltbld', 16:31:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:07 INFO - '_': '/tools/buildbot/bin/python'} 16:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:07 INFO - Downloading/unpacking psutil>=3.1.1 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:09 INFO - Installing collected packages: psutil 16:31:09 INFO - Running setup.py install for psutil 16:31:09 INFO - building 'psutil._psutil_linux' extension 16:31:09 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 16:31:10 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 16:31:10 INFO - building 'psutil._psutil_posix' extension 16:31:10 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 16:31:10 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 16:31:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:10 INFO - Successfully installed psutil 16:31:10 INFO - Cleaning up... 16:31:10 INFO - Return code: 0 16:31:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:31: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 mozsystemmonitor==0.3 16:31:10 INFO - Using env: {'DISPLAY': ':0', 16:31:10 INFO - 'HOME': '/home/cltbld', 16:31:10 INFO - 'LANG': 'en_US.UTF-8', 16:31:10 INFO - 'LANGUAGE': 'en_US:en', 16:31:10 INFO - 'LOGNAME': 'cltbld', 16:31:10 INFO - 'MAIL': '/var/mail/cltbld', 16:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:10 INFO - 'MOZ_NO_REMOTE': '1', 16:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:10 INFO - 'NO_EM_RESTART': '1', 16:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:10 INFO - 'PWD': '/builds/slave/test', 16:31:10 INFO - 'SHELL': '/bin/bash', 16:31:10 INFO - 'SHLVL': '1', 16:31:10 INFO - 'TERM': 'linux', 16:31:10 INFO - 'TMOUT': '86400', 16:31:10 INFO - 'USER': 'cltbld', 16:31:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:10 INFO - '_': '/tools/buildbot/bin/python'} 16:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:12 INFO - Installing collected packages: mozsystemmonitor 16:31:12 INFO - Running setup.py install for mozsystemmonitor 16:31:12 INFO - Successfully installed mozsystemmonitor 16:31:12 INFO - Cleaning up... 16:31:12 INFO - Return code: 0 16:31:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:31:12 INFO - Using env: {'DISPLAY': ':0', 16:31:12 INFO - 'HOME': '/home/cltbld', 16:31:12 INFO - 'LANG': 'en_US.UTF-8', 16:31:12 INFO - 'LANGUAGE': 'en_US:en', 16:31:12 INFO - 'LOGNAME': 'cltbld', 16:31:12 INFO - 'MAIL': '/var/mail/cltbld', 16:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:12 INFO - 'MOZ_NO_REMOTE': '1', 16:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:12 INFO - 'NO_EM_RESTART': '1', 16:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:12 INFO - 'PWD': '/builds/slave/test', 16:31:12 INFO - 'SHELL': '/bin/bash', 16:31:12 INFO - 'SHLVL': '1', 16:31:12 INFO - 'TERM': 'linux', 16:31:12 INFO - 'TMOUT': '86400', 16:31:12 INFO - 'USER': 'cltbld', 16:31:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:12 INFO - '_': '/tools/buildbot/bin/python'} 16:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:15 INFO - warning: no files found matching '*.txt' 16:31:15 INFO - no previously-included directories found matching 'build' 16:31:15 INFO - no previously-included directories found matching 'dist' 16:31:15 INFO - no previously-included directories found matching '.git*' 16:31:15 INFO - Installing collected packages: jsonschema, functools32 16:31:15 INFO - Running setup.py install for functools32 16:31:15 INFO - warning: no files found matching '*.txt' 16:31:15 INFO - no previously-included directories found matching 'build' 16:31:15 INFO - no previously-included directories found matching 'dist' 16:31:15 INFO - no previously-included directories found matching '.git*' 16:31:15 INFO - Successfully installed jsonschema functools32 16:31:15 INFO - Cleaning up... 16:31:15 INFO - Return code: 0 16:31:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:15 INFO - Using env: {'DISPLAY': ':0', 16:31:15 INFO - 'HOME': '/home/cltbld', 16:31:15 INFO - 'LANG': 'en_US.UTF-8', 16:31:15 INFO - 'LANGUAGE': 'en_US:en', 16:31:15 INFO - 'LOGNAME': 'cltbld', 16:31:15 INFO - 'MAIL': '/var/mail/cltbld', 16:31:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:15 INFO - 'MOZ_NO_REMOTE': '1', 16:31:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:15 INFO - 'NO_EM_RESTART': '1', 16:31:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:15 INFO - 'PWD': '/builds/slave/test', 16:31:15 INFO - 'SHELL': '/bin/bash', 16:31:15 INFO - 'SHLVL': '1', 16:31:15 INFO - 'TERM': 'linux', 16:31:15 INFO - 'TMOUT': '86400', 16:31:15 INFO - 'USER': 'cltbld', 16:31:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:15 INFO - '_': '/tools/buildbot/bin/python'} 16:31:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:15 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 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 16:31:17 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 16:31:18 INFO - Downloading docopt-0.6.1.tar.gz 16:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:18 INFO - Running setup.py install for blobuploader 16:31:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:18 INFO - Running setup.py install for requests 16:31:18 INFO - Running setup.py install for docopt 16:31:18 INFO - Successfully installed blobuploader requests docopt 16:31:18 INFO - Cleaning up... 16:31:18 INFO - Return code: 0 16:31:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:18 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 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:18 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 16:31:18 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 16:31:18 INFO - Using env: {'DISPLAY': ':0', 16:31:18 INFO - 'HOME': '/home/cltbld', 16:31:18 INFO - 'LANG': 'en_US.UTF-8', 16:31:18 INFO - 'LANGUAGE': 'en_US:en', 16:31:18 INFO - 'LOGNAME': 'cltbld', 16:31:18 INFO - 'MAIL': '/var/mail/cltbld', 16:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:18 INFO - 'MOZ_NO_REMOTE': '1', 16:31:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:18 INFO - 'NO_EM_RESTART': '1', 16:31:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:18 INFO - 'PWD': '/builds/slave/test', 16:31:18 INFO - 'SHELL': '/bin/bash', 16:31:18 INFO - 'SHLVL': '1', 16:31:18 INFO - 'TERM': 'linux', 16:31:18 INFO - 'TMOUT': '86400', 16:31:18 INFO - 'USER': 'cltbld', 16:31:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:18 INFO - '_': '/tools/buildbot/bin/python'} 16:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:18 INFO - Running setup.py (path:/tmp/pip-8A6x6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:19 INFO - Running setup.py (path:/tmp/pip-6XUcA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:19 INFO - Running setup.py (path:/tmp/pip-hanR9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:19 INFO - Running setup.py (path:/tmp/pip-QBLEFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:19 INFO - Running setup.py (path:/tmp/pip-9XfCzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:19 INFO - Running setup.py (path:/tmp/pip-s3n9D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:19 INFO - Running setup.py (path:/tmp/pip-V9crXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:19 INFO - Running setup.py (path:/tmp/pip-YYHhHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:19 INFO - Running setup.py (path:/tmp/pip-nVZs9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:19 INFO - Running setup.py (path:/tmp/pip-XBWv0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:19 INFO - Running setup.py (path:/tmp/pip-ITztnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:19 INFO - Running setup.py (path:/tmp/pip-B3UPto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:19 INFO - Running setup.py (path:/tmp/pip-Wywx2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:19 INFO - Running setup.py (path:/tmp/pip-_tlZLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:19 INFO - Running setup.py (path:/tmp/pip-cugsjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:20 INFO - Running setup.py (path:/tmp/pip-DIUYCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:20 INFO - Running setup.py (path:/tmp/pip-kXZjIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:20 INFO - Running setup.py install for manifestparser 16:31:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Running setup.py install for mozcrash 16:31:20 INFO - Running setup.py install for mozdebug 16:31:20 INFO - Running setup.py install for mozdevice 16:31:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Running setup.py install for mozfile 16:31:20 INFO - Running setup.py install for mozhttpd 16:31:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Running setup.py install for mozinfo 16:31:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Running setup.py install for mozInstall 16:31:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:20 INFO - Running setup.py install for mozleak 16:31:21 INFO - Running setup.py install for mozlog 16:31:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for moznetwork 16:31:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozprocess 16:31:21 INFO - Running setup.py install for mozprofile 16:31:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozrunner 16:31:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Running setup.py install for mozscreenshot 16:31:21 INFO - Running setup.py install for moztest 16:31:21 INFO - Running setup.py install for mozversion 16:31:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:21 INFO - Cleaning up... 16:31:21 INFO - Return code: 0 16:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:21 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 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:21 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 16:31:21 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 16:31:21 INFO - Using env: {'DISPLAY': ':0', 16:31:21 INFO - 'HOME': '/home/cltbld', 16:31:21 INFO - 'LANG': 'en_US.UTF-8', 16:31:21 INFO - 'LANGUAGE': 'en_US:en', 16:31:21 INFO - 'LOGNAME': 'cltbld', 16:31:21 INFO - 'MAIL': '/var/mail/cltbld', 16:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:21 INFO - 'MOZ_NO_REMOTE': '1', 16:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:21 INFO - 'NO_EM_RESTART': '1', 16:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:21 INFO - 'PWD': '/builds/slave/test', 16:31:21 INFO - 'SHELL': '/bin/bash', 16:31:21 INFO - 'SHLVL': '1', 16:31:21 INFO - 'TERM': 'linux', 16:31:21 INFO - 'TMOUT': '86400', 16:31:21 INFO - 'USER': 'cltbld', 16:31:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:21 INFO - '_': '/tools/buildbot/bin/python'} 16:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:22 INFO - Running setup.py (path:/tmp/pip-1ApD3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:22 INFO - Running setup.py (path:/tmp/pip-5hXMmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:22 INFO - Running setup.py (path:/tmp/pip-igv_Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:22 INFO - Running setup.py (path:/tmp/pip-qGULBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:22 INFO - Running setup.py (path:/tmp/pip-nZxadz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:22 INFO - Running setup.py (path:/tmp/pip-c7ycXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:22 INFO - Running setup.py (path:/tmp/pip-5X6fiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:22 INFO - Running setup.py (path:/tmp/pip-3WOlka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:22 INFO - Running setup.py (path:/tmp/pip-pi0EnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:22 INFO - Running setup.py (path:/tmp/pip-BrIjD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:22 INFO - Running setup.py (path:/tmp/pip-ADcwV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:22 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)) 16:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:22 INFO - Running setup.py (path:/tmp/pip-Xm9AOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:23 INFO - Running setup.py (path:/tmp/pip-Vjgciv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:23 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)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:23 INFO - Running setup.py (path:/tmp/pip-4SrpNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:23 INFO - Running setup.py (path:/tmp/pip-HuiXBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:23 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)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:23 INFO - Running setup.py (path:/tmp/pip-1KYt54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:23 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)) 16:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:23 INFO - Running setup.py (path:/tmp/pip-SiyyPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:23 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)) 16:31:23 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)) 16:31:23 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)) 16:31:23 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)) 16:31:23 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)) 16:31:23 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)) 16:31:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:25 INFO - Downloading blessings-1.6.tar.gz 16:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:25 INFO - Installing collected packages: blessings 16:31:25 INFO - Running setup.py install for blessings 16:31:25 INFO - Successfully installed blessings 16:31:25 INFO - Cleaning up... 16:31:25 INFO - Return code: 0 16:31:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:25 INFO - Reading from file tmpfile_stdout 16:31:25 INFO - Current package versions: 16:31:25 INFO - argparse == 1.2.1 16:31:25 INFO - blessings == 1.6 16:31:25 INFO - blobuploader == 1.2.4 16:31:25 INFO - docopt == 0.6.1 16:31:25 INFO - functools32 == 3.2.3-2 16:31:25 INFO - jsonschema == 2.5.1 16:31:25 INFO - manifestparser == 1.1 16:31:25 INFO - mozInstall == 1.12 16:31:25 INFO - mozcrash == 0.17 16:31:25 INFO - mozdebug == 0.1 16:31:25 INFO - mozdevice == 0.48 16:31:25 INFO - mozfile == 1.2 16:31:25 INFO - mozhttpd == 0.7 16:31:25 INFO - mozinfo == 0.9 16:31:25 INFO - mozleak == 0.1 16:31:25 INFO - mozlog == 3.2 16:31:25 INFO - moznetwork == 0.27 16:31:25 INFO - mozprocess == 0.22 16:31:25 INFO - mozprofile == 0.28 16:31:25 INFO - mozrunner == 6.11 16:31:25 INFO - mozscreenshot == 0.1 16:31:25 INFO - mozsystemmonitor == 0.3 16:31:25 INFO - moztest == 0.7 16:31:25 INFO - mozversion == 1.4 16:31:25 INFO - psutil == 3.1.1 16:31:25 INFO - requests == 1.2.3 16:31:25 INFO - wsgiref == 0.1.2 16:31:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:25 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:25 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 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:25 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 16:31:25 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 16:31:25 INFO - Using env: {'DISPLAY': ':0', 16:31:25 INFO - 'HOME': '/home/cltbld', 16:31:25 INFO - 'LANG': 'en_US.UTF-8', 16:31:25 INFO - 'LANGUAGE': 'en_US:en', 16:31:25 INFO - 'LOGNAME': 'cltbld', 16:31:25 INFO - 'MAIL': '/var/mail/cltbld', 16:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:25 INFO - 'MOZ_NO_REMOTE': '1', 16:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:25 INFO - 'NO_EM_RESTART': '1', 16:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:25 INFO - 'PWD': '/builds/slave/test', 16:31:25 INFO - 'SHELL': '/bin/bash', 16:31:25 INFO - 'SHLVL': '1', 16:31:25 INFO - 'TERM': 'linux', 16:31:25 INFO - 'TMOUT': '86400', 16:31:25 INFO - 'USER': 'cltbld', 16:31:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:25 INFO - '_': '/tools/buildbot/bin/python'} 16:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 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)) 16:31:25 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 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 0x2a02030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b658a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cc3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, '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': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', '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 16:31:26 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 16:31:26 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 16:31:26 INFO - Using env: {'DISPLAY': ':0', 16:31:26 INFO - 'HOME': '/home/cltbld', 16:31:26 INFO - 'LANG': 'en_US.UTF-8', 16:31:26 INFO - 'LANGUAGE': 'en_US:en', 16:31:26 INFO - 'LOGNAME': 'cltbld', 16:31:26 INFO - 'MAIL': '/var/mail/cltbld', 16:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:26 INFO - 'MOZ_NO_REMOTE': '1', 16:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:26 INFO - 'NO_EM_RESTART': '1', 16:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:26 INFO - 'PWD': '/builds/slave/test', 16:31:26 INFO - 'SHELL': '/bin/bash', 16:31:26 INFO - 'SHLVL': '1', 16:31:26 INFO - 'TERM': 'linux', 16:31:26 INFO - 'TMOUT': '86400', 16:31:26 INFO - 'USER': 'cltbld', 16:31:26 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:26 INFO - '_': '/tools/buildbot/bin/python'} 16:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:26 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Running post-action listener: _resource_record_post_action 16:31:26 INFO - Running post-action listener: _start_resource_monitoring 16:31:26 INFO - Starting resource monitoring. 16:31:26 INFO - ##### 16:31:26 INFO - ##### Finished create-virtualenv step (success) 16:31:26 INFO - ##### 16:31:26 INFO - ##### 16:31:26 INFO - ##### Running install step. 16:31:26 INFO - ##### 16:31:26 INFO - Running pre-action listener: _resource_record_pre_action 16:31:26 INFO - Running main action method: install 16:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:26 INFO - Reading from file tmpfile_stdout 16:31:26 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:26 INFO - Reading from file tmpfile_stdout 16:31:26 INFO - Output received: 16:31:26 INFO - Usage: mozinstall [options] installer 16:31:26 INFO - Options: 16:31:26 INFO - -h, --help show this help message and exit 16:31:26 INFO - -d DEST, --destination=DEST 16:31:26 INFO - Directory to install application into. [default: 16:31:26 INFO - "/builds/slave/test"] 16:31:26 INFO - --app=APP Application being installed. [default: firefox] 16:31:26 INFO - mkdir: /builds/slave/test/build/application 16:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:31:43 INFO - Reading from file tmpfile_stdout 16:31:43 INFO - Output received: 16:31:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:31:43 INFO - Running post-action listener: _resource_record_post_action 16:31:43 INFO - ##### 16:31:43 INFO - ##### Finished install step (success) 16:31:43 INFO - ##### 16:31:43 INFO - ##### 16:31:43 INFO - ##### Running run-tests step. 16:31:43 INFO - ##### 16:31:43 INFO - Running pre-action listener: _resource_record_pre_action 16:31:43 INFO - Running main action method: run_tests 16:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:43 INFO - Python 2.7.3 16:31:43 INFO - Return code: 0 16:31:43 INFO - grabbing minidump binary from tooltool 16:31:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 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 0x2cc13b0>, '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 0x2cc22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cc2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:43 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 16:31:43 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 16:31:43 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 16:31:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:43 INFO - Return code: 0 16:31:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:31:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:31:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 16:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 16:31:43 INFO - Using env: {'DISPLAY': ':0', 16:31:43 INFO - 'HOME': '/home/cltbld', 16:31:43 INFO - 'LANG': 'en_US.UTF-8', 16:31:43 INFO - 'LANGUAGE': 'en_US:en', 16:31:43 INFO - 'LOGNAME': 'cltbld', 16:31:43 INFO - 'MAIL': '/var/mail/cltbld', 16:31:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:43 INFO - 'MOZ_NO_REMOTE': '1', 16:31:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:43 INFO - 'NO_EM_RESTART': '1', 16:31:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:43 INFO - 'PWD': '/builds/slave/test', 16:31:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:43 INFO - 'SHELL': '/bin/bash', 16:31:43 INFO - 'SHLVL': '1', 16:31:43 INFO - 'TERM': 'linux', 16:31:43 INFO - 'TMOUT': '86400', 16:31:43 INFO - 'USER': 'cltbld', 16:31:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273', 16:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:43 INFO - '_': '/tools/buildbot/bin/python'} 16:31:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 16:31:43 INFO - mozversion application_buildid: 20160630133123 16:31:43 INFO - mozversion application_changeset: 7339ed5e03791159421bc91995ebc7160d4976b2 16:31:43 INFO - mozversion application_display_name: Nightly 16:31:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:43 INFO - mozversion application_name: Firefox 16:31:43 INFO - mozversion application_remotingname: firefox 16:31:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:31:43 INFO - mozversion application_vendor: Mozilla 16:31:43 INFO - mozversion application_version: 50.0a1 16:31:43 INFO - mozversion platform_buildid: 20160630133123 16:31:43 INFO - mozversion platform_changeset: 7339ed5e03791159421bc91995ebc7160d4976b2 16:31:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:31:43 INFO - mozversion platform_version: 50.0a1 16:31:43 INFO - using testdate: 1467329503 16:31:43 INFO - actual date: 1467329503 16:31:43 INFO - starting webserver on 'localhost:33548' 16:31:43 INFO - SUITE-START | Running 2 tests 16:31:43 INFO - TEST-START | dromaeo_css 16:31:43 INFO - operating with platform_type : linux_ 16:31:43 INFO - Initialising browser for dromaeo_css test... 16:31:43 INFO - TEST-INFO | started process 11342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPAZCqF/profile http://localhost:33548/getInfo.html) 16:31:48 INFO - PROCESS | 11342 | __metrics Screen width/height:1600/1200 16:31:48 INFO - PROCESS | 11342 | colorDepth:24 16:31:48 INFO - PROCESS | 11342 | Browser inner width/height: 1024/697 16:31:48 INFO - PROCESS | 11342 | __metrics 16:31:49 INFO - PROCESS | 11342 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:50 INFO - TEST-INFO | 11342: exit 0 16:31:50 INFO - Browser initialized. 16:31:50 INFO - Running cycle 1/1 for dromaeo_css test... 16:31:50 INFO - TEST-INFO | started process 11426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPAZCqF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:01 INFO - PROCESS | 11426 | RSS: Main: 157540352 16:32:01 INFO - PROCESS | 11426 | 16:32:52 INFO - PROCESS | 11426 | 1467329572666 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] 16:35:01 INFO - PROCESS | 11426 | Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33548/tests/dromaeo/cssquery-ext.html) 16:35:02 INFO - PROCESS | 11426 | RSS: Main: 280563712 16:35:02 INFO - PROCESS | 11426 | 16:38:05 INFO - PROCESS | 11426 | Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-ext.html (next: http://localhost:33548/tests/dromaeo/cssquery-jquery.html) 16:38:06 INFO - PROCESS | 11426 | RSS: Main: 245686272 16:38:06 INFO - PROCESS | 11426 | 16:41:07 INFO - PROCESS | 11426 | Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33548/tests/dromaeo/cssquery-mootools.html) 16:41:08 INFO - PROCESS | 11426 | RSS: Main: 240435200 16:41:08 INFO - PROCESS | 11426 | 16:44:10 INFO - PROCESS | 11426 | Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33548/tests/dromaeo/cssquery-prototype.html) 16:44:11 INFO - PROCESS | 11426 | RSS: Main: 238387200 16:44:11 INFO - PROCESS | 11426 | 16:47:13 INFO - PROCESS | 11426 | Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33548/tests/dromaeo/cssquery-yui.html) 16:47:14 INFO - PROCESS | 11426 | RSS: Main: 221007872 16:47:14 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | Cycle 1(1): loaded http://localhost:33548/tests/dromaeo/cssquery-yui.html (next: http://localhost:33548/tests/dromaeo/cssquery-dojo.html) 16:50:17 INFO - PROCESS | 11426 | RSS: Main: 322662400 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | __start_tp_report 16:50:17 INFO - PROCESS | 11426 | _x_x_mozilla_page_load 16:50:17 INFO - PROCESS | 11426 | _x_x_mozilla_page_load_details 16:50:17 INFO - PROCESS | 11426 | |i|pagename|runs| 16:50:17 INFO - PROCESS | 11426 | |0;dojo.html;3150.165206220351;3157.9842100789506;3173.841307934603;3200.2959348943223;3227.080282119595;5333.599980001506;5409.594280428969;5418.512333889949;5486.725663716813;5541.5289700375415;5387.380451248107;5400.540954018913;5408.648437851547;5443.1835224716315;5496.31296087989;4819.8795030124265;4888.364512613355;4908.288298196777;4915.680480768757;5102.515261050195;4998.22527508235;5014.8244811431605;5046.09170349337;5071.670341427814;5079.1365467870555;4826.034793041371;4850.830220942268;4885.755712214393;4904.681195722303;4937.8271760488215;4900.117978763821;4907.411110666742;4912.3437741859625;4917.631177661689;4994.650374473788;4863.927041094386;4886.1204983103025;4886.169351210267;4890.193118135503;4926.9014619707405;5294;5365.463453654643;5387.1380579107545;5437.673739575598;5478.178273259004;5883;5899.5870289079785;5911.527077833763;5916.852078698067;5926.614770039933;5907.084401917709;5959.344472108065;5978.910316345258;5979.5515336349945;5980.312264089598;5293.338332708411;5433.673979561199;5488.56091512678;5493.533049690741;5528.474794894479;6039.3000758631915;6040.758369665252;6043.229813664596;6050.878982420327;6095.969520152371;5828.970855145697;5877.177195192677;5881.7647294107755;5886.764529418775;5896.380880007538;5638;5748.741306641127;5815.709214539256;5819.476247137778;5952.7321270542925;5816.941830581724;5848.678322692208;5849.064149736022;5855.180274761537;5899.056151015817;5831.970840145772;5872.853178670482;5885.588008839341;5894.528437724972;5894.557908156906;4351.586599273064;4387.188370151468;4390.868273951723;4391.451068616423;4394.890127746768;3921.6666583340734;3941.467901833273;3943.4676318697184;3981.3629819228786;3984.621460961204;5531.806386776443;5534.391216966131;5537.58468114893;5538.390777014525;5579.246801681802;5748.252727145528;5772.913406298909;5778.133280007948;5882.264716910387;5931.169636250928;5520.751566179531;5557.44425557441;5562.582806289544;5600.775968961278;5610.635308704921;4872.6589138760655;4880.463149053601;4888.584470319992;4889.339939108246;4951.777170027285;5889.057750759858;5963.314218864799;6014.09788531715;6058.545609079337;6063.242094738158;5917;5918.467337939606;5923.348431672599;5931.436513531207;5935.436133567304;6004;6035.456808887221;6049.758009679564;6059.878802423838;6065.848353791191;5669.3480249770155;5769.913451298318;5796.971015144897;5810.854728631818;5831.94168058331;5918.881622367442;5961.105834124743;5965.8806823862415;5974.611650242894;5977;5791.739371728198;5804.2744656917885;5805.8548536286935;5811.622244554091;5812.476877081083;5589;5662.801801936913;5673.404292549223;5717.085266357363;5744.080947048452;5648.4633959773755;5656.1798539212405;5658.462446067617;5664.830055098354;5665.915011274752;5605.915911261416;5752.511036561772;5786.652800831964;5837.854053648693;5840.766369345179;5503.174523821299;5518.530924871431;5542;5567.66594004361;5571.66570005801 16:50:17 INFO - PROCESS | 11426 | |1;ext.html;575.9539236861051;607.6293460988798;613.868018376049;616.1774031667725;628.6071205496564;43252.783736081314;44024;44190.11619767607;44233.11533769323;48188.51811481884;45241;45650.54349456513;45695.77152114235;45730.31404528935;45738;8999.640014399416;9129.863052054225;9151.588178531982;9152.8627070594;9153.633854645806;9012.54937253138;9082.09179082093;9101.908980910172;9105.043970383114;9106.817863642724;9115.635374585008;9138.817223655524;9149.313801464883;9149.63401463944;9155.221806146452;9051.683191088281;9065.093490650883;9069.138431848964;9070.909290907073;9077.04691007448;8965.327600429928;9032.77418064547;9035.322350823715;9038.774030649287;9039.502827344493;42925.78537107326;43383.132337353076;43383.56616433827;43451.56548434507;43475.30459910911;3585.4084076127406;3626.528551288342;3646.835892384849;3741.7754934704003;3784.243151369737;33540.49689254663;33758.662413375794;33793;33796.15509612255;33813.32373352544;4078.3270760324513;4302.763348015857;4312.870613881589;4361.206278384185;4457.598816106533;374704;376743;377173;377223;378211;52352;57195.71402142962;58785.70607146937;58857;64685.67657161778;63789.681051594445;64591.35408645854;64662.676686617204;64665;64685;16412.917935410245;16431.83568164303;16438.506844794676;16454.341826326814;16608.916955415145;12316.630501084981;12474.875251247553;12536.874631253753;12703;12705.237685738884;19338.969408212215;19490.64007397977;19573.706394404096;19576.412707618794;19668.803311966698;7146.392556632641;7170.211276759553;7196.9280307197305;7357.30105639974;7515.8121046973165;997.6009596161593;1064.7178497698117;1078.396098185019;1107.4628805029554;1140.156284349592;32007.839960800047;32327.51508727371;32546;32627.184320391705;33017.66982330194;1072.983905241422;1103.3545375955157;1104.2766987622958;1115.8158903780948;1168.526746667601;16571.585710357336;17169.399071032454;17209.020962589464;17368.739468907977;17607.29570817153;562692;565538;569283;569442;572144.5320507329;60051.39948600545;60358.698206509565;60394.39605603975;60485;60701.39298607046;1219.5182902753363;1259.9999999999816;1318.3935389720643;1381.6891199480037;1387.861213878604;32585.34829303448;33502;33910.83044584761;34068.65931340655;34319.82840085884;51085.23372149495;51845.48154518406;51936;51949.480505194464;51996.220056698425;387476;389102;390314;390481;390563;24688.753112469363;27870.581941271303;29055;29164.7083529162;29537.852310738308;48685.5131448681;49349;49639.50360496349;49755.50244497653;50014.499855000984;41271.380929285486;42233.57766422296;42522.787386062875;43037.56962430335;43944.78027609841;42526.57473425226;42647.57352426436;42720.78639606782;42877;43454.78272608617;40593.391099134125;41248.38127428151;41522;41634.79182604067;42110.157796844505;35132.297354053284;36808.81595592005;36937.63062369342;37128;37840.24319513649;27381;27808.90768847972;27903.860480697465;27950;28073.43853122967 16:50:17 INFO - PROCESS | 11426 | |2;jquery.html;406.25857809497654;407.6290575576226;410.49714100227226;412.6822346792969;426.65014687955886;18840.528986775338;19409.12658930348;20276.39170824874;20693.068811903446;20710.48223794406;19146.71279930802;19385.12766925488;20143.697844532344;20387.694184587206;20567.588648227025;5605.495505404502;5965.985782416999;5973.671448070354;5982.760689572434;5983.820485385445;5724.8282551523525;5784.219130417403;5901.704914754267;5907.616004959686;5914.142449344842;5868.501177399905;5895.469407753301;5902.173695682608;5913.526917846562;5915.08316210988;5829.679367634779;5850.625103100768;5855.648661080328;6199.845003874894;6565.113709649232;5963.850903727442;5977.790777322816;5977.8804423911715;6005;6005.1892994445625;14785.92607036958;16158.838411615969;21674.916254187385;24428.26715198547;25282.49435011308;2269.1490690990877;2292.4841910570153;2308.2728940383727;2322.6516022596575;2502.336880726609;10506.579736810518;10618.36289822613;11079.667609971713;13811.825994790455;13827.654308642364;1960.862739608228;1995.9301424450075;2025.6961455781604;2055.22160975732;2063.8452116091353;87095;88707.55646221792;90431.54784226103;90853;92231.53884230604;11510.827337589943;11520.193586448868;11788.70528236801;11837.408129593487;11919.821202681967;16599.253033613517;16703.749443758352;16758.83241167573;16761.24574394131;16783.328666853435;8115.310198633182;8363.247307742333;8386.371022173362;8502.914970850212;8570.057293697688;8030.718924837603;8081.111077781439;8082.595870206584;8239.423240373117;8242.505449673039;5118.846434606968;5131.307273518102;5176.456472070378;5199.29809475716;5269.209618557247;2023.4738967868166;2034.6642803937184;2067.1111422088647;2067.400453868361;2075.2746979565277;895.9462432254086;987.3434166279344;989.8218320702342;1006.9043440873105;1012.1851909213007;20084.397468075982;20508.487287817923;20560;20608.58782824365;20654.896725516275;983.6508039645965;994.7314225159166;1009.8687170667766;1037.3775734559356;1068.1561566362486;10753.89246107529;11225.66323010311;11446;11474.139439542068;11484.253523520945;370535;376142;376167;451434;452183;97387.51306243423;104265.47867260616;104634;105482.47258763657;106894;1002.1932344462632;1015.9847602285971;1027.928045036855;1028.5937054863286;1029.0789743179962;18109.637807244046;18186.636267274316;18528.44414667562;18624.627507450045;18701.15844787015;40166.1966760669;40306;44873.32690009718;47097;47161.292580612004;64496.032559510706;64900.675496624106;64954.35045649483;67510;68199.65900170666;8156.184381561797;8323.417360784686;8460.238578527962;8850.911490885266;9292.860607090764;10750.408727520062;13040.869591303965;14059.929700351433;14447.133172009713;15147.091174529563;12413.255204687748;12580.811287830507;12647.177933434297;12723.300218488072;12727.872721272668;12141.817872731739;12494.250344979331;12820;12853.228806271654;12868.163569368335;12630.936845315715;12870.613881583567;12900.741985160432;12933.417996190006;13016.934915325362;9059.68291109808;9097.77255568616;9335.626574936927;9358.15776580111;9373;9434;11342.079514367115;11641.59254426091;12376.75246495083;12403.75192496163 16:50:17 INFO - PROCESS | 11426 | |3;mootools.html;1311.2984553263993;1435.2536680925919;1471.8528147185282;1580.48634193887;1752.325354738426;7449.627518624067;8564.486130832154;8843.513606751627;8870.55647217639;9072.546372681356;8721.5639218039;8857.955710221457;8866.069062748415;8883.51140687262;8883.777905552364;2054.5274586845035;2318.0727708916484;2368.159303447277;2401.519696060795;2407.759224077587;2402.783749462548;2416.1422694943217;2421.4672771990136;2424.9451488602513;2426.0659646036315;2372.4424760181346;2380.964280537963;2402.6876506054277;2404.7475015123423;2407.4462873539096;1980.792016838233;2209.8895055247335;2284.4859906521065;2294.380517260339;2295.9081636734677;2332.24202134307;2339.1345202275265;2352.0591763294647;2356.575816353056;2359.4809141988735;8500.914990850137;8558.828823423559;8591.484510929302;8593.742187734379;8597.140285971416;5114.181730923072;5201.739913004335;5214.270002199695;5217.2695822584865;5218;3432.3135372925267;3519.5776506819348;3625.9456108158397;3635.472856435802;3649.817509124533;1224.5163160551533;1246.9376531173405;1268.6764874956827;1273.4778740716354;1274.0762946863542;11427.942860285728;11466.369349685763;11500.079993600491;11535.653930382103;11553.711157221136;4466.665000125004;4571.611413029863;4723.055388922229;4723.881902952385;4729.881752956135;9577.569009394594;9611.711648650411;9619.18236949853;9666.806663866684;9680.854787178198;5244.5542128918705;5253.4221235664045;5254.633795213195;5257.447967963385;5258.97370513145;4336.241157797373;4663.603593694574;4824.807007719722;4836.202026665631;4904.901901961941;3997.1605962747567;4066.6340029396906;4070.895303039196;4071.42999980003;4086.7752273625238;1179.6166245970094;1240.9379531023594;1303.947842086325;1304.9739005220033;1310.7968264918952;833.2167762303416;863.0635760200128;970.5147426286857;978.7504186432415;1043.2227990147237;5850.5612079094235;6079.422454866781;6178.66017369049;6273.557081871195;6353.491720662336;960.9519524023771;974.4591751577942;989.618996686281;990.9009099090177;1025.3950169400089;4058.553559108496;4127.814248358831;4162.334026555736;4162.542120366757;4287.164003019381;10290.228232882564;10526.263161578769;10587.523561439753;10590.841137382946;10593.046625803561;10457.163426925828;10688.412137332365;10858.61994830193;10886.40124793144;10954.507047182897;7698;7990.720324788605;7999.840003199904;8070.798230044178;8194.22154895272;6058.969705151622;6218.9378106218355;6243.875122497616;6254.437100660781;6351.015592583157;9626.566804493674;10034.49827508607;10126.493675316058;10133.64532241368;10149.238807089645;9919.15687166599;10229.181665466596;10274.691759247235;10648.094911932572;10660.680179594625;7100.857982840417;7511.661975211019;7747.18654541265;7847.293743563107;8003.83992320162;8519.616617252115;8548.529830859363;8601.784955375915;8608.48349099056;8618.267447267053;7625.8856117157175;7664.195259497673;7753.496022758728;7828.13890472059;7943.285104340637;7641.88537171954;7662.157162712208;7678.347340476123;7805.141434442094;7872.173421790859;7171.390431813355;7253.746118885813;7294.781156565312;7300.634968251672;7303.379212766762;5389.083855744454;5403.567714582902;5559.388467268678;5603.831885043455;5604.411536788579;5193.37899087513;5215.55667768244;5253.632245742914;5272.578193744568;5514.2004409359615 16:50:17 INFO - PROCESS | 11426 | |4;prototype.html;336.83326753257137;337.56285610134876;345.64053384480144;347.113125963164;347.1754582865694;5298.721549733613;5325.3875804282425;5342.2253773202865;5350.464953504653;5355.437679043703;5285.7885684572575;5288;5305.549028332587;5307.920381194285;5312;3950.3481925482333;4023.537293211289;4162.646175075122;4165.208610364036;4193.979030104861;4108.876733697994;4157.875263742078;4169.854055108071;4186.979065104685;4193.119444916556;3923.9607603924023;4132.5040995080635;4133.3386658134705;4136.097395198212;4143.544210136883;4016.3975403689533;4131.173765246963;4133.925179453334;4144.212599606095;4144.48193975753;3691.446283057536;3701.703863690925;3710.2579484103017;3710.2764960832646;3710.777353358807;5162.88997865457;5165.845024649267;5175.146100893348;5177.844664660066;5181.663191892515;4521.937344723987;4749.311349854286;4749.525047495223;4771.928421073687;4794.5205479452125;5534.142207957773;5550.72246387679;5552.3892371839065;5555.416681248492;5568.777248910079;4052.4124002019544;4053.43251944728;4055.5944405559208;4060.7969601520103;4066.410370496291;5514.889702205974;5758.654480731169;5760.711964401805;5761.654300741969;5765.682887441147;4077.368007958771;4085.7344272622186;4093.7688959517136;4094.6724262058965;4097.7541347519245;4131.938020929689;4132.938005929914;4136.669066474735;4138.716997730713;4140.192662430797;4569.903223226402;4697.882552936204;4726.834560790425;4728.929066064012;4732.645051621143;5520.696361700065;5537.889242215133;5538.723063846792;5556.721953950614;5581.525570326487;1423.9533942552216;1434.5481173430337;1434.7130573885265;1434.763264061439;1435.468876515696;910.988802429303;915.1214833759665;926.9026752191057;982.7788747531748;983.3804703037184;5317.9202311965355;5323.334583177103;5355.86610334737;5356.866078348073;5359.169328753971;5626.127950167731;5634.774609015593;5637.548996080303;5642;5648.6893220872425;5144.845654630367;5309.327561818092;5337.839864804062;5446.400895901447;5455.263539422127;3003.714647108521;3023.6069310989433;3036.832974186441;3039.407315573442;3053.511438169927;5621.184928185472;5861.238039054981;5863.5309175265875;5882.470577648032;5885.499732522698;5803.88392232153;5810.1575271586225;5810.518317829011;5810.622309549865;5853.94146058534;5786.537077033827;5830.7959221427045;5842.604532141886;5860.443257890579;5871.295444546682;5453.7545810439415;5689.800856969986;5692.260006199168;5760.337561180518;5762.279715035621;5636.323641163087;5660.490555849993;5665.858353541194;5672.688002159921;5673.914891276717;5668.971655141863;5866.560007999332;5908.497777688945;5919.171316015847;5936.5844390892225;4239.47006624172;4264.0832221072615;4270.444842170498;4273.081287523198;4291.184674911757;5714.114312281603;5719.7426115824055;5728.742206600797;5731.885362292647;5736.598438109292;5378.19327100938;5403.162509810985;5565.276514053147;5565.471280228372;5590.413006634245;5533.916991245215;5535.643767277043;5552.972235138798;5557.194206839905;5569.66582005081;5260.210968354778;5471.206675032177;5473.972630136824;5476.698781567052;5498.615096943176;5583.330000399978;5595.300587426572;5616.747246373841;5625.690587017753;5637.633553818989;5442.727863606883;5461.563074954073;5478.041857396961;5492.203630473638;5499.092649712913 16:50:17 INFO - PROCESS | 11426 | |5;yui.html;699.5522865366165;717.5013365710834;734.9706011759533;735.9926400735992;789.1240722797697;13779.311034448276;14353.35409906554;14706.338214780348;14730.926345368272;16113.597160070974;14737.705245895075;14768.483103091394;14864.108153510797;14931.850681493182;14951.850481495181;662.4832630548156;793.2107552984774;796.6813274690112;811.2982270336146;821.8356328734247;823.4236034775681;824.418784756745;826.8759686047081;827.0571548434789;827.2554700769325;871;874.7813046738315;875.1817051057282;875.2341701011615;875.5053394831899;687.9793606191797;811.6063709101081;845.9238668519863;846.2087947768856;868.0104680664048;612.7916508387125;614.5636598015415;614.6527212125135;614.735663664624;614.8032629558498;14732.18972956487;14768.483103091448;14777.408903643842;14778.26108694561;14783.852161478355;14139.293035348192;14381.784273235806;14421.78367324491;14811.555653330417;14867.92566037163;12913.289769062698;13103.934480327633;13208.801867971988;13283.867161328457;13363.265020423873;4447.1995040892625;4457.843975460875;4460.4647442306805;4623.69945953512;4647.9535204647855;76480;77732.61133694352;78165.21834781636;78653;80482.5975870117;11066.612668556561;11082.556697732161;11212.27120237182;11314.038306743854;11333.829992550118;18341.90829045873;18343.35798247055;18384.54038649018;18427.90786046088;18437.907810460863;8149.877751833727;8242.29940455068;8275.213854683796;8278.254957053774;8407.957960210282;4583.243764778841;4703.106409782131;4760.571548560646;4773.7374444405195;4863.586595139382;3380.2901390707734;3481.408160612702;3484.5470088888787;3488.302339532104;3488.5464889564196;612.2194202391897;613.9447449729546;626.8620903401245;636.9426751592295;645.8514541655445;616.7995401494533;618.7679620142446;700.096875031204;709.7125664106045;710.0910834132319;8717.346199035097;8923;9392.15470607635;9409.67066152695;9495.57269922855;655.1875674164003;657.9341466823776;671.6702961996573;719.9748008819666;721.3651986252064;4779.354787103696;4803.543663351976;4890.486498917634;5070.340855688737;5506.91739623906;121071;126292;127901;131003;131172;84765;107302;110010;113028;113679;90467.54766226126;90511;90511;91079.54460227657;91993.54003229941;9887.159591434809;9947.846818655995;10027.398356098365;10150.441725705157;10267.486625668836;51241.48758512516;51269.48730512647;51694;52188.739056304476;53184;76360.61819690866;81876.59061704653;82025;82741;83977.58011209905;12677.492900283885;12683.492660293854;12924;13132.40904159296;13234.933825330812;14971.775423368876;15327.386904523693;15391.692166156838;15568.610784730472;15926;13733.381997809922;13889.51386701501;14086.647833804236;14329.172973375433;14592.854071459149;13296.933515332361;13562.457501699822;13617.387217575431;14051.648708782363;14215.715685686435;13182.143160694908;13675.794863076862;13887.930560347133;14126.717465650834;14280.785788212977;11505;11571.826422603499;11926.463309151282;12037.277763334228;12131.696707582381;10802.567897284334;10853.40306283162;11593.304401735923;11839.171258011856;12014.939925300318 16:50:17 INFO - PROCESS | 11426 | __end_tp_report 16:50:17 INFO - PROCESS | 11426 | __start_cc_report 16:50:17 INFO - PROCESS | 11426 | _x_x_mozilla_cycle_collect,1106 16:50:17 INFO - PROCESS | 11426 | __end_cc_report 16:50:17 INFO - PROCESS | 11426 | __startTimestamp1467330617641__endTimestamp 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | ------- Summary: start ------- 16:50:17 INFO - PROCESS | 11426 | Number of tests: 6 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | [#0] dojo.html Cycles:165 Average:5430.14 Median:5638.00 stddev:640.41 (11.4%) stddev-sans-first:616.89 16:50:17 INFO - PROCESS | 11426 | Values: 3150.2 3158.0 3173.8 3200.3 3227.1 5333.6 5409.6 5418.5 5486.7 5541.5 5387.4 5400.5 5408.6 5443.2 5496.3 4819.9 4888.4 4908.3 4915.7 5102.5 4998.2 5014.8 5046.1 5071.7 5079.1 4826.0 4850.8 4885.8 4904.7 4937.8 4900.1 4907.4 4912.3 4917.6 4994.7 4863.9 4886.1 4886.2 4890.2 4926.9 5294.0 5365.5 5387.1 5437.7 5478.2 5883.0 5899.6 5911.5 5916.9 5926.6 5907.1 5959.3 5978.9 5979.6 5980.3 5293.3 5433.7 5488.6 5493.5 5528.5 6039.3 6040.8 6043.2 6050.9 6096.0 5829.0 5877.2 5881.8 5886.8 5896.4 5638.0 5748.7 5815.7 5819.5 5952.7 5816.9 5848.7 5849.1 5855.2 5899.1 5832.0 5872.9 5885.6 5894.5 5894.6 4351.6 4387.2 4390.9 4391.5 4394.9 3921.7 3941.5 3943.5 3981.4 3984.6 5531.8 5534.4 5537.6 5538.4 5579.2 5748.3 5772.9 5778.1 5882.3 5931.2 5520.8 5557.4 5562.6 5600.8 5610.6 4872.7 4880.5 4888.6 4889.3 4951.8 5889.1 5963.3 6014.1 6058.5 6063.2 5917.0 5918.5 5923.3 5931.4 5935.4 6004.0 6035.5 6049.8 6059.9 6065.8 5669.3 5769.9 5797.0 5810.9 5831.9 5918.9 5961.1 5965.9 5974.6 5977.0 5791.7 5804.3 5805.9 5811.6 5812.5 5589.0 5662.8 5673.4 5717.1 5744.1 5648.5 5656.2 5658.5 5664.8 5665.9 5605.9 5752.5 5786.7 5837.9 5840.8 5503.2 5518.5 5542.0 5567.7 5571.7 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | [#1] ext.html Cycles:180 Average:61178.15 Median:42798.89 stddev:120172.61 (280.8%) stddev-sans-first:120423.59 16:50:17 INFO - PROCESS | 11426 | Values: 576.0 607.6 613.9 616.2 628.6 43252.8 44024.0 44190.1 44233.1 48188.5 45241.0 45650.5 45695.8 45730.3 45738.0 8999.6 9129.9 9151.6 9152.9 9153.6 9012.5 9082.1 9101.9 9105.0 9106.8 9115.6 9138.8 9149.3 9149.6 9155.2 9051.7 9065.1 9069.1 9070.9 9077.0 8965.3 9032.8 9035.3 9038.8 9039.5 42925.8 43383.1 43383.6 43451.6 43475.3 3585.4 3626.5 3646.8 3741.8 3784.2 33540.5 33758.7 33793.0 33796.2 33813.3 4078.3 4302.8 4312.9 4361.2 4457.6 374704.0 376743.0 377173.0 377223.0 378211.0 52352.0 57195.7 58785.7 58857.0 64685.7 63789.7 64591.4 64662.7 64665.0 64685.0 16412.9 16431.8 16438.5 16454.3 16608.9 12316.6 12474.9 12536.9 12703.0 12705.2 19339.0 19490.6 19573.7 19576.4 19668.8 7146.4 7170.2 7196.9 7357.3 7515.8 997.6 1064.7 1078.4 1107.5 1140.2 32007.8 32327.5 32546.0 32627.2 33017.7 1073.0 1103.4 1104.3 1115.8 1168.5 16571.6 17169.4 17209.0 17368.7 17607.3 562692.0 565538.0 569283.0 569442.0 572144.5 60051.4 60358.7 60394.4 60485.0 60701.4 1219.5 1260.0 1318.4 1381.7 1387.9 32585.3 33502.0 33910.8 34068.7 34319.8 51085.2 51845.5 51936.0 51949.5 51996.2 387476.0 389102.0 390314.0 390481.0 390563.0 24688.8 27870.6 29055.0 29164.7 29537.9 48685.5 49349.0 49639.5 49755.5 50014.5 41271.4 42233.6 42522.8 43037.6 43944.8 42526.6 42647.6 42720.8 42877.0 43454.8 40593.4 41248.4 41522.0 41634.8 42110.2 35132.3 36808.8 36937.6 37128.0 37840.2 27381.0 27808.9 27903.9 27950.0 28073.4 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | [#2] jquery.html Cycles:180 Average:27831.93 Median:11972.03 stddev:68293.71 (570.4%) stddev-sans-first:68454.25 16:50:17 INFO - PROCESS | 11426 | Values: 406.3 407.6 410.5 412.7 426.7 18840.5 19409.1 20276.4 20693.1 20710.5 19146.7 19385.1 20143.7 20387.7 20567.6 5605.5 5966.0 5973.7 5982.8 5983.8 5724.8 5784.2 5901.7 5907.6 5914.1 5868.5 5895.5 5902.2 5913.5 5915.1 5829.7 5850.6 5855.6 6199.8 6565.1 5963.9 5977.8 5977.9 6005.0 6005.2 14785.9 16158.8 21674.9 24428.3 25282.5 2269.1 2292.5 2308.3 2322.7 2502.3 10506.6 10618.4 11079.7 13811.8 13827.7 1960.9 1995.9 2025.7 2055.2 2063.8 87095.0 88707.6 90431.5 90853.0 92231.5 11510.8 11520.2 11788.7 11837.4 11919.8 16599.3 16703.7 16758.8 16761.2 16783.3 8115.3 8363.2 8386.4 8502.9 8570.1 8030.7 8081.1 8082.6 8239.4 8242.5 5118.8 5131.3 5176.5 5199.3 5269.2 2023.5 2034.7 2067.1 2067.4 2075.3 895.9 987.3 989.8 1006.9 1012.2 20084.4 20508.5 20560.0 20608.6 20654.9 983.7 994.7 1009.9 1037.4 1068.2 10753.9 11225.7 11446.0 11474.1 11484.3 370535.0 376142.0 376167.0 451434.0 452183.0 97387.5 104265.5 104634.0 105482.5 106894.0 1002.2 1016.0 1027.9 1028.6 1029.1 18109.6 18186.6 18528.4 18624.6 18701.2 40166.2 40306.0 44873.3 47097.0 47161.3 64496.0 64900.7 64954.4 67510.0 68199.7 8156.2 8323.4 8460.2 8850.9 9292.9 10750.4 13040.9 14059.9 14447.1 15147.1 12413.3 12580.8 12647.2 12723.3 12727.9 12141.8 12494.3 12820.0 12853.2 12868.2 12630.9 12870.6 12900.7 12933.4 13016.9 9059.7 9097.8 9335.6 9358.2 9373.0 9434.0 11342.1 11641.6 12376.8 12403.8 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | [#3] mootools.html Cycles:180 Average:5781.43 Median:5153.78 stddev:3190.50 (61.9%) stddev-sans-first:3181.76 16:50:17 INFO - PROCESS | 11426 | Values: 1311.3 1435.3 1471.9 1580.5 1752.3 7449.6 8564.5 8843.5 8870.6 9072.5 8721.6 8858.0 8866.1 8883.5 8883.8 2054.5 2318.1 2368.2 2401.5 2407.8 2402.8 2416.1 2421.5 2424.9 2426.1 2372.4 2381.0 2402.7 2404.7 2407.4 1980.8 2209.9 2284.5 2294.4 2295.9 2332.2 2339.1 2352.1 2356.6 2359.5 8500.9 8558.8 8591.5 8593.7 8597.1 5114.2 5201.7 5214.3 5217.3 5218.0 3432.3 3519.6 3625.9 3635.5 3649.8 1224.5 1246.9 1268.7 1273.5 1274.1 11427.9 11466.4 11500.1 11535.7 11553.7 4466.7 4571.6 4723.1 4723.9 4729.9 9577.6 9611.7 9619.2 9666.8 9680.9 5244.6 5253.4 5254.6 5257.4 5259.0 4336.2 4663.6 4824.8 4836.2 4904.9 3997.2 4066.6 4070.9 4071.4 4086.8 1179.6 1240.9 1303.9 1305.0 1310.8 833.2 863.1 970.5 978.8 1043.2 5850.6 6079.4 6178.7 6273.6 6353.5 961.0 974.5 989.6 990.9 1025.4 4058.6 4127.8 4162.3 4162.5 4287.2 10290.2 10526.3 10587.5 10590.8 10593.0 10457.2 10688.4 10858.6 10886.4 10954.5 7698.0 7990.7 7999.8 8070.8 8194.2 6059.0 6218.9 6243.9 6254.4 6351.0 9626.6 10034.5 10126.5 10133.6 10149.2 9919.2 10229.2 10274.7 10648.1 10660.7 7100.9 7511.7 7747.2 7847.3 8003.8 8519.6 8548.5 8601.8 8608.5 8618.3 7625.9 7664.2 7753.5 7828.1 7943.3 7641.9 7662.2 7678.3 7805.1 7872.2 7171.4 7253.7 7294.8 7300.6 7303.4 5389.1 5403.6 5559.4 5603.8 5604.4 5193.4 5215.6 5253.6 5272.6 5514.2 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | [#4] prototype.html Cycles:180 Average:4688.77 Median:5355.65 stddev:1366.64 (25.5%) stddev-sans-first:1330.87 16:50:17 INFO - PROCESS | 11426 | Values: 336.8 337.6 345.6 347.1 347.2 5298.7 5325.4 5342.2 5350.5 5355.4 5285.8 5288.0 5305.5 5307.9 5312.0 3950.3 4023.5 4162.6 4165.2 4194.0 4108.9 4157.9 4169.9 4187.0 4193.1 3924.0 4132.5 4133.3 4136.1 4143.5 4016.4 4131.2 4133.9 4144.2 4144.5 3691.4 3701.7 3710.3 3710.3 3710.8 5162.9 5165.8 5175.1 5177.8 5181.7 4521.9 4749.3 4749.5 4771.9 4794.5 5534.1 5550.7 5552.4 5555.4 5568.8 4052.4 4053.4 4055.6 4060.8 4066.4 5514.9 5758.7 5760.7 5761.7 5765.7 4077.4 4085.7 4093.8 4094.7 4097.8 4131.9 4132.9 4136.7 4138.7 4140.2 4569.9 4697.9 4726.8 4728.9 4732.6 5520.7 5537.9 5538.7 5556.7 5581.5 1424.0 1434.5 1434.7 1434.8 1435.5 911.0 915.1 926.9 982.8 983.4 5317.9 5323.3 5355.9 5356.9 5359.2 5626.1 5634.8 5637.5 5642.0 5648.7 5144.8 5309.3 5337.8 5446.4 5455.3 3003.7 3023.6 3036.8 3039.4 3053.5 5621.2 5861.2 5863.5 5882.5 5885.5 5803.9 5810.2 5810.5 5810.6 5853.9 5786.5 5830.8 5842.6 5860.4 5871.3 5453.8 5689.8 5692.3 5760.3 5762.3 5636.3 5660.5 5665.9 5672.7 5673.9 5669.0 5866.6 5908.5 5919.2 5936.6 4239.5 4264.1 4270.4 4273.1 4291.2 5714.1 5719.7 5728.7 5731.9 5736.6 5378.2 5403.2 5565.3 5565.5 5590.4 5533.9 5535.6 5553.0 5557.2 5569.7 5260.2 5471.2 5474.0 5476.7 5498.6 5583.3 5595.3 5616.7 5625.7 5637.6 5442.7 5461.6 5478.0 5492.2 5499.1 16:50:17 INFO - PROCESS | 11426 | 16:50:17 INFO - PROCESS | 11426 | [#5] yui.html Cycles:180 Average:21739.43 Median:4603.47 stddev:32313.02 (701.9%) stddev-sans-first:32365.05 16:50:17 INFO - PROCESS | 11426 | Values: 699.6 717.5 735.0 736.0 789.1 13779.3 14353.4 14706.3 14730.9 16113.6 14737.7 14768.5 14864.1 14931.9 14951.9 662.5 793.2 796.7 811.3 821.8 823.4 824.4 826.9 827.1 827.3 871.0 874.8 875.2 875.2 875.5 688.0 811.6 845.9 846.2 868.0 612.8 614.6 614.7 614.7 614.8 14732.2 14768.5 14777.4 14778.3 14783.9 14139.3 14381.8 14421.8 14811.6 14867.9 12913.3 13103.9 13208.8 13283.9 13363.3 4447.2 4457.8 4460.5 4623.7 4648.0 76480.0 77732.6 78165.2 78653.0 80482.6 11066.6 11082.6 11212.3 11314.0 11333.8 18341.9 18343.4 18384.5 18427.9 18437.9 8149.9 8242.3 8275.2 8278.3 8408.0 4583.2 4703.1 4760.6 4773.7 4863.6 3380.3 3481.4 3484.5 3488.3 3488.5 612.2 613.9 626.9 636.9 645.9 616.8 618.8 700.1 709.7 710.1 8717.3 8923.0 9392.2 9409.7 9495.6 655.2 657.9 671.7 720.0 721.4 4779.4 4803.5 4890.5 5070.3 5506.9 121071.0 126292.0 127901.0 131003.0 131172.0 84765.0 107302.0 110010.0 113028.0 113679.0 90467.5 90511.0 90511.0 91079.5 91993.5 9887.2 9947.8 10027.4 10150.4 10267.5 51241.5 51269.5 51694.0 52188.7 53184.0 76360.6 81876.6 82025.0 82741.0 83977.6 12677.5 12683.5 12924.0 13132.4 13234.9 14971.8 15327.4 15391.7 15568.6 15926.0 13733.4 13889.5 14086.6 14329.2 14592.9 13296.9 13562.5 13617.4 14051.6 14215.7 13182.1 13675.8 13887.9 14126.7 14280.8 11505.0 11571.8 11926.5 12037.3 12131.7 10802.6 10853.4 11593.3 11839.2 12014.9 16:50:17 INFO - PROCESS | 11426 | -------- Summary: end -------- 16:50:17 INFO - PROCESS | 11426 | 16:50:18 INFO - TEST-INFO | 11426: exit 0 16:50:18 INFO - TEST-OK | dromaeo_css | took 1114460ms 16:50:18 INFO - TEST-START | kraken 16:50:18 INFO - operating with platform_type : linux_ 16:50:18 INFO - Initialising browser for kraken test... 16:50:18 INFO - TEST-INFO | started process 11617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpacBSsV/profile http://localhost:33548/getInfo.html) 16:50:22 INFO - PROCESS | 11617 | __metrics Screen width/height:1600/1200 16:50:22 INFO - PROCESS | 11617 | colorDepth:24 16:50:22 INFO - PROCESS | 11617 | Browser inner width/height: 1024/697 16:50:22 INFO - PROCESS | 11617 | __metrics 16:50:23 INFO - PROCESS | 11617 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:24 INFO - TEST-INFO | 11617: exit 0 16:50:24 INFO - Browser initialized. 16:50:24 INFO - Running cycle 1/1 for kraken test... 16:50:24 INFO - TEST-INFO | started process 11700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpacBSsV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:36 INFO - PROCESS | 11700 | RSS: Main: 156962816 16:50:36 INFO - PROCESS | 11700 | 16:50:38 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:39 INFO - PROCESS | 11700 | RSS: Main: 215261184 16:50:39 INFO - PROCESS | 11700 | 16:50:41 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-dft) 16:50:42 INFO - PROCESS | 11700 | RSS: Main: 202448896 16:50:42 INFO - PROCESS | 11700 | 16:50:45 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-fft) 16:50:46 INFO - PROCESS | 11700 | RSS: Main: 269361152 16:50:46 INFO - PROCESS | 11700 | 16:50:48 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33548/tests/kraken/driver.html?testName=audio-oscillator) 16:50:48 INFO - PROCESS | 11700 | RSS: Main: 179847168 16:50:48 INFO - PROCESS | 11700 | 16:50:51 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:50:51 INFO - PROCESS | 11700 | RSS: Main: 184926208 16:50:51 INFO - PROCESS | 11700 | 16:50:54 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33548/tests/kraken/driver.html?testName=imaging-darkroom) 16:50:55 INFO - PROCESS | 11700 | RSS: Main: 219619328 16:50:55 INFO - PROCESS | 11700 | 16:50:58 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33548/tests/kraken/driver.html?testName=imaging-desaturate) 16:50:59 INFO - PROCESS | 11700 | RSS: Main: 221138944 16:50:59 INFO - PROCESS | 11700 | 16:51:02 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33548/tests/kraken/driver.html?testName=json-parse-financial) 16:51:02 INFO - PROCESS | 11700 | RSS: Main: 221335552 16:51:02 INFO - PROCESS | 11700 | 16:51:04 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:04 INFO - PROCESS | 11700 | RSS: Main: 207986688 16:51:04 INFO - PROCESS | 11700 | 16:51:06 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:07 INFO - PROCESS | 11700 | RSS: Main: 211021824 16:51:07 INFO - PROCESS | 11700 | 16:51:09 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:09 INFO - PROCESS | 11700 | RSS: Main: 209293312 16:51:09 INFO - PROCESS | 11700 | 16:51:12 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:13 INFO - PROCESS | 11700 | RSS: Main: 223592448 16:51:13 INFO - PROCESS | 11700 | 16:51:15 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:16 INFO - PROCESS | 11700 | RSS: Main: 223891456 16:51:16 INFO - PROCESS | 11700 | 16:51:17 INFO - PROCESS | 11700 | Cycle 1(1): loaded http://localhost:33548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33548/tests/kraken/driver.html?testName=ai-astar) 16:51:18 INFO - PROCESS | 11700 | RSS: Main: 266473472 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | __start_tp_report 16:51:18 INFO - PROCESS | 11700 | _x_x_mozilla_page_load 16:51:18 INFO - PROCESS | 11700 | _x_x_mozilla_page_load_details 16:51:18 INFO - PROCESS | 11700 | |i|pagename|runs| 16:51:18 INFO - PROCESS | 11700 | |0;ai-astar;102;112;112;110;111;113;111;111;110;114 16:51:18 INFO - PROCESS | 11700 | |1;audio-beat-detection;143;115;119;179;120;116;147;117;150;120 16:51:18 INFO - PROCESS | 11700 | |2;audio-dft;160;161;159;159;161;159;160;159;161;162 16:51:18 INFO - PROCESS | 11700 | |3;audio-fft;74;74;76;122;79;76;74;73;110;74 16:51:18 INFO - PROCESS | 11700 | |4;audio-oscillator;85;84;110;84;84;85;124;84;84;131 16:51:18 INFO - PROCESS | 11700 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;117;116;117 16:51:18 INFO - PROCESS | 11700 | |6;imaging-darkroom;146;146;145;146;145;147;145;145;145;146 16:51:18 INFO - PROCESS | 11700 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:51:18 INFO - PROCESS | 11700 | |8;json-parse-financial;51;51;51;52;52;51;52;51;52;52 16:51:18 INFO - PROCESS | 11700 | |9;json-stringify-tinderbox;59;60;60;60;61;58;60;60;59;59 16:51:18 INFO - PROCESS | 11700 | |10;stanford-crypto-aes;76;75;81;75;74;76;75;75;75;80 16:51:18 INFO - PROCESS | 11700 | |11;stanford-crypto-ccm;133;116;139;119;118;127;127;125;164;118 16:51:18 INFO - PROCESS | 11700 | |12;stanford-crypto-pbkdf2;162;155;158;159;161;160;158;159;158;157 16:51:18 INFO - PROCESS | 11700 | |13;stanford-crypto-sha256-iterative;63;66;62;63;61;63;65;62;61;61 16:51:18 INFO - PROCESS | 11700 | __end_tp_report 16:51:18 INFO - PROCESS | 11700 | __start_cc_report 16:51:18 INFO - PROCESS | 11700 | _x_x_mozilla_cycle_collect,1691 16:51:18 INFO - PROCESS | 11700 | __end_cc_report 16:51:18 INFO - PROCESS | 11700 | __startTimestamp1467330678190__endTimestamp 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | ------- Summary: start ------- 16:51:18 INFO - PROCESS | 11700 | Number of tests: 14 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:3.27 (2.9%) stddev-sans-first:1.33 16:51:18 INFO - PROCESS | 11700 | Values: 102.0 112.0 112.0 110.0 111.0 113.0 111.0 111.0 110.0 114.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:131.50 stddev:21.35 (16.2%) stddev-sans-first:22.31 16:51:18 INFO - PROCESS | 11700 | Values: 143.0 115.0 119.0 179.0 120.0 116.0 147.0 117.0 150.0 120.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 16:51:18 INFO - PROCESS | 11700 | Values: 160.0 161.0 159.0 159.0 161.0 159.0 160.0 159.0 161.0 162.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#3] audio-fft Cycles:10 Average:83.20 Median:74.00 stddev:17.60 (23.8%) stddev-sans-first:18.35 16:51:18 INFO - PROCESS | 11700 | Values: 74.0 74.0 76.0 122.0 79.0 76.0 74.0 73.0 110.0 74.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:84.00 stddev:18.75 (22.3%) stddev-sans-first:19.50 16:51:18 INFO - PROCESS | 11700 | Values: 85.0 84.0 110.0 84.0 84.0 85.0 124.0 84.0 84.0 131.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:51:18 INFO - PROCESS | 11700 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 116.0 117.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:51:18 INFO - PROCESS | 11700 | Values: 146.0 146.0 145.0 146.0 145.0 147.0 145.0 145.0 145.0 146.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:51:18 INFO - PROCESS | 11700 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 16:51:18 INFO - PROCESS | 11700 | Values: 51.0 51.0 51.0 52.0 52.0 51.0 52.0 51.0 52.0 52.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.84 (1.4%) stddev-sans-first:0.87 16:51:18 INFO - PROCESS | 11700 | Values: 59.0 60.0 60.0 60.0 61.0 58.0 60.0 60.0 59.0 59.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.50 stddev:2.35 (3.1%) stddev-sans-first:2.49 16:51:18 INFO - PROCESS | 11700 | Values: 76.0 75.0 81.0 75.0 74.0 76.0 75.0 75.0 75.0 80.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.00 stddev:14.43 (11.4%) stddev-sans-first:15.22 16:51:18 INFO - PROCESS | 11700 | Values: 133.0 116.0 139.0 119.0 118.0 127.0 127.0 125.0 164.0 118.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.00 stddev:2.00 (1.3%) stddev-sans-first:1.73 16:51:18 INFO - PROCESS | 11700 | Values: 162.0 155.0 158.0 159.0 161.0 160.0 158.0 159.0 158.0 157.0 16:51:18 INFO - PROCESS | 11700 | 16:51:18 INFO - PROCESS | 11700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 16:51:18 INFO - PROCESS | 11700 | Values: 63.0 66.0 62.0 63.0 61.0 63.0 65.0 62.0 61.0 61.0 16:51:18 INFO - PROCESS | 11700 | -------- Summary: end -------- 16:51:18 INFO - PROCESS | 11700 | 16:51:19 INFO - TEST-INFO | 11700: exit 0 16:51:19 INFO - TEST-OK | kraken | took 60794ms 16:51:19 INFO - SUITE-END | took 1175s 16:51:19 INFO - Completed test suite (00:19:35) 16:51:19 INFO - javascript benchmark 16:51:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.165206220351, 3157.9842100789506, 3173.841307934603, 3200.2959348943223, 3227.080282119595, 5333.599980001506, 5409.594280428969, 5418.512333889949, 5486.725663716813, 5541.5289700375415, 5387.380451248107, 5400.540954018913, 5408.648437851547, 5443.1835224716315, 5496.31296087989, 4819.8795030124265, 4888.364512613355, 4908.288298196777, 4915.680480768757, 5102.515261050195, 4998.22527508235, 5014.8244811431605, 5046.09170349337, 5071.670341427814, 5079.1365467870555, 4826.034793041371, 4850.830220942268, 4885.755712214393, 4904.681195722303, 4937.8271760488215, 4900.117978763821, 4907.411110666742, 4912.3437741859625, 4917.631177661689, 4994.650374473788, 4863.927041094386, 4886.1204983103025, 4886.169351210267, 4890.193118135503, 4926.9014619707405, 5294.0, 5365.463453654643, 5387.1380579107545, 5437.673739575598, 5478.178273259004, 5883.0, 5899.5870289079785, 5911.527077833763, 5916.852078698067, 5926.614770039933, 5907.084401917709, 5959.344472108065, 5978.910316345258, 5979.5515336349945, 5980.312264089598, 5293.338332708411, 5433.673979561199, 5488.56091512678, 5493.533049690741, 5528.474794894479, 6039.3000758631915, 6040.758369665252, 6043.229813664596, 6050.878982420327, 6095.969520152371, 5828.970855145697, 5877.177195192677, 5881.7647294107755, 5886.764529418775, 5896.380880007538, 5638.0, 5748.741306641127, 5815.709214539256, 5819.476247137778, 5952.7321270542925, 5816.941830581724, 5848.678322692208, 5849.064149736022, 5855.180274761537, 5899.056151015817, 5831.970840145772, 5872.853178670482, 5885.588008839341, 5894.528437724972, 5894.557908156906, 4351.586599273064, 4387.188370151468, 4390.868273951723, 4391.451068616423, 4394.890127746768, 3921.6666583340734, 3941.467901833273, 3943.4676318697184, 3981.3629819228786, 3984.621460961204, 5531.806386776443, 5534.391216966131, 5537.58468114893, 5538.390777014525, 5579.246801681802, 5748.252727145528, 5772.913406298909, 5778.133280007948, 5882.264716910387, 5931.169636250928, 5520.751566179531, 5557.44425557441, 5562.582806289544, 5600.775968961278, 5610.635308704921, 4872.6589138760655, 4880.463149053601, 4888.584470319992, 4889.339939108246, 4951.777170027285, 5889.057750759858, 5963.314218864799, 6014.09788531715, 6058.545609079337, 6063.242094738158, 5917.0, 5918.467337939606, 5923.348431672599, 5931.436513531207, 5935.436133567304, 6004.0, 6035.456808887221, 6049.758009679564, 6059.878802423838, 6065.848353791191, 5669.3480249770155, 5769.913451298318, 5796.971015144897, 5810.854728631818, 5831.94168058331, 5918.881622367442, 5961.105834124743, 5965.8806823862415, 5974.611650242894, 5977.0, 5791.739371728198, 5804.2744656917885, 5805.8548536286935, 5811.622244554091, 5812.476877081083, 5589.0, 5662.801801936913, 5673.404292549223, 5717.085266357363, 5744.080947048452, 5648.4633959773755, 5656.1798539212405, 5658.462446067617, 5664.830055098354, 5665.915011274752, 5605.915911261416, 5752.511036561772, 5786.652800831964, 5837.854053648693, 5840.766369345179, 5503.174523821299, 5518.530924871431, 5542.0, 5567.66594004361, 5571.66570005801], "value": 5385.694798057875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9539236861051, 607.6293460988798, 613.868018376049, 616.1774031667725, 628.6071205496564, 43252.783736081314, 44024.0, 44190.11619767607, 44233.11533769323, 48188.51811481884, 45241.0, 45650.54349456513, 45695.77152114235, 45730.31404528935, 45738.0, 8999.640014399416, 9129.863052054225, 9151.588178531982, 9152.8627070594, 9153.633854645806, 9012.54937253138, 9082.09179082093, 9101.908980910172, 9105.043970383114, 9106.817863642724, 9115.635374585008, 9138.817223655524, 9149.313801464883, 9149.63401463944, 9155.221806146452, 9051.683191088281, 9065.093490650883, 9069.138431848964, 9070.909290907073, 9077.04691007448, 8965.327600429928, 9032.77418064547, 9035.322350823715, 9038.774030649287, 9039.502827344493, 42925.78537107326, 43383.132337353076, 43383.56616433827, 43451.56548434507, 43475.30459910911, 3585.4084076127406, 3626.528551288342, 3646.835892384849, 3741.7754934704003, 3784.243151369737, 33540.49689254663, 33758.662413375794, 33793.0, 33796.15509612255, 33813.32373352544, 4078.3270760324513, 4302.763348015857, 4312.870613881589, 4361.206278384185, 4457.598816106533, 374704.0, 376743.0, 377173.0, 377223.0, 378211.0, 52352.0, 57195.71402142962, 58785.70607146937, 58857.0, 64685.67657161778, 63789.681051594445, 64591.35408645854, 64662.676686617204, 64665.0, 64685.0, 16412.917935410245, 16431.83568164303, 16438.506844794676, 16454.341826326814, 16608.916955415145, 12316.630501084981, 12474.875251247553, 12536.874631253753, 12703.0, 12705.237685738884, 19338.969408212215, 19490.64007397977, 19573.706394404096, 19576.412707618794, 19668.803311966698, 7146.392556632641, 7170.211276759553, 7196.9280307197305, 7357.30105639974, 7515.8121046973165, 997.6009596161593, 1064.7178497698117, 1078.396098185019, 1107.4628805029554, 1140.156284349592, 32007.839960800047, 32327.51508727371, 32546.0, 32627.184320391705, 33017.66982330194, 1072.983905241422, 1103.3545375955157, 1104.2766987622958, 1115.8158903780948, 1168.526746667601, 16571.585710357336, 17169.399071032454, 17209.020962589464, 17368.739468907977, 17607.29570817153, 562692.0, 565538.0, 569283.0, 569442.0, 572144.5320507329, 60051.39948600545, 60358.698206509565, 60394.39605603975, 60485.0, 60701.39298607046, 1219.5182902753363, 1259.9999999999816, 1318.3935389720643, 1381.6891199480037, 1387.861213878604, 32585.34829303448, 33502.0, 33910.83044584761, 34068.65931340655, 34319.82840085884, 51085.23372149495, 51845.48154518406, 51936.0, 51949.480505194464, 51996.220056698425, 387476.0, 389102.0, 390314.0, 390481.0, 390563.0, 24688.753112469363, 27870.581941271303, 29055.0, 29164.7083529162, 29537.852310738308, 48685.5131448681, 49349.0, 49639.50360496349, 49755.50244497653, 50014.499855000984, 41271.380929285486, 42233.57766422296, 42522.787386062875, 43037.56962430335, 43944.78027609841, 42526.57473425226, 42647.57352426436, 42720.78639606782, 42877.0, 43454.78272608617, 40593.391099134125, 41248.38127428151, 41522.0, 41634.79182604067, 42110.157796844505, 35132.297354053284, 36808.81595592005, 36937.63062369342, 37128.0, 37840.24319513649, 27381.0, 27808.90768847972, 27903.860480697465, 27950.0, 28073.43853122967], "value": 20488.867572908235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.25857809497654, 407.6290575576226, 410.49714100227226, 412.6822346792969, 426.65014687955886, 18840.528986775338, 19409.12658930348, 20276.39170824874, 20693.068811903446, 20710.48223794406, 19146.71279930802, 19385.12766925488, 20143.697844532344, 20387.694184587206, 20567.588648227025, 5605.495505404502, 5965.985782416999, 5973.671448070354, 5982.760689572434, 5983.820485385445, 5724.8282551523525, 5784.219130417403, 5901.704914754267, 5907.616004959686, 5914.142449344842, 5868.501177399905, 5895.469407753301, 5902.173695682608, 5913.526917846562, 5915.08316210988, 5829.679367634779, 5850.625103100768, 5855.648661080328, 6199.845003874894, 6565.113709649232, 5963.850903727442, 5977.790777322816, 5977.8804423911715, 6005.0, 6005.1892994445625, 14785.92607036958, 16158.838411615969, 21674.916254187385, 24428.26715198547, 25282.49435011308, 2269.1490690990877, 2292.4841910570153, 2308.2728940383727, 2322.6516022596575, 2502.336880726609, 10506.579736810518, 10618.36289822613, 11079.667609971713, 13811.825994790455, 13827.654308642364, 1960.862739608228, 1995.9301424450075, 2025.6961455781604, 2055.22160975732, 2063.8452116091353, 87095.0, 88707.55646221792, 90431.54784226103, 90853.0, 92231.53884230604, 11510.827337589943, 11520.193586448868, 11788.70528236801, 11837.408129593487, 11919.821202681967, 16599.253033613517, 16703.749443758352, 16758.83241167573, 16761.24574394131, 16783.328666853435, 8115.310198633182, 8363.247307742333, 8386.371022173362, 8502.914970850212, 8570.057293697688, 8030.718924837603, 8081.111077781439, 8082.595870206584, 8239.423240373117, 8242.505449673039, 5118.846434606968, 5131.307273518102, 5176.456472070378, 5199.29809475716, 5269.209618557247, 2023.4738967868166, 2034.6642803937184, 2067.1111422088647, 2067.400453868361, 2075.2746979565277, 895.9462432254086, 987.3434166279344, 989.8218320702342, 1006.9043440873105, 1012.1851909213007, 20084.397468075982, 20508.487287817923, 20560.0, 20608.58782824365, 20654.896725516275, 983.6508039645965, 994.7314225159166, 1009.8687170667766, 1037.3775734559356, 1068.1561566362486, 10753.89246107529, 11225.66323010311, 11446.0, 11474.139439542068, 11484.253523520945, 370535.0, 376142.0, 376167.0, 451434.0, 452183.0, 97387.51306243423, 104265.47867260616, 104634.0, 105482.47258763657, 106894.0, 1002.1932344462632, 1015.9847602285971, 1027.928045036855, 1028.5937054863286, 1029.0789743179962, 18109.637807244046, 18186.636267274316, 18528.44414667562, 18624.627507450045, 18701.15844787015, 40166.1966760669, 40306.0, 44873.32690009718, 47097.0, 47161.292580612004, 64496.032559510706, 64900.675496624106, 64954.35045649483, 67510.0, 68199.65900170666, 8156.184381561797, 8323.417360784686, 8460.238578527962, 8850.911490885266, 9292.860607090764, 10750.408727520062, 13040.869591303965, 14059.929700351433, 14447.133172009713, 15147.091174529563, 12413.255204687748, 12580.811287830507, 12647.177933434297, 12723.300218488072, 12727.872721272668, 12141.817872731739, 12494.250344979331, 12820.0, 12853.228806271654, 12868.163569368335, 12630.936845315715, 12870.613881583567, 12900.741985160432, 12933.417996190006, 13016.934915325362, 9059.68291109808, 9097.77255568616, 9335.626574936927, 9358.15776580111, 9373.0, 9434.0, 11342.079514367115, 11641.59254426091, 12376.75246495083, 12403.75192496163], "value": 9611.77643885106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.2984553263993, 1435.2536680925919, 1471.8528147185282, 1580.48634193887, 1752.325354738426, 7449.627518624067, 8564.486130832154, 8843.513606751627, 8870.55647217639, 9072.546372681356, 8721.5639218039, 8857.955710221457, 8866.069062748415, 8883.51140687262, 8883.777905552364, 2054.5274586845035, 2318.0727708916484, 2368.159303447277, 2401.519696060795, 2407.759224077587, 2402.783749462548, 2416.1422694943217, 2421.4672771990136, 2424.9451488602513, 2426.0659646036315, 2372.4424760181346, 2380.964280537963, 2402.6876506054277, 2404.7475015123423, 2407.4462873539096, 1980.792016838233, 2209.8895055247335, 2284.4859906521065, 2294.380517260339, 2295.9081636734677, 2332.24202134307, 2339.1345202275265, 2352.0591763294647, 2356.575816353056, 2359.4809141988735, 8500.914990850137, 8558.828823423559, 8591.484510929302, 8593.742187734379, 8597.140285971416, 5114.181730923072, 5201.739913004335, 5214.270002199695, 5217.2695822584865, 5218.0, 3432.3135372925267, 3519.5776506819348, 3625.9456108158397, 3635.472856435802, 3649.817509124533, 1224.5163160551533, 1246.9376531173405, 1268.6764874956827, 1273.4778740716354, 1274.0762946863542, 11427.942860285728, 11466.369349685763, 11500.079993600491, 11535.653930382103, 11553.711157221136, 4466.665000125004, 4571.611413029863, 4723.055388922229, 4723.881902952385, 4729.881752956135, 9577.569009394594, 9611.711648650411, 9619.18236949853, 9666.806663866684, 9680.854787178198, 5244.5542128918705, 5253.4221235664045, 5254.633795213195, 5257.447967963385, 5258.97370513145, 4336.241157797373, 4663.603593694574, 4824.807007719722, 4836.202026665631, 4904.901901961941, 3997.1605962747567, 4066.6340029396906, 4070.895303039196, 4071.42999980003, 4086.7752273625238, 1179.6166245970094, 1240.9379531023594, 1303.947842086325, 1304.9739005220033, 1310.7968264918952, 833.2167762303416, 863.0635760200128, 970.5147426286857, 978.7504186432415, 1043.2227990147237, 5850.5612079094235, 6079.422454866781, 6178.66017369049, 6273.557081871195, 6353.491720662336, 960.9519524023771, 974.4591751577942, 989.618996686281, 990.9009099090177, 1025.3950169400089, 4058.553559108496, 4127.814248358831, 4162.334026555736, 4162.542120366757, 4287.164003019381, 10290.228232882564, 10526.263161578769, 10587.523561439753, 10590.841137382946, 10593.046625803561, 10457.163426925828, 10688.412137332365, 10858.61994830193, 10886.40124793144, 10954.507047182897, 7698.0, 7990.720324788605, 7999.840003199904, 8070.798230044178, 8194.22154895272, 6058.969705151622, 6218.9378106218355, 6243.875122497616, 6254.437100660781, 6351.015592583157, 9626.566804493674, 10034.49827508607, 10126.493675316058, 10133.64532241368, 10149.238807089645, 9919.15687166599, 10229.181665466596, 10274.691759247235, 10648.094911932572, 10660.680179594625, 7100.857982840417, 7511.661975211019, 7747.18654541265, 7847.293743563107, 8003.83992320162, 8519.616617252115, 8548.529830859363, 8601.784955375915, 8608.48349099056, 8618.267447267053, 7625.8856117157175, 7664.195259497673, 7753.496022758728, 7828.13890472059, 7943.285104340637, 7641.88537171954, 7662.157162712208, 7678.347340476123, 7805.141434442094, 7872.173421790859, 7171.390431813355, 7253.746118885813, 7294.781156565312, 7300.634968251672, 7303.379212766762, 5389.083855744454, 5403.567714582902, 5559.388467268678, 5603.831885043455, 5604.411536788579, 5193.37899087513, 5215.55667768244, 5253.632245742914, 5272.578193744568, 5514.2004409359615], "value": 4665.473614749499, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.83326753257137, 337.56285610134876, 345.64053384480144, 347.113125963164, 347.1754582865694, 5298.721549733613, 5325.3875804282425, 5342.2253773202865, 5350.464953504653, 5355.437679043703, 5285.7885684572575, 5288.0, 5305.549028332587, 5307.920381194285, 5312.0, 3950.3481925482333, 4023.537293211289, 4162.646175075122, 4165.208610364036, 4193.979030104861, 4108.876733697994, 4157.875263742078, 4169.854055108071, 4186.979065104685, 4193.119444916556, 3923.9607603924023, 4132.5040995080635, 4133.3386658134705, 4136.097395198212, 4143.544210136883, 4016.3975403689533, 4131.173765246963, 4133.925179453334, 4144.212599606095, 4144.48193975753, 3691.446283057536, 3701.703863690925, 3710.2579484103017, 3710.2764960832646, 3710.777353358807, 5162.88997865457, 5165.845024649267, 5175.146100893348, 5177.844664660066, 5181.663191892515, 4521.937344723987, 4749.311349854286, 4749.525047495223, 4771.928421073687, 4794.5205479452125, 5534.142207957773, 5550.72246387679, 5552.3892371839065, 5555.416681248492, 5568.777248910079, 4052.4124002019544, 4053.43251944728, 4055.5944405559208, 4060.7969601520103, 4066.410370496291, 5514.889702205974, 5758.654480731169, 5760.711964401805, 5761.654300741969, 5765.682887441147, 4077.368007958771, 4085.7344272622186, 4093.7688959517136, 4094.6724262058965, 4097.7541347519245, 4131.938020929689, 4132.938005929914, 4136.669066474735, 4138.716997730713, 4140.192662430797, 4569.903223226402, 4697.882552936204, 4726.834560790425, 4728.929066064012, 4732.645051621143, 5520.696361700065, 5537.889242215133, 5538.723063846792, 5556.721953950614, 5581.525570326487, 1423.9533942552216, 1434.5481173430337, 1434.7130573885265, 1434.763264061439, 1435.468876515696, 910.988802429303, 915.1214833759665, 926.9026752191057, 982.7788747531748, 983.3804703037184, 5317.9202311965355, 5323.334583177103, 5355.86610334737, 5356.866078348073, 5359.169328753971, 5626.127950167731, 5634.774609015593, 5637.548996080303, 5642.0, 5648.6893220872425, 5144.845654630367, 5309.327561818092, 5337.839864804062, 5446.400895901447, 5455.263539422127, 3003.714647108521, 3023.6069310989433, 3036.832974186441, 3039.407315573442, 3053.511438169927, 5621.184928185472, 5861.238039054981, 5863.5309175265875, 5882.470577648032, 5885.499732522698, 5803.88392232153, 5810.1575271586225, 5810.518317829011, 5810.622309549865, 5853.94146058534, 5786.537077033827, 5830.7959221427045, 5842.604532141886, 5860.443257890579, 5871.295444546682, 5453.7545810439415, 5689.800856969986, 5692.260006199168, 5760.337561180518, 5762.279715035621, 5636.323641163087, 5660.490555849993, 5665.858353541194, 5672.688002159921, 5673.914891276717, 5668.971655141863, 5866.560007999332, 5908.497777688945, 5919.171316015847, 5936.5844390892225, 4239.47006624172, 4264.0832221072615, 4270.444842170498, 4273.081287523198, 4291.184674911757, 5714.114312281603, 5719.7426115824055, 5728.742206600797, 5731.885362292647, 5736.598438109292, 5378.19327100938, 5403.162509810985, 5565.276514053147, 5565.471280228372, 5590.413006634245, 5533.916991245215, 5535.643767277043, 5552.972235138798, 5557.194206839905, 5569.66582005081, 5260.210968354778, 5471.206675032177, 5473.972630136824, 5476.698781567052, 5498.615096943176, 5583.330000399978, 5595.300587426572, 5616.747246373841, 5625.690587017753, 5637.633553818989, 5442.727863606883, 5461.563074954073, 5478.041857396961, 5492.203630473638, 5499.092649712913], "value": 4255.154741267566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.5522865366165, 717.5013365710834, 734.9706011759533, 735.9926400735992, 789.1240722797697, 13779.311034448276, 14353.35409906554, 14706.338214780348, 14730.926345368272, 16113.597160070974, 14737.705245895075, 14768.483103091394, 14864.108153510797, 14931.850681493182, 14951.850481495181, 662.4832630548156, 793.2107552984774, 796.6813274690112, 811.2982270336146, 821.8356328734247, 823.4236034775681, 824.418784756745, 826.8759686047081, 827.0571548434789, 827.2554700769325, 871.0, 874.7813046738315, 875.1817051057282, 875.2341701011615, 875.5053394831899, 687.9793606191797, 811.6063709101081, 845.9238668519863, 846.2087947768856, 868.0104680664048, 612.7916508387125, 614.5636598015415, 614.6527212125135, 614.735663664624, 614.8032629558498, 14732.18972956487, 14768.483103091448, 14777.408903643842, 14778.26108694561, 14783.852161478355, 14139.293035348192, 14381.784273235806, 14421.78367324491, 14811.555653330417, 14867.92566037163, 12913.289769062698, 13103.934480327633, 13208.801867971988, 13283.867161328457, 13363.265020423873, 4447.1995040892625, 4457.843975460875, 4460.4647442306805, 4623.69945953512, 4647.9535204647855, 76480.0, 77732.61133694352, 78165.21834781636, 78653.0, 80482.5975870117, 11066.612668556561, 11082.556697732161, 11212.27120237182, 11314.038306743854, 11333.829992550118, 18341.90829045873, 18343.35798247055, 18384.54038649018, 18427.90786046088, 18437.907810460863, 8149.877751833727, 8242.29940455068, 8275.213854683796, 8278.254957053774, 8407.957960210282, 4583.243764778841, 4703.106409782131, 4760.571548560646, 4773.7374444405195, 4863.586595139382, 3380.2901390707734, 3481.408160612702, 3484.5470088888787, 3488.302339532104, 3488.5464889564196, 612.2194202391897, 613.9447449729546, 626.8620903401245, 636.9426751592295, 645.8514541655445, 616.7995401494533, 618.7679620142446, 700.096875031204, 709.7125664106045, 710.0910834132319, 8717.346199035097, 8923.0, 9392.15470607635, 9409.67066152695, 9495.57269922855, 655.1875674164003, 657.9341466823776, 671.6702961996573, 719.9748008819666, 721.3651986252064, 4779.354787103696, 4803.543663351976, 4890.486498917634, 5070.340855688737, 5506.91739623906, 121071.0, 126292.0, 127901.0, 131003.0, 131172.0, 84765.0, 107302.0, 110010.0, 113028.0, 113679.0, 90467.54766226126, 90511.0, 90511.0, 91079.54460227657, 91993.54003229941, 9887.159591434809, 9947.846818655995, 10027.398356098365, 10150.441725705157, 10267.486625668836, 51241.48758512516, 51269.48730512647, 51694.0, 52188.739056304476, 53184.0, 76360.61819690866, 81876.59061704653, 82025.0, 82741.0, 83977.58011209905, 12677.492900283885, 12683.492660293854, 12924.0, 13132.40904159296, 13234.933825330812, 14971.775423368876, 15327.386904523693, 15391.692166156838, 15568.610784730472, 15926.0, 13733.381997809922, 13889.51386701501, 14086.647833804236, 14329.172973375433, 14592.854071459149, 13296.933515332361, 13562.457501699822, 13617.387217575431, 14051.648708782363, 14215.715685686435, 13182.143160694908, 13675.794863076862, 13887.930560347133, 14126.717465650834, 14280.785788212977, 11505.0, 11571.826422603499, 11926.463309151282, 12037.277763334228, 12131.696707582381, 10802.567897284334, 10853.40306283162, 11593.304401735923, 11839.171258011856, 12014.939925300318], "value": 7646.773062561478, "unit": "score"}], "name": "dromaeo_css", "value": 7375.92321987578, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 110.0, 111.0, 113.0, 111.0, 111.0, 110.0, 114.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 119.0, 179.0, 120.0, 116.0, 147.0, 117.0, 150.0, 120.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 159.0, 161.0, 159.0, 160.0, 159.0, 161.0, 162.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 122.0, 79.0, 76.0, 74.0, 73.0, 110.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 110.0, 84.0, 84.0, 85.0, 124.0, 84.0, 84.0, 131.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 116.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 52.0, 51.0, 52.0, 51.0, 52.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 61.0, 58.0, 60.0, 60.0, 59.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 81.0, 75.0, 74.0, 76.0, 75.0, 75.0, 75.0, 80.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 116.0, 139.0, 119.0, 118.0, 127.0, 127.0, 125.0, 164.0, 118.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 155.0, 158.0, 159.0, 161.0, 160.0, 158.0, 159.0, 158.0, 157.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 62.0, 63.0, 61.0, 63.0, 65.0, 62.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1477.1000000000001, "alertThreshold": 2.0}]} 16:51:19 INFO - Return code: 0 16:51:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:19 INFO - # TBPL SUCCESS # 16:51:19 INFO - Running post-action listener: _resource_record_post_action 16:51:19 INFO - ##### 16:51:19 INFO - ##### Finished run-tests step (success) 16:51:19 INFO - ##### 16:51:19 INFO - Running post-run listener: _resource_record_post_run 16:51:19 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553738240; Read time: 12; Write time: 590488 16:51:19 INFO - TinderboxPrint: CPU usage
13.0% 16:51:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:51:19 INFO - TinderboxPrint: I/O write bytes / time
553,738,240 / 590,488 16:51:19 INFO - TinderboxPrint: CPU idle
8,284.7 (87.0%) 16:51:19 INFO - TinderboxPrint: CPU user
1,192.2 (12.5%) 16:51:19 INFO - TinderboxPrint: Swap in / out
0 / 0 16:51:19 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257323008; Read time: 0; Write time: 396488 16:51:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 296415232; Read time: 0; Write time: 194000 16:51:20 INFO - Running post-run listener: _upload_blobber_files 16:51:20 INFO - Blob upload gear active. 16:51:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:51:20 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:51:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:21 INFO - (blobuploader) - INFO - Done attempting. 16:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:24 INFO - (blobuploader) - INFO - Done attempting. 16:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:25 INFO - (blobuploader) - INFO - Done attempting. 16:51:25 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:25 INFO - Return code: 0 16:51:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ba2de15b8c09b120691d50a67d26b117d3d7082cb66e8a747b366966fbb03f9d7601a246e96b39a042dbfb06aebb3502d44f77aa189c2c36e5735c56b838fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01338079e477e1efee04dac56f25d46aca480f49b712d6e400c099fcb494a58a0ed7a990f414c69b73496449b9ac51d357544c4b21d2a70644a5d8ab265b982", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85ab8691fd482a197972e3d62f266d608e7ab3cc076a3339ab3af70ba69d9cef08cd54b3a0882313623137eb0e7bc60e1c22b99bcb07c64c8fbee371c32bb389"} 16:51:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:25 INFO - Contents: 16:51:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ba2de15b8c09b120691d50a67d26b117d3d7082cb66e8a747b366966fbb03f9d7601a246e96b39a042dbfb06aebb3502d44f77aa189c2c36e5735c56b838fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01338079e477e1efee04dac56f25d46aca480f49b712d6e400c099fcb494a58a0ed7a990f414c69b73496449b9ac51d357544c4b21d2a70644a5d8ab265b982", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85ab8691fd482a197972e3d62f266d608e7ab3cc076a3339ab3af70ba69d9cef08cd54b3a0882313623137eb0e7bc60e1c22b99bcb07c64c8fbee371c32bb389"} 16:51:25 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:25 INFO - Copying logs to upload dir... 16:51:25 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.820244 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-30 16:51:25.628791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:25.632545) ========= 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=232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ba2de15b8c09b120691d50a67d26b117d3d7082cb66e8a747b366966fbb03f9d7601a246e96b39a042dbfb06aebb3502d44f77aa189c2c36e5735c56b838fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01338079e477e1efee04dac56f25d46aca480f49b712d6e400c099fcb494a58a0ed7a990f414c69b73496449b9ac51d357544c4b21d2a70644a5d8ab265b982", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85ab8691fd482a197972e3d62f266d608e7ab3cc076a3339ab3af70ba69d9cef08cd54b3a0882313623137eb0e7bc60e1c22b99bcb07c64c8fbee371c32bb389"} build_url:https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/Ihja5NHIRDai3GQ65Ldyfw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ba2de15b8c09b120691d50a67d26b117d3d7082cb66e8a747b366966fbb03f9d7601a246e96b39a042dbfb06aebb3502d44f77aa189c2c36e5735c56b838fff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f01338079e477e1efee04dac56f25d46aca480f49b712d6e400c099fcb494a58a0ed7a990f414c69b73496449b9ac51d357544c4b21d2a70644a5d8ab265b982", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/85ab8691fd482a197972e3d62f266d608e7ab3cc076a3339ab3af70ba69d9cef08cd54b3a0882313623137eb0e7bc60e1c22b99bcb07c64c8fbee371c32bb389"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:25.658777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:25.659129) ========= 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=232498196343f89f466a4a9a000001c8-1467329398.720953-1977030273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 16:51:25.742353) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:51:25.742755) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 16:51:25.743109) ========= ========= Total master_lag: 0.73 =========