builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1468030264.2 results: success (0) buildid: 20160708163028 builduid: 7e684ce57b004e89b0920fe47e16f9b3 revision: 9ec9a9682d4680afa2d66281d518edb98908824f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.201101) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.201592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.201870) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.218025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.218387) ========= 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-1468028271.546470-1272017956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 19:11: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% 46.0M=0s 2016-07-08 19:11:04 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094518 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.326923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.327307) ========= 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-1468028271.546470-1272017956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.377462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:04.377820) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9ec9a9682d4680afa2d66281d518edb98908824f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9ec9a9682d4680afa2d66281d518edb98908824f --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-1468028271.546470-1272017956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 19:11:04,724 truncating revision to first 12 chars 2016-07-08 19:11:04,724 Setting DEBUG logging. 2016-07-08 19:11:04,724 attempt 1/10 2016-07-08 19:11:04,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9ec9a9682d46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 19:11:05,301 unpacking tar archive at: mozilla-inbound-9ec9a9682d46/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:05.349522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:05.349828) ========= script_repo_revision: 9ec9a9682d4680afa2d66281d518edb98908824f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:05.350217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:05.350479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 19:11:05.361287) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-08 19:11:05.361687) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:11:05 INFO - MultiFileLogger online at 20160708 19:11:05 in /builds/slave/test 19:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:05 INFO - {'append_to_log': False, 19:11:05 INFO - 'base_work_dir': '/builds/slave/test', 19:11:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:05 INFO - 'branch': 'Mozilla-Inbound', 19:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:05 INFO - 'config_files': ('talos/linux_config.py',), 19:11:05 INFO - 'default_actions': ('clobber', 19:11:05 INFO - 'read-buildbot-config', 19:11:05 INFO - 'download-and-extract', 19:11:05 INFO - 'populate-webroot', 19:11:05 INFO - 'create-virtualenv', 19:11:05 INFO - 'install', 19:11:05 INFO - 'run-tests'), 19:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:05 INFO - 'download_minidump_stackwalk': True, 19:11:05 INFO - 'download_symbols': 'ondemand', 19:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:05 INFO - 'installer_path': 'installer.exe', 19:11:05 INFO - 'log_level': 'info', 19:11:05 INFO - 'log_name': 'talos', 19:11:05 INFO - 'log_to_console': True, 19:11:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:11:05 INFO - 'opt_config_files': (), 19:11:05 INFO - 'pip_index': False, 19:11:05 INFO - 'sps_profile': False, 19:11:05 INFO - 'sps_profile_interval': 0, 19:11:05 INFO - 'suite': 'dromaeojs', 19:11:05 INFO - 'system_bits': '32', 19:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:05 INFO - 'title': 'talos-linux64-ix-041', 19:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:05 INFO - 'use_talos_json': True, 19:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:05 INFO - 'work_dir': 'build'} 19:11:05 INFO - ##### 19:11:05 INFO - ##### Running clobber step. 19:11:05 INFO - ##### 19:11:05 INFO - Running pre-action listener: _resource_record_pre_action 19:11:05 INFO - Running main action method: clobber 19:11:05 INFO - rmtree: /builds/slave/test/build 19:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:06 INFO - Running post-action listener: _resource_record_post_action 19:11:06 INFO - ##### 19:11:06 INFO - ##### Finished clobber step (success) 19:11:06 INFO - ##### 19:11:06 INFO - ##### 19:11:06 INFO - ##### Running read-buildbot-config step. 19:11:06 INFO - ##### 19:11:06 INFO - Running pre-action listener: _resource_record_pre_action 19:11:06 INFO - Running main action method: read_buildbot_config 19:11:06 INFO - Using buildbot properties: 19:11:06 INFO - { 19:11:06 INFO - "project": "", 19:11:06 INFO - "product": "firefox", 19:11:06 INFO - "script_repo_revision": "production", 19:11:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:11:06 INFO - "repository": "", 19:11:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:11:06 INFO - "buildid": "20160708163028", 19:11:06 INFO - "pgo_build": "True", 19:11:06 INFO - "basedir": "/builds/slave/test", 19:11:06 INFO - "buildnumber": 1220, 19:11:06 INFO - "slavename": "talos-linux64-ix-041", 19:11:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:11:06 INFO - "platform": "ubuntu64_hw", 19:11:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:11:06 INFO - "branch": "mozilla-inbound", 19:11:06 INFO - "repo_path": "integration/mozilla-inbound", 19:11:06 INFO - "revision": "9ec9a9682d4680afa2d66281d518edb98908824f", 19:11:06 INFO - "stage_platform": "linux64-pgo", 19:11:06 INFO - "builduid": "7e684ce57b004e89b0920fe47e16f9b3", 19:11:06 INFO - "slavebuilddir": "test" 19:11:06 INFO - } 19:11:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:11:06 INFO - Running post-action listener: _resource_record_post_action 19:11:06 INFO - ##### 19:11:06 INFO - ##### Finished read-buildbot-config step (success) 19:11:06 INFO - ##### 19:11:06 INFO - ##### 19:11:06 INFO - ##### Running download-and-extract step. 19:11:06 INFO - ##### 19:11:06 INFO - Running pre-action listener: _resource_record_pre_action 19:11:06 INFO - Running main action method: download_and_extract 19:11:06 INFO - mkdir: /builds/slave/test/build/tests 19:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:06 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:07 INFO - Downloaded 1361 bytes. 19:11:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:11:07 INFO - Using the following test package requirements: 19:11:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:11:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:11:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'jsshell-linux-x86_64.zip'], 19:11:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:11:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:11:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:11:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:11:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:11:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:11:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:11: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')]} 19:11:07 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:09 INFO - Downloaded 24307143 bytes. 19:11:09 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'] 19:11:09 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 19:11:10 INFO - Return code: 0 19:11:10 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 19:11:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:10 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:13 INFO - Downloaded 24307143 bytes. 19:11:13 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'] 19:11:13 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 19:11:15 INFO - Return code: 0 19:11: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')]} 19:11:15 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:11:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:11:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:16 INFO - Downloaded 14403333 bytes. 19:11:16 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'] 19:11:16 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 19:11:16 INFO - Return code: 0 19:11:16 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')]} 19:11:16 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:18 INFO - Downloaded 60458563 bytes. 19:11:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:18 INFO - mkdir: /builds/slave/test/properties 19:11:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:18 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:18 INFO - Contents: 19:11:18 INFO - build_url:https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:11:19 INFO - Running post-action listener: _resource_record_post_action 19:11:19 INFO - Running post-action listener: set_extra_try_arguments 19:11:19 INFO - ##### 19:11:19 INFO - ##### Finished download-and-extract step (success) 19:11:19 INFO - ##### 19:11:19 INFO - ##### 19:11:19 INFO - ##### Running populate-webroot step. 19:11:19 INFO - ##### 19:11:19 INFO - Running pre-action listener: _resource_record_pre_action 19:11:19 INFO - Running main action method: populate_webroot 19:11:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:19 INFO - '--tppagecycles', 19:11:19 INFO - '7'], 19:11:19 INFO - 'tests': ['tsvgm']}}, 19:11:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['damp', 'tps']}, 19:11:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'tests': ['damp', 'tps']}, 19:11:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['dromaeo_dom']}, 19:11:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['basic_compositor_video']}, 19:11:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:11:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['a11yr', 19:11:19 INFO - 'ts_paint', 19:11:19 INFO - 'tpaint', 19:11:19 INFO - 'sessionrestore', 19:11:19 INFO - 'sessionrestore_no_auto_restore', 19:11:19 INFO - 'tabpaint']}, 19:11:19 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:19 INFO - 'ts_paint', 19:11:19 INFO - 'tpaint', 19:11:19 INFO - 'sessionrestore', 19:11:19 INFO - 'sessionrestore_no_auto_restore', 19:11:19 INFO - 'tabpaint']}, 19:11:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:19 INFO - 'ts_paint', 19:11:19 INFO - 'tpaint', 19:11:19 INFO - 'sessionrestore', 19:11:19 INFO - 'sessionrestore_no_auto_restore', 19:11:19 INFO - 'tabpaint']}, 19:11:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:19 INFO - 'ts_paint', 19:11:19 INFO - 'tpaint', 19:11:19 INFO - 'sessionrestore', 19:11:19 INFO - 'sessionrestore_no_auto_restore', 19:11:19 INFO - 'tabpaint']}, 19:11:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['a11yr', 19:11:19 INFO - 'ts_paint', 19:11:19 INFO - 'tpaint', 19:11:19 INFO - 'sessionrestore', 19:11:19 INFO - 'sessionrestore_no_auto_restore', 19:11:19 INFO - 'tabpaint']}, 19:11:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['a11yr', 19:11:19 INFO - 'ts_paint', 19:11:19 INFO - 'tpaint', 19:11:19 INFO - 'sessionrestore', 19:11:19 INFO - 'sessionrestore_no_auto_restore', 19:11:19 INFO - 'tabpaint']}, 19:11:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['tsvgx', 19:11:19 INFO - 'tsvgr_opacity', 19:11:19 INFO - 'tart', 19:11:19 INFO - 'tscrollx', 19:11:19 INFO - 'cart']}, 19:11:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:19 INFO - 'tsvgr_opacity', 19:11:19 INFO - 'tart', 19:11:19 INFO - 'tscrollx', 19:11:19 INFO - 'cart']}, 19:11:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'talos_options': ['--disable-e10s'], 19:11:19 INFO - 'tests': ['tp5o']}, 19:11:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'tests': ['tp5o']}, 19:11:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'talos_options': ['--disable-e10s', 19:11:19 INFO - '--xperf_path', 19:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:19 INFO - 'tests': ['tp5n']}, 19:11:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:19 INFO - 'talos_options': ['--xperf_path', 19:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:19 INFO - 'tests': ['tp5n']}}, 19:11:19 INFO - 'talos.zip': {'path': '', 19:11:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:19 INFO - Running post-action listener: _resource_record_post_action 19:11:19 INFO - ##### 19:11:19 INFO - ##### Finished populate-webroot step (success) 19:11:19 INFO - ##### 19:11:19 INFO - ##### 19:11:19 INFO - ##### Running create-virtualenv step. 19:11:19 INFO - ##### 19:11:19 INFO - Running pre-action listener: _resource_record_pre_action 19:11:19 INFO - Running main action method: create_virtualenv 19:11:19 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:19 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 19:11:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:19 INFO - Using real prefix '/usr' 19:11:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:20 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:22 INFO - Installing pip.................done. 19:11:22 INFO - Return code: 0 19:11:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:22 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:22 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 19:11:22 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 19:11:22 INFO - Using env: {'DISPLAY': ':0', 19:11:22 INFO - 'HOME': '/home/cltbld', 19:11:22 INFO - 'LANG': 'en_US.UTF-8', 19:11:22 INFO - 'LANGUAGE': 'en_US:en', 19:11:22 INFO - 'LOGNAME': 'cltbld', 19:11:22 INFO - 'MAIL': '/var/mail/cltbld', 19:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:22 INFO - 'MOZ_NO_REMOTE': '1', 19:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:22 INFO - 'NO_EM_RESTART': '1', 19:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:22 INFO - 'PWD': '/builds/slave/test', 19:11:22 INFO - 'SHELL': '/bin/bash', 19:11:22 INFO - 'SHLVL': '1', 19:11:22 INFO - 'TERM': 'linux', 19:11:22 INFO - 'TMOUT': '86400', 19:11:22 INFO - 'USER': 'cltbld', 19:11:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:22 INFO - '_': '/tools/buildbot/bin/python'} 19:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:22 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 19:11:22 INFO - Cleaning up... 19:11:22 INFO - Return code: 0 19:11:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:22 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:22 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 19:11:22 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 19:11:22 INFO - Using env: {'DISPLAY': ':0', 19:11:22 INFO - 'HOME': '/home/cltbld', 19:11:22 INFO - 'LANG': 'en_US.UTF-8', 19:11:22 INFO - 'LANGUAGE': 'en_US:en', 19:11:22 INFO - 'LOGNAME': 'cltbld', 19:11:22 INFO - 'MAIL': '/var/mail/cltbld', 19:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:22 INFO - 'MOZ_NO_REMOTE': '1', 19:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:22 INFO - 'NO_EM_RESTART': '1', 19:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:22 INFO - 'PWD': '/builds/slave/test', 19:11:22 INFO - 'SHELL': '/bin/bash', 19:11:22 INFO - 'SHLVL': '1', 19:11:22 INFO - 'TERM': 'linux', 19:11:22 INFO - 'TMOUT': '86400', 19:11:22 INFO - 'USER': 'cltbld', 19:11:22 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:22 INFO - '_': '/tools/buildbot/bin/python'} 19:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:22 INFO - Downloading/unpacking psutil>=3.1.1 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 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 19:11:22 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 19:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:24 INFO - Installing collected packages: psutil 19:11:24 INFO - Running setup.py install for psutil 19:11:24 INFO - building 'psutil._psutil_linux' extension 19:11:24 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 19:11:24 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 19:11:24 INFO - building 'psutil._psutil_posix' extension 19:11:24 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 19:11:24 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 19:11:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:24 INFO - Successfully installed psutil 19:11:24 INFO - Cleaning up... 19:11:25 INFO - Return code: 0 19:11:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:25 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:25 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 19:11:25 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 19:11:25 INFO - Using env: {'DISPLAY': ':0', 19:11:25 INFO - 'HOME': '/home/cltbld', 19:11:25 INFO - 'LANG': 'en_US.UTF-8', 19:11:25 INFO - 'LANGUAGE': 'en_US:en', 19:11:25 INFO - 'LOGNAME': 'cltbld', 19:11:25 INFO - 'MAIL': '/var/mail/cltbld', 19:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:25 INFO - 'MOZ_NO_REMOTE': '1', 19:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:25 INFO - 'NO_EM_RESTART': '1', 19:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:25 INFO - 'PWD': '/builds/slave/test', 19:11:25 INFO - 'SHELL': '/bin/bash', 19:11:25 INFO - 'SHLVL': '1', 19:11:25 INFO - 'TERM': 'linux', 19:11:25 INFO - 'TMOUT': '86400', 19:11:25 INFO - 'USER': 'cltbld', 19:11:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:25 INFO - '_': '/tools/buildbot/bin/python'} 19:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:25 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 19:11:25 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 19:11:25 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 19:11:25 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 19:11:25 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 19:11:25 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 19:11:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:11:27 INFO - Installing collected packages: mozsystemmonitor 19:11:27 INFO - Running setup.py install for mozsystemmonitor 19:11:27 INFO - Successfully installed mozsystemmonitor 19:11:27 INFO - Cleaning up... 19:11:27 INFO - Return code: 0 19:11:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:27 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:27 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 19:11:27 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 19:11:27 INFO - Using env: {'DISPLAY': ':0', 19:11:27 INFO - 'HOME': '/home/cltbld', 19:11:27 INFO - 'LANG': 'en_US.UTF-8', 19:11:27 INFO - 'LANGUAGE': 'en_US:en', 19:11:27 INFO - 'LOGNAME': 'cltbld', 19:11:27 INFO - 'MAIL': '/var/mail/cltbld', 19:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:27 INFO - 'MOZ_NO_REMOTE': '1', 19:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:27 INFO - 'NO_EM_RESTART': '1', 19:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:27 INFO - 'PWD': '/builds/slave/test', 19:11:27 INFO - 'SHELL': '/bin/bash', 19:11:27 INFO - 'SHLVL': '1', 19:11:27 INFO - 'TERM': 'linux', 19:11:27 INFO - 'TMOUT': '86400', 19:11:27 INFO - 'USER': 'cltbld', 19:11:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:27 INFO - '_': '/tools/buildbot/bin/python'} 19:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:27 INFO - Downloading/unpacking jsonschema==2.5.1 19:11:27 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 19:11:27 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 19:11:27 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 19:11:27 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 19:11:27 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 19:11:27 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 19:11:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:11:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:29 INFO - Downloading functools32-3.2.3-2.tar.gz 19:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:11:29 INFO - warning: no files found matching '*.txt' 19:11:29 INFO - no previously-included directories found matching 'build' 19:11:29 INFO - no previously-included directories found matching 'dist' 19:11:29 INFO - no previously-included directories found matching '.git*' 19:11:29 INFO - Installing collected packages: jsonschema, functools32 19:11:29 INFO - Running setup.py install for functools32 19:11:29 INFO - warning: no files found matching '*.txt' 19:11:29 INFO - no previously-included directories found matching 'build' 19:11:29 INFO - no previously-included directories found matching 'dist' 19:11:29 INFO - no previously-included directories found matching '.git*' 19:11:29 INFO - Successfully installed jsonschema functools32 19:11:29 INFO - Cleaning up... 19:11:29 INFO - Return code: 0 19:11:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:29 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:29 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 19:11:29 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 19:11:29 INFO - Using env: {'DISPLAY': ':0', 19:11:29 INFO - 'HOME': '/home/cltbld', 19:11:29 INFO - 'LANG': 'en_US.UTF-8', 19:11:29 INFO - 'LANGUAGE': 'en_US:en', 19:11:29 INFO - 'LOGNAME': 'cltbld', 19:11:29 INFO - 'MAIL': '/var/mail/cltbld', 19:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:29 INFO - 'MOZ_NO_REMOTE': '1', 19:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:29 INFO - 'NO_EM_RESTART': '1', 19:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:29 INFO - 'PWD': '/builds/slave/test', 19:11:29 INFO - 'SHELL': '/bin/bash', 19:11:29 INFO - 'SHLVL': '1', 19:11:29 INFO - 'TERM': 'linux', 19:11:29 INFO - 'TMOUT': '86400', 19:11:29 INFO - 'USER': 'cltbld', 19:11:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:29 INFO - '_': '/tools/buildbot/bin/python'} 19:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:30 INFO - Downloading/unpacking blobuploader==1.2.4 19:11:30 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 19:11:30 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 19:11:30 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 19:11:30 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 19:11:30 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 19:11:30 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 19:11:31 INFO - Downloading blobuploader-1.2.4.tar.gz 19:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:11:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:11:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 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 19:11:32 INFO - Downloading docopt-0.6.1.tar.gz 19:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:11:32 INFO - Installing collected packages: blobuploader, requests, docopt 19:11:32 INFO - Running setup.py install for blobuploader 19:11:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:11:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:11:32 INFO - Running setup.py install for requests 19:11:33 INFO - Running setup.py install for docopt 19:11:33 INFO - Successfully installed blobuploader requests docopt 19:11:33 INFO - Cleaning up... 19:11:33 INFO - Return code: 0 19:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:33 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')]} 19:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:33 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')]} 19:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:33 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:33 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 19:11:33 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 19:11:33 INFO - Using env: {'DISPLAY': ':0', 19:11:33 INFO - 'HOME': '/home/cltbld', 19:11:33 INFO - 'LANG': 'en_US.UTF-8', 19:11:33 INFO - 'LANGUAGE': 'en_US:en', 19:11:33 INFO - 'LOGNAME': 'cltbld', 19:11:33 INFO - 'MAIL': '/var/mail/cltbld', 19:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:33 INFO - 'MOZ_NO_REMOTE': '1', 19:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:33 INFO - 'NO_EM_RESTART': '1', 19:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:33 INFO - 'PWD': '/builds/slave/test', 19:11:33 INFO - 'SHELL': '/bin/bash', 19:11:33 INFO - 'SHLVL': '1', 19:11:33 INFO - 'TERM': 'linux', 19:11:33 INFO - 'TMOUT': '86400', 19:11:33 INFO - 'USER': 'cltbld', 19:11:33 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:33 INFO - '_': '/tools/buildbot/bin/python'} 19:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:33 INFO - Running setup.py (path:/tmp/pip-d0fY9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:33 INFO - Running setup.py (path:/tmp/pip-4G_LT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:33 INFO - Running setup.py (path:/tmp/pip-aVZUQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:33 INFO - Running setup.py (path:/tmp/pip-ea_tRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:33 INFO - Running setup.py (path:/tmp/pip-BU14nR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:33 INFO - Running setup.py (path:/tmp/pip-hT2y84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:33 INFO - Running setup.py (path:/tmp/pip-VL3KKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:34 INFO - Running setup.py (path:/tmp/pip-u976ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:34 INFO - Running setup.py (path:/tmp/pip-RRH8S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:34 INFO - Running setup.py (path:/tmp/pip-6vO8ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:34 INFO - Running setup.py (path:/tmp/pip-U9_1eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:34 INFO - Running setup.py (path:/tmp/pip-eKqfxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:34 INFO - Running setup.py (path:/tmp/pip-zRJUU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:34 INFO - Running setup.py (path:/tmp/pip-FlN9hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:34 INFO - Running setup.py (path:/tmp/pip-I3WL4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:34 INFO - Running setup.py (path:/tmp/pip-4SZlLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:34 INFO - Running setup.py (path:/tmp/pip-VeHh3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:11:34 INFO - Running setup.py install for manifestparser 19:11:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:11:34 INFO - Running setup.py install for mozcrash 19:11:34 INFO - Running setup.py install for mozdebug 19:11:35 INFO - Running setup.py install for mozdevice 19:11:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Running setup.py install for mozfile 19:11:35 INFO - Running setup.py install for mozhttpd 19:11:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Running setup.py install for mozinfo 19:11:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Running setup.py install for mozInstall 19:11:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Running setup.py install for mozleak 19:11:35 INFO - Running setup.py install for mozlog 19:11:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Running setup.py install for moznetwork 19:11:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:11:35 INFO - Running setup.py install for mozprocess 19:11:36 INFO - Running setup.py install for mozprofile 19:11:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:11:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:11:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:11:36 INFO - Running setup.py install for mozrunner 19:11:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:11:36 INFO - Running setup.py install for mozscreenshot 19:11:36 INFO - Running setup.py install for moztest 19:11:36 INFO - Running setup.py install for mozversion 19:11:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:11:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:11:36 INFO - Cleaning up... 19:11:36 INFO - Return code: 0 19:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:36 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:36 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 19:11:36 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 19:11:36 INFO - Using env: {'DISPLAY': ':0', 19:11:36 INFO - 'HOME': '/home/cltbld', 19:11:36 INFO - 'LANG': 'en_US.UTF-8', 19:11:36 INFO - 'LANGUAGE': 'en_US:en', 19:11:36 INFO - 'LOGNAME': 'cltbld', 19:11:36 INFO - 'MAIL': '/var/mail/cltbld', 19:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:36 INFO - 'MOZ_NO_REMOTE': '1', 19:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:36 INFO - 'NO_EM_RESTART': '1', 19:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:36 INFO - 'PWD': '/builds/slave/test', 19:11:36 INFO - 'SHELL': '/bin/bash', 19:11:36 INFO - 'SHLVL': '1', 19:11:36 INFO - 'TERM': 'linux', 19:11:36 INFO - 'TMOUT': '86400', 19:11:36 INFO - 'USER': 'cltbld', 19:11:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:36 INFO - '_': '/tools/buildbot/bin/python'} 19:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:11:36 INFO - Running setup.py (path:/tmp/pip-XY5tud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:11:36 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)) 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:11:36 INFO - Running setup.py (path:/tmp/pip-MmWZyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:11:36 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)) 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:11:36 INFO - Running setup.py (path:/tmp/pip-c1AIDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:11:36 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)) 19:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:11:37 INFO - Running setup.py (path:/tmp/pip-kLHVxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:11:37 INFO - Running setup.py (path:/tmp/pip-nQC_Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:11:37 INFO - Running setup.py (path:/tmp/pip-Yp4ABw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:11:37 INFO - Running setup.py (path:/tmp/pip-EDm1ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:11:37 INFO - Running setup.py (path:/tmp/pip-jklyBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:11:37 INFO - Running setup.py (path:/tmp/pip-kc85DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:11:37 INFO - Running setup.py (path:/tmp/pip-8suAF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:11:37 INFO - Running setup.py (path:/tmp/pip-lpA6Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:11:37 INFO - Running setup.py (path:/tmp/pip-UBKm9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:11:37 INFO - Running setup.py (path:/tmp/pip-fpB6f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:11:37 INFO - Running setup.py (path:/tmp/pip-WmmLYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:37 INFO - Running setup.py (path:/tmp/pip-GfJNQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:11:37 INFO - Running setup.py (path:/tmp/pip-V9UP92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:11:37 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)) 19:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:11:37 INFO - Running setup.py (path:/tmp/pip-NdSr_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:11:38 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)) 19:11:38 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)) 19:11:38 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)) 19:11:38 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)) 19:11:38 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)) 19:11:38 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)) 19:11:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:11:38 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 19:11:38 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 19:11:38 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 19:11:38 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 19:11:38 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 19:11:38 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 19:11:39 INFO - Downloading blessings-1.6.tar.gz 19:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:11:39 INFO - Installing collected packages: blessings 19:11:39 INFO - Running setup.py install for blessings 19:11:40 INFO - Successfully installed blessings 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:40 INFO - Reading from file tmpfile_stdout 19:11:40 INFO - Current package versions: 19:11:40 INFO - argparse == 1.2.1 19:11:40 INFO - blessings == 1.6 19:11:40 INFO - blobuploader == 1.2.4 19:11:40 INFO - docopt == 0.6.1 19:11:40 INFO - functools32 == 3.2.3-2 19:11:40 INFO - jsonschema == 2.5.1 19:11:40 INFO - manifestparser == 1.1 19:11:40 INFO - mozInstall == 1.12 19:11:40 INFO - mozcrash == 0.17 19:11:40 INFO - mozdebug == 0.1 19:11:40 INFO - mozdevice == 0.48 19:11:40 INFO - mozfile == 1.2 19:11:40 INFO - mozhttpd == 0.7 19:11:40 INFO - mozinfo == 0.9 19:11:40 INFO - mozleak == 0.1 19:11:40 INFO - mozlog == 3.2 19:11:40 INFO - moznetwork == 0.27 19:11:40 INFO - mozprocess == 0.23 19:11:40 INFO - mozprofile == 0.28 19:11:40 INFO - mozrunner == 6.12 19:11:40 INFO - mozscreenshot == 0.1 19:11:40 INFO - mozsystemmonitor == 0.3 19:11:40 INFO - moztest == 0.7 19:11:40 INFO - mozversion == 1.4 19:11:40 INFO - psutil == 3.1.1 19:11:40 INFO - requests == 1.2.3 19:11:40 INFO - wsgiref == 0.1.2 19:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:40 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 19:11:40 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 19:11:40 INFO - Using env: {'DISPLAY': ':0', 19:11:40 INFO - 'HOME': '/home/cltbld', 19:11:40 INFO - 'LANG': 'en_US.UTF-8', 19:11:40 INFO - 'LANGUAGE': 'en_US:en', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MAIL': '/var/mail/cltbld', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SHLVL': '1', 19:11:40 INFO - 'TERM': 'linux', 19:11:40 INFO - 'TMOUT': '86400', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - '_': '/tools/buildbot/bin/python'} 19:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 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)) 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:40 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 0xed0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1191180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, '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-1468028271.546470-1272017956', '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 19:11:40 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 19:11:40 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 19:11:40 INFO - Using env: {'DISPLAY': ':0', 19:11:40 INFO - 'HOME': '/home/cltbld', 19:11:40 INFO - 'LANG': 'en_US.UTF-8', 19:11:40 INFO - 'LANGUAGE': 'en_US:en', 19:11:40 INFO - 'LOGNAME': 'cltbld', 19:11:40 INFO - 'MAIL': '/var/mail/cltbld', 19:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:40 INFO - 'MOZ_NO_REMOTE': '1', 19:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:40 INFO - 'NO_EM_RESTART': '1', 19:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:40 INFO - 'PWD': '/builds/slave/test', 19:11:40 INFO - 'SHELL': '/bin/bash', 19:11:40 INFO - 'SHLVL': '1', 19:11:40 INFO - 'TERM': 'linux', 19:11:40 INFO - 'TMOUT': '86400', 19:11:40 INFO - 'USER': 'cltbld', 19:11:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:40 INFO - '_': '/tools/buildbot/bin/python'} 19:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:11:40 INFO - Cleaning up... 19:11:40 INFO - Return code: 0 19:11:40 INFO - Running post-action listener: _resource_record_post_action 19:11:40 INFO - Running post-action listener: _start_resource_monitoring 19:11:40 INFO - Starting resource monitoring. 19:11:40 INFO - ##### 19:11:40 INFO - ##### Finished create-virtualenv step (success) 19:11:40 INFO - ##### 19:11:40 INFO - ##### 19:11:40 INFO - ##### Running install step. 19:11:40 INFO - ##### 19:11:40 INFO - Running pre-action listener: _resource_record_pre_action 19:11:40 INFO - Running main action method: install 19:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:11:41 INFO - Reading from file tmpfile_stdout 19:11:41 INFO - Detecting whether we're running mozinstall >=1.0... 19:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:11:41 INFO - Reading from file tmpfile_stdout 19:11:41 INFO - Output received: 19:11:41 INFO - Usage: mozinstall [options] installer 19:11:41 INFO - Options: 19:11:41 INFO - -h, --help show this help message and exit 19:11:41 INFO - -d DEST, --destination=DEST 19:11:41 INFO - Directory to install application into. [default: 19:11:41 INFO - "/builds/slave/test"] 19:11:41 INFO - --app=APP Application being installed. [default: firefox] 19:11:41 INFO - mkdir: /builds/slave/test/build/application 19:11:41 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'] 19:11:41 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 19:11:58 INFO - Reading from file tmpfile_stdout 19:11:58 INFO - Output received: 19:11:58 INFO - /builds/slave/test/build/application/firefox/firefox 19:11:58 INFO - Running post-action listener: _resource_record_post_action 19:11:58 INFO - ##### 19:11:58 INFO - ##### Finished install step (success) 19:11:58 INFO - ##### 19:11:58 INFO - ##### 19:11:58 INFO - ##### Running run-tests step. 19:11:58 INFO - ##### 19:11:58 INFO - Running pre-action listener: _resource_record_pre_action 19:11:58 INFO - Running main action method: run_tests 19:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:11:58 INFO - Python 2.7.3 19:11:58 INFO - Return code: 0 19:11:58 INFO - grabbing minidump binary from tooltool 19:11:58 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')]} 19:11:58 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 0x118f3b0>, '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 0x11902b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1190740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:11:58 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 19:11:58 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 19:11:58 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 19:11:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:11:58 INFO - Return code: 0 19:11:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:11:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:11:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:11:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:11:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:58 INFO - Using env: {'DISPLAY': ':0', 19:11:58 INFO - 'HOME': '/home/cltbld', 19:11:58 INFO - 'LANG': 'en_US.UTF-8', 19:11:58 INFO - 'LANGUAGE': 'en_US:en', 19:11:58 INFO - 'LOGNAME': 'cltbld', 19:11:58 INFO - 'MAIL': '/var/mail/cltbld', 19:11:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:11:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:58 INFO - 'MOZ_NO_REMOTE': '1', 19:11:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:11:58 INFO - 'NO_EM_RESTART': '1', 19:11:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:58 INFO - 'PWD': '/builds/slave/test', 19:11:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:11:58 INFO - 'SHELL': '/bin/bash', 19:11:58 INFO - 'SHLVL': '1', 19:11:58 INFO - 'TERM': 'linux', 19:11:58 INFO - 'TMOUT': '86400', 19:11:58 INFO - 'USER': 'cltbld', 19:11:58 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1468028271.546470-1272017956', 19:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:58 INFO - '_': '/tools/buildbot/bin/python'} 19:11:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/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 19:11:58 INFO - mozversion application_buildid: 20160708163028 19:11:58 INFO - mozversion application_changeset: 9ec9a9682d4680afa2d66281d518edb98908824f 19:11:58 INFO - mozversion application_display_name: Nightly 19:11:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:11:58 INFO - mozversion application_name: Firefox 19:11:58 INFO - mozversion application_remotingname: firefox 19:11:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:58 INFO - mozversion application_vendor: Mozilla 19:11:58 INFO - mozversion application_version: 50.0a1 19:11:58 INFO - mozversion platform_buildid: 20160708163028 19:11:58 INFO - mozversion platform_changeset: 9ec9a9682d4680afa2d66281d518edb98908824f 19:11:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:11:58 INFO - mozversion platform_version: 50.0a1 19:11:58 INFO - using testdate: 1468030318 19:11:58 INFO - actual date: 1468030318 19:11:58 INFO - starting webserver on 'localhost:58424' 19:11:58 INFO - SUITE-START | Running 2 tests 19:11:58 INFO - TEST-START | dromaeo_css 19:11:58 INFO - operating with platform_type : linux_ 19:11:58 INFO - Initialising browser for dromaeo_css test... 19:11:58 INFO - TEST-INFO | started process 11474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6Zbp2/profile http://localhost:58424/getInfo.html) 19:12:02 INFO - PROCESS | 11474 | __metrics Screen width/height:1600/1200 19:12:02 INFO - PROCESS | 11474 | colorDepth:24 19:12:02 INFO - PROCESS | 11474 | Browser inner width/height: 1024/697 19:12:02 INFO - PROCESS | 11474 | __metrics 19:12:03 INFO - PROCESS | 11474 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:04 INFO - TEST-INFO | 11474: exit 0 19:12:04 INFO - Browser initialized. 19:12:04 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:04 INFO - TEST-INFO | started process 11560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6Zbp2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:16 INFO - PROCESS | 11560 | RSS: Main: 157392896 19:12:16 INFO - PROCESS | 11560 | 19:13:07 INFO - PROCESS | 11560 | 1468030387521 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] 19:15:15 INFO - PROCESS | 11560 | Cycle 1(1): loaded http://localhost:58424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58424/tests/dromaeo/cssquery-ext.html) 19:15:16 INFO - PROCESS | 11560 | RSS: Main: 288448512 19:15:16 INFO - PROCESS | 11560 | 19:18:19 INFO - PROCESS | 11560 | Cycle 1(1): loaded http://localhost:58424/tests/dromaeo/cssquery-ext.html (next: http://localhost:58424/tests/dromaeo/cssquery-jquery.html) 19:18:19 INFO - PROCESS | 11560 | RSS: Main: 240320512 19:18:19 INFO - PROCESS | 11560 | 19:21:21 INFO - PROCESS | 11560 | Cycle 1(1): loaded http://localhost:58424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58424/tests/dromaeo/cssquery-mootools.html) 19:21:22 INFO - PROCESS | 11560 | RSS: Main: 242970624 19:21:22 INFO - PROCESS | 11560 | 19:24:24 INFO - PROCESS | 11560 | Cycle 1(1): loaded http://localhost:58424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58424/tests/dromaeo/cssquery-prototype.html) 19:24:24 INFO - PROCESS | 11560 | RSS: Main: 247640064 19:24:24 INFO - PROCESS | 11560 | 19:27:27 INFO - PROCESS | 11560 | Cycle 1(1): loaded http://localhost:58424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58424/tests/dromaeo/cssquery-yui.html) 19:27:28 INFO - PROCESS | 11560 | RSS: Main: 223633408 19:27:28 INFO - PROCESS | 11560 | 19:30:30 INFO - PROCESS | 11560 | Cycle 1(1): loaded http://localhost:58424/tests/dromaeo/cssquery-yui.html (next: http://localhost:58424/tests/dromaeo/cssquery-dojo.html) 19:30:31 INFO - PROCESS | 11560 | RSS: Main: 279011328 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | __start_tp_report 19:30:31 INFO - PROCESS | 11560 | _x_x_mozilla_page_load 19:30:31 INFO - PROCESS | 11560 | _x_x_mozilla_page_load_details 19:30:31 INFO - PROCESS | 11560 | |i|pagename|runs| 19:30:31 INFO - PROCESS | 11560 | |0;dojo.html;3048.4969979953307;3066.5400189971515;3096.7212950834432;3098.9773374786314;3113.143885431506;5176.0683077046215;5253.448387919266;5273.129933560957;5367.409584945653;5375.731213439327;5335.33308336458;5336.226247194155;5347.224652425396;5355.08963476209;5358.705271210082;4786.066716990197;4855.854324370274;4863.756812159396;4878.390201224847;4924.335214745999;4847.224444088946;4849.127157111719;4880.438749543795;4894.730789806559;4923.113839508887;4783.904321913559;4797.856064318076;4836.032793441291;4858.927116093261;4868.683535570177;4784.5933095686905;4789.042191561702;4789.784459699322;4796.736179510125;4867.488913664085;4784.425868895755;4793.544613261734;4820.469748327681;4826.710397376169;4847.733374664392;5215.504527069922;5271.789128434896;5336.786528538853;5340.465953404629;5389.541888939445;5703.914441283384;5726.856828579277;5740.799072032459;5767.6539407635255;5769;5795.507381872546;5799.014167591477;5804.738786754606;5806.854828629276;5813.215215945836;5186.740662966874;5280.2343660169445;5327.573794096502;5337.653052551572;5387;5899.292084949748;5907.05487122067;5907.438793314628;5920.993431116721;5928.79249226275;5456.072467680504;5665.631733937281;5665.943340566624;5668.036433806263;5669.092945128842;5520.723963801794;5530.806421775219;5535.280413546213;5608.831735047955;5610.887782244332;5561.972190139104;5567.2762540870235;5570.61005729595;5577.2191893135;5613.859653508695;5532.972335138379;5567.3040869891265;5570.3315602127195;5570.637908535932;5576.358718747315;4257.595528424795;4269.893252668709;4341.305391137466;4374;4389.6927215095275;3910.8435662573747;3915.6280153385383;3917.6474117329576;3954.5056867891512;3962.6037396260144;5452.809151679672;5463.071277882769;5464.480874316933;5468.125099984063;5472.069748142825;5679.233303503974;5731.426857314235;5794.333651630117;5797.36229014808;5823.097419899922;5462.071447853875;5492.5331346835965;5492.752826122834;5492.835214943558;5493.917591236134;4864.732439715779;5004.699718016931;5008.073506401327;5016.247562865599;5060.962502686941;5820.068788993741;5848.181254624356;5859.619124756877;5863.648181109147;5873.119032145212;5690.459406356389;5733.827985160452;5744.253247077853;5746.482816546531;5760.8271751847515;5744.281964754406;5884.499817515559;5903.085021821625;5914.172015917861;5924.318703348998;5673.319201695823;5675.77296908119;5701.572382071278;5708.857278568069;5757.136429535603;5684.090545512863;5716.485516303553;5720.74256658443;5742.856428589319;5794.333651629948;5468.972655136698;5512.283403157564;5538.556915446835;5672.978863804555;5676.886462270649;5519.944800551943;5522.475364840334;5530.778768849201;5535.0313695104005;5581.051221292309;5506.531944784738;5527.613067085265;5541.944580554143;5542.861428464321;5548.889022219614;5499.285092937893;5589.55283577321;5619.80330688424;5657.886842263214;5667.716614169192;5319.547838433777;5365.114756065205;5366.517013468807;5409.377921538916;5451.182322651634 19:30:31 INFO - PROCESS | 11560 | |1;ext.html;583.4777873802947;623.9781607643733;624.503519701837;627.5105417774138;642.2838535033437;30060.24849378764;30981;32875.34249315012;32915.50626740601;32960.34079318415;43536.56463435372;44293.77853110738;44427.11145777091;47837;47873;9044.547772611377;9186.54067296636;9187.678431254908;9188.1730644242;9189.081091890825;9051.637934482613;9137.862932056025;9138.543072846363;9143.405678630868;9146.451212927212;9031;9077.909220907806;9088.272938164964;9089.500077495735;9093.136152065543;9086.818263634723;9137.040610735843;9146.131117543822;9150.267978561766;9155.084491550859;9083.636654533877;9128.817423651557;9143.817123657489;9152.679656212;9153.450792952377;42609.36085958682;42859.35710964307;42894.571054289685;42950.14099718019;42986.78506607478;3481.094915322009;3559.323728491578;3677.7425580209397;3985.0236692010353;4147.8963025924295;30529.71027172971;31167.844160779277;31456.213594660316;31503;31869;4239.703220774547;4280.33654783506;4375.168717943612;4381.6494680425485;4493.977530112328;342582;345744;345830;346438;348161;58262.417375826546;58329;58411;58561.70719146377;58613.706931465924;61189.082163767576;61687.691561541906;61785.38214617886;61798;61874.381256187764;16947.067911264752;17108.914455427643;17183.914080429517;17191.656166876593;17206.31174753021;13446.596602101952;13457;13514.121582097132;13543.119697219649;13547.729045419037;15808.130552819704;16764.916175419046;16786.83213167877;16824.15879206035;16974.830251697324;5886.352501224862;5935.465808077293;5954.55340849438;6005.159277701038;6175.413335733098;816.7876352148484;945.7959370597764;997.5162046407487;1129.7062763681502;1182.8876256755595;32828.3434331312;33197.50203746946;33230.335393292;33391.4991275131;33591.66408335885;963.4604621412032;1118.6252605377126;1119.8096323625002;1191.2495128069434;1206.4631239098517;17208.741868871977;17331.133443328035;17331.913340433468;17462.47612571625;17626.471205863843;552137;556934;557670;557881;558290;58170.709146454;58403.70798145982;58409.41590584125;58482.415175848546;58547.70726146342;1256.1458208418362;1340.4169186403944;1359.2252416122913;1362.788767740982;1382.9170249785045;33916.83041584776;34184.82907585446;34432;34673;34708.65291347054;51319.74340128276;51439;51847;51881.22178167406;51936.74031629818;410366;410915;411608;413707;458567;27083;41223.793881031605;42091.57908420999;42220;45071.549284506735;45757.31364029609;48762;49122.263166051824;50006.49993500018;50671.49328506815;40639.39040914448;41989.79005104955;42312;44874.775626122966;45598.54401455943;41018.38472422856;41894.790526047174;42044;42641;43035.78482107569;41679;42145.36781948335;42410.57589424066;42598.148037039704;43324;37367;37630.62369376271;38073.619263807006;38145.23358900311;38572.614273858024;28926.855365723037;29001.274968125967;29080.7091929078;29268.7073129266;29288.853555732087 19:30:31 INFO - PROCESS | 11560 | |2;jquery.html;387.3086540525162;387.387927075221;392.4760444806184;401.7489069331668;411.47742367193666;17942.19260133294;19683.409497715093;19756.506087347825;20639.793602063975;20646.348292136612;12185.878141218585;12268.447919843606;12411.38651975242;12429.564965226218;19517.609647807036;5089;5233.058049551079;5274.182501712241;5281.788728450857;5282.709450980195;3835.386338185891;5461.907618476321;6782.084418603499;6813;6914.308569143096;6352.23773147223;6823.078884350623;6830.112085428887;6856.382925536701;6870.519063665545;6031.155638210654;6098.81703548892;6116.3272040076;6127.448529632332;6185.195924529828;3805.82873770681;5265.183896496011;5547.916781248285;5561.610687251894;5621.7751289948355;13425.39585718645;13459.528916487876;15172.696546069017;23495.647565286534;24230.636540451906;2409.6265078912797;2440.9755902440925;2479.194261864901;2534.746525347469;2963.970360296391;9656.517174141265;9803.558839852223;10122.89877101227;10170.644027459077;10357.06786389221;1869.9252029918787;1885.0857334192906;1943.5918457124021;1956.168628332967;1962.1660794162567;66457;81831;82905.58547207285;83107.75338369989;84213;10952.780944381067;11179.596386776882;11235.66293011211;11247.437628118561;11408.201425900108;15438.5368438947;15482;15582.9220853895;15591.688166236612;15620.76568851468;8044.879326810103;8104.189581041848;8172.591370431454;8271.627776750061;8312.085670576233;7376.299251571092;7404.925950740531;7527.8494430111095;7664.923350766421;7831.451798374173;4562.813668446228;4801.639877009238;4845;4875.463698993108;4949.752512374439;1873.484791682271;1895.8672892897364;1940.146335612326;1954.0947576113176;1987.2512189273637;913.8857642794651;927.4481683398367;954.5418199264392;1004.909558139771;1090.1387903556101;20451.488712782;20715.4821129473;20776;20851.374458766262;21037.15851365959;1014.1683819268277;1039.5218199628105;1048.1509976918721;1063.239783554762;1097;11082.778344433065;11673.194352514862;11687;11818.468168932246;11854.110941679408;485846;490624;495056;495792;497450;98439.50780246053;99873.00126998637;100683.49658251808;102500;103495;987.2990176974286;997.8247420622967;1006.3911333643186;1013.6249587652616;1015.1979935850743;18318.72521912199;18351.908240458713;18766.53083672919;18811.886107205864;18819.341323053628;43950.12099757923;44853.32720009137;44873.775631121636;45171;45790.542094578625;59935.700321498116;61356.386436135064;62021.68989155025;62851.37148628455;63289.68355158379;6667.333266673488;8360.498370097814;8626.870596941177;8878.600462979051;9053;13266.933665331997;14102.36539355711;14197.858021419654;14695.92652036733;14744.115353078849;12415.689607759878;12529;12778.233306001297;12901.354932253538;12949.287789171685;12255.877441225473;12705.936127506817;12715.745685086431;12859.357032148542;12979.221246725227;12590.559330423392;12785.296808675612;12798.424070916644;12916.612501624966;12955.481780728665;8386.538740369338;8637.093105223861;8728;8783.121687831166;8884.73345799627;8526.872096918676;11710.414479275832;12300;12604.621861344174;12847.871521284667 19:30:31 INFO - PROCESS | 11560 | |3;mootools.html;1320.7688654485462;1411.146256514808;1477.7118461899931;1521.8173819141698;1702.3956495444118;8258.545779982107;8515.701950431736;8517.27603153732;8790.64837406503;8796.032436431988;8344.332453403727;8497.702580409687;8530.829383412343;8546.572671366423;8555.058943516224;2276.601594720921;2292.5644127615783;2295.6097463431174;2298.9655155172686;2299.2297580310533;2292.5071109711407;2313.8611683299055;2335.3927978725483;2337.8714170720605;2339.6607491913746;2153.2988938738376;2170.2295685031822;2188.113813905371;2343.753905839888;2347.272345572869;2239.529698763262;2282.4408020035116;2296.058615967462;2299.402155439581;2301.5742087713825;2182.388931099295;2199.0763879170786;2199.0983696684284;2202.6916231727573;2207.23850271656;8632.65469381224;8671.21959023691;8680.435771674822;8726.781830454225;8868.157525035176;4958.727270000149;5097.108006098918;5113.156329205676;5118.385793704742;5121.948780512184;3302.7192688621494;3303.0751389610946;3347.581552305962;3365.899023029313;3373.696367326928;1046.6284469013467;1056.7675111475462;1061.7186445591924;1069.8395240713878;1078.6710053433699;11951.701207469796;12004.399780010965;12066.396680165957;12091.153619246656;12097.455614497281;4183.267928112568;4220.725652832556;4348.217320882271;4375.47494300686;4465.084657645175;9173.72478825623;9196.35625506208;9207.309451791143;9211;9234.445933244027;5040.243963405445;5068.4424713281505;5081.517255860687;5084.466131056186;5103.923441148386;4204.768737719393;4527.320901864747;4720.362751028636;4740.691855029481;4792.568668819823;3680.742348035665;3690.5202323698286;3768.8869333920024;3775.244951009754;3813.656770890633;1108.2519299472824;1129.0016670493344;1135.2620796482352;1140.8003599370077;1150.2121047082776;748.4274529984566;977.0620204603518;1025.4565080507343;1027.2244455436248;1037.865077539915;5972.671503067373;6090.604110732788;6221.3156552779155;6308.589941653778;6346.524010699216;959.1846930109491;981.259149342242;993.5926270229171;996.5314372516666;1015.6140666546665;3950.4074388841327;4129.772862492592;4168.979155104205;4240.597143271384;4336.704104880314;10306.845397319046;10797.352158870493;10804.729881752863;10870.021698047214;10872.945635271773;10636.30863993838;10730.463476826128;10734.248602597743;10763;10765.30025548337;8130.674773009132;8259.793505162419;8275.213854683796;8279.834403312021;8281.17188281167;5911.733971971185;6032.095185722177;6037.63774173551;6212.689365531795;6217.067439884054;10056.34633748804;10137.341072830242;10157;10173.949130254598;10228.590856365661;10249.33379330341;10358.896411035794;10377.117944974761;10478.580856765644;10492.213084018576;6107.69461526913;6197.225346831646;7162.46281528877;7267.854642907218;7343.192248852729;8585.65657373698;8597.82804343897;8651.6971905983;8657.22085012352;8680.348973826862;7598.886016709644;7770.883436748566;7798.649060792164;7900.68397264103;7925.405594580545;7471.327580517779;7637.427192960439;7663.501872378278;7773.455858090106;7783;6787.185537735503;6835.384815366641;6842.452603791784;6844.315568443116;6855.931440685529;5131.615128865425;5186.792528298825;5249.47505249472;5266.815661451831;5334.67991920486;5155.9742201288755;5213.817516386908;5215.0612889678705;5365.678059316298;5390.51485366319 19:30:31 INFO - PROCESS | 11560 | |4;prototype.html;287.44809964867454;294.9587057811906;300.90972708187553;305.1714594874913;306.0542922369877;5347.197920311955;5367.463253674636;5387.730613469321;5387.946120538793;5393.217983392406;5249.947500525003;5282.973585132078;5319.601029922752;5329.333833270841;5347.518723314901;3936.1537269487053;3976.5426975897853;4128.277551428503;4137.1725654869;4146.025683964266;4067.4712287402594;4125.216208920296;4126.587341265879;4127.172886572707;4138.234426631067;3957.5053118360206;4028.5769994150633;4096.180763847243;4103;4141.316682747343;4026.617471340218;4055.7566546007038;4063.674906007512;4068.6338229559187;4096.160287141129;3558.768680035815;3576.3191300088915;3584.4085725855202;3593.4789455528803;3600.6219346968455;5081.949180508184;5091.287219789232;5092.3125378073855;5099.617528685363;5126.974365128151;4481.750730720234;4619.237825758746;4621.075784843045;4622.953770462286;4627.23650597651;5447.536959358459;5449.3460784706085;5457.727113644341;5469.288992430958;5483.533899618537;3894.201688653819;3909.4135879618284;3909.960900390988;3915.5105611798526;3924.1759230561615;5472.781088756445;5664.830055098354;5691.943080569183;5696.572757043238;5730.280915725308;3941.034446560611;3952.565217826037;3953.892909985209;3956.188981258835;3959.1685745993086;3998.1603863189057;4004.1591265833918;4013.9598604013586;4052.230076285496;4072.4095006223934;4466.888327791831;4562.475315338712;4572.474165470947;4682;4688.976555117202;5486.039943009957;5507.972460137674;5515.696636685021;5523.475269849358;5523.861903452445;1355.7966305054322;1369.1716511510392;1383.280694039094;1384.8545902680276;1385.8059871617982;881.405051590174;888.813349196676;921.138735282513;930.3441074042784;939.6758118449125;5194.532492075731;5219.660722053054;5296.682199068068;5309.681419114788;5326.414094449608;5538.390777014525;5553.278073850373;5557.138643510262;5629.352624448159;5631.915521267184;5088.508731936476;5290.814821481306;5299.065840968096;5313.388960269618;5314.309139811877;2945.867435965387;2967.3768508613434;2971.2469642910355;2982.8806847725846;2997.4904266274784;5537.7784888604;5798.304203495608;5801.506871915934;5810.796622118206;5822.48615360001;5685.5167310778215;5687.3459552152035;5712.228849105318;5715.599908006399;5747.770089196469;5761.88476230473;5787.56593255516;5788.565857560699;5802.65184088956;5804.477597016289;5428.809991650273;5564.582656300713;5579.7489112990825;5730.799422020209;5735.971320143372;5622.493975542221;5630.324361076697;5637.379888212376;5669.744861481326;5676.5742569308295;5740.454656807597;5940.762369505344;5943.1679564861815;5955.6724380157775;6020.337762845996;4014.53832809219;4023.195360927885;4030.3148464760475;4039.212353591139;4047.9392809108476;5709.885802284014;5732.512736417451;5749.310082790092;5756.366799652119;5763.801090394871;5463.180522921593;5581.162825576196;5589.189567512769;5633;5634;5544.584156188222;5551.666899986014;5556.527695145958;5569.10894256917;5589.608727389043;5359.785608575613;5431.185322201702;5471.699056551928;5475.288212532345;5550.500454959073;5546.833594992157;5556.138798486241;5567.972160139336;5568.610197286151;5620.494155525858;5446.891062178814;5478.123500239943;5485.61600687964;5530.944690553043;5541.473560011793 19:30:31 INFO - PROCESS | 11560 | |5;yui.html;713.7359177104471;718.8670096032238;757.5114051436823;785.4344871692383;792.4294507954272;13612.727745445085;13625.659358516043;13815.1020183688;13854.445822167114;14676.853231467681;14386.352614132364;14438.422463101464;14598.124112553227;14612.853871461282;14626.853731462683;666.8799616069106;774.0401901641951;789.8143936174994;808.1514409869643;818.950862948225;795.9482633628825;808.7452452477451;809.6194788449449;809.9352051835868;810.1210186947169;849.413904405958;853.7780177153953;854.2354592639584;855.4311382930343;857.6483641706901;692.3042342445809;828.9626966786509;847.5338563789891;849.0957130655831;852.4331319672441;615.2616859768295;619.755196697302;620.6090163197202;621.4469122480996;621.7202258983431;14136;14137.646558836008;14171.87421886715;14174.291285435687;14197.219152946584;12611.747765044647;12703.463224985344;13016.153949993315;13097.083204175711;13185;11599.94200029003;11815.232009919328;11907.821382679267;12012.939935300268;12092.032637388987;3961.3265744823448;3980.641742243212;4007.5591684914634;4090.202410529948;4131.07050913545;70455;71449.28550714478;74540;75751.62124189344;76130;10120.696379108638;10313.690589282334;10348.22388320879;10457.581696732197;10577.999999999845;18830.811691882907;18878.150483228288;18879.905600472186;18882.716759248622;18887.716684249746;7934;8045.15525869787;8123.918760812317;8151.95924020388;8420.53687047206;4699;4708.552687494683;4783.210770222944;4805.087033463631;4843.878903027453;3118.766092543068;3223.564818749439;3230.176305042199;3230.1924518870283;3233.4988076848126;574.5030548575452;585.4496773033335;585.8388943040698;597.05068940385;603.2820943077724;624.865653884417;652.8792173447928;696.7665831946254;716.4912911832657;736.0641512821246;9405.858912116324;9449.763755906157;9479.668211612561;9503.524823758784;9677.854832177523;576.9192511986015;595.5146555557207;621.2327775197627;673.865226954611;766.1342682768548;4327.913441731211;4620.745858977789;4641.164590373765;4654.464736555272;4705.223638099676;104958;112148;115938.42030789792;116397;118069;63740.36259637437;64377.356226438074;78402.6079869597;82512.58743706244;100338.498307508;87580;92265.53867230755;92617;93095.53452232695;93740.99999999863;8564.657413703382;8572.571371431279;8580;8586.141385861363;8618.155913898087;51422;51867.740661296455;52044.479555203965;53725.731371342896;53800;70222.64888675524;74077;80322;82360;83701;12998.545050923172;13141.868581314448;13237.404316805574;13394.397252123872;13759.312034398441;13694.315284235947;13993.930030349784;14022.158670479805;14291.213983231022;14614.415423382945;13724.689501309738;13921.512747053805;13925.930370348084;14260.144391336553;14390.640233994234;13055.738885222432;13257;13331.733365332833;13354.465821367037;13530.18818870871;13406.257186565685;13718;13935.30323483842;14009.159450433006;14298.64253393632;10543.630972915911;10611.41637209961;10766.515506802369;11006.669799906016;11014.779704406028;10512.894871051498;10631.285641522658;10730.624428144978;10891.945540272249;10941.781164376827 19:30:31 INFO - PROCESS | 11560 | __end_tp_report 19:30:31 INFO - PROCESS | 11560 | __start_cc_report 19:30:31 INFO - PROCESS | 11560 | _x_x_mozilla_cycle_collect,1141 19:30:31 INFO - PROCESS | 11560 | __end_cc_report 19:30:31 INFO - PROCESS | 11560 | __startTimestamp1468031431098__endTimestamp 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | ------- Summary: start ------- 19:30:31 INFO - PROCESS | 11560 | Number of tests: 6 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | [#0] dojo.html Cycles:165 Average:5297.23 Median:5499.29 stddev:600.83 (10.9%) stddev-sans-first:576.19 19:30:31 INFO - PROCESS | 11560 | Values: 3048.5 3066.5 3096.7 3099.0 3113.1 5176.1 5253.4 5273.1 5367.4 5375.7 5335.3 5336.2 5347.2 5355.1 5358.7 4786.1 4855.9 4863.8 4878.4 4924.3 4847.2 4849.1 4880.4 4894.7 4923.1 4783.9 4797.9 4836.0 4858.9 4868.7 4784.6 4789.0 4789.8 4796.7 4867.5 4784.4 4793.5 4820.5 4826.7 4847.7 5215.5 5271.8 5336.8 5340.5 5389.5 5703.9 5726.9 5740.8 5767.7 5769.0 5795.5 5799.0 5804.7 5806.9 5813.2 5186.7 5280.2 5327.6 5337.7 5387.0 5899.3 5907.1 5907.4 5921.0 5928.8 5456.1 5665.6 5665.9 5668.0 5669.1 5520.7 5530.8 5535.3 5608.8 5610.9 5562.0 5567.3 5570.6 5577.2 5613.9 5533.0 5567.3 5570.3 5570.6 5576.4 4257.6 4269.9 4341.3 4374.0 4389.7 3910.8 3915.6 3917.6 3954.5 3962.6 5452.8 5463.1 5464.5 5468.1 5472.1 5679.2 5731.4 5794.3 5797.4 5823.1 5462.1 5492.5 5492.8 5492.8 5493.9 4864.7 5004.7 5008.1 5016.2 5061.0 5820.1 5848.2 5859.6 5863.6 5873.1 5690.5 5733.8 5744.3 5746.5 5760.8 5744.3 5884.5 5903.1 5914.2 5924.3 5673.3 5675.8 5701.6 5708.9 5757.1 5684.1 5716.5 5720.7 5742.9 5794.3 5469.0 5512.3 5538.6 5673.0 5676.9 5519.9 5522.5 5530.8 5535.0 5581.1 5506.5 5527.6 5541.9 5542.9 5548.9 5499.3 5589.6 5619.8 5657.9 5667.7 5319.5 5365.1 5366.5 5409.4 5451.2 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | [#1] ext.html Cycles:180 Average:60680.79 Median:42625.18 stddev:119259.07 (279.8%) stddev-sans-first:119508.26 19:30:31 INFO - PROCESS | 11560 | Values: 583.5 624.0 624.5 627.5 642.3 30060.2 30981.0 32875.3 32915.5 32960.3 43536.6 44293.8 44427.1 47837.0 47873.0 9044.5 9186.5 9187.7 9188.2 9189.1 9051.6 9137.9 9138.5 9143.4 9146.5 9031.0 9077.9 9088.3 9089.5 9093.1 9086.8 9137.0 9146.1 9150.3 9155.1 9083.6 9128.8 9143.8 9152.7 9153.5 42609.4 42859.4 42894.6 42950.1 42986.8 3481.1 3559.3 3677.7 3985.0 4147.9 30529.7 31167.8 31456.2 31503.0 31869.0 4239.7 4280.3 4375.2 4381.6 4494.0 342582.0 345744.0 345830.0 346438.0 348161.0 58262.4 58329.0 58411.0 58561.7 58613.7 61189.1 61687.7 61785.4 61798.0 61874.4 16947.1 17108.9 17183.9 17191.7 17206.3 13446.6 13457.0 13514.1 13543.1 13547.7 15808.1 16764.9 16786.8 16824.2 16974.8 5886.4 5935.5 5954.6 6005.2 6175.4 816.8 945.8 997.5 1129.7 1182.9 32828.3 33197.5 33230.3 33391.5 33591.7 963.5 1118.6 1119.8 1191.2 1206.5 17208.7 17331.1 17331.9 17462.5 17626.5 552137.0 556934.0 557670.0 557881.0 558290.0 58170.7 58403.7 58409.4 58482.4 58547.7 1256.1 1340.4 1359.2 1362.8 1382.9 33916.8 34184.8 34432.0 34673.0 34708.7 51319.7 51439.0 51847.0 51881.2 51936.7 410366.0 410915.0 411608.0 413707.0 458567.0 27083.0 41223.8 42091.6 42220.0 45071.5 45757.3 48762.0 49122.3 50006.5 50671.5 40639.4 41989.8 42312.0 44874.8 45598.5 41018.4 41894.8 42044.0 42641.0 43035.8 41679.0 42145.4 42410.6 42598.1 43324.0 37367.0 37630.6 38073.6 38145.2 38572.6 28926.9 29001.3 29080.7 29268.7 29288.9 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | [#2] jquery.html Cycles:180 Average:29453.85 Median:13335.81 stddev:81512.74 (611.2%) stddev-sans-first:81712.19 19:30:31 INFO - PROCESS | 11560 | Values: 387.3 387.4 392.5 401.7 411.5 17942.2 19683.4 19756.5 20639.8 20646.3 12185.9 12268.4 12411.4 12429.6 19517.6 5089.0 5233.1 5274.2 5281.8 5282.7 3835.4 5461.9 6782.1 6813.0 6914.3 6352.2 6823.1 6830.1 6856.4 6870.5 6031.2 6098.8 6116.3 6127.4 6185.2 3805.8 5265.2 5547.9 5561.6 5621.8 13425.4 13459.5 15172.7 23495.6 24230.6 2409.6 2441.0 2479.2 2534.7 2964.0 9656.5 9803.6 10122.9 10170.6 10357.1 1869.9 1885.1 1943.6 1956.2 1962.2 66457.0 81831.0 82905.6 83107.8 84213.0 10952.8 11179.6 11235.7 11247.4 11408.2 15438.5 15482.0 15582.9 15591.7 15620.8 8044.9 8104.2 8172.6 8271.6 8312.1 7376.3 7404.9 7527.8 7664.9 7831.5 4562.8 4801.6 4845.0 4875.5 4949.8 1873.5 1895.9 1940.1 1954.1 1987.3 913.9 927.4 954.5 1004.9 1090.1 20451.5 20715.5 20776.0 20851.4 21037.2 1014.2 1039.5 1048.2 1063.2 1097.0 11082.8 11673.2 11687.0 11818.5 11854.1 485846.0 490624.0 495056.0 495792.0 497450.0 98439.5 99873.0 100683.5 102500.0 103495.0 987.3 997.8 1006.4 1013.6 1015.2 18318.7 18351.9 18766.5 18811.9 18819.3 43950.1 44853.3 44873.8 45171.0 45790.5 59935.7 61356.4 62021.7 62851.4 63289.7 6667.3 8360.5 8626.9 8878.6 9053.0 13266.9 14102.4 14197.9 14695.9 14744.1 12415.7 12529.0 12778.2 12901.4 12949.3 12255.9 12705.9 12715.7 12859.4 12979.2 12590.6 12785.3 12798.4 12916.6 12955.5 8386.5 8637.1 8728.0 8783.1 8884.7 8526.9 11710.4 12300.0 12604.6 12847.9 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | [#3] mootools.html Cycles:180 Average:5697.04 Median:4623.84 stddev:3243.60 (70.1%) stddev-sans-first:3236.02 19:30:31 INFO - PROCESS | 11560 | Values: 1320.8 1411.1 1477.7 1521.8 1702.4 8258.5 8515.7 8517.3 8790.6 8796.0 8344.3 8497.7 8530.8 8546.6 8555.1 2276.6 2292.6 2295.6 2299.0 2299.2 2292.5 2313.9 2335.4 2337.9 2339.7 2153.3 2170.2 2188.1 2343.8 2347.3 2239.5 2282.4 2296.1 2299.4 2301.6 2182.4 2199.1 2199.1 2202.7 2207.2 8632.7 8671.2 8680.4 8726.8 8868.2 4958.7 5097.1 5113.2 5118.4 5121.9 3302.7 3303.1 3347.6 3365.9 3373.7 1046.6 1056.8 1061.7 1069.8 1078.7 11951.7 12004.4 12066.4 12091.2 12097.5 4183.3 4220.7 4348.2 4375.5 4465.1 9173.7 9196.4 9207.3 9211.0 9234.4 5040.2 5068.4 5081.5 5084.5 5103.9 4204.8 4527.3 4720.4 4740.7 4792.6 3680.7 3690.5 3768.9 3775.2 3813.7 1108.3 1129.0 1135.3 1140.8 1150.2 748.4 977.1 1025.5 1027.2 1037.9 5972.7 6090.6 6221.3 6308.6 6346.5 959.2 981.3 993.6 996.5 1015.6 3950.4 4129.8 4169.0 4240.6 4336.7 10306.8 10797.4 10804.7 10870.0 10872.9 10636.3 10730.5 10734.2 10763.0 10765.3 8130.7 8259.8 8275.2 8279.8 8281.2 5911.7 6032.1 6037.6 6212.7 6217.1 10056.3 10137.3 10157.0 10173.9 10228.6 10249.3 10358.9 10377.1 10478.6 10492.2 6107.7 6197.2 7162.5 7267.9 7343.2 8585.7 8597.8 8651.7 8657.2 8680.3 7598.9 7770.9 7798.6 7900.7 7925.4 7471.3 7637.4 7663.5 7773.5 7783.0 6787.2 6835.4 6842.5 6844.3 6855.9 5131.6 5186.8 5249.5 5266.8 5334.7 5156.0 5213.8 5215.1 5365.7 5390.5 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | [#4] prototype.html Cycles:180 Average:4636.68 Median:5353.65 stddev:1380.71 (25.8%) stddev-sans-first:1345.44 19:30:31 INFO - PROCESS | 11560 | Values: 287.4 295.0 300.9 305.2 306.1 5347.2 5367.5 5387.7 5387.9 5393.2 5249.9 5283.0 5319.6 5329.3 5347.5 3936.2 3976.5 4128.3 4137.2 4146.0 4067.5 4125.2 4126.6 4127.2 4138.2 3957.5 4028.6 4096.2 4103.0 4141.3 4026.6 4055.8 4063.7 4068.6 4096.2 3558.8 3576.3 3584.4 3593.5 3600.6 5081.9 5091.3 5092.3 5099.6 5127.0 4481.8 4619.2 4621.1 4623.0 4627.2 5447.5 5449.3 5457.7 5469.3 5483.5 3894.2 3909.4 3910.0 3915.5 3924.2 5472.8 5664.8 5691.9 5696.6 5730.3 3941.0 3952.6 3953.9 3956.2 3959.2 3998.2 4004.2 4014.0 4052.2 4072.4 4466.9 4562.5 4572.5 4682.0 4689.0 5486.0 5508.0 5515.7 5523.5 5523.9 1355.8 1369.2 1383.3 1384.9 1385.8 881.4 888.8 921.1 930.3 939.7 5194.5 5219.7 5296.7 5309.7 5326.4 5538.4 5553.3 5557.1 5629.4 5631.9 5088.5 5290.8 5299.1 5313.4 5314.3 2945.9 2967.4 2971.2 2982.9 2997.5 5537.8 5798.3 5801.5 5810.8 5822.5 5685.5 5687.3 5712.2 5715.6 5747.8 5761.9 5787.6 5788.6 5802.7 5804.5 5428.8 5564.6 5579.7 5730.8 5736.0 5622.5 5630.3 5637.4 5669.7 5676.6 5740.5 5940.8 5943.2 5955.7 6020.3 4014.5 4023.2 4030.3 4039.2 4047.9 5709.9 5732.5 5749.3 5756.4 5763.8 5463.2 5581.2 5589.2 5633.0 5634.0 5544.6 5551.7 5556.5 5569.1 5589.6 5359.8 5431.2 5471.7 5475.3 5550.5 5546.8 5556.1 5568.0 5568.6 5620.5 5446.9 5478.1 5485.6 5530.9 5541.5 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - PROCESS | 11560 | [#5] yui.html Cycles:180 Average:20105.93 Median:4702.11 stddev:29057.77 (618.0%) stddev-sans-first:29102.80 19:30:31 INFO - PROCESS | 11560 | Values: 713.7 718.9 757.5 785.4 792.4 13612.7 13625.7 13815.1 13854.4 14676.9 14386.4 14438.4 14598.1 14612.9 14626.9 666.9 774.0 789.8 808.2 819.0 795.9 808.7 809.6 809.9 810.1 849.4 853.8 854.2 855.4 857.6 692.3 829.0 847.5 849.1 852.4 615.3 619.8 620.6 621.4 621.7 14136.0 14137.6 14171.9 14174.3 14197.2 12611.7 12703.5 13016.2 13097.1 13185.0 11599.9 11815.2 11907.8 12012.9 12092.0 3961.3 3980.6 4007.6 4090.2 4131.1 70455.0 71449.3 74540.0 75751.6 76130.0 10120.7 10313.7 10348.2 10457.6 10578.0 18830.8 18878.2 18879.9 18882.7 18887.7 7934.0 8045.2 8123.9 8152.0 8420.5 4699.0 4708.6 4783.2 4805.1 4843.9 3118.8 3223.6 3230.2 3230.2 3233.5 574.5 585.4 585.8 597.1 603.3 624.9 652.9 696.8 716.5 736.1 9405.9 9449.8 9479.7 9503.5 9677.9 576.9 595.5 621.2 673.9 766.1 4327.9 4620.7 4641.2 4654.5 4705.2 104958.0 112148.0 115938.4 116397.0 118069.0 63740.4 64377.4 78402.6 82512.6 100338.5 87580.0 92265.5 92617.0 93095.5 93741.0 8564.7 8572.6 8580.0 8586.1 8618.2 51422.0 51867.7 52044.5 53725.7 53800.0 70222.6 74077.0 80322.0 82360.0 83701.0 12998.5 13141.9 13237.4 13394.4 13759.3 13694.3 13993.9 14022.2 14291.2 14614.4 13724.7 13921.5 13925.9 14260.1 14390.6 13055.7 13257.0 13331.7 13354.5 13530.2 13406.3 13718.0 13935.3 14009.2 14298.6 10543.6 10611.4 10766.5 11006.7 11014.8 10512.9 10631.3 10730.6 10891.9 10941.8 19:30:31 INFO - PROCESS | 11560 | -------- Summary: end -------- 19:30:31 INFO - PROCESS | 11560 | 19:30:31 INFO - TEST-INFO | 11560: exit 0 19:30:31 INFO - TEST-OK | dromaeo_css | took 1113303ms 19:30:31 INFO - TEST-START | kraken 19:30:31 INFO - operating with platform_type : linux_ 19:30:31 INFO - Initialising browser for kraken test... 19:30:31 INFO - TEST-INFO | started process 11751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpza95rz/profile http://localhost:58424/getInfo.html) 19:30:35 INFO - PROCESS | 11751 | __metrics Screen width/height:1600/1200 19:30:35 INFO - PROCESS | 11751 | colorDepth:24 19:30:35 INFO - PROCESS | 11751 | Browser inner width/height: 1024/697 19:30:35 INFO - PROCESS | 11751 | __metrics 19:30:36 INFO - PROCESS | 11751 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:30:37 INFO - TEST-INFO | 11751: exit 0 19:30:37 INFO - Browser initialized. 19:30:37 INFO - Running cycle 1/1 for kraken test... 19:30:37 INFO - TEST-INFO | started process 11831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpza95rz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:30:49 INFO - PROCESS | 11831 | RSS: Main: 157581312 19:30:49 INFO - PROCESS | 11831 | 19:30:52 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58424/tests/kraken/driver.html?testName=audio-beat-detection) 19:30:52 INFO - PROCESS | 11831 | RSS: Main: 215228416 19:30:52 INFO - PROCESS | 11831 | 19:30:55 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58424/tests/kraken/driver.html?testName=audio-dft) 19:30:56 INFO - PROCESS | 11831 | RSS: Main: 204029952 19:30:56 INFO - PROCESS | 11831 | 19:30:59 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58424/tests/kraken/driver.html?testName=audio-fft) 19:30:59 INFO - PROCESS | 11831 | RSS: Main: 269639680 19:30:59 INFO - PROCESS | 11831 | 19:31:01 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58424/tests/kraken/driver.html?testName=audio-oscillator) 19:31:02 INFO - PROCESS | 11831 | RSS: Main: 181346304 19:31:02 INFO - PROCESS | 11831 | 19:31:04 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:05 INFO - PROCESS | 11831 | RSS: Main: 184967168 19:31:05 INFO - PROCESS | 11831 | 19:31:08 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58424/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:08 INFO - PROCESS | 11831 | RSS: Main: 220659712 19:31:08 INFO - PROCESS | 11831 | 19:31:12 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58424/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:12 INFO - PROCESS | 11831 | RSS: Main: 221347840 19:31:12 INFO - PROCESS | 11831 | 19:31:15 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58424/tests/kraken/driver.html?testName=json-parse-financial) 19:31:16 INFO - PROCESS | 11831 | RSS: Main: 221450240 19:31:16 INFO - PROCESS | 11831 | 19:31:17 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:31:18 INFO - PROCESS | 11831 | RSS: Main: 208158720 19:31:18 INFO - PROCESS | 11831 | 19:31:20 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:31:20 INFO - PROCESS | 11831 | RSS: Main: 211300352 19:31:20 INFO - PROCESS | 11831 | 19:31:22 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:31:23 INFO - PROCESS | 11831 | RSS: Main: 208973824 19:31:23 INFO - PROCESS | 11831 | 19:31:25 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:31:26 INFO - PROCESS | 11831 | RSS: Main: 222011392 19:31:26 INFO - PROCESS | 11831 | 19:31:29 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:31:29 INFO - PROCESS | 11831 | RSS: Main: 222961664 19:31:29 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | Cycle 1(1): loaded http://localhost:58424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58424/tests/kraken/driver.html?testName=ai-astar) 19:31:31 INFO - PROCESS | 11831 | RSS: Main: 266117120 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | __start_tp_report 19:31:31 INFO - PROCESS | 11831 | _x_x_mozilla_page_load 19:31:31 INFO - PROCESS | 11831 | _x_x_mozilla_page_load_details 19:31:31 INFO - PROCESS | 11831 | |i|pagename|runs| 19:31:31 INFO - PROCESS | 11831 | |0;ai-astar;104;111;112;112;113;113;113;111;112;111 19:31:31 INFO - PROCESS | 11831 | |1;audio-beat-detection;145;116;119;168;123;118;144;118;150;115 19:31:31 INFO - PROCESS | 11831 | |2;audio-dft;161;164;160;166;162;160;160;160;162;161 19:31:31 INFO - PROCESS | 11831 | |3;audio-fft;75;75;75;121;75;76;75;75;104;76 19:31:31 INFO - PROCESS | 11831 | |4;audio-oscillator;84;84;113;85;84;84;123;84;84;133 19:31:31 INFO - PROCESS | 11831 | |5;imaging-gaussian-blur;116;117;117;117;117;116;116;116;117;117 19:31:31 INFO - PROCESS | 11831 | |6;imaging-darkroom;146;146;145;146;147;147;147;145;146;147 19:31:31 INFO - PROCESS | 11831 | |7;imaging-desaturate;96;96;96;95;94;95;95;95;95;95 19:31:31 INFO - PROCESS | 11831 | |8;json-parse-financial;63;51;52;52;51;52;54;51;51;52 19:31:31 INFO - PROCESS | 11831 | |9;json-stringify-tinderbox;61;62;62;63;63;61;61;62;62;62 19:31:31 INFO - PROCESS | 11831 | |10;stanford-crypto-aes;81;74;74;75;79;74;80;75;74;79 19:31:31 INFO - PROCESS | 11831 | |11;stanford-crypto-ccm;129;116;123;119;125;139;126;121;165;118 19:31:31 INFO - PROCESS | 11831 | |12;stanford-crypto-pbkdf2;161;158;159;160;159;159;159;158;159;160 19:31:31 INFO - PROCESS | 11831 | |13;stanford-crypto-sha256-iterative;63;66;67;64;62;62;64;63;63;61 19:31:31 INFO - PROCESS | 11831 | __end_tp_report 19:31:31 INFO - PROCESS | 11831 | __start_cc_report 19:31:31 INFO - PROCESS | 11831 | _x_x_mozilla_cycle_collect,1666 19:31:31 INFO - PROCESS | 11831 | __end_cc_report 19:31:31 INFO - PROCESS | 11831 | __startTimestamp1468031491748__endTimestamp 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | ------- Summary: start ------- 19:31:31 INFO - PROCESS | 11831 | Number of tests: 14 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 19:31:31 INFO - PROCESS | 11831 | Values: 104.0 111.0 112.0 112.0 113.0 113.0 113.0 111.0 112.0 111.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:133.50 stddev:18.61 (13.9%) stddev-sans-first:19.10 19:31:31 INFO - PROCESS | 11831 | Values: 145.0 116.0 119.0 168.0 123.0 118.0 144.0 118.0 150.0 115.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:2.01 (1.2%) stddev-sans-first:2.12 19:31:31 INFO - PROCESS | 11831 | Values: 161.0 164.0 160.0 166.0 162.0 160.0 160.0 160.0 162.0 161.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:16.21 (21.6%) stddev-sans-first:16.96 19:31:31 INFO - PROCESS | 11831 | Values: 75.0 75.0 75.0 121.0 75.0 76.0 75.0 75.0 104.0 76.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.00 stddev:19.36 (23.0%) stddev-sans-first:20.05 19:31:31 INFO - PROCESS | 11831 | Values: 84.0 84.0 113.0 85.0 84.0 84.0 123.0 84.0 84.0 133.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:31:31 INFO - PROCESS | 11831 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 19:31:31 INFO - PROCESS | 11831 | Values: 146.0 146.0 145.0 146.0 147.0 147.0 147.0 145.0 146.0 147.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 19:31:31 INFO - PROCESS | 11831 | Values: 96.0 96.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.00 stddev:3.67 (7.0%) stddev-sans-first:0.97 19:31:31 INFO - PROCESS | 11831 | Values: 63.0 51.0 52.0 52.0 51.0 52.0 54.0 51.0 51.0 52.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 19:31:31 INFO - PROCESS | 11831 | Values: 61.0 62.0 62.0 63.0 63.0 61.0 61.0 62.0 62.0 62.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:77.00 stddev:2.88 (3.7%) stddev-sans-first:2.55 19:31:31 INFO - PROCESS | 11831 | Values: 81.0 74.0 74.0 75.0 79.0 74.0 80.0 75.0 74.0 79.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:125.50 stddev:14.54 (11.6%) stddev-sans-first:15.42 19:31:31 INFO - PROCESS | 11831 | Values: 129.0 116.0 123.0 119.0 125.0 139.0 126.0 121.0 165.0 118.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 19:31:31 INFO - PROCESS | 11831 | Values: 161.0 158.0 159.0 160.0 159.0 159.0 159.0 158.0 159.0 160.0 19:31:31 INFO - PROCESS | 11831 | 19:31:31 INFO - PROCESS | 11831 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.84 (2.9%) stddev-sans-first:1.94 19:31:31 INFO - PROCESS | 11831 | Values: 63.0 66.0 67.0 64.0 62.0 62.0 64.0 63.0 63.0 61.0 19:31:31 INFO - PROCESS | 11831 | -------- Summary: end -------- 19:31:31 INFO - PROCESS | 11831 | 19:31:32 INFO - TEST-INFO | 11831: exit 0 19:31:32 INFO - TEST-OK | kraken | took 60848ms 19:31:32 INFO - SUITE-END | took 1174s 19:31:32 INFO - Completed test suite (00:19:34) 19:31:32 INFO - javascript benchmark 19:31:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.4969979953307, 3066.5400189971515, 3096.7212950834432, 3098.9773374786314, 3113.143885431506, 5176.0683077046215, 5253.448387919266, 5273.129933560957, 5367.409584945653, 5375.731213439327, 5335.33308336458, 5336.226247194155, 5347.224652425396, 5355.08963476209, 5358.705271210082, 4786.066716990197, 4855.854324370274, 4863.756812159396, 4878.390201224847, 4924.335214745999, 4847.224444088946, 4849.127157111719, 4880.438749543795, 4894.730789806559, 4923.113839508887, 4783.904321913559, 4797.856064318076, 4836.032793441291, 4858.927116093261, 4868.683535570177, 4784.5933095686905, 4789.042191561702, 4789.784459699322, 4796.736179510125, 4867.488913664085, 4784.425868895755, 4793.544613261734, 4820.469748327681, 4826.710397376169, 4847.733374664392, 5215.504527069922, 5271.789128434896, 5336.786528538853, 5340.465953404629, 5389.541888939445, 5703.914441283384, 5726.856828579277, 5740.799072032459, 5767.6539407635255, 5769.0, 5795.507381872546, 5799.014167591477, 5804.738786754606, 5806.854828629276, 5813.215215945836, 5186.740662966874, 5280.2343660169445, 5327.573794096502, 5337.653052551572, 5387.0, 5899.292084949748, 5907.05487122067, 5907.438793314628, 5920.993431116721, 5928.79249226275, 5456.072467680504, 5665.631733937281, 5665.943340566624, 5668.036433806263, 5669.092945128842, 5520.723963801794, 5530.806421775219, 5535.280413546213, 5608.831735047955, 5610.887782244332, 5561.972190139104, 5567.2762540870235, 5570.61005729595, 5577.2191893135, 5613.859653508695, 5532.972335138379, 5567.3040869891265, 5570.3315602127195, 5570.637908535932, 5576.358718747315, 4257.595528424795, 4269.893252668709, 4341.305391137466, 4374.0, 4389.6927215095275, 3910.8435662573747, 3915.6280153385383, 3917.6474117329576, 3954.5056867891512, 3962.6037396260144, 5452.809151679672, 5463.071277882769, 5464.480874316933, 5468.125099984063, 5472.069748142825, 5679.233303503974, 5731.426857314235, 5794.333651630117, 5797.36229014808, 5823.097419899922, 5462.071447853875, 5492.5331346835965, 5492.752826122834, 5492.835214943558, 5493.917591236134, 4864.732439715779, 5004.699718016931, 5008.073506401327, 5016.247562865599, 5060.962502686941, 5820.068788993741, 5848.181254624356, 5859.619124756877, 5863.648181109147, 5873.119032145212, 5690.459406356389, 5733.827985160452, 5744.253247077853, 5746.482816546531, 5760.8271751847515, 5744.281964754406, 5884.499817515559, 5903.085021821625, 5914.172015917861, 5924.318703348998, 5673.319201695823, 5675.77296908119, 5701.572382071278, 5708.857278568069, 5757.136429535603, 5684.090545512863, 5716.485516303553, 5720.74256658443, 5742.856428589319, 5794.333651629948, 5468.972655136698, 5512.283403157564, 5538.556915446835, 5672.978863804555, 5676.886462270649, 5519.944800551943, 5522.475364840334, 5530.778768849201, 5535.0313695104005, 5581.051221292309, 5506.531944784738, 5527.613067085265, 5541.944580554143, 5542.861428464321, 5548.889022219614, 5499.285092937893, 5589.55283577321, 5619.80330688424, 5657.886842263214, 5667.716614169192, 5319.547838433777, 5365.114756065205, 5366.517013468807, 5409.377921538916, 5451.182322651634], "value": 5256.683087446803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4777873802947, 623.9781607643733, 624.503519701837, 627.5105417774138, 642.2838535033437, 30060.24849378764, 30981.0, 32875.34249315012, 32915.50626740601, 32960.34079318415, 43536.56463435372, 44293.77853110738, 44427.11145777091, 47837.0, 47873.0, 9044.547772611377, 9186.54067296636, 9187.678431254908, 9188.1730644242, 9189.081091890825, 9051.637934482613, 9137.862932056025, 9138.543072846363, 9143.405678630868, 9146.451212927212, 9031.0, 9077.909220907806, 9088.272938164964, 9089.500077495735, 9093.136152065543, 9086.818263634723, 9137.040610735843, 9146.131117543822, 9150.267978561766, 9155.084491550859, 9083.636654533877, 9128.817423651557, 9143.817123657489, 9152.679656212, 9153.450792952377, 42609.36085958682, 42859.35710964307, 42894.571054289685, 42950.14099718019, 42986.78506607478, 3481.094915322009, 3559.323728491578, 3677.7425580209397, 3985.0236692010353, 4147.8963025924295, 30529.71027172971, 31167.844160779277, 31456.213594660316, 31503.0, 31869.0, 4239.703220774547, 4280.33654783506, 4375.168717943612, 4381.6494680425485, 4493.977530112328, 342582.0, 345744.0, 345830.0, 346438.0, 348161.0, 58262.417375826546, 58329.0, 58411.0, 58561.70719146377, 58613.706931465924, 61189.082163767576, 61687.691561541906, 61785.38214617886, 61798.0, 61874.381256187764, 16947.067911264752, 17108.914455427643, 17183.914080429517, 17191.656166876593, 17206.31174753021, 13446.596602101952, 13457.0, 13514.121582097132, 13543.119697219649, 13547.729045419037, 15808.130552819704, 16764.916175419046, 16786.83213167877, 16824.15879206035, 16974.830251697324, 5886.352501224862, 5935.465808077293, 5954.55340849438, 6005.159277701038, 6175.413335733098, 816.7876352148484, 945.7959370597764, 997.5162046407487, 1129.7062763681502, 1182.8876256755595, 32828.3434331312, 33197.50203746946, 33230.335393292, 33391.4991275131, 33591.66408335885, 963.4604621412032, 1118.6252605377126, 1119.8096323625002, 1191.2495128069434, 1206.4631239098517, 17208.741868871977, 17331.133443328035, 17331.913340433468, 17462.47612571625, 17626.471205863843, 552137.0, 556934.0, 557670.0, 557881.0, 558290.0, 58170.709146454, 58403.70798145982, 58409.41590584125, 58482.415175848546, 58547.70726146342, 1256.1458208418362, 1340.4169186403944, 1359.2252416122913, 1362.788767740982, 1382.9170249785045, 33916.83041584776, 34184.82907585446, 34432.0, 34673.0, 34708.65291347054, 51319.74340128276, 51439.0, 51847.0, 51881.22178167406, 51936.74031629818, 410366.0, 410915.0, 411608.0, 413707.0, 458567.0, 27083.0, 41223.793881031605, 42091.57908420999, 42220.0, 45071.549284506735, 45757.31364029609, 48762.0, 49122.263166051824, 50006.49993500018, 50671.49328506815, 40639.39040914448, 41989.79005104955, 42312.0, 44874.775626122966, 45598.54401455943, 41018.38472422856, 41894.790526047174, 42044.0, 42641.0, 43035.78482107569, 41679.0, 42145.36781948335, 42410.57589424066, 42598.148037039704, 43324.0, 37367.0, 37630.62369376271, 38073.619263807006, 38145.23358900311, 38572.614273858024, 28926.855365723037, 29001.274968125967, 29080.7091929078, 29268.7073129266, 29288.853555732087], "value": 20348.17971894648, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.3086540525162, 387.387927075221, 392.4760444806184, 401.7489069331668, 411.47742367193666, 17942.19260133294, 19683.409497715093, 19756.506087347825, 20639.793602063975, 20646.348292136612, 12185.878141218585, 12268.447919843606, 12411.38651975242, 12429.564965226218, 19517.609647807036, 5089.0, 5233.058049551079, 5274.182501712241, 5281.788728450857, 5282.709450980195, 3835.386338185891, 5461.907618476321, 6782.084418603499, 6813.0, 6914.308569143096, 6352.23773147223, 6823.078884350623, 6830.112085428887, 6856.382925536701, 6870.519063665545, 6031.155638210654, 6098.81703548892, 6116.3272040076, 6127.448529632332, 6185.195924529828, 3805.82873770681, 5265.183896496011, 5547.916781248285, 5561.610687251894, 5621.7751289948355, 13425.39585718645, 13459.528916487876, 15172.696546069017, 23495.647565286534, 24230.636540451906, 2409.6265078912797, 2440.9755902440925, 2479.194261864901, 2534.746525347469, 2963.970360296391, 9656.517174141265, 9803.558839852223, 10122.89877101227, 10170.644027459077, 10357.06786389221, 1869.9252029918787, 1885.0857334192906, 1943.5918457124021, 1956.168628332967, 1962.1660794162567, 66457.0, 81831.0, 82905.58547207285, 83107.75338369989, 84213.0, 10952.780944381067, 11179.596386776882, 11235.66293011211, 11247.437628118561, 11408.201425900108, 15438.5368438947, 15482.0, 15582.9220853895, 15591.688166236612, 15620.76568851468, 8044.879326810103, 8104.189581041848, 8172.591370431454, 8271.627776750061, 8312.085670576233, 7376.299251571092, 7404.925950740531, 7527.8494430111095, 7664.923350766421, 7831.451798374173, 4562.813668446228, 4801.639877009238, 4845.0, 4875.463698993108, 4949.752512374439, 1873.484791682271, 1895.8672892897364, 1940.146335612326, 1954.0947576113176, 1987.2512189273637, 913.8857642794651, 927.4481683398367, 954.5418199264392, 1004.909558139771, 1090.1387903556101, 20451.488712782, 20715.4821129473, 20776.0, 20851.374458766262, 21037.15851365959, 1014.1683819268277, 1039.5218199628105, 1048.1509976918721, 1063.239783554762, 1097.0, 11082.778344433065, 11673.194352514862, 11687.0, 11818.468168932246, 11854.110941679408, 485846.0, 490624.0, 495056.0, 495792.0, 497450.0, 98439.50780246053, 99873.00126998637, 100683.49658251808, 102500.0, 103495.0, 987.2990176974286, 997.8247420622967, 1006.3911333643186, 1013.6249587652616, 1015.1979935850743, 18318.72521912199, 18351.908240458713, 18766.53083672919, 18811.886107205864, 18819.341323053628, 43950.12099757923, 44853.32720009137, 44873.775631121636, 45171.0, 45790.542094578625, 59935.700321498116, 61356.386436135064, 62021.68989155025, 62851.37148628455, 63289.68355158379, 6667.333266673488, 8360.498370097814, 8626.870596941177, 8878.600462979051, 9053.0, 13266.933665331997, 14102.36539355711, 14197.858021419654, 14695.92652036733, 14744.115353078849, 12415.689607759878, 12529.0, 12778.233306001297, 12901.354932253538, 12949.287789171685, 12255.877441225473, 12705.936127506817, 12715.745685086431, 12859.357032148542, 12979.221246725227, 12590.559330423392, 12785.296808675612, 12798.424070916644, 12916.612501624966, 12955.481780728665, 8386.538740369338, 8637.093105223861, 8728.0, 8783.121687831166, 8884.73345799627, 8526.872096918676, 11710.414479275832, 12300.0, 12604.621861344174, 12847.871521284667], "value": 9323.686368209621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.7688654485462, 1411.146256514808, 1477.7118461899931, 1521.8173819141698, 1702.3956495444118, 8258.545779982107, 8515.701950431736, 8517.27603153732, 8790.64837406503, 8796.032436431988, 8344.332453403727, 8497.702580409687, 8530.829383412343, 8546.572671366423, 8555.058943516224, 2276.601594720921, 2292.5644127615783, 2295.6097463431174, 2298.9655155172686, 2299.2297580310533, 2292.5071109711407, 2313.8611683299055, 2335.3927978725483, 2337.8714170720605, 2339.6607491913746, 2153.2988938738376, 2170.2295685031822, 2188.113813905371, 2343.753905839888, 2347.272345572869, 2239.529698763262, 2282.4408020035116, 2296.058615967462, 2299.402155439581, 2301.5742087713825, 2182.388931099295, 2199.0763879170786, 2199.0983696684284, 2202.6916231727573, 2207.23850271656, 8632.65469381224, 8671.21959023691, 8680.435771674822, 8726.781830454225, 8868.157525035176, 4958.727270000149, 5097.108006098918, 5113.156329205676, 5118.385793704742, 5121.948780512184, 3302.7192688621494, 3303.0751389610946, 3347.581552305962, 3365.899023029313, 3373.696367326928, 1046.6284469013467, 1056.7675111475462, 1061.7186445591924, 1069.8395240713878, 1078.6710053433699, 11951.701207469796, 12004.399780010965, 12066.396680165957, 12091.153619246656, 12097.455614497281, 4183.267928112568, 4220.725652832556, 4348.217320882271, 4375.47494300686, 4465.084657645175, 9173.72478825623, 9196.35625506208, 9207.309451791143, 9211.0, 9234.445933244027, 5040.243963405445, 5068.4424713281505, 5081.517255860687, 5084.466131056186, 5103.923441148386, 4204.768737719393, 4527.320901864747, 4720.362751028636, 4740.691855029481, 4792.568668819823, 3680.742348035665, 3690.5202323698286, 3768.8869333920024, 3775.244951009754, 3813.656770890633, 1108.2519299472824, 1129.0016670493344, 1135.2620796482352, 1140.8003599370077, 1150.2121047082776, 748.4274529984566, 977.0620204603518, 1025.4565080507343, 1027.2244455436248, 1037.865077539915, 5972.671503067373, 6090.604110732788, 6221.3156552779155, 6308.589941653778, 6346.524010699216, 959.1846930109491, 981.259149342242, 993.5926270229171, 996.5314372516666, 1015.6140666546665, 3950.4074388841327, 4129.772862492592, 4168.979155104205, 4240.597143271384, 4336.704104880314, 10306.845397319046, 10797.352158870493, 10804.729881752863, 10870.021698047214, 10872.945635271773, 10636.30863993838, 10730.463476826128, 10734.248602597743, 10763.0, 10765.30025548337, 8130.674773009132, 8259.793505162419, 8275.213854683796, 8279.834403312021, 8281.17188281167, 5911.733971971185, 6032.095185722177, 6037.63774173551, 6212.689365531795, 6217.067439884054, 10056.34633748804, 10137.341072830242, 10157.0, 10173.949130254598, 10228.590856365661, 10249.33379330341, 10358.896411035794, 10377.117944974761, 10478.580856765644, 10492.213084018576, 6107.69461526913, 6197.225346831646, 7162.46281528877, 7267.854642907218, 7343.192248852729, 8585.65657373698, 8597.82804343897, 8651.6971905983, 8657.22085012352, 8680.348973826862, 7598.886016709644, 7770.883436748566, 7798.649060792164, 7900.68397264103, 7925.405594580545, 7471.327580517779, 7637.427192960439, 7663.501872378278, 7773.455858090106, 7783.0, 6787.185537735503, 6835.384815366641, 6842.452603791784, 6844.315568443116, 6855.931440685529, 5131.615128865425, 5186.792528298825, 5249.47505249472, 5266.815661451831, 5334.67991920486, 5155.9742201288755, 5213.817516386908, 5215.0612889678705, 5365.678059316298, 5390.51485366319], "value": 4548.037584003323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.44809964867454, 294.9587057811906, 300.90972708187553, 305.1714594874913, 306.0542922369877, 5347.197920311955, 5367.463253674636, 5387.730613469321, 5387.946120538793, 5393.217983392406, 5249.947500525003, 5282.973585132078, 5319.601029922752, 5329.333833270841, 5347.518723314901, 3936.1537269487053, 3976.5426975897853, 4128.277551428503, 4137.1725654869, 4146.025683964266, 4067.4712287402594, 4125.216208920296, 4126.587341265879, 4127.172886572707, 4138.234426631067, 3957.5053118360206, 4028.5769994150633, 4096.180763847243, 4103.0, 4141.316682747343, 4026.617471340218, 4055.7566546007038, 4063.674906007512, 4068.6338229559187, 4096.160287141129, 3558.768680035815, 3576.3191300088915, 3584.4085725855202, 3593.4789455528803, 3600.6219346968455, 5081.949180508184, 5091.287219789232, 5092.3125378073855, 5099.617528685363, 5126.974365128151, 4481.750730720234, 4619.237825758746, 4621.075784843045, 4622.953770462286, 4627.23650597651, 5447.536959358459, 5449.3460784706085, 5457.727113644341, 5469.288992430958, 5483.533899618537, 3894.201688653819, 3909.4135879618284, 3909.960900390988, 3915.5105611798526, 3924.1759230561615, 5472.781088756445, 5664.830055098354, 5691.943080569183, 5696.572757043238, 5730.280915725308, 3941.034446560611, 3952.565217826037, 3953.892909985209, 3956.188981258835, 3959.1685745993086, 3998.1603863189057, 4004.1591265833918, 4013.9598604013586, 4052.230076285496, 4072.4095006223934, 4466.888327791831, 4562.475315338712, 4572.474165470947, 4682.0, 4688.976555117202, 5486.039943009957, 5507.972460137674, 5515.696636685021, 5523.475269849358, 5523.861903452445, 1355.7966305054322, 1369.1716511510392, 1383.280694039094, 1384.8545902680276, 1385.8059871617982, 881.405051590174, 888.813349196676, 921.138735282513, 930.3441074042784, 939.6758118449125, 5194.532492075731, 5219.660722053054, 5296.682199068068, 5309.681419114788, 5326.414094449608, 5538.390777014525, 5553.278073850373, 5557.138643510262, 5629.352624448159, 5631.915521267184, 5088.508731936476, 5290.814821481306, 5299.065840968096, 5313.388960269618, 5314.309139811877, 2945.867435965387, 2967.3768508613434, 2971.2469642910355, 2982.8806847725846, 2997.4904266274784, 5537.7784888604, 5798.304203495608, 5801.506871915934, 5810.796622118206, 5822.48615360001, 5685.5167310778215, 5687.3459552152035, 5712.228849105318, 5715.599908006399, 5747.770089196469, 5761.88476230473, 5787.56593255516, 5788.565857560699, 5802.65184088956, 5804.477597016289, 5428.809991650273, 5564.582656300713, 5579.7489112990825, 5730.799422020209, 5735.971320143372, 5622.493975542221, 5630.324361076697, 5637.379888212376, 5669.744861481326, 5676.5742569308295, 5740.454656807597, 5940.762369505344, 5943.1679564861815, 5955.6724380157775, 6020.337762845996, 4014.53832809219, 4023.195360927885, 4030.3148464760475, 4039.212353591139, 4047.9392809108476, 5709.885802284014, 5732.512736417451, 5749.310082790092, 5756.366799652119, 5763.801090394871, 5463.180522921593, 5581.162825576196, 5589.189567512769, 5633.0, 5634.0, 5544.584156188222, 5551.666899986014, 5556.527695145958, 5569.10894256917, 5589.608727389043, 5359.785608575613, 5431.185322201702, 5471.699056551928, 5475.288212532345, 5550.500454959073, 5546.833594992157, 5556.138798486241, 5567.972160139336, 5568.610197286151, 5620.494155525858, 5446.891062178814, 5478.123500239943, 5485.61600687964, 5530.944690553043, 5541.473560011793], "value": 4184.198355167825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.7359177104471, 718.8670096032238, 757.5114051436823, 785.4344871692383, 792.4294507954272, 13612.727745445085, 13625.659358516043, 13815.1020183688, 13854.445822167114, 14676.853231467681, 14386.352614132364, 14438.422463101464, 14598.124112553227, 14612.853871461282, 14626.853731462683, 666.8799616069106, 774.0401901641951, 789.8143936174994, 808.1514409869643, 818.950862948225, 795.9482633628825, 808.7452452477451, 809.6194788449449, 809.9352051835868, 810.1210186947169, 849.413904405958, 853.7780177153953, 854.2354592639584, 855.4311382930343, 857.6483641706901, 692.3042342445809, 828.9626966786509, 847.5338563789891, 849.0957130655831, 852.4331319672441, 615.2616859768295, 619.755196697302, 620.6090163197202, 621.4469122480996, 621.7202258983431, 14136.0, 14137.646558836008, 14171.87421886715, 14174.291285435687, 14197.219152946584, 12611.747765044647, 12703.463224985344, 13016.153949993315, 13097.083204175711, 13185.0, 11599.94200029003, 11815.232009919328, 11907.821382679267, 12012.939935300268, 12092.032637388987, 3961.3265744823448, 3980.641742243212, 4007.5591684914634, 4090.202410529948, 4131.07050913545, 70455.0, 71449.28550714478, 74540.0, 75751.62124189344, 76130.0, 10120.696379108638, 10313.690589282334, 10348.22388320879, 10457.581696732197, 10577.999999999845, 18830.811691882907, 18878.150483228288, 18879.905600472186, 18882.716759248622, 18887.716684249746, 7934.0, 8045.15525869787, 8123.918760812317, 8151.95924020388, 8420.53687047206, 4699.0, 4708.552687494683, 4783.210770222944, 4805.087033463631, 4843.878903027453, 3118.766092543068, 3223.564818749439, 3230.176305042199, 3230.1924518870283, 3233.4988076848126, 574.5030548575452, 585.4496773033335, 585.8388943040698, 597.05068940385, 603.2820943077724, 624.865653884417, 652.8792173447928, 696.7665831946254, 716.4912911832657, 736.0641512821246, 9405.858912116324, 9449.763755906157, 9479.668211612561, 9503.524823758784, 9677.854832177523, 576.9192511986015, 595.5146555557207, 621.2327775197627, 673.865226954611, 766.1342682768548, 4327.913441731211, 4620.745858977789, 4641.164590373765, 4654.464736555272, 4705.223638099676, 104958.0, 112148.0, 115938.42030789792, 116397.0, 118069.0, 63740.36259637437, 64377.356226438074, 78402.6079869597, 82512.58743706244, 100338.498307508, 87580.0, 92265.53867230755, 92617.0, 93095.53452232695, 93740.99999999863, 8564.657413703382, 8572.571371431279, 8580.0, 8586.141385861363, 8618.155913898087, 51422.0, 51867.740661296455, 52044.479555203965, 53725.731371342896, 53800.0, 70222.64888675524, 74077.0, 80322.0, 82360.0, 83701.0, 12998.545050923172, 13141.868581314448, 13237.404316805574, 13394.397252123872, 13759.312034398441, 13694.315284235947, 13993.930030349784, 14022.158670479805, 14291.213983231022, 14614.415423382945, 13724.689501309738, 13921.512747053805, 13925.930370348084, 14260.144391336553, 14390.640233994234, 13055.738885222432, 13257.0, 13331.733365332833, 13354.465821367037, 13530.18818870871, 13406.257186565685, 13718.0, 13935.30323483842, 14009.159450433006, 14298.64253393632, 10543.630972915911, 10611.41637209961, 10766.515506802369, 11006.669799906016, 11014.779704406028, 10512.894871051498, 10631.285641522658, 10730.624428144978, 10891.945540272249, 10941.781164376827], "value": 7299.214308827532, "unit": "score"}], "name": "dromaeo_css", "value": 7193.342693814817, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 112.0, 113.0, 113.0, 113.0, 111.0, 112.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 119.0, 168.0, 123.0, 118.0, 144.0, 118.0, 150.0, 115.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 160.0, 166.0, 162.0, 160.0, 160.0, 160.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 121.0, 75.0, 76.0, 75.0, 75.0, 104.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 85.0, 84.0, 84.0, 123.0, 84.0, 84.0, 133.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 51.0, 52.0, 52.0, 51.0, 52.0, 54.0, 51.0, 51.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 63.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 74.0, 75.0, 79.0, 74.0, 80.0, 75.0, 74.0, 79.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 116.0, 123.0, 119.0, 125.0, 139.0, 126.0, 121.0, 165.0, 118.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 159.0, 160.0, 159.0, 159.0, 159.0, 158.0, 159.0, 160.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 67.0, 64.0, 62.0, 62.0, 64.0, 63.0, 63.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1483.0, "alertThreshold": 2.0}]} 19:31:32 INFO - Return code: 0 19:31:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:31:33 INFO - # TBPL SUCCESS # 19:31:33 INFO - Running post-action listener: _resource_record_post_action 19:31:33 INFO - ##### 19:31:33 INFO - ##### Finished run-tests step (success) 19:31:33 INFO - ##### 19:31:33 INFO - Running post-run listener: _resource_record_post_run 19:31:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 564539392; Read time: 328; Write time: 507300 19:31:33 INFO - TinderboxPrint: CPU usage
13.0% 19:31:33 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 328 19:31:33 INFO - TinderboxPrint: I/O write bytes / time
564,539,392 / 507,300 19:31:33 INFO - TinderboxPrint: CPU idle
8,277.4 (87.0%) 19:31:33 INFO - TinderboxPrint: CPU user
1,193.0 (12.5%) 19:31:33 INFO - TinderboxPrint: Swap in / out
0 / 0 19:31:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 4096; Write bytes: 269295616; Read time: 116; Write time: 294332 19:31:33 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295243776; Read time: 204; Write time: 212968 19:31:33 INFO - Running post-run listener: _upload_blobber_files 19:31:33 INFO - Blob upload gear active. 19:31:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:31:33 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 19:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:31:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:31:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:31:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:37 INFO - (blobuploader) - INFO - Done attempting. 19:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:38 INFO - (blobuploader) - INFO - Done attempting. 19:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:31:38 INFO - (blobuploader) - INFO - Done attempting. 19:31:38 INFO - (blobuploader) - INFO - Iteration through files over. 19:31:38 INFO - Return code: 0 19:31:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:31:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:31:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74f93a92bbf4d3818ff2a4b80006a0f51a778f10e5e1c105368906ae3ddba5a9e7cd0b1f77d5cc27e12e548c645f97ae95948e1db1fa96fafa48e988240da659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7d9006c4b1ec99647fa8718988b35bffdd0b99e0b9e577ace09047e719c1113bf11e217db50ab383aa3e275b106174f6fde429cf7f7288d023bbb91fac6769f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/083bdad15091704132e2dfa730a123ec0c73c7f65cc3cd612bcd087b47fffa5d509262dc191084bf42e341d2e3e3363e369e957b94335ab91f6bb75e2c3afa97"} 19:31:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:31:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:31:38 INFO - Contents: 19:31:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74f93a92bbf4d3818ff2a4b80006a0f51a778f10e5e1c105368906ae3ddba5a9e7cd0b1f77d5cc27e12e548c645f97ae95948e1db1fa96fafa48e988240da659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7d9006c4b1ec99647fa8718988b35bffdd0b99e0b9e577ace09047e719c1113bf11e217db50ab383aa3e275b106174f6fde429cf7f7288d023bbb91fac6769f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/083bdad15091704132e2dfa730a123ec0c73c7f65cc3cd612bcd087b47fffa5d509262dc191084bf42e341d2e3e3363e369e957b94335ab91f6bb75e2c3afa97"} 19:31:38 INFO - Running post-run listener: copy_logs_to_upload_dir 19:31:38 INFO - Copying logs to upload dir... 19:31:38 INFO - mkdir: /builds/slave/test/build/upload/logs 19:31:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.224124 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-08 19:31:38.602340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 19:31:38.606057) ========= 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-1468028271.546470-1272017956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74f93a92bbf4d3818ff2a4b80006a0f51a778f10e5e1c105368906ae3ddba5a9e7cd0b1f77d5cc27e12e548c645f97ae95948e1db1fa96fafa48e988240da659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7d9006c4b1ec99647fa8718988b35bffdd0b99e0b9e577ace09047e719c1113bf11e217db50ab383aa3e275b106174f6fde429cf7f7288d023bbb91fac6769f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/083bdad15091704132e2dfa730a123ec0c73c7f65cc3cd612bcd087b47fffa5d509262dc191084bf42e341d2e3e3363e369e957b94335ab91f6bb75e2c3afa97"} build_url:https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/74f93a92bbf4d3818ff2a4b80006a0f51a778f10e5e1c105368906ae3ddba5a9e7cd0b1f77d5cc27e12e548c645f97ae95948e1db1fa96fafa48e988240da659", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b7d9006c4b1ec99647fa8718988b35bffdd0b99e0b9e577ace09047e719c1113bf11e217db50ab383aa3e275b106174f6fde429cf7f7288d023bbb91fac6769f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/083bdad15091704132e2dfa730a123ec0c73c7f65cc3cd612bcd087b47fffa5d509262dc191084bf42e341d2e3e3363e369e957b94335ab91f6bb75e2c3afa97"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 19:31:38.631916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:31:38.632278) ========= 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-1468028271.546470-1272017956 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:31:38.717625) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 19:31:38.718012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 19:31:38.718306) ========= ========= Total master_lag: 0.17 =========