builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1468593364.57 results: success (0) buildid: 20160713163005 builduid: 4e27467b6b114389b436cd7afdc62c4a revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.574003) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.574460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.574728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.676840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.677146) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 07:36:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-07-15 07:36:04 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161003 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.866655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.866977) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.065474 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:04.945261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 07:36:04.945660) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 07:36:04,979 truncating revision to first 12 chars 2016-07-15 07:36:04,979 Setting DEBUG logging. 2016-07-15 07:36:04,979 attempt 1/10 2016-07-15 07:36:04,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 07:36:05,305 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=1.000227 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 07:36:05.999639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:05.999962) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:06.000396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:06.000653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 07:36:06.016356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-07-15 07:36:06.016605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:06 INFO - MultiFileLogger online at 20160715 07:36:06 in /builds/slave/test 07:36:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:36:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:06 INFO - {'append_to_log': False, 07:36:06 INFO - 'base_work_dir': '/builds/slave/test', 07:36:06 INFO - 'blob_upload_branch': 'Firefox', 07:36:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:06 INFO - 'branch': 'Firefox', 07:36:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:06 INFO - 'config_files': ('talos/linux_config.py',), 07:36:06 INFO - 'default_actions': ('clobber', 07:36:06 INFO - 'read-buildbot-config', 07:36:06 INFO - 'download-and-extract', 07:36:06 INFO - 'populate-webroot', 07:36:06 INFO - 'create-virtualenv', 07:36:06 INFO - 'install', 07:36:06 INFO - 'run-tests'), 07:36:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:06 INFO - 'download_minidump_stackwalk': True, 07:36:06 INFO - 'download_symbols': 'ondemand', 07:36:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:06 INFO - 'installer_path': 'installer.exe', 07:36:06 INFO - 'log_level': 'info', 07:36:06 INFO - 'log_name': 'talos', 07:36:06 INFO - 'log_to_console': True, 07:36:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:06 INFO - 'opt_config_files': (), 07:36:06 INFO - 'pip_index': False, 07:36:06 INFO - 'sps_profile': False, 07:36:06 INFO - 'sps_profile_interval': 0, 07:36:06 INFO - 'suite': 'dromaeojs', 07:36:06 INFO - 'system_bits': '32', 07:36:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:06 INFO - 'title': 'talos-linux64-ix-041', 07:36:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:06 INFO - 'use_talos_json': True, 07:36:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:06 INFO - 'work_dir': 'build'} 07:36:06 INFO - ##### 07:36:06 INFO - ##### Running clobber step. 07:36:06 INFO - ##### 07:36:06 INFO - Running pre-action listener: _resource_record_pre_action 07:36:06 INFO - Running main action method: clobber 07:36:06 INFO - rmtree: /builds/slave/test/build 07:36:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:07 INFO - Running post-action listener: _resource_record_post_action 07:36:07 INFO - ##### 07:36:07 INFO - ##### Finished clobber step (success) 07:36:07 INFO - ##### 07:36:07 INFO - ##### 07:36:07 INFO - ##### Running read-buildbot-config step. 07:36:07 INFO - ##### 07:36:07 INFO - Running pre-action listener: _resource_record_pre_action 07:36:07 INFO - Running main action method: read_buildbot_config 07:36:07 INFO - Using buildbot properties: 07:36:07 INFO - { 07:36:07 INFO - "project": "", 07:36:07 INFO - "product": "firefox", 07:36:07 INFO - "script_repo_revision": "production", 07:36:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:36:07 INFO - "repository": "", 07:36:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:36:07 INFO - "buildid": "20160713163005", 07:36:07 INFO - "pgo_build": "True", 07:36:07 INFO - "basedir": "/builds/slave/test", 07:36:07 INFO - "buildnumber": 392, 07:36:07 INFO - "slavename": "talos-linux64-ix-041", 07:36:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:36:07 INFO - "platform": "ubuntu64_hw", 07:36:07 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:36:07 INFO - "branch": "mozilla-central", 07:36:07 INFO - "repo_path": "mozilla-central", 07:36:07 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 07:36:07 INFO - "stage_platform": "linux64-pgo", 07:36:07 INFO - "builduid": "4e27467b6b114389b436cd7afdc62c4a", 07:36:07 INFO - "slavebuilddir": "test" 07:36:07 INFO - } 07:36:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:36:07 INFO - Running post-action listener: _resource_record_post_action 07:36:07 INFO - ##### 07:36:07 INFO - ##### Finished read-buildbot-config step (success) 07:36:07 INFO - ##### 07:36:07 INFO - ##### 07:36:07 INFO - ##### Running download-and-extract step. 07:36:07 INFO - ##### 07:36:07 INFO - Running pre-action listener: _resource_record_pre_action 07:36:07 INFO - Running main action method: download_and_extract 07:36:07 INFO - mkdir: /builds/slave/test/build/tests 07:36: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')]} 07:36:07 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:36:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:24 INFO - Downloaded 1361 bytes. 07:36:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:36:24 INFO - Using the following test package requirements: 07:36:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'jsshell-linux-x86_64.zip'], 07:36:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:36:24 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:36:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:36:54 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:36:54 INFO - retry: attempt #1 caught exception: timed out 07:36:54 INFO - retry: Failed, sleeping 30 seconds before retrying 07:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 #2 07:37:25 INFO - Downloaded 24326108 bytes. 07:37:25 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'] 07:37:25 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 07:37:27 INFO - Return code: 0 07:37:27 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 07:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:27 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:28 INFO - Downloaded 24326108 bytes. 07:37:28 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'] 07:37:28 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 07:37:29 INFO - Return code: 0 07:37:29 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')]} 07:37:29 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:30 INFO - Downloaded 14403317 bytes. 07:37:30 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'] 07:37:30 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 07:37:31 INFO - Return code: 0 07:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:31 INFO - https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AeKnLAWLTt2AXK4wg48S7w/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 07:37:32 INFO - Downloaded 60811395 bytes. 07:37:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:32 INFO - mkdir: /builds/slave/test/properties 07:37:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:32 INFO - Contents: 07:37:32 INFO - build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:33 INFO - Running post-action listener: _resource_record_post_action 07:37:33 INFO - Running post-action listener: set_extra_try_arguments 07:37:33 INFO - ##### 07:37:33 INFO - ##### Finished download-and-extract step (success) 07:37:33 INFO - ##### 07:37:33 INFO - ##### 07:37:33 INFO - ##### Running populate-webroot step. 07:37:33 INFO - ##### 07:37:33 INFO - Running pre-action listener: _resource_record_pre_action 07:37:33 INFO - Running main action method: populate_webroot 07:37:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:33 INFO - '--tppagecycles', 07:37:33 INFO - '7'], 07:37:33 INFO - 'tests': ['tsvgm']}}, 07:37:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['damp', 'tps']}, 07:37:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'tests': ['damp', 'tps']}, 07:37:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['dromaeo_dom']}, 07:37:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['basic_compositor_video']}, 07:37:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['a11yr', 07:37:33 INFO - 'ts_paint', 07:37:33 INFO - 'tpaint', 07:37:33 INFO - 'sessionrestore', 07:37:33 INFO - 'sessionrestore_no_auto_restore', 07:37:33 INFO - 'tabpaint']}, 07:37:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:33 INFO - 'ts_paint', 07:37:33 INFO - 'tpaint', 07:37:33 INFO - 'sessionrestore', 07:37:33 INFO - 'sessionrestore_no_auto_restore', 07:37:33 INFO - 'tabpaint']}, 07:37:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:33 INFO - 'ts_paint', 07:37:33 INFO - 'tpaint', 07:37:33 INFO - 'sessionrestore', 07:37:33 INFO - 'sessionrestore_no_auto_restore', 07:37:33 INFO - 'tabpaint']}, 07:37:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:33 INFO - 'ts_paint', 07:37:33 INFO - 'tpaint', 07:37:33 INFO - 'sessionrestore', 07:37:33 INFO - 'sessionrestore_no_auto_restore', 07:37:33 INFO - 'tabpaint']}, 07:37:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['a11yr', 07:37:33 INFO - 'ts_paint', 07:37:33 INFO - 'tpaint', 07:37:33 INFO - 'sessionrestore', 07:37:33 INFO - 'sessionrestore_no_auto_restore', 07:37:33 INFO - 'tabpaint']}, 07:37:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['a11yr', 07:37:33 INFO - 'ts_paint', 07:37:33 INFO - 'tpaint', 07:37:33 INFO - 'sessionrestore', 07:37:33 INFO - 'sessionrestore_no_auto_restore', 07:37:33 INFO - 'tabpaint']}, 07:37:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['tsvgx', 07:37:33 INFO - 'tsvgr_opacity', 07:37:33 INFO - 'tart', 07:37:33 INFO - 'tscrollx', 07:37:33 INFO - 'cart']}, 07:37:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:33 INFO - 'tsvgr_opacity', 07:37:33 INFO - 'tart', 07:37:33 INFO - 'tscrollx', 07:37:33 INFO - 'cart']}, 07:37:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'talos_options': ['--disable-e10s'], 07:37:33 INFO - 'tests': ['tp5o']}, 07:37:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'tests': ['tp5o']}, 07:37:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'talos_options': ['--disable-e10s', 07:37:33 INFO - '--xperf_path', 07:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:33 INFO - 'tests': ['tp5n']}, 07:37:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:33 INFO - 'talos_options': ['--xperf_path', 07:37:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:33 INFO - 'tests': ['tp5n']}}, 07:37:33 INFO - 'talos.zip': {'path': '', 07:37:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:33 INFO - Running post-action listener: _resource_record_post_action 07:37:33 INFO - ##### 07:37:33 INFO - ##### Finished populate-webroot step (success) 07:37:33 INFO - ##### 07:37:33 INFO - ##### 07:37:33 INFO - ##### Running create-virtualenv step. 07:37:33 INFO - ##### 07:37:33 INFO - Running pre-action listener: _resource_record_pre_action 07:37:33 INFO - Running main action method: create_virtualenv 07:37:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:33 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 07:37:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:33 INFO - Using real prefix '/usr' 07:37:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:36 INFO - Installing pip.................done. 07:37:36 INFO - Return code: 0 07:37:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:36 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')]} 07:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 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')]} 07:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:36 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:36 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 07:37:36 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 07:37:36 INFO - Using env: {'DISPLAY': ':0', 07:37:36 INFO - 'HOME': '/home/cltbld', 07:37:36 INFO - 'LANG': 'en_US.UTF-8', 07:37:36 INFO - 'LANGUAGE': 'en_US:en', 07:37:36 INFO - 'LOGNAME': 'cltbld', 07:37:36 INFO - 'MAIL': '/var/mail/cltbld', 07:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:36 INFO - 'MOZ_NO_REMOTE': '1', 07:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:36 INFO - 'NO_EM_RESTART': '1', 07:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:36 INFO - 'PWD': '/builds/slave/test', 07:37:36 INFO - 'SHELL': '/bin/bash', 07:37:36 INFO - 'SHLVL': '1', 07:37:36 INFO - 'TERM': 'linux', 07:37:36 INFO - 'TMOUT': '86400', 07:37:36 INFO - 'USER': 'cltbld', 07:37:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:36 INFO - '_': '/tools/buildbot/bin/python'} 07:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:37:37 INFO - Cleaning up... 07:37:37 INFO - Return code: 0 07:37:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:37 INFO - Using env: {'DISPLAY': ':0', 07:37:37 INFO - 'HOME': '/home/cltbld', 07:37:37 INFO - 'LANG': 'en_US.UTF-8', 07:37:37 INFO - 'LANGUAGE': 'en_US:en', 07:37:37 INFO - 'LOGNAME': 'cltbld', 07:37:37 INFO - 'MAIL': '/var/mail/cltbld', 07:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:37 INFO - 'MOZ_NO_REMOTE': '1', 07:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:37 INFO - 'NO_EM_RESTART': '1', 07:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:37 INFO - 'PWD': '/builds/slave/test', 07:37:37 INFO - 'SHELL': '/bin/bash', 07:37:37 INFO - 'SHLVL': '1', 07:37:37 INFO - 'TERM': 'linux', 07:37:37 INFO - 'TMOUT': '86400', 07:37:37 INFO - 'USER': 'cltbld', 07:37:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:37 INFO - '_': '/tools/buildbot/bin/python'} 07:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:37 INFO - Downloading/unpacking psutil>=3.1.1 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:39 INFO - Installing collected packages: psutil 07:37:39 INFO - Running setup.py install for psutil 07:37:39 INFO - building 'psutil._psutil_linux' extension 07:37:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:37:41 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 07:37:41 INFO - building 'psutil._psutil_posix' extension 07:37:41 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 07:37:41 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 07:37:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:41 INFO - Successfully installed psutil 07:37:41 INFO - Cleaning up... 07:37:41 INFO - Return code: 0 07:37:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37:41 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')]} 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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')]} 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:41 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 07:37:41 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 07:37:41 INFO - Using env: {'DISPLAY': ':0', 07:37:41 INFO - 'HOME': '/home/cltbld', 07:37:41 INFO - 'LANG': 'en_US.UTF-8', 07:37:41 INFO - 'LANGUAGE': 'en_US:en', 07:37:41 INFO - 'LOGNAME': 'cltbld', 07:37:41 INFO - 'MAIL': '/var/mail/cltbld', 07:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:41 INFO - 'MOZ_NO_REMOTE': '1', 07:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:41 INFO - 'NO_EM_RESTART': '1', 07:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:41 INFO - 'PWD': '/builds/slave/test', 07:37:41 INFO - 'SHELL': '/bin/bash', 07:37:41 INFO - 'SHLVL': '1', 07:37:41 INFO - 'TERM': 'linux', 07:37:41 INFO - 'TMOUT': '86400', 07:37:41 INFO - 'USER': 'cltbld', 07:37:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:41 INFO - '_': '/tools/buildbot/bin/python'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:41 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 07:37:41 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 07:37:41 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 07:37:41 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 07:37:41 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 07:37:41 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 07:37:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:43 INFO - Installing collected packages: mozsystemmonitor 07:37:43 INFO - Running setup.py install for mozsystemmonitor 07:37:43 INFO - Successfully installed mozsystemmonitor 07:37:43 INFO - Cleaning up... 07:37:43 INFO - Return code: 0 07:37:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:43 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:43 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 07:37:43 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 07:37:43 INFO - Using env: {'DISPLAY': ':0', 07:37:43 INFO - 'HOME': '/home/cltbld', 07:37:43 INFO - 'LANG': 'en_US.UTF-8', 07:37:43 INFO - 'LANGUAGE': 'en_US:en', 07:37:43 INFO - 'LOGNAME': 'cltbld', 07:37:43 INFO - 'MAIL': '/var/mail/cltbld', 07:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:43 INFO - 'MOZ_NO_REMOTE': '1', 07:37:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:43 INFO - 'NO_EM_RESTART': '1', 07:37:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:43 INFO - 'PWD': '/builds/slave/test', 07:37:43 INFO - 'SHELL': '/bin/bash', 07:37:43 INFO - 'SHLVL': '1', 07:37:43 INFO - 'TERM': 'linux', 07:37:43 INFO - 'TMOUT': '86400', 07:37:43 INFO - 'USER': 'cltbld', 07:37:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:43 INFO - '_': '/tools/buildbot/bin/python'} 07:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:46 INFO - warning: no files found matching '*.txt' 07:37:46 INFO - no previously-included directories found matching 'build' 07:37:46 INFO - no previously-included directories found matching 'dist' 07:37:46 INFO - no previously-included directories found matching '.git*' 07:37:46 INFO - Installing collected packages: jsonschema, functools32 07:37:46 INFO - Running setup.py install for functools32 07:37:46 INFO - warning: no files found matching '*.txt' 07:37:46 INFO - no previously-included directories found matching 'build' 07:37:46 INFO - no previously-included directories found matching 'dist' 07:37:46 INFO - no previously-included directories found matching '.git*' 07:37:46 INFO - Successfully installed jsonschema functools32 07:37:46 INFO - Cleaning up... 07:37:46 INFO - Return code: 0 07:37:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:46 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:46 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 07:37:46 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 07:37:46 INFO - Using env: {'DISPLAY': ':0', 07:37:46 INFO - 'HOME': '/home/cltbld', 07:37:46 INFO - 'LANG': 'en_US.UTF-8', 07:37:46 INFO - 'LANGUAGE': 'en_US:en', 07:37:46 INFO - 'LOGNAME': 'cltbld', 07:37:46 INFO - 'MAIL': '/var/mail/cltbld', 07:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:46 INFO - 'MOZ_NO_REMOTE': '1', 07:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:46 INFO - 'NO_EM_RESTART': '1', 07:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:46 INFO - 'PWD': '/builds/slave/test', 07:37:46 INFO - 'SHELL': '/bin/bash', 07:37:46 INFO - 'SHLVL': '1', 07:37:46 INFO - 'TERM': 'linux', 07:37:46 INFO - 'TMOUT': '86400', 07:37:46 INFO - 'USER': 'cltbld', 07:37:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:46 INFO - '_': '/tools/buildbot/bin/python'} 07:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 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 07:37:46 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 07:37:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:49 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 07:37:49 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 07:37:49 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 07:37:49 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 07:37:49 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 07:37:49 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 07:37:49 INFO - Downloading docopt-0.6.1.tar.gz 07:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:49 INFO - Running setup.py install for blobuploader 07:37:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:49 INFO - Running setup.py install for requests 07:37:49 INFO - Running setup.py install for docopt 07:37:50 INFO - Successfully installed blobuploader requests docopt 07:37:50 INFO - Cleaning up... 07:37:50 INFO - Return code: 0 07:37:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:50 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')]} 07:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:50 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')]} 07:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:50 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:50 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 07:37:50 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 07:37:50 INFO - Using env: {'DISPLAY': ':0', 07:37:50 INFO - 'HOME': '/home/cltbld', 07:37:50 INFO - 'LANG': 'en_US.UTF-8', 07:37:50 INFO - 'LANGUAGE': 'en_US:en', 07:37:50 INFO - 'LOGNAME': 'cltbld', 07:37:50 INFO - 'MAIL': '/var/mail/cltbld', 07:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:50 INFO - 'MOZ_NO_REMOTE': '1', 07:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:50 INFO - 'NO_EM_RESTART': '1', 07:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:50 INFO - 'PWD': '/builds/slave/test', 07:37:50 INFO - 'SHELL': '/bin/bash', 07:37:50 INFO - 'SHLVL': '1', 07:37:50 INFO - 'TERM': 'linux', 07:37:50 INFO - 'TMOUT': '86400', 07:37:50 INFO - 'USER': 'cltbld', 07:37:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:50 INFO - '_': '/tools/buildbot/bin/python'} 07:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:50 INFO - Running setup.py (path:/tmp/pip-3cARMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:50 INFO - Running setup.py (path:/tmp/pip-N_soRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:50 INFO - Running setup.py (path:/tmp/pip-nUE0tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:50 INFO - Running setup.py (path:/tmp/pip-dvevXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:50 INFO - Running setup.py (path:/tmp/pip-v7_Tgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:50 INFO - Running setup.py (path:/tmp/pip-DGsWcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:50 INFO - Running setup.py (path:/tmp/pip-YDuvV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:50 INFO - Running setup.py (path:/tmp/pip-z3spc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:50 INFO - Running setup.py (path:/tmp/pip-MkCRcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:50 INFO - Running setup.py (path:/tmp/pip-Koj9Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:50 INFO - Running setup.py (path:/tmp/pip-iCuyJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 INFO - Running setup.py (path:/tmp/pip-xiwzl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:51 INFO - Running setup.py (path:/tmp/pip-uAepZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:51 INFO - Running setup.py (path:/tmp/pip-IOQi3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:51 INFO - Running setup.py (path:/tmp/pip-hA8C1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:51 INFO - Running setup.py (path:/tmp/pip-icWnRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:51 INFO - Running setup.py (path:/tmp/pip-1yHt7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:51 INFO - Running setup.py install for manifestparser 07:37:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Running setup.py install for mozcrash 07:37:51 INFO - Running setup.py install for mozdebug 07:37:51 INFO - Running setup.py install for mozdevice 07:37:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:51 INFO - Running setup.py install for mozfile 07:37:52 INFO - Running setup.py install for mozhttpd 07:37:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for mozinfo 07:37:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for mozInstall 07:37:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for mozleak 07:37:52 INFO - Running setup.py install for mozlog 07:37:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for moznetwork 07:37:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for mozprocess 07:37:52 INFO - Running setup.py install for mozprofile 07:37:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for mozrunner 07:37:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:52 INFO - Running setup.py install for mozscreenshot 07:37:53 INFO - Running setup.py install for moztest 07:37:53 INFO - Running setup.py install for mozversion 07:37:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:53 INFO - Cleaning up... 07:37:53 INFO - Return code: 0 07:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:53 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:53 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 07:37:53 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 07:37:53 INFO - Using env: {'DISPLAY': ':0', 07:37:53 INFO - 'HOME': '/home/cltbld', 07:37:53 INFO - 'LANG': 'en_US.UTF-8', 07:37:53 INFO - 'LANGUAGE': 'en_US:en', 07:37:53 INFO - 'LOGNAME': 'cltbld', 07:37:53 INFO - 'MAIL': '/var/mail/cltbld', 07:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:53 INFO - 'MOZ_NO_REMOTE': '1', 07:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:53 INFO - 'NO_EM_RESTART': '1', 07:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:53 INFO - 'PWD': '/builds/slave/test', 07:37:53 INFO - 'SHELL': '/bin/bash', 07:37:53 INFO - 'SHLVL': '1', 07:37:53 INFO - 'TERM': 'linux', 07:37:53 INFO - 'TMOUT': '86400', 07:37:53 INFO - 'USER': 'cltbld', 07:37:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:53 INFO - '_': '/tools/buildbot/bin/python'} 07:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:53 INFO - Running setup.py (path:/tmp/pip-5j9GGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:53 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)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:53 INFO - Running setup.py (path:/tmp/pip-NruXbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:53 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)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:53 INFO - Running setup.py (path:/tmp/pip-J8F9dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:53 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)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:53 INFO - Running setup.py (path:/tmp/pip-I1GYRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:53 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)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:53 INFO - Running setup.py (path:/tmp/pip-dr49W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:53 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)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:53 INFO - Running setup.py (path:/tmp/pip-koLKwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:53 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)) 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:53 INFO - Running setup.py (path:/tmp/pip-BWjJaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:54 INFO - Running setup.py (path:/tmp/pip-svl6JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:54 INFO - Running setup.py (path:/tmp/pip-cxGkEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:54 INFO - Running setup.py (path:/tmp/pip-MrZwA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:54 INFO - Running setup.py (path:/tmp/pip-oIx9wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:54 INFO - Running setup.py (path:/tmp/pip-i_ASoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:54 INFO - Running setup.py (path:/tmp/pip-T5TUAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:54 INFO - Running setup.py (path:/tmp/pip-f3K6bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:54 INFO - Running setup.py (path:/tmp/pip-kC9Cf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:54 INFO - Running setup.py (path:/tmp/pip-0XJLly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:54 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)) 07:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:54 INFO - Running setup.py (path:/tmp/pip-iRffUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 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)) 07:37:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:56 INFO - Downloading blessings-1.6.tar.gz 07:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:56 INFO - Installing collected packages: blessings 07:37:56 INFO - Running setup.py install for blessings 07:37:56 INFO - Successfully installed blessings 07:37:56 INFO - Cleaning up... 07:37:56 INFO - Return code: 0 07:37:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:57 INFO - Reading from file tmpfile_stdout 07:37:57 INFO - Current package versions: 07:37:57 INFO - argparse == 1.2.1 07:37:57 INFO - blessings == 1.6 07:37:57 INFO - blobuploader == 1.2.4 07:37:57 INFO - docopt == 0.6.1 07:37:57 INFO - functools32 == 3.2.3-2 07:37:57 INFO - jsonschema == 2.5.1 07:37:57 INFO - manifestparser == 1.1 07:37:57 INFO - mozInstall == 1.12 07:37:57 INFO - mozcrash == 0.17 07:37:57 INFO - mozdebug == 0.1 07:37:57 INFO - mozdevice == 0.48 07:37:57 INFO - mozfile == 1.2 07:37:57 INFO - mozhttpd == 0.7 07:37:57 INFO - mozinfo == 0.9 07:37:57 INFO - mozleak == 0.1 07:37:57 INFO - mozlog == 3.2 07:37:57 INFO - moznetwork == 0.27 07:37:57 INFO - mozprocess == 0.23 07:37:57 INFO - mozprofile == 0.28 07:37:57 INFO - mozrunner == 6.12 07:37:57 INFO - mozscreenshot == 0.1 07:37:57 INFO - mozsystemmonitor == 0.3 07:37:57 INFO - moztest == 0.7 07:37:57 INFO - mozversion == 1.4 07:37:57 INFO - psutil == 3.1.1 07:37:57 INFO - requests == 1.2.3 07:37:57 INFO - wsgiref == 0.1.2 07:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:57 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:57 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 07:37:57 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 07:37:57 INFO - Using env: {'DISPLAY': ':0', 07:37:57 INFO - 'HOME': '/home/cltbld', 07:37:57 INFO - 'LANG': 'en_US.UTF-8', 07:37:57 INFO - 'LANGUAGE': 'en_US:en', 07:37:57 INFO - 'LOGNAME': 'cltbld', 07:37:57 INFO - 'MAIL': '/var/mail/cltbld', 07:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:57 INFO - 'MOZ_NO_REMOTE': '1', 07:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:57 INFO - 'NO_EM_RESTART': '1', 07:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:57 INFO - 'PWD': '/builds/slave/test', 07:37:57 INFO - 'SHELL': '/bin/bash', 07:37:57 INFO - 'SHLVL': '1', 07:37:57 INFO - 'TERM': 'linux', 07:37:57 INFO - 'TMOUT': '86400', 07:37:57 INFO - 'USER': 'cltbld', 07:37:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:57 INFO - '_': '/tools/buildbot/bin/python'} 07:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 INFO - Cleaning up... 07:37:57 INFO - Return code: 0 07:37:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:57 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 0x1b11030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', '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 07:37:57 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 07:37:57 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 07:37:57 INFO - Using env: {'DISPLAY': ':0', 07:37:57 INFO - 'HOME': '/home/cltbld', 07:37:57 INFO - 'LANG': 'en_US.UTF-8', 07:37:57 INFO - 'LANGUAGE': 'en_US:en', 07:37:57 INFO - 'LOGNAME': 'cltbld', 07:37:57 INFO - 'MAIL': '/var/mail/cltbld', 07:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:57 INFO - 'MOZ_NO_REMOTE': '1', 07:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:57 INFO - 'NO_EM_RESTART': '1', 07:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:57 INFO - 'PWD': '/builds/slave/test', 07:37:57 INFO - 'SHELL': '/bin/bash', 07:37:57 INFO - 'SHLVL': '1', 07:37:57 INFO - 'TERM': 'linux', 07:37:57 INFO - 'TMOUT': '86400', 07:37:57 INFO - 'USER': 'cltbld', 07:37:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:57 INFO - '_': '/tools/buildbot/bin/python'} 07:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:57 INFO - Cleaning up... 07:37:57 INFO - Return code: 0 07:37:57 INFO - Running post-action listener: _resource_record_post_action 07:37:57 INFO - Running post-action listener: _start_resource_monitoring 07:37:57 INFO - Starting resource monitoring. 07:37:57 INFO - ##### 07:37:57 INFO - ##### Finished create-virtualenv step (success) 07:37:57 INFO - ##### 07:37:57 INFO - ##### 07:37:57 INFO - ##### Running install step. 07:37:57 INFO - ##### 07:37:57 INFO - Running pre-action listener: _resource_record_pre_action 07:37:57 INFO - Running main action method: install 07:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:57 INFO - Reading from file tmpfile_stdout 07:37:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:57 INFO - Reading from file tmpfile_stdout 07:37:57 INFO - Output received: 07:37:57 INFO - Usage: mozinstall [options] installer 07:37:57 INFO - Options: 07:37:57 INFO - -h, --help show this help message and exit 07:37:57 INFO - -d DEST, --destination=DEST 07:37:57 INFO - Directory to install application into. [default: 07:37:57 INFO - "/builds/slave/test"] 07:37:57 INFO - --app=APP Application being installed. [default: firefox] 07:37:57 INFO - mkdir: /builds/slave/test/build/application 07:37:57 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'] 07:37:57 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 07:38:15 INFO - Reading from file tmpfile_stdout 07:38:15 INFO - Output received: 07:38:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:15 INFO - Running post-action listener: _resource_record_post_action 07:38:15 INFO - ##### 07:38:15 INFO - ##### Finished install step (success) 07:38:15 INFO - ##### 07:38:15 INFO - ##### 07:38:15 INFO - ##### Running run-tests step. 07:38:15 INFO - ##### 07:38:15 INFO - Running pre-action listener: _resource_record_pre_action 07:38:15 INFO - Running main action method: run_tests 07:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:15 INFO - Python 2.7.3 07:38:15 INFO - Return code: 0 07:38:15 INFO - grabbing minidump binary from tooltool 07:38: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')]} 07:38:15 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 0x1dd03b0>, '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 0x1dd12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:15 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 07:38:15 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 07:38:15 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 07:38:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:15 INFO - Return code: 0 07:38:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 07:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 07:38:15 INFO - Using env: {'DISPLAY': ':0', 07:38:15 INFO - 'HOME': '/home/cltbld', 07:38:15 INFO - 'LANG': 'en_US.UTF-8', 07:38:15 INFO - 'LANGUAGE': 'en_US:en', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MAIL': '/var/mail/cltbld', 07:38:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SHLVL': '1', 07:38:15 INFO - 'TERM': 'linux', 07:38:15 INFO - 'TMOUT': '86400', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - '_': '/tools/buildbot/bin/python'} 07:38:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 07:38:16 INFO - mozversion application_buildid: 20160713163005 07:38:16 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:38:16 INFO - mozversion application_display_name: Nightly 07:38:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:16 INFO - mozversion application_name: Firefox 07:38:16 INFO - mozversion application_remotingname: firefox 07:38:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:16 INFO - mozversion application_vendor: Mozilla 07:38:16 INFO - mozversion application_version: 50.0a1 07:38:16 INFO - mozversion platform_buildid: 20160713163005 07:38:16 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 07:38:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:16 INFO - mozversion platform_version: 50.0a1 07:38:16 INFO - using testdate: 1468593496 07:38:16 INFO - actual date: 1468593496 07:38:16 INFO - starting webserver on 'localhost:60300' 07:38:16 INFO - SUITE-START | Running 2 tests 07:38:16 INFO - TEST-START | dromaeo_css 07:38:16 INFO - operating with platform_type : linux_ 07:38:16 INFO - Initialising browser for dromaeo_css test... 07:38:16 INFO - TEST-INFO | started process 3290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5FJJHn/profile http://localhost:60300/getInfo.html) 07:38:22 INFO - PROCESS | 3290 | __metrics Screen width/height:1600/1200 07:38:22 INFO - PROCESS | 3290 | colorDepth:24 07:38:22 INFO - PROCESS | 3290 | Browser inner width/height: 1024/697 07:38:22 INFO - PROCESS | 3290 | __metrics 07:38:23 INFO - PROCESS | 3290 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:23 INFO - PROCESS | 3290 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:24 INFO - TEST-INFO | 3290: exit 0 07:38:24 INFO - Browser initialized. 07:38:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:24 INFO - TEST-INFO | started process 3374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5FJJHn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:35 INFO - PROCESS | 3374 | RSS: Main: 158150656 07:38:35 INFO - PROCESS | 3374 | 07:39:27 INFO - PROCESS | 3374 | 1468593567366 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] 07:41:35 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60300/tests/dromaeo/cssquery-ext.html) 07:41:36 INFO - PROCESS | 3374 | RSS: Main: 242323456 07:41:36 INFO - PROCESS | 3374 | 07:44:38 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-ext.html (next: http://localhost:60300/tests/dromaeo/cssquery-jquery.html) 07:44:39 INFO - PROCESS | 3374 | RSS: Main: 242163712 07:44:39 INFO - PROCESS | 3374 | 07:47:41 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60300/tests/dromaeo/cssquery-mootools.html) 07:47:41 INFO - PROCESS | 3374 | RSS: Main: 232103936 07:47:41 INFO - PROCESS | 3374 | 07:50:43 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60300/tests/dromaeo/cssquery-prototype.html) 07:50:44 INFO - PROCESS | 3374 | RSS: Main: 236548096 07:50:44 INFO - PROCESS | 3374 | 07:53:47 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60300/tests/dromaeo/cssquery-yui.html) 07:53:47 INFO - PROCESS | 3374 | RSS: Main: 222355456 07:53:47 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | Cycle 1(1): loaded http://localhost:60300/tests/dromaeo/cssquery-yui.html (next: http://localhost:60300/tests/dromaeo/cssquery-dojo.html) 07:56:50 INFO - PROCESS | 3374 | RSS: Main: 306352128 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | __start_tp_report 07:56:50 INFO - PROCESS | 3374 | _x_x_mozilla_page_load 07:56:50 INFO - PROCESS | 3374 | _x_x_mozilla_page_load_details 07:56:50 INFO - PROCESS | 3374 | |i|pagename|runs| 07:56:50 INFO - PROCESS | 3374 | |0;dojo.html;3054.0074475795363;3056.8471576421175;3073.600431943847;3081.198888289044;3089.428455735689;5245.973770131153;5311.946880531198;5348.812791552296;5389.245505629215;5431.158170483576;5366.597505187097;5383.838484845451;5415.0523658359825;5459.153831156167;5492.670439773617;4819.34938783265;4826.3001864729595;4863.635227357945;4886.755662216893;5028.572571331441;4916.557509824115;4958.578520825734;4970.2296144097545;4982.875428114308;4987.226979818134;4780.115678599453;4809.807607695688;4821.927671084954;4843.806247750086;4924.187509061001;4818.301346304801;4821.566059054667;4822.6624136310475;4837.177679794443;4927.581155601778;4842.249451335048;4856.247281671346;4864.878378040542;4886.144924638174;4921.089598424267;5199.714015729133;5304.283921670563;5387.595930305203;5393.1101368274185;5418.729063546846;5795.768169273224;5831.766729330821;5834.708264586754;5848.327442344143;5852;5870.823875283749;5873.559483038789;5884.764609415618;5885.323187833411;5888.558358123158;5215.739213039333;5288.2596436498925;5354.170103633943;5355.732213389354;5424.349078110652;5925.081612350093;5925.762969481259;5925.970370148121;5929.199558059693;5935;5479;5691.772329106872;5694.515966142924;5695.430456954355;5696.572757043238;5777.480026797609;5835.270591176103;5844.9415505845245;5846.590738648254;5850.063989761617;5751.3673495916255;5762.078067509178;5775.740091695884;5776.364599894008;5816.302043754777;5507.091329930517;5634.605577609528;5788.392218817048;5790.739416726257;5799.33307669615;4347.282698354736;4360.934585981213;4374.103308821684;4400.977995110068;4414.536473670282;3881.80590970456;3892.8442862285756;3902.0635047588944;3915.040815000343;3949.170674158459;5226;5279.894402111936;5286.973565132226;5338.733063346895;5445.754941027663;5685.0335442973965;5738.856528586819;5745.597808153473;5751.22358481608;5754.165645981309;5386.461353864661;5388.326459192601;5389.164679474688;5391;5395.082835917903;4803.639727020487;4925.187344088257;4959.0989271275985;4967.850964471072;5007.499250075036;5841.591088623755;5928.199693041471;5936.7031648417405;5937.6734279614175;5983.6708981005595;5785.681787501728;5796.855078623068;5799.449052340021;5806.01297779387;5814.680192589448;5681.772729090955;5873.882522349614;5895.498882595028;5902.763889444546;5914.645121292736;5679.261695979496;5703.914441283301;5713.143028545752;5729.942700572941;5743.540516758566;5762.106873434456;5802.4197580241635;5803.7968671096305;5812.680302583399;5819.447152520504;5405.3513578369275;5532.640378375393;5543.113101903676;5589.664620122806;5692.686902220417;5579.330480342385;5584.274044374205;5588.189712491747;5589.524890384363;5598.356189038313;5511.586631002771;5522.5581953442825;5522.917156242579;5525.778968841362;5579.358373787067;5426.457354264542;5515.117581186991;5592.273004509388;5608.691521966331;5624.971875140598;5477.233187353853;5508.44915508446;5513.641613295284;5514.91727624078;5522.696251706034 07:56:50 INFO - PROCESS | 3374 | |1;ext.html;599.682168450721;617.8980468222743;642.8682120165366;654.7315600603754;668.2649086005391;31837.52243716346;32365.51451728226;43220.99999999996;44394.55605443953;44472.555274447244;42834.14331713364;46385.30422043672;46451.07097858041;46556.301655475196;46579.30131048037;8877.911220887789;9044;9048.140426659456;9050.366474346798;9054.818903621923;8923.553822308892;9004.099590040976;9016.8647470288;9021.774455638595;9025.097490250988;9026.86459703105;9073.183413492785;9085.091490850895;9086.909130908673;9091;8999.865002024975;9036.096390360977;9045.457272563634;9048.095190480932;9052.547372631409;8963.14850089247;9058.818823623556;9059.637614495412;9061.18449339556;9065.954670226673;43572.564274357486;43591.34612980808;43769.12461750779;43871.34192987108;43878;3504.754667173299;3569.589497207802;3680.0983758978955;3793.1844653399653;4186.28833098374;33447.6655233447;33774.32451350984;34050.65949340499;34778.82610586931;35042;4379.846705365297;4391.187630288407;4398.032432864765;4451.844185453526;4464.441944756905;388582;389110;390837;390880;391051.0447447773;59071.70464147738;59560.404395955484;59683.403165967786;59686;59712.70143649341;56502.43497565054;60778.69610652007;64341.678291609176;65700.70047548313;66006.33993660002;16953.152342382833;17042.91478542624;17148.742768858476;17152.742708859376;17153.742693859604;13280;13385.464581416829;13403.195808251536;13403.860671842807;13407.731845363232;14646;15953.68092638164;16206.513804585882;16432.589185270463;16606.916965415097;6035.64198055434;6100.145979562864;6162.691865406712;6237.251529816361;6387.2335319761;940.219617717293;953.4994128082674;1000.429755039635;1024.975024975025;1083.4582708645678;31063;32699.182520437178;33085.503717444255;33110;33736;1073.5222825842425;1102.7408558988632;1145.473082382097;1156.242661057009;1177.1171621284036;16693;17043.318267269417;17210.82789172092;17393.869398489056;17950.820491795177;567352;574708;576926;577815;580695;61071;61804.69097654483;61867.381326186165;61949.69025154936;62000.37999619946;1259.703969567151;1336.5388940815403;1367.6649220941133;1368.8288963879515;1389.4650559534653;29564.408711825214;33734.49398259077;33783.49324760081;33801.3239735199;34219;50200.748996254784;50550;50649.240261395375;50664.74667626638;50810.23784643159;436414;438495;438638;440271;440897;21376.251831185833;25027.249182524552;27645.585316220677;27742.44515109646;29272.121836344944;55370;55384.72307638436;56374.718126409105;58608.70695646494;58760.4123958772;42670.35994460148;43444.348334775634;44407.555924441636;45749.31376029429;47486;41116.1776764469;44631.55368446274;45264;45652.771736141105;45739;44547.77726111478;45453;45504.31743523916;45781.54218457773;45794.31308530308;38936.610633893295;40740.59259407368;40895.591044089175;40961.1807763849;40986.590134098275;30417.847910760305;30420.9579042094;30491.390172196876;30787;30899.536506951965 07:56:50 INFO - PROCESS | 3374 | |2;jquery.html;381.12531739657487;385.4468837218591;395.26678012287226;401.72481849932797;425.7381710248196;14262.216335026702;18902.14940327685;20602.793972060295;20629.484262893417;20711.689324660143;14490.927545362258;19575.41273761786;19629.411117666456;19711.310104146356;19994;5608.355039170487;5759.5968282220265;5776.162456443834;5777.942220577783;5801.593888427812;5677.57418193635;5744.885102297952;5750.108733146348;5761.654300741969;5765.971170144144;4140.627343539081;6087.604305720136;6440.645764482952;6449.6130232186215;6554.7705830295945;6274.843128921768;6451.16134902462;6482.675866206718;6491.513136514756;6532.987386955029;5616.045272303677;5682.659040457585;5700.40145784695;5705.400932902027;5715.342735585419;19281.325153619695;23100.76899231003;23833.642495362583;24197.395065123335;24220.273391798273;2579.512659545996;2579.6001619748968;2607.191770551135;2637.894484220629;2994.371182051772;14366.784498232535;14794.630134246623;14818.33317500715;14915.552533424014;15368.692626147415;1978.099964516156;1997.350860970176;2058.5985732782115;2060.1862264405627;2102.2642075273684;82823.58588207081;83072.58463707703;83304.16695833024;83990.58004709937;86211.56894215551;10457.006584374472;10599.470026498644;10688.625898093529;10916.890831091587;10917.945410273056;14758.893083018816;14849.331780069922;14854.925725371304;14880.255987200813;14883.776743348642;8143.6742530298125;8384.664613415516;8512.191341822518;8563.272121869712;8582.227599516074;8197.590120493951;8199.672013119527;8201.13888041747;8339.916600834036;8364.749057528285;5813.709314534256;6162.7226774795245;6471.449926756279;6675.79972600813;6723.058771771955;1903.505088676954;1947.9547970755527;1999.9000049997442;2001.0895042755512;2048.5800410915726;971.4268581536927;1009.5658866687395;1009.9343542669703;1026.3226270661328;1095.6712986104137;19613.215471380983;19703.802961970483;20008.59982800336;20286.492837679176;20376.796232037785;1026.343140390151;1030.2479190191202;1054.9525271362654;1056.8573242612304;1061.766411389493;11138.610148644759;11366.261193022427;11545.480453379618;11616.186866919403;11645.961956657551;505454;516232;526233;526385;526993;83629;86204;86333.5683321592;86419.1358086411;86695.13304866871;1004.6031817432073;1023.2581378500677;1038.9792204155874;1040.9011143941314;1053.2416660004938;17693.11534423248;17727.468175954742;17757.46727598174;17916.641667166845;18370.632587348446;41407;42579.148417032105;42759.7862010688;43039.35440968451;43147.56852431435;58583.707081466026;58930.41069589249;61191;68123;68682;7662.387009039152;7869.173736757558;7926.445148839756;8294.792630184294;8498.235158835734;12779.48882044745;13969.58091257264;14172.645683857985;14224.14655120696;14410;12166.57416990401;12268.141230113806;12315.93842030784;12347.506099755909;12589.370531473573;11667.124965627441;11839.526418943491;11847.348395838311;11890.76218475643;12080;11836.763264734485;12064.939675301568;12483.875161248272;12555.874441255835;12721.236725796482;8822.294216462797;8857.424267422597;8951.910480895107;9073.364864459689;9272.860907086533;8751.124887511198;11278.887211128113;11655.475503602189;12145.14983951115;12395.75208495807 07:56:50 INFO - PROCESS | 3374 | |3;mootools.html;1341.4110766221202;1464.5313499680103;1507.9623009424765;1622.3916031488193;1816.4913824129248;7986.760397188086;8362.03836558796;8365.163483651639;8493.702720404786;8499.065102838698;8281.58592070397;8438.83122337553;8451.19713627206;8456.154384561542;8462.492250464977;1997.4207479830905;2227.1536816009975;2291.644795056769;2310.630299152136;2313.1325752842686;2329.5108027314286;2344.7772461616205;2355.939827077822;2356.587597170497;2357.3988632898586;2287.885605719716;2294.369048511656;2334.5214231082673;2336.053898171235;2338.2166974063707;1925.5667474818194;1973.6447439460892;1977.0806574942576;2198.8240940724704;2248.4378905273684;2275.442516583431;2306.0545176477563;2308.180595888469;2309.7459279479244;2311.653252012195;8555.95722021392;8617.827643447095;8619.870701939475;8627.137286271385;8636.956815215884;5027.949720502821;5173.094708426048;5174;5174.249733788617;5176.352955880515;3265.379577880195;3375.578052743407;3379.3579219948133;3383.661633836621;3406.5741782277214;1180.710725872167;1196.4735516372768;1206.481213078376;1213.3811756004502;1237.4802582915108;11931.821022684666;11994.760104797942;12004.69988250292;12005.279683218947;12014.63956081319;4339.609435150788;4447.399601053817;4483.30508771141;4601.171789077931;4616.792244349012;9922.057404546556;9955;9962.950185249172;9976.05227503386;9989.250806189564;5088.033273677989;5093.134167191586;5103.97448012765;5111.7699703513435;5120.231965205249;4019.8995025124605;4660.603848672833;4789.832355867528;4790.257510085942;4823.782929768169;3853.6339047790416;3877.418387241936;3913.491246138041;3944.723869329177;4019.437278780973;1116.3804088730833;1173.677238759348;1220.1032241302635;1238.2013601227159;1245.3461932485336;968.6658102954469;997.9850302245472;1012.3015119567475;1021.7088129882948;1030.896910308963;6095.4818840398175;6126.6017708848785;6179.949408600549;6183.474404675563;6262.874742505124;964.2045312617118;971.5627967414691;985.261054209343;994.7562847102506;1031.8091153136693;4371.256886329332;4390.824367025347;4405.118976204708;4420.80106395213;4423.535528769497;10225.130863876506;10636.149108071335;10657.733556661145;10701.732456688489;10726.570937162582;9579.568919398644;9982.850257246148;9993.400395976265;10637.202209834293;10646.254762166729;7642.579658118746;7738.806529836799;7749.341305988942;7772.961135194401;7807.258310460497;6182.103594978793;6191.628502289697;6362.809115726535;6421.8715625688155;6424.51816113784;9835.21318294549;9861.802763944825;9887.406755594688;9961;9997.500124993867;9786.41281523111;10278.434686092038;10283.845742313722;10295.021972912562;10304.845427318447;7718.768436946901;7778.0666320041955;7805;7811.648475818715;7812.843743124992;8172.4687895289;8226.177382261725;8291.668333266602;8295;8331.875021874797;6286.402791734778;7808.570528620753;7875.803104922423;7890.684372625031;7925.326347260548;7491.513051651626;7787.92212077872;7878.960605196938;7894.21057894206;7946.64240109208;6801.693923773541;7068.787936361918;7148.785536433916;7176.820579485555;7188.317109874553;5390.892182156414;5419.539339156216;5437.157240627709;5460.726963651881;5539.861503462445;5299.814506492255;5336.626436149432;5421.593380496557;5489.615726899079;5683.403242659461 07:56:50 INFO - PROCESS | 3374 | |4;prototype.html;324.7110072035887;333.2984068535732;336.06741292912176;339.5467051486266;340.29728610419477;5092.618053645972;5278.498542638448;5287.762050707718;5333;5357.946420535794;5199;5245.711485868275;5247.842564723055;5267.841964741055;5280;4147;4151.23202207591;4157.272477316473;4166.83332666693;4176.7911604419805;3981.3430783920617;4163.562825903282;4165.854195103172;4168.43726096976;4181.456410666609;4120.505539335284;4126.216018956388;4132.2355364257555;4139.296319625671;4149.668026557868;4086;4124.237016152021;4143.8342466301465;4149.854755083587;4150.169966006811;3638.5451818522683;3699.4820725098507;3702.2595480903656;3706.240220754739;3727.422249551324;5118.232265160219;5145.691258524463;5154.484551544815;5159.767810448501;5192.792288308463;4664.346991421204;4693.812247510095;4724.881877953045;4726.810927562893;4758.500357462486;5232.8691782705355;5410.513053825174;5426.864328391783;5454.427285135043;5462.044142275086;3992.680585553149;4008.2584721826556;4028.295048366524;4036.798160091984;4044.8382064717375;5391.3799913009725;5561.748606563572;5657.886842263173;5682.715864206773;5699.2590963174935;3984.940225896614;3987.8205480753436;3988.7806170660892;3994.860179893748;4120.546739858613;4150;4150.3566947123245;4176.77027763476;4181.644560212416;4201.159768046403;4670.6497012724185;4736.976315118472;4751.52484751529;4773.785179666923;4789.85043589543;5505.889882202414;5512.145617429305;5517.089680202802;5527.226188333637;5531.838313954115;1408.2186034666156;1431.119861285302;1434.7130573885265;1436.956891293263;1446.1323206076481;936.5285874606437;946.7727745341206;959.8992105828927;967.3905439573024;977.5014742481244;4662.976685116552;4706.694064885772;4707.693999889996;4719.418994636767;4725.716457012591;5003.7998480061115;5016.749162541858;5020.824271150492;5048.47576211894;5057.898842023139;4574.405327307495;4655.674102812838;4740.478547359788;4741.984656520965;4780.521947805191;2659.842968308792;2661.859006372499;2665.5335316319565;2675.879585418661;2683.5169669459683;5087.6263408879395;5111.488851114858;5119.564836988898;5129.9230511542355;5154.92267615986;4880.316755654211;5029.98800479811;5050.49495050492;5138.434772175057;5151.840835811987;5020.246962955586;5078.97460512695;5092.911906118474;5132.3327967364;5134.794608215704;5014.498550144956;5025.522575355335;5025.919427322997;5044.47033061538;5047.520485553867;4698.718076915396;4806;4992.450830408725;5005.34930459038;5018.648694591489;5097.847064588068;5481.725913704219;5583.022970980143;5746.655200687972;5767.9134812977;4062.471878655756;4071.470708807836;4076.1236334188293;4114.773687447219;4123.237201117803;5637.210790489253;5652.265205523256;5693.231413759089;5701.8859622806485;5715.257016587817;5268.947310526845;5556.499915007668;5561.416051314553;5569.66582005081;5589.832305030855;5491.615586908878;5507.5593952484505;5511.641743286674;5545.639533430314;5550.972245138749;5261.342332208474;5464.590155738256;5478.150886612581;5482.2873026506295;5500.752466138953;5491.265939161249;5521.2270282159725;5548.167774833646;5574.16387541872;5592.161175823659;5410.053240682786;5424.83725488236;5428.9098697001145;5435.782568697208;5457.290552228185 07:56:50 INFO - PROCESS | 3374 | |5;yui.html;759.3507551043857;765.1774342581726;782.1787123520306;793.1830214878673;801.3789313282207;14835.184064876441;16253.349866005346;16262;16293.429729959455;16311.102889341097;14067.788983165261;14205.502807401743;14882.290074810968;15127.84872151278;15218.923905380485;816.3836303590796;826.7478419082178;833.8248967716787;836.0970152235601;836.5900708652778;673.8753330633824;819.5574389829485;841.7769291137853;846.2130218896424;849.8470275350435;853.3173461231021;857.3741168946673;858.0647094666812;859.5014891363026;859.7162936231028;711.4059760100322;853.0190281176634;853.4367317570404;853.5390888919976;856.3448961544424;619.3651507205105;635.1806170040642;635.5455849067938;638.1098367776925;640.606027293216;14131.78802317966;14232.146071235758;14336.566343365685;14342.211178385185;14361.210133442657;14443.422263109464;14897.404103835834;14950.850491495055;15014.924925375302;15176.241187940559;13471;13553.322333883365;13573.728525429437;13836.169829810244;13869;4484.304932735398;4497.527759585229;4559.110973360196;4692.202325604655;4717.080169366975;73871.26128738752;75735.24264757337;75810.62094689491;77943;78809.60595196988;11643.650690479299;11652.30086194831;11680.667693023599;11811.173217874839;11952.880471195176;22332.88833555822;22403.775962240496;22406.887965560392;22459.550808984055;22467.88766056159;8868.467891926504;8968;8975.775605609912;9061.13919177677;9082.909170908339;4820.39745031871;4909.3126962225315;4982.77577509013;4990.351254336913;5029.547340739351;3473.2011637323053;3540.752147349661;3566.268914872445;3578.355895938756;3587.982060089683;620.1256228717486;620.7579044172776;626.9341719119427;628.5003422279299;634.3624657219465;605.198112500938;617.660286842235;673.2898437967606;679.6431873266574;690.7444245629049;9480.194183494481;9828.262880284008;9984.700458986243;10007.49962501872;10014.198864090855;683.6907322477499;692.3803196139427;693.2893783871572;703.082477367041;707.5118168463744;4575.153596584642;4576.496585375606;4614.9385641302015;4652.092841895797;4652.590410653702;105002;115881;118536;118628;119537.40231298788;82520.17479825245;104140;105034.4748276269;105092;105558.47220763846;86014.56992715121;86308.56845715731;86452.08383329319;87049.69425458749;88119.55940220258;10183.49082545855;10482.52828622729;10897.400642964712;10986.176036797113;11103.72240693989;48093;49503;49738;54571.454285458225;55209.44790552043;76288;77865.61067194628;78353.60823195848;78750;83570.58214708888;11066.28069175501;13363.3986470611;13470.730585388434;13657.931710341385;13703.588892333246;13567.321633918067;14110.223937683526;14282.714345713235;14331.450376341785;15977.920110399373;13299.800502992657;13714.314284285945;14041.36813843359;15096.849031509984;15144.394224231348;14147.858521414653;14424.42302307896;14802.925985370004;15240.161791101596;15709.528714138594;13661.316934153452;14153.08004979673;14474.493392731203;14765.778513322093;14772.261386930395;11730.70673233176;11950.223235489666;12179;12340.197887137307;12466.688332791753;12049.457774399998;12439.253644781342;12495.812562811383;12790.424430900446;12848.807267890803 07:56:50 INFO - PROCESS | 3374 | __end_tp_report 07:56:50 INFO - PROCESS | 3374 | __start_cc_report 07:56:50 INFO - PROCESS | 3374 | _x_x_mozilla_cycle_collect,1025 07:56:50 INFO - PROCESS | 3374 | __end_cc_report 07:56:50 INFO - PROCESS | 3374 | __startTimestamp1468594610621__endTimestamp 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | ------- Summary: start ------- 07:56:50 INFO - PROCESS | 3374 | Number of tests: 6 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | [#0] dojo.html Cycles:165 Average:5333.47 Median:5513.64 stddev:618.20 (11.2%) stddev-sans-first:593.68 07:56:50 INFO - PROCESS | 3374 | Values: 3054.0 3056.8 3073.6 3081.2 3089.4 5246.0 5311.9 5348.8 5389.2 5431.2 5366.6 5383.8 5415.1 5459.2 5492.7 4819.3 4826.3 4863.6 4886.8 5028.6 4916.6 4958.6 4970.2 4982.9 4987.2 4780.1 4809.8 4821.9 4843.8 4924.2 4818.3 4821.6 4822.7 4837.2 4927.6 4842.2 4856.2 4864.9 4886.1 4921.1 5199.7 5304.3 5387.6 5393.1 5418.7 5795.8 5831.8 5834.7 5848.3 5852.0 5870.8 5873.6 5884.8 5885.3 5888.6 5215.7 5288.3 5354.2 5355.7 5424.3 5925.1 5925.8 5926.0 5929.2 5935.0 5479.0 5691.8 5694.5 5695.4 5696.6 5777.5 5835.3 5844.9 5846.6 5850.1 5751.4 5762.1 5775.7 5776.4 5816.3 5507.1 5634.6 5788.4 5790.7 5799.3 4347.3 4360.9 4374.1 4401.0 4414.5 3881.8 3892.8 3902.1 3915.0 3949.2 5226.0 5279.9 5287.0 5338.7 5445.8 5685.0 5738.9 5745.6 5751.2 5754.2 5386.5 5388.3 5389.2 5391.0 5395.1 4803.6 4925.2 4959.1 4967.9 5007.5 5841.6 5928.2 5936.7 5937.7 5983.7 5785.7 5796.9 5799.4 5806.0 5814.7 5681.8 5873.9 5895.5 5902.8 5914.6 5679.3 5703.9 5713.1 5729.9 5743.5 5762.1 5802.4 5803.8 5812.7 5819.4 5405.4 5532.6 5543.1 5589.7 5692.7 5579.3 5584.3 5588.2 5589.5 5598.4 5511.6 5522.6 5522.9 5525.8 5579.4 5426.5 5515.1 5592.3 5608.7 5625.0 5477.2 5508.4 5513.6 5514.9 5522.7 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | [#1] ext.html Cycles:180 Average:63443.83 Median:222334.52 stddev:125961.10 (56.7%) stddev-sans-first:126226.08 07:56:50 INFO - PROCESS | 3374 | Values: 599.7 617.9 642.9 654.7 668.3 31837.5 32365.5 43221.0 44394.6 44472.6 42834.1 46385.3 46451.1 46556.3 46579.3 8877.9 9044.0 9048.1 9050.4 9054.8 8923.6 9004.1 9016.9 9021.8 9025.1 9026.9 9073.2 9085.1 9086.9 9091.0 8999.9 9036.1 9045.5 9048.1 9052.5 8963.1 9058.8 9059.6 9061.2 9066.0 43572.6 43591.3 43769.1 43871.3 43878.0 3504.8 3569.6 3680.1 3793.2 4186.3 33447.7 33774.3 34050.7 34778.8 35042.0 4379.8 4391.2 4398.0 4451.8 4464.4 388582.0 389110.0 390837.0 390880.0 391051.0 59071.7 59560.4 59683.4 59686.0 59712.7 56502.4 60778.7 64341.7 65700.7 66006.3 16953.2 17042.9 17148.7 17152.7 17153.7 13280.0 13385.5 13403.2 13403.9 13407.7 14646.0 15953.7 16206.5 16432.6 16606.9 6035.6 6100.1 6162.7 6237.3 6387.2 940.2 953.5 1000.4 1025.0 1083.5 31063.0 32699.2 33085.5 33110.0 33736.0 1073.5 1102.7 1145.5 1156.2 1177.1 16693.0 17043.3 17210.8 17393.9 17950.8 567352.0 574708.0 576926.0 577815.0 580695.0 61071.0 61804.7 61867.4 61949.7 62000.4 1259.7 1336.5 1367.7 1368.8 1389.5 29564.4 33734.5 33783.5 33801.3 34219.0 50200.7 50550.0 50649.2 50664.7 50810.2 436414.0 438495.0 438638.0 440271.0 440897.0 21376.3 25027.2 27645.6 27742.4 29272.1 55370.0 55384.7 56374.7 58608.7 58760.4 42670.4 43444.3 44407.6 45749.3 47486.0 41116.2 44631.6 45264.0 45652.8 45739.0 44547.8 45453.0 45504.3 45781.5 45794.3 38936.6 40740.6 40895.6 40961.2 40986.6 30417.8 30421.0 30491.4 30787.0 30899.5 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | [#2] jquery.html Cycles:180 Average:30212.03 Median:24015.52 stddev:85556.39 (356.3%) stddev-sans-first:85767.08 07:56:50 INFO - PROCESS | 3374 | Values: 381.1 385.4 395.3 401.7 425.7 14262.2 18902.1 20602.8 20629.5 20711.7 14490.9 19575.4 19629.4 19711.3 19994.0 5608.4 5759.6 5776.2 5777.9 5801.6 5677.6 5744.9 5750.1 5761.7 5766.0 4140.6 6087.6 6440.6 6449.6 6554.8 6274.8 6451.2 6482.7 6491.5 6533.0 5616.0 5682.7 5700.4 5705.4 5715.3 19281.3 23100.8 23833.6 24197.4 24220.3 2579.5 2579.6 2607.2 2637.9 2994.4 14366.8 14794.6 14818.3 14915.6 15368.7 1978.1 1997.4 2058.6 2060.2 2102.3 82823.6 83072.6 83304.2 83990.6 86211.6 10457.0 10599.5 10688.6 10916.9 10917.9 14758.9 14849.3 14854.9 14880.3 14883.8 8143.7 8384.7 8512.2 8563.3 8582.2 8197.6 8199.7 8201.1 8339.9 8364.7 5813.7 6162.7 6471.4 6675.8 6723.1 1903.5 1948.0 1999.9 2001.1 2048.6 971.4 1009.6 1009.9 1026.3 1095.7 19613.2 19703.8 20008.6 20286.5 20376.8 1026.3 1030.2 1055.0 1056.9 1061.8 11138.6 11366.3 11545.5 11616.2 11646.0 505454.0 516232.0 526233.0 526385.0 526993.0 83629.0 86204.0 86333.6 86419.1 86695.1 1004.6 1023.3 1039.0 1040.9 1053.2 17693.1 17727.5 17757.5 17916.6 18370.6 41407.0 42579.1 42759.8 43039.4 43147.6 58583.7 58930.4 61191.0 68123.0 68682.0 7662.4 7869.2 7926.4 8294.8 8498.2 12779.5 13969.6 14172.6 14224.1 14410.0 12166.6 12268.1 12315.9 12347.5 12589.4 11667.1 11839.5 11847.3 11890.8 12080.0 11836.8 12064.9 12483.9 12555.9 12721.2 8822.3 8857.4 8951.9 9073.4 9272.9 8751.1 11278.9 11655.5 12145.1 12395.8 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | [#3] mootools.html Cycles:180 Average:5723.56 Median:5146.66 stddev:3187.71 (61.9%) stddev-sans-first:3179.64 07:56:50 INFO - PROCESS | 3374 | Values: 1341.4 1464.5 1508.0 1622.4 1816.5 7986.8 8362.0 8365.2 8493.7 8499.1 8281.6 8438.8 8451.2 8456.2 8462.5 1997.4 2227.2 2291.6 2310.6 2313.1 2329.5 2344.8 2355.9 2356.6 2357.4 2287.9 2294.4 2334.5 2336.1 2338.2 1925.6 1973.6 1977.1 2198.8 2248.4 2275.4 2306.1 2308.2 2309.7 2311.7 8556.0 8617.8 8619.9 8627.1 8637.0 5027.9 5173.1 5174.0 5174.2 5176.4 3265.4 3375.6 3379.4 3383.7 3406.6 1180.7 1196.5 1206.5 1213.4 1237.5 11931.8 11994.8 12004.7 12005.3 12014.6 4339.6 4447.4 4483.3 4601.2 4616.8 9922.1 9955.0 9963.0 9976.1 9989.3 5088.0 5093.1 5104.0 5111.8 5120.2 4019.9 4660.6 4789.8 4790.3 4823.8 3853.6 3877.4 3913.5 3944.7 4019.4 1116.4 1173.7 1220.1 1238.2 1245.3 968.7 998.0 1012.3 1021.7 1030.9 6095.5 6126.6 6179.9 6183.5 6262.9 964.2 971.6 985.3 994.8 1031.8 4371.3 4390.8 4405.1 4420.8 4423.5 10225.1 10636.1 10657.7 10701.7 10726.6 9579.6 9982.9 9993.4 10637.2 10646.3 7642.6 7738.8 7749.3 7773.0 7807.3 6182.1 6191.6 6362.8 6421.9 6424.5 9835.2 9861.8 9887.4 9961.0 9997.5 9786.4 10278.4 10283.8 10295.0 10304.8 7718.8 7778.1 7805.0 7811.6 7812.8 8172.5 8226.2 8291.7 8295.0 8331.9 6286.4 7808.6 7875.8 7890.7 7925.3 7491.5 7787.9 7879.0 7894.2 7946.6 6801.7 7068.8 7148.8 7176.8 7188.3 5390.9 5419.5 5437.2 5460.7 5539.9 5299.8 5336.6 5421.6 5489.6 5683.4 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | [#4] prototype.html Cycles:180 Average:4496.68 Median:5023.17 stddev:1280.34 (25.5%) stddev-sans-first:1245.05 07:56:50 INFO - PROCESS | 3374 | Values: 324.7 333.3 336.1 339.5 340.3 5092.6 5278.5 5287.8 5333.0 5357.9 5199.0 5245.7 5247.8 5267.8 5280.0 4147.0 4151.2 4157.3 4166.8 4176.8 3981.3 4163.6 4165.9 4168.4 4181.5 4120.5 4126.2 4132.2 4139.3 4149.7 4086.0 4124.2 4143.8 4149.9 4150.2 3638.5 3699.5 3702.3 3706.2 3727.4 5118.2 5145.7 5154.5 5159.8 5192.8 4664.3 4693.8 4724.9 4726.8 4758.5 5232.9 5410.5 5426.9 5454.4 5462.0 3992.7 4008.3 4028.3 4036.8 4044.8 5391.4 5561.7 5657.9 5682.7 5699.3 3984.9 3987.8 3988.8 3994.9 4120.5 4150.0 4150.4 4176.8 4181.6 4201.2 4670.6 4737.0 4751.5 4773.8 4789.9 5505.9 5512.1 5517.1 5527.2 5531.8 1408.2 1431.1 1434.7 1437.0 1446.1 936.5 946.8 959.9 967.4 977.5 4663.0 4706.7 4707.7 4719.4 4725.7 5003.8 5016.7 5020.8 5048.5 5057.9 4574.4 4655.7 4740.5 4742.0 4780.5 2659.8 2661.9 2665.5 2675.9 2683.5 5087.6 5111.5 5119.6 5129.9 5154.9 4880.3 5030.0 5050.5 5138.4 5151.8 5020.2 5079.0 5092.9 5132.3 5134.8 5014.5 5025.5 5025.9 5044.5 5047.5 4698.7 4806.0 4992.5 5005.3 5018.6 5097.8 5481.7 5583.0 5746.7 5767.9 4062.5 4071.5 4076.1 4114.8 4123.2 5637.2 5652.3 5693.2 5701.9 5715.3 5268.9 5556.5 5561.4 5569.7 5589.8 5491.6 5507.6 5511.6 5545.6 5551.0 5261.3 5464.6 5478.2 5482.3 5500.8 5491.3 5521.2 5548.2 5574.2 5592.2 5410.1 5424.8 5428.9 5435.8 5457.3 07:56:50 INFO - PROCESS | 3374 | 07:56:50 INFO - PROCESS | 3374 | [#5] yui.html Cycles:180 Average:21303.81 Median:4036.14 stddev:30315.81 (751.1%) stddev-sans-first:30361.60 07:56:50 INFO - PROCESS | 3374 | Values: 759.4 765.2 782.2 793.2 801.4 14835.2 16253.3 16262.0 16293.4 16311.1 14067.8 14205.5 14882.3 15127.8 15218.9 816.4 826.7 833.8 836.1 836.6 673.9 819.6 841.8 846.2 849.8 853.3 857.4 858.1 859.5 859.7 711.4 853.0 853.4 853.5 856.3 619.4 635.2 635.5 638.1 640.6 14131.8 14232.1 14336.6 14342.2 14361.2 14443.4 14897.4 14950.9 15014.9 15176.2 13471.0 13553.3 13573.7 13836.2 13869.0 4484.3 4497.5 4559.1 4692.2 4717.1 73871.3 75735.2 75810.6 77943.0 78809.6 11643.7 11652.3 11680.7 11811.2 11952.9 22332.9 22403.8 22406.9 22459.6 22467.9 8868.5 8968.0 8975.8 9061.1 9082.9 4820.4 4909.3 4982.8 4990.4 5029.5 3473.2 3540.8 3566.3 3578.4 3588.0 620.1 620.8 626.9 628.5 634.4 605.2 617.7 673.3 679.6 690.7 9480.2 9828.3 9984.7 10007.5 10014.2 683.7 692.4 693.3 703.1 707.5 4575.2 4576.5 4614.9 4652.1 4652.6 105002.0 115881.0 118536.0 118628.0 119537.4 82520.2 104140.0 105034.5 105092.0 105558.5 86014.6 86308.6 86452.1 87049.7 88119.6 10183.5 10482.5 10897.4 10986.2 11103.7 48093.0 49503.0 49738.0 54571.5 55209.4 76288.0 77865.6 78353.6 78750.0 83570.6 11066.3 13363.4 13470.7 13657.9 13703.6 13567.3 14110.2 14282.7 14331.5 15977.9 13299.8 13714.3 14041.4 15096.8 15144.4 14147.9 14424.4 14802.9 15240.2 15709.5 13661.3 14153.1 14474.5 14765.8 14772.3 11730.7 11950.2 12179.0 12340.2 12466.7 12049.5 12439.3 12495.8 12790.4 12848.8 07:56:50 INFO - PROCESS | 3374 | -------- Summary: end -------- 07:56:50 INFO - PROCESS | 3374 | 07:56:51 INFO - TEST-INFO | 3374: exit 0 07:56:51 INFO - TEST-OK | dromaeo_css | took 1115227ms 07:56:51 INFO - TEST-START | kraken 07:56:51 INFO - operating with platform_type : linux_ 07:56:51 INFO - Initialising browser for kraken test... 07:56:51 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwM2hvX/profile http://localhost:60300/getInfo.html) 07:56:55 INFO - PROCESS | 3560 | __metrics Screen width/height:1600/1200 07:56:55 INFO - PROCESS | 3560 | colorDepth:24 07:56:55 INFO - PROCESS | 3560 | Browser inner width/height: 1024/697 07:56:55 INFO - PROCESS | 3560 | __metrics 07:56:56 INFO - PROCESS | 3560 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:56 INFO - PROCESS | 3560 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:56 INFO - PROCESS | 3560 | console.error: PushService: 07:56:56 INFO - PROCESS | 3560 | stateChangeProcessEnqueue: Error transitioning state 07:56:56 INFO - PROCESS | 3560 | UnknownError 07:56:57 INFO - TEST-INFO | 3560: exit 0 07:56:57 INFO - Browser initialized. 07:56:57 INFO - Running cycle 1/1 for kraken test... 07:56:57 INFO - TEST-INFO | started process 3645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwM2hvX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:09 INFO - PROCESS | 3645 | RSS: Main: 156618752 07:57:09 INFO - PROCESS | 3645 | 07:57:11 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:12 INFO - PROCESS | 3645 | RSS: Main: 215875584 07:57:12 INFO - PROCESS | 3645 | 07:57:15 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-dft) 07:57:15 INFO - PROCESS | 3645 | RSS: Main: 203620352 07:57:15 INFO - PROCESS | 3645 | 07:57:18 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-fft) 07:57:19 INFO - PROCESS | 3645 | RSS: Main: 270082048 07:57:19 INFO - PROCESS | 3645 | 07:57:21 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60300/tests/kraken/driver.html?testName=audio-oscillator) 07:57:22 INFO - PROCESS | 3645 | RSS: Main: 180584448 07:57:22 INFO - PROCESS | 3645 | 07:57:24 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:24 INFO - PROCESS | 3645 | RSS: Main: 185253888 07:57:24 INFO - PROCESS | 3645 | 07:57:27 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:28 INFO - PROCESS | 3645 | RSS: Main: 219324416 07:57:28 INFO - PROCESS | 3645 | 07:57:31 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60300/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:32 INFO - PROCESS | 3645 | RSS: Main: 221605888 07:57:32 INFO - PROCESS | 3645 | 07:57:35 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60300/tests/kraken/driver.html?testName=json-parse-financial) 07:57:35 INFO - PROCESS | 3645 | RSS: Main: 221659136 07:57:35 INFO - PROCESS | 3645 | 07:57:37 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:37 INFO - PROCESS | 3645 | RSS: Main: 206290944 07:57:37 INFO - PROCESS | 3645 | 07:57:39 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:40 INFO - PROCESS | 3645 | RSS: Main: 211566592 07:57:40 INFO - PROCESS | 3645 | 07:57:42 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:43 INFO - PROCESS | 3645 | RSS: Main: 210956288 07:57:43 INFO - PROCESS | 3645 | 07:57:45 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:46 INFO - PROCESS | 3645 | RSS: Main: 225435648 07:57:46 INFO - PROCESS | 3645 | 07:57:48 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:49 INFO - PROCESS | 3645 | RSS: Main: 225484800 07:57:49 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:60300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60300/tests/kraken/driver.html?testName=ai-astar) 07:57:51 INFO - PROCESS | 3645 | RSS: Main: 268222464 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | __start_tp_report 07:57:51 INFO - PROCESS | 3645 | _x_x_mozilla_page_load 07:57:51 INFO - PROCESS | 3645 | _x_x_mozilla_page_load_details 07:57:51 INFO - PROCESS | 3645 | |i|pagename|runs| 07:57:51 INFO - PROCESS | 3645 | |0;ai-astar;102;111;111;110;113;121;109;111;109;110 07:57:51 INFO - PROCESS | 3645 | |1;audio-beat-detection;143;122;123;160;117;117;139;121;158;116 07:57:51 INFO - PROCESS | 3645 | |2;audio-dft;160;160;162;160;159;159;160;162;162;161 07:57:51 INFO - PROCESS | 3645 | |3;audio-fft;74;74;75;137;76;75;76;75;116;75 07:57:51 INFO - PROCESS | 3645 | |4;audio-oscillator;83;85;130;85;85;84;129;83;84;123 07:57:51 INFO - PROCESS | 3645 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 07:57:51 INFO - PROCESS | 3645 | |6;imaging-darkroom;145;146;145;146;146;146;146;145;146;146 07:57:51 INFO - PROCESS | 3645 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;95 07:57:51 INFO - PROCESS | 3645 | |8;json-parse-financial;52;52;53;52;51;52;53;52;51;52 07:57:51 INFO - PROCESS | 3645 | |9;json-stringify-tinderbox;62;62;63;62;63;62;62;62;63;63 07:57:51 INFO - PROCESS | 3645 | |10;stanford-crypto-aes;83;75;76;75;75;77;74;81;79;76 07:57:51 INFO - PROCESS | 3645 | |11;stanford-crypto-ccm;129;119;117;128;124;119;119;125;162;125 07:57:51 INFO - PROCESS | 3645 | |12;stanford-crypto-pbkdf2;157;152;153;153;150;154;153;156;152;153 07:57:51 INFO - PROCESS | 3645 | |13;stanford-crypto-sha256-iterative;73;61;62;62;62;61;62;62;61;61 07:57:51 INFO - PROCESS | 3645 | __end_tp_report 07:57:51 INFO - PROCESS | 3645 | __start_cc_report 07:57:51 INFO - PROCESS | 3645 | _x_x_mozilla_cycle_collect,1667 07:57:51 INFO - PROCESS | 3645 | __end_cc_report 07:57:51 INFO - PROCESS | 3645 | __startTimestamp1468594671318__endTimestamp 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | ------- Summary: start ------- 07:57:51 INFO - PROCESS | 3645 | Number of tests: 14 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:4.64 (4.2%) stddev-sans-first:3.71 07:57:51 INFO - PROCESS | 3645 | Values: 102.0 111.0 111.0 110.0 113.0 121.0 109.0 111.0 109.0 110.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:131.00 stddev:17.12 (13.1%) stddev-sans-first:17.65 07:57:51 INFO - PROCESS | 3645 | Values: 143.0 122.0 123.0 160.0 117.0 117.0 139.0 121.0 158.0 116.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.18 (0.7%) stddev-sans-first:1.24 07:57:51 INFO - PROCESS | 3645 | Values: 160.0 160.0 162.0 160.0 159.0 159.0 160.0 162.0 162.0 161.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#3] audio-fft Cycles:10 Average:85.30 Median:75.00 stddev:22.28 (29.7%) stddev-sans-first:23.25 07:57:51 INFO - PROCESS | 3645 | Values: 74.0 74.0 75.0 137.0 76.0 75.0 76.0 75.0 116.0 75.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:84.00 stddev:20.95 (24.9%) stddev-sans-first:21.59 07:57:51 INFO - PROCESS | 3645 | Values: 83.0 85.0 130.0 85.0 85.0 84.0 129.0 83.0 84.0 123.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:51 INFO - PROCESS | 3645 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:57:51 INFO - PROCESS | 3645 | Values: 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:57:51 INFO - PROCESS | 3645 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.67 (1.3%) stddev-sans-first:0.71 07:57:51 INFO - PROCESS | 3645 | Values: 52.0 52.0 53.0 52.0 51.0 52.0 53.0 52.0 51.0 52.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 07:57:51 INFO - PROCESS | 3645 | Values: 62.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 63.0 63.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.50 stddev:2.96 (3.9%) stddev-sans-first:2.24 07:57:51 INFO - PROCESS | 3645 | Values: 83.0 75.0 76.0 75.0 75.0 77.0 74.0 81.0 79.0 76.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:13.07 (10.5%) stddev-sans-first:13.84 07:57:51 INFO - PROCESS | 3645 | Values: 129.0 119.0 117.0 128.0 124.0 119.0 119.0 125.0 162.0 125.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.00 stddev:2.00 (1.3%) stddev-sans-first:1.62 07:57:51 INFO - PROCESS | 3645 | Values: 157.0 152.0 153.0 153.0 150.0 154.0 153.0 156.0 152.0 153.0 07:57:51 INFO - PROCESS | 3645 | 07:57:51 INFO - PROCESS | 3645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:3.65 (5.9%) stddev-sans-first:0.53 07:57:51 INFO - PROCESS | 3645 | Values: 73.0 61.0 62.0 62.0 62.0 61.0 62.0 62.0 61.0 61.0 07:57:51 INFO - PROCESS | 3645 | -------- Summary: end -------- 07:57:51 INFO - PROCESS | 3645 | 07:57:52 INFO - TEST-INFO | 3645: exit 0 07:57:52 INFO - TEST-OK | kraken | took 60917ms 07:57:52 INFO - SUITE-END | took 1176s 07:57:52 INFO - Completed test suite (00:19:36) 07:57:52 INFO - javascript benchmark 07:57:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.0074475795363, 3056.8471576421175, 3073.600431943847, 3081.198888289044, 3089.428455735689, 5245.973770131153, 5311.946880531198, 5348.812791552296, 5389.245505629215, 5431.158170483576, 5366.597505187097, 5383.838484845451, 5415.0523658359825, 5459.153831156167, 5492.670439773617, 4819.34938783265, 4826.3001864729595, 4863.635227357945, 4886.755662216893, 5028.572571331441, 4916.557509824115, 4958.578520825734, 4970.2296144097545, 4982.875428114308, 4987.226979818134, 4780.115678599453, 4809.807607695688, 4821.927671084954, 4843.806247750086, 4924.187509061001, 4818.301346304801, 4821.566059054667, 4822.6624136310475, 4837.177679794443, 4927.581155601778, 4842.249451335048, 4856.247281671346, 4864.878378040542, 4886.144924638174, 4921.089598424267, 5199.714015729133, 5304.283921670563, 5387.595930305203, 5393.1101368274185, 5418.729063546846, 5795.768169273224, 5831.766729330821, 5834.708264586754, 5848.327442344143, 5852.0, 5870.823875283749, 5873.559483038789, 5884.764609415618, 5885.323187833411, 5888.558358123158, 5215.739213039333, 5288.2596436498925, 5354.170103633943, 5355.732213389354, 5424.349078110652, 5925.081612350093, 5925.762969481259, 5925.970370148121, 5929.199558059693, 5935.0, 5479.0, 5691.772329106872, 5694.515966142924, 5695.430456954355, 5696.572757043238, 5777.480026797609, 5835.270591176103, 5844.9415505845245, 5846.590738648254, 5850.063989761617, 5751.3673495916255, 5762.078067509178, 5775.740091695884, 5776.364599894008, 5816.302043754777, 5507.091329930517, 5634.605577609528, 5788.392218817048, 5790.739416726257, 5799.33307669615, 4347.282698354736, 4360.934585981213, 4374.103308821684, 4400.977995110068, 4414.536473670282, 3881.80590970456, 3892.8442862285756, 3902.0635047588944, 3915.040815000343, 3949.170674158459, 5226.0, 5279.894402111936, 5286.973565132226, 5338.733063346895, 5445.754941027663, 5685.0335442973965, 5738.856528586819, 5745.597808153473, 5751.22358481608, 5754.165645981309, 5386.461353864661, 5388.326459192601, 5389.164679474688, 5391.0, 5395.082835917903, 4803.639727020487, 4925.187344088257, 4959.0989271275985, 4967.850964471072, 5007.499250075036, 5841.591088623755, 5928.199693041471, 5936.7031648417405, 5937.6734279614175, 5983.6708981005595, 5785.681787501728, 5796.855078623068, 5799.449052340021, 5806.01297779387, 5814.680192589448, 5681.772729090955, 5873.882522349614, 5895.498882595028, 5902.763889444546, 5914.645121292736, 5679.261695979496, 5703.914441283301, 5713.143028545752, 5729.942700572941, 5743.540516758566, 5762.106873434456, 5802.4197580241635, 5803.7968671096305, 5812.680302583399, 5819.447152520504, 5405.3513578369275, 5532.640378375393, 5543.113101903676, 5589.664620122806, 5692.686902220417, 5579.330480342385, 5584.274044374205, 5588.189712491747, 5589.524890384363, 5598.356189038313, 5511.586631002771, 5522.5581953442825, 5522.917156242579, 5525.778968841362, 5579.358373787067, 5426.457354264542, 5515.117581186991, 5592.273004509388, 5608.691521966331, 5624.971875140598, 5477.233187353853, 5508.44915508446, 5513.641613295284, 5514.91727624078, 5522.696251706034], "value": 5290.832720220423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.682168450721, 617.8980468222743, 642.8682120165366, 654.7315600603754, 668.2649086005391, 31837.52243716346, 32365.51451728226, 43220.99999999996, 44394.55605443953, 44472.555274447244, 42834.14331713364, 46385.30422043672, 46451.07097858041, 46556.301655475196, 46579.30131048037, 8877.911220887789, 9044.0, 9048.140426659456, 9050.366474346798, 9054.818903621923, 8923.553822308892, 9004.099590040976, 9016.8647470288, 9021.774455638595, 9025.097490250988, 9026.86459703105, 9073.183413492785, 9085.091490850895, 9086.909130908673, 9091.0, 8999.865002024975, 9036.096390360977, 9045.457272563634, 9048.095190480932, 9052.547372631409, 8963.14850089247, 9058.818823623556, 9059.637614495412, 9061.18449339556, 9065.954670226673, 43572.564274357486, 43591.34612980808, 43769.12461750779, 43871.34192987108, 43878.0, 3504.754667173299, 3569.589497207802, 3680.0983758978955, 3793.1844653399653, 4186.28833098374, 33447.6655233447, 33774.32451350984, 34050.65949340499, 34778.82610586931, 35042.0, 4379.846705365297, 4391.187630288407, 4398.032432864765, 4451.844185453526, 4464.441944756905, 388582.0, 389110.0, 390837.0, 390880.0, 391051.0447447773, 59071.70464147738, 59560.404395955484, 59683.403165967786, 59686.0, 59712.70143649341, 56502.43497565054, 60778.69610652007, 64341.678291609176, 65700.70047548313, 66006.33993660002, 16953.152342382833, 17042.91478542624, 17148.742768858476, 17152.742708859376, 17153.742693859604, 13280.0, 13385.464581416829, 13403.195808251536, 13403.860671842807, 13407.731845363232, 14646.0, 15953.68092638164, 16206.513804585882, 16432.589185270463, 16606.916965415097, 6035.64198055434, 6100.145979562864, 6162.691865406712, 6237.251529816361, 6387.2335319761, 940.219617717293, 953.4994128082674, 1000.429755039635, 1024.975024975025, 1083.4582708645678, 31063.0, 32699.182520437178, 33085.503717444255, 33110.0, 33736.0, 1073.5222825842425, 1102.7408558988632, 1145.473082382097, 1156.242661057009, 1177.1171621284036, 16693.0, 17043.318267269417, 17210.82789172092, 17393.869398489056, 17950.820491795177, 567352.0, 574708.0, 576926.0, 577815.0, 580695.0, 61071.0, 61804.69097654483, 61867.381326186165, 61949.69025154936, 62000.37999619946, 1259.703969567151, 1336.5388940815403, 1367.6649220941133, 1368.8288963879515, 1389.4650559534653, 29564.408711825214, 33734.49398259077, 33783.49324760081, 33801.3239735199, 34219.0, 50200.748996254784, 50550.0, 50649.240261395375, 50664.74667626638, 50810.23784643159, 436414.0, 438495.0, 438638.0, 440271.0, 440897.0, 21376.251831185833, 25027.249182524552, 27645.585316220677, 27742.44515109646, 29272.121836344944, 55370.0, 55384.72307638436, 56374.718126409105, 58608.70695646494, 58760.4123958772, 42670.35994460148, 43444.348334775634, 44407.555924441636, 45749.31376029429, 47486.0, 41116.1776764469, 44631.55368446274, 45264.0, 45652.771736141105, 45739.0, 44547.77726111478, 45453.0, 45504.31743523916, 45781.54218457773, 45794.31308530308, 38936.610633893295, 40740.59259407368, 40895.591044089175, 40961.1807763849, 40986.590134098275, 30417.847910760305, 30420.9579042094, 30491.390172196876, 30787.0, 30899.536506951965], "value": 20631.420984180822, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.12531739657487, 385.4468837218591, 395.26678012287226, 401.72481849932797, 425.7381710248196, 14262.216335026702, 18902.14940327685, 20602.793972060295, 20629.484262893417, 20711.689324660143, 14490.927545362258, 19575.41273761786, 19629.411117666456, 19711.310104146356, 19994.0, 5608.355039170487, 5759.5968282220265, 5776.162456443834, 5777.942220577783, 5801.593888427812, 5677.57418193635, 5744.885102297952, 5750.108733146348, 5761.654300741969, 5765.971170144144, 4140.627343539081, 6087.604305720136, 6440.645764482952, 6449.6130232186215, 6554.7705830295945, 6274.843128921768, 6451.16134902462, 6482.675866206718, 6491.513136514756, 6532.987386955029, 5616.045272303677, 5682.659040457585, 5700.40145784695, 5705.400932902027, 5715.342735585419, 19281.325153619695, 23100.76899231003, 23833.642495362583, 24197.395065123335, 24220.273391798273, 2579.512659545996, 2579.6001619748968, 2607.191770551135, 2637.894484220629, 2994.371182051772, 14366.784498232535, 14794.630134246623, 14818.33317500715, 14915.552533424014, 15368.692626147415, 1978.099964516156, 1997.350860970176, 2058.5985732782115, 2060.1862264405627, 2102.2642075273684, 82823.58588207081, 83072.58463707703, 83304.16695833024, 83990.58004709937, 86211.56894215551, 10457.006584374472, 10599.470026498644, 10688.625898093529, 10916.890831091587, 10917.945410273056, 14758.893083018816, 14849.331780069922, 14854.925725371304, 14880.255987200813, 14883.776743348642, 8143.6742530298125, 8384.664613415516, 8512.191341822518, 8563.272121869712, 8582.227599516074, 8197.590120493951, 8199.672013119527, 8201.13888041747, 8339.916600834036, 8364.749057528285, 5813.709314534256, 6162.7226774795245, 6471.449926756279, 6675.79972600813, 6723.058771771955, 1903.505088676954, 1947.9547970755527, 1999.9000049997442, 2001.0895042755512, 2048.5800410915726, 971.4268581536927, 1009.5658866687395, 1009.9343542669703, 1026.3226270661328, 1095.6712986104137, 19613.215471380983, 19703.802961970483, 20008.59982800336, 20286.492837679176, 20376.796232037785, 1026.343140390151, 1030.2479190191202, 1054.9525271362654, 1056.8573242612304, 1061.766411389493, 11138.610148644759, 11366.261193022427, 11545.480453379618, 11616.186866919403, 11645.961956657551, 505454.0, 516232.0, 526233.0, 526385.0, 526993.0, 83629.0, 86204.0, 86333.5683321592, 86419.1358086411, 86695.13304866871, 1004.6031817432073, 1023.2581378500677, 1038.9792204155874, 1040.9011143941314, 1053.2416660004938, 17693.11534423248, 17727.468175954742, 17757.46727598174, 17916.641667166845, 18370.632587348446, 41407.0, 42579.148417032105, 42759.7862010688, 43039.35440968451, 43147.56852431435, 58583.707081466026, 58930.41069589249, 61191.0, 68123.0, 68682.0, 7662.387009039152, 7869.173736757558, 7926.445148839756, 8294.792630184294, 8498.235158835734, 12779.48882044745, 13969.58091257264, 14172.645683857985, 14224.14655120696, 14410.0, 12166.57416990401, 12268.141230113806, 12315.93842030784, 12347.506099755909, 12589.370531473573, 11667.124965627441, 11839.526418943491, 11847.348395838311, 11890.76218475643, 12080.0, 11836.763264734485, 12064.939675301568, 12483.875161248272, 12555.874441255835, 12721.236725796482, 8822.294216462797, 8857.424267422597, 8951.910480895107, 9073.364864459689, 9272.860907086533, 8751.124887511198, 11278.887211128113, 11655.475503602189, 12145.14983951115, 12395.75208495807], "value": 9619.406460633189, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.4110766221202, 1464.5313499680103, 1507.9623009424765, 1622.3916031488193, 1816.4913824129248, 7986.760397188086, 8362.03836558796, 8365.163483651639, 8493.702720404786, 8499.065102838698, 8281.58592070397, 8438.83122337553, 8451.19713627206, 8456.154384561542, 8462.492250464977, 1997.4207479830905, 2227.1536816009975, 2291.644795056769, 2310.630299152136, 2313.1325752842686, 2329.5108027314286, 2344.7772461616205, 2355.939827077822, 2356.587597170497, 2357.3988632898586, 2287.885605719716, 2294.369048511656, 2334.5214231082673, 2336.053898171235, 2338.2166974063707, 1925.5667474818194, 1973.6447439460892, 1977.0806574942576, 2198.8240940724704, 2248.4378905273684, 2275.442516583431, 2306.0545176477563, 2308.180595888469, 2309.7459279479244, 2311.653252012195, 8555.95722021392, 8617.827643447095, 8619.870701939475, 8627.137286271385, 8636.956815215884, 5027.949720502821, 5173.094708426048, 5174.0, 5174.249733788617, 5176.352955880515, 3265.379577880195, 3375.578052743407, 3379.3579219948133, 3383.661633836621, 3406.5741782277214, 1180.710725872167, 1196.4735516372768, 1206.481213078376, 1213.3811756004502, 1237.4802582915108, 11931.821022684666, 11994.760104797942, 12004.69988250292, 12005.279683218947, 12014.63956081319, 4339.609435150788, 4447.399601053817, 4483.30508771141, 4601.171789077931, 4616.792244349012, 9922.057404546556, 9955.0, 9962.950185249172, 9976.05227503386, 9989.250806189564, 5088.033273677989, 5093.134167191586, 5103.97448012765, 5111.7699703513435, 5120.231965205249, 4019.8995025124605, 4660.603848672833, 4789.832355867528, 4790.257510085942, 4823.782929768169, 3853.6339047790416, 3877.418387241936, 3913.491246138041, 3944.723869329177, 4019.437278780973, 1116.3804088730833, 1173.677238759348, 1220.1032241302635, 1238.2013601227159, 1245.3461932485336, 968.6658102954469, 997.9850302245472, 1012.3015119567475, 1021.7088129882948, 1030.896910308963, 6095.4818840398175, 6126.6017708848785, 6179.949408600549, 6183.474404675563, 6262.874742505124, 964.2045312617118, 971.5627967414691, 985.261054209343, 994.7562847102506, 1031.8091153136693, 4371.256886329332, 4390.824367025347, 4405.118976204708, 4420.80106395213, 4423.535528769497, 10225.130863876506, 10636.149108071335, 10657.733556661145, 10701.732456688489, 10726.570937162582, 9579.568919398644, 9982.850257246148, 9993.400395976265, 10637.202209834293, 10646.254762166729, 7642.579658118746, 7738.806529836799, 7749.341305988942, 7772.961135194401, 7807.258310460497, 6182.103594978793, 6191.628502289697, 6362.809115726535, 6421.8715625688155, 6424.51816113784, 9835.21318294549, 9861.802763944825, 9887.406755594688, 9961.0, 9997.500124993867, 9786.41281523111, 10278.434686092038, 10283.845742313722, 10295.021972912562, 10304.845427318447, 7718.768436946901, 7778.0666320041955, 7805.0, 7811.648475818715, 7812.843743124992, 8172.4687895289, 8226.177382261725, 8291.668333266602, 8295.0, 8331.875021874797, 6286.402791734778, 7808.570528620753, 7875.803104922423, 7890.684372625031, 7925.326347260548, 7491.513051651626, 7787.92212077872, 7878.960605196938, 7894.21057894206, 7946.64240109208, 6801.693923773541, 7068.787936361918, 7148.785536433916, 7176.820579485555, 7188.317109874553, 5390.892182156414, 5419.539339156216, 5437.157240627709, 5460.726963651881, 5539.861503462445, 5299.814506492255, 5336.626436149432, 5421.593380496557, 5489.615726899079, 5683.403242659461], "value": 4608.239417612999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.7110072035887, 333.2984068535732, 336.06741292912176, 339.5467051486266, 340.29728610419477, 5092.618053645972, 5278.498542638448, 5287.762050707718, 5333.0, 5357.946420535794, 5199.0, 5245.711485868275, 5247.842564723055, 5267.841964741055, 5280.0, 4147.0, 4151.23202207591, 4157.272477316473, 4166.83332666693, 4176.7911604419805, 3981.3430783920617, 4163.562825903282, 4165.854195103172, 4168.43726096976, 4181.456410666609, 4120.505539335284, 4126.216018956388, 4132.2355364257555, 4139.296319625671, 4149.668026557868, 4086.0, 4124.237016152021, 4143.8342466301465, 4149.854755083587, 4150.169966006811, 3638.5451818522683, 3699.4820725098507, 3702.2595480903656, 3706.240220754739, 3727.422249551324, 5118.232265160219, 5145.691258524463, 5154.484551544815, 5159.767810448501, 5192.792288308463, 4664.346991421204, 4693.812247510095, 4724.881877953045, 4726.810927562893, 4758.500357462486, 5232.8691782705355, 5410.513053825174, 5426.864328391783, 5454.427285135043, 5462.044142275086, 3992.680585553149, 4008.2584721826556, 4028.295048366524, 4036.798160091984, 4044.8382064717375, 5391.3799913009725, 5561.748606563572, 5657.886842263173, 5682.715864206773, 5699.2590963174935, 3984.940225896614, 3987.8205480753436, 3988.7806170660892, 3994.860179893748, 4120.546739858613, 4150.0, 4150.3566947123245, 4176.77027763476, 4181.644560212416, 4201.159768046403, 4670.6497012724185, 4736.976315118472, 4751.52484751529, 4773.785179666923, 4789.85043589543, 5505.889882202414, 5512.145617429305, 5517.089680202802, 5527.226188333637, 5531.838313954115, 1408.2186034666156, 1431.119861285302, 1434.7130573885265, 1436.956891293263, 1446.1323206076481, 936.5285874606437, 946.7727745341206, 959.8992105828927, 967.3905439573024, 977.5014742481244, 4662.976685116552, 4706.694064885772, 4707.693999889996, 4719.418994636767, 4725.716457012591, 5003.7998480061115, 5016.749162541858, 5020.824271150492, 5048.47576211894, 5057.898842023139, 4574.405327307495, 4655.674102812838, 4740.478547359788, 4741.984656520965, 4780.521947805191, 2659.842968308792, 2661.859006372499, 2665.5335316319565, 2675.879585418661, 2683.5169669459683, 5087.6263408879395, 5111.488851114858, 5119.564836988898, 5129.9230511542355, 5154.92267615986, 4880.316755654211, 5029.98800479811, 5050.49495050492, 5138.434772175057, 5151.840835811987, 5020.246962955586, 5078.97460512695, 5092.911906118474, 5132.3327967364, 5134.794608215704, 5014.498550144956, 5025.522575355335, 5025.919427322997, 5044.47033061538, 5047.520485553867, 4698.718076915396, 4806.0, 4992.450830408725, 5005.34930459038, 5018.648694591489, 5097.847064588068, 5481.725913704219, 5583.022970980143, 5746.655200687972, 5767.9134812977, 4062.471878655756, 4071.470708807836, 4076.1236334188293, 4114.773687447219, 4123.237201117803, 5637.210790489253, 5652.265205523256, 5693.231413759089, 5701.8859622806485, 5715.257016587817, 5268.947310526845, 5556.499915007668, 5561.416051314553, 5569.66582005081, 5589.832305030855, 5491.615586908878, 5507.5593952484505, 5511.641743286674, 5545.639533430314, 5550.972245138749, 5261.342332208474, 5464.590155738256, 5478.150886612581, 5482.2873026506295, 5500.752466138953, 5491.265939161249, 5521.2270282159725, 5548.167774833646, 5574.16387541872, 5592.161175823659, 5410.053240682786, 5424.83725488236, 5428.9098697001145, 5435.782568697208, 5457.290552228185], "value": 4095.525230711226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.3507551043857, 765.1774342581726, 782.1787123520306, 793.1830214878673, 801.3789313282207, 14835.184064876441, 16253.349866005346, 16262.0, 16293.429729959455, 16311.102889341097, 14067.788983165261, 14205.502807401743, 14882.290074810968, 15127.84872151278, 15218.923905380485, 816.3836303590796, 826.7478419082178, 833.8248967716787, 836.0970152235601, 836.5900708652778, 673.8753330633824, 819.5574389829485, 841.7769291137853, 846.2130218896424, 849.8470275350435, 853.3173461231021, 857.3741168946673, 858.0647094666812, 859.5014891363026, 859.7162936231028, 711.4059760100322, 853.0190281176634, 853.4367317570404, 853.5390888919976, 856.3448961544424, 619.3651507205105, 635.1806170040642, 635.5455849067938, 638.1098367776925, 640.606027293216, 14131.78802317966, 14232.146071235758, 14336.566343365685, 14342.211178385185, 14361.210133442657, 14443.422263109464, 14897.404103835834, 14950.850491495055, 15014.924925375302, 15176.241187940559, 13471.0, 13553.322333883365, 13573.728525429437, 13836.169829810244, 13869.0, 4484.304932735398, 4497.527759585229, 4559.110973360196, 4692.202325604655, 4717.080169366975, 73871.26128738752, 75735.24264757337, 75810.62094689491, 77943.0, 78809.60595196988, 11643.650690479299, 11652.30086194831, 11680.667693023599, 11811.173217874839, 11952.880471195176, 22332.88833555822, 22403.775962240496, 22406.887965560392, 22459.550808984055, 22467.88766056159, 8868.467891926504, 8968.0, 8975.775605609912, 9061.13919177677, 9082.909170908339, 4820.39745031871, 4909.3126962225315, 4982.77577509013, 4990.351254336913, 5029.547340739351, 3473.2011637323053, 3540.752147349661, 3566.268914872445, 3578.355895938756, 3587.982060089683, 620.1256228717486, 620.7579044172776, 626.9341719119427, 628.5003422279299, 634.3624657219465, 605.198112500938, 617.660286842235, 673.2898437967606, 679.6431873266574, 690.7444245629049, 9480.194183494481, 9828.262880284008, 9984.700458986243, 10007.49962501872, 10014.198864090855, 683.6907322477499, 692.3803196139427, 693.2893783871572, 703.082477367041, 707.5118168463744, 4575.153596584642, 4576.496585375606, 4614.9385641302015, 4652.092841895797, 4652.590410653702, 105002.0, 115881.0, 118536.0, 118628.0, 119537.40231298788, 82520.17479825245, 104140.0, 105034.4748276269, 105092.0, 105558.47220763846, 86014.56992715121, 86308.56845715731, 86452.08383329319, 87049.69425458749, 88119.55940220258, 10183.49082545855, 10482.52828622729, 10897.400642964712, 10986.176036797113, 11103.72240693989, 48093.0, 49503.0, 49738.0, 54571.454285458225, 55209.44790552043, 76288.0, 77865.61067194628, 78353.60823195848, 78750.0, 83570.58214708888, 11066.28069175501, 13363.3986470611, 13470.730585388434, 13657.931710341385, 13703.588892333246, 13567.321633918067, 14110.223937683526, 14282.714345713235, 14331.450376341785, 15977.920110399373, 13299.800502992657, 13714.314284285945, 14041.36813843359, 15096.849031509984, 15144.394224231348, 14147.858521414653, 14424.42302307896, 14802.925985370004, 15240.161791101596, 15709.528714138594, 13661.316934153452, 14153.08004979673, 14474.493392731203, 14765.778513322093, 14772.261386930395, 11730.70673233176, 11950.223235489666, 12179.0, 12340.197887137307, 12466.688332791753, 12049.457774399998, 12439.253644781342, 12495.812562811383, 12790.424430900446, 12848.807267890803], "value": 7776.504225447814, "unit": "score"}], "name": "dromaeo_css", "value": 7322.282922697307, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 113.0, 121.0, 109.0, 111.0, 109.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 122.0, 123.0, 160.0, 117.0, 117.0, 139.0, 121.0, 158.0, 116.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 159.0, 159.0, 160.0, 162.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 137.0, 76.0, 75.0, 76.0, 75.0, 116.0, 75.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 130.0, 85.0, 85.0, 84.0, 129.0, 83.0, 84.0, 123.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 51.0, 52.0, 53.0, 52.0, 51.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 76.0, 75.0, 75.0, 77.0, 74.0, 81.0, 79.0, 76.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 119.0, 117.0, 128.0, 124.0, 119.0, 119.0, 125.0, 162.0, 125.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 152.0, 153.0, 153.0, 150.0, 154.0, 153.0, 156.0, 152.0, 153.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1476.7, "alertThreshold": 2.0}]} 07:57:52 INFO - Return code: 0 07:57:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:52 INFO - # TBPL SUCCESS # 07:57:52 INFO - Running post-action listener: _resource_record_post_action 07:57:52 INFO - ##### 07:57:52 INFO - ##### Finished run-tests step (success) 07:57:52 INFO - ##### 07:57:52 INFO - Running post-run listener: _resource_record_post_run 07:57:52 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7901184; Write bytes: 427728896; Read time: 2084; Write time: 385396 07:57:52 INFO - TinderboxPrint: CPU usage
13.0% 07:57:52 INFO - TinderboxPrint: I/O read bytes / time
7,901,184 / 2,084 07:57:52 INFO - TinderboxPrint: I/O write bytes / time
427,728,896 / 385,396 07:57:52 INFO - TinderboxPrint: CPU idle
8,287.0 (87.0%) 07:57:52 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 07:57:52 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 4558848; Read time: 0; Write time: 560 07:57:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6041600; Write bytes: 403607552; Read time: 1772; Write time: 371360 07:57:53 INFO - Running post-run listener: _upload_blobber_files 07:57:53 INFO - Blob upload gear active. 07:57:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:53 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 07:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:57:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:57 INFO - (blobuploader) - INFO - Done attempting. 07:57:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:57:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:57:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:58 INFO - (blobuploader) - INFO - Done attempting. 07:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:59 INFO - (blobuploader) - INFO - Done attempting. 07:57:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:59 INFO - Return code: 0 07:57:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a86c03d851814638c9a9f6b3d67c93f3fd6d6ee8e8b6a979aa02e4883e532f5f012e45d04f3720620a48a1803a6c5273cd2951f24d4aba5c6ee8faba6536a66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818278ee0c82d3f90fdb17824adcc989ea0f38311ccd7b707d0904fdc49a5128218c1472064ea67e217c48b768b0e462c08085442c9ef5b8c9b535c61cd81958", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d9e01b2b2276b97268551b6b397d4e9043b36042c918927b66031c2fadcd0be0ef7af225ae60a4d29e227d4cfb9c367bc718a50fc52207045b2b10215be10e"} 07:57:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:59 INFO - Contents: 07:57:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a86c03d851814638c9a9f6b3d67c93f3fd6d6ee8e8b6a979aa02e4883e532f5f012e45d04f3720620a48a1803a6c5273cd2951f24d4aba5c6ee8faba6536a66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818278ee0c82d3f90fdb17824adcc989ea0f38311ccd7b707d0904fdc49a5128218c1472064ea67e217c48b768b0e462c08085442c9ef5b8c9b535c61cd81958", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d9e01b2b2276b97268551b6b397d4e9043b36042c918927b66031c2fadcd0be0ef7af225ae60a4d29e227d4cfb9c367bc718a50fc52207045b2b10215be10e"} 07:57:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:59 INFO - Copying logs to upload dir... 07:57:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.254818 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-07-15 07:57:59.294042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:59.298161) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a86c03d851814638c9a9f6b3d67c93f3fd6d6ee8e8b6a979aa02e4883e532f5f012e45d04f3720620a48a1803a6c5273cd2951f24d4aba5c6ee8faba6536a66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818278ee0c82d3f90fdb17824adcc989ea0f38311ccd7b707d0904fdc49a5128218c1472064ea67e217c48b768b0e462c08085442c9ef5b8c9b535c61cd81958", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d9e01b2b2276b97268551b6b397d4e9043b36042c918927b66031c2fadcd0be0ef7af225ae60a4d29e227d4cfb9c367bc718a50fc52207045b2b10215be10e"} build_url:https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/AeKnLAWLTt2AXK4wg48S7w/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/Firefox/sha512/8a86c03d851814638c9a9f6b3d67c93f3fd6d6ee8e8b6a979aa02e4883e532f5f012e45d04f3720620a48a1803a6c5273cd2951f24d4aba5c6ee8faba6536a66", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/818278ee0c82d3f90fdb17824adcc989ea0f38311ccd7b707d0904fdc49a5128218c1472064ea67e217c48b768b0e462c08085442c9ef5b8c9b535c61cd81958", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d9e01b2b2276b97268551b6b397d4e9043b36042c918927b66031c2fadcd0be0ef7af225ae60a4d29e227d4cfb9c367bc718a50fc52207045b2b10215be10e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:59.328548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:59.328905) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1468589774.76355-899399946 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 07:57:59.384224) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:57:59.384582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 07:57:59.384928) ========= ========= Total master_lag: 0.19 =========