builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1469100126.64 results: success (0) buildid: 20160721013053 builduid: 5eea57702cd640139e1f7c0364126b00 revision: 79b1ba1f1f4bcc68801315438fa632e6c916549e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.641708) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.642215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.642557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.658304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.658669) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 04:22:06-- 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.5M=0s 2016-07-21 04:22:07 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.791827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.792189) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015402 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:06.842644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 04:22:06.843060) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 79b1ba1f1f4bcc68801315438fa632e6c916549e --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 79b1ba1f1f4bcc68801315438fa632e6c916549e --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=a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 04:22:07,125 truncating revision to first 12 chars 2016-07-21 04:22:07,125 Setting DEBUG logging. 2016-07-21 04:22:07,125 attempt 1/10 2016-07-21 04:22:07,125 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/79b1ba1f1f4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 04:22:08,350 unpacking tar archive at: mozilla-inbound-79b1ba1f1f4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.592068 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 04:22:08.449707) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:08.450076) ========= script_repo_revision: 79b1ba1f1f4bcc68801315438fa632e6c916549e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:08.450520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:08.450824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 04:22:08.461835) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-21 04:22:08.462195) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:08 INFO - MultiFileLogger online at 20160721 04:22:08 in /builds/slave/test 04:22:08 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 04:22:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:08 INFO - {'append_to_log': False, 04:22:08 INFO - 'base_work_dir': '/builds/slave/test', 04:22:08 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:22:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:08 INFO - 'branch': 'Mozilla-Inbound', 04:22:08 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:08 INFO - 'config_files': ('talos/linux_config.py',), 04:22:08 INFO - 'default_actions': ('clobber', 04:22:08 INFO - 'read-buildbot-config', 04:22:08 INFO - 'download-and-extract', 04:22:08 INFO - 'populate-webroot', 04:22:08 INFO - 'create-virtualenv', 04:22:08 INFO - 'install', 04:22:08 INFO - 'run-tests'), 04:22:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:08 INFO - 'download_minidump_stackwalk': True, 04:22:08 INFO - 'download_symbols': 'ondemand', 04:22:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:08 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:08 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:08 INFO - 'installer_path': 'installer.exe', 04:22:08 INFO - 'log_level': 'info', 04:22:08 INFO - 'log_name': 'talos', 04:22:08 INFO - 'log_to_console': True, 04:22:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:08 INFO - 'opt_config_files': (), 04:22:08 INFO - 'pip_index': False, 04:22:08 INFO - 'sps_profile': False, 04:22:08 INFO - 'sps_profile_interval': 0, 04:22:08 INFO - 'suite': 'dromaeojs', 04:22:08 INFO - 'system_bits': '32', 04:22:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:08 INFO - 'title': 'talos-linux64-ix-062', 04:22:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:08 INFO - 'use_talos_json': True, 04:22:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:08 INFO - 'work_dir': 'build'} 04:22:08 INFO - [mozharness: 2016-07-21 11:22:08.827561Z] Running clobber step. 04:22:08 INFO - Running pre-action listener: _resource_record_pre_action 04:22:08 INFO - Running main action method: clobber 04:22:08 INFO - rmtree: /builds/slave/test/build 04:22:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:09 INFO - Running post-action listener: _resource_record_post_action 04:22:09 INFO - [mozharness: 2016-07-21 11:22:09.300134Z] Finished clobber step (success) 04:22:09 INFO - [mozharness: 2016-07-21 11:22:09.300236Z] Running read-buildbot-config step. 04:22:09 INFO - Running pre-action listener: _resource_record_pre_action 04:22:09 INFO - Running main action method: read_buildbot_config 04:22:09 INFO - Using buildbot properties: 04:22:09 INFO - { 04:22:09 INFO - "project": "", 04:22:09 INFO - "product": "firefox", 04:22:09 INFO - "script_repo_revision": "production", 04:22:09 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:22:09 INFO - "repository": "", 04:22:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:22:09 INFO - "buildid": "20160721013053", 04:22:09 INFO - "pgo_build": "True", 04:22:09 INFO - "basedir": "/builds/slave/test", 04:22:09 INFO - "buildnumber": 2102, 04:22:09 INFO - "slavename": "talos-linux64-ix-062", 04:22:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:22:09 INFO - "platform": "ubuntu64_hw", 04:22:09 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:22:09 INFO - "branch": "mozilla-inbound", 04:22:09 INFO - "repo_path": "integration/mozilla-inbound", 04:22:09 INFO - "revision": "79b1ba1f1f4bcc68801315438fa632e6c916549e", 04:22:09 INFO - "stage_platform": "linux64-pgo", 04:22:09 INFO - "builduid": "5eea57702cd640139e1f7c0364126b00", 04:22:09 INFO - "slavebuilddir": "test" 04:22:09 INFO - } 04:22:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:22:09 INFO - Running post-action listener: _resource_record_post_action 04:22:09 INFO - [mozharness: 2016-07-21 11:22:09.302702Z] Finished read-buildbot-config step (success) 04:22:09 INFO - [mozharness: 2016-07-21 11:22:09.302793Z] Running download-and-extract step. 04:22:09 INFO - Running pre-action listener: _resource_record_pre_action 04:22:09 INFO - Running main action method: download_and_extract 04:22:09 INFO - mkdir: /builds/slave/test/build/tests 04:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:22:09 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:09 INFO - Downloaded 1361 bytes. 04:22:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:22:09 INFO - Using the following test package requirements: 04:22:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'jsshell-linux-x86_64.zip'], 04:22:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:22:09 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:10 INFO - Downloaded 24347469 bytes. 04:22:10 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'] 04:22:10 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 04:22:12 INFO - Return code: 0 04:22:12 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 04:22:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:12 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:22:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:22:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:13 INFO - Downloaded 24347469 bytes. 04:22: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'] 04:22: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 04:22:14 INFO - Return code: 0 04:22:14 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')]} 04:22:14 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:15 INFO - Downloaded 14403317 bytes. 04:22:15 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'] 04:22:15 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 04:22:15 INFO - Return code: 0 04:22: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')]} 04:22:15 INFO - https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTA_XSR8QZWITG-yR4Soag/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 04:22:16 INFO - Downloaded 60923273 bytes. 04:22:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:16 INFO - mkdir: /builds/slave/test/properties 04:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:16 INFO - Contents: 04:22:16 INFO - build_url:https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:22:17 INFO - Running post-action listener: _resource_record_post_action 04:22:17 INFO - Running post-action listener: set_extra_try_arguments 04:22:17 INFO - [mozharness: 2016-07-21 11:22:17.589229Z] Finished download-and-extract step (success) 04:22:17 INFO - [mozharness: 2016-07-21 11:22:17.589464Z] Running populate-webroot step. 04:22:17 INFO - Running pre-action listener: _resource_record_pre_action 04:22:17 INFO - Running main action method: populate_webroot 04:22:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:17 INFO - '--tppagecycles', 04:22:17 INFO - '7'], 04:22:17 INFO - 'tests': ['tsvgm']}}, 04:22:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['damp', 'tps']}, 04:22:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'tests': ['damp', 'tps']}, 04:22:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['dromaeo_dom']}, 04:22:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['basic_compositor_video']}, 04:22:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:22:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['a11yr', 04:22:17 INFO - 'ts_paint', 04:22:17 INFO - 'tpaint', 04:22:17 INFO - 'sessionrestore', 04:22:17 INFO - 'sessionrestore_no_auto_restore', 04:22:17 INFO - 'tabpaint']}, 04:22:17 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:17 INFO - 'ts_paint', 04:22:17 INFO - 'tpaint', 04:22:17 INFO - 'sessionrestore', 04:22:17 INFO - 'sessionrestore_no_auto_restore', 04:22:17 INFO - 'tabpaint']}, 04:22:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:17 INFO - 'ts_paint', 04:22:17 INFO - 'tpaint', 04:22:17 INFO - 'sessionrestore', 04:22:17 INFO - 'sessionrestore_no_auto_restore', 04:22:17 INFO - 'tabpaint']}, 04:22:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:17 INFO - 'ts_paint', 04:22:17 INFO - 'tpaint', 04:22:17 INFO - 'sessionrestore', 04:22:17 INFO - 'sessionrestore_no_auto_restore', 04:22:17 INFO - 'tabpaint']}, 04:22:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['a11yr', 04:22:17 INFO - 'ts_paint', 04:22:17 INFO - 'tpaint', 04:22:17 INFO - 'sessionrestore', 04:22:17 INFO - 'sessionrestore_no_auto_restore', 04:22:17 INFO - 'tabpaint']}, 04:22:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['a11yr', 04:22:17 INFO - 'ts_paint', 04:22:17 INFO - 'tpaint', 04:22:17 INFO - 'sessionrestore', 04:22:17 INFO - 'sessionrestore_no_auto_restore', 04:22:17 INFO - 'tabpaint']}, 04:22:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['tsvgx', 04:22:17 INFO - 'tsvgr_opacity', 04:22:17 INFO - 'tart', 04:22:17 INFO - 'tscrollx', 04:22:17 INFO - 'cart']}, 04:22:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:17 INFO - 'tsvgr_opacity', 04:22:17 INFO - 'tart', 04:22:17 INFO - 'tscrollx', 04:22:17 INFO - 'cart']}, 04:22:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'talos_options': ['--disable-e10s'], 04:22:17 INFO - 'tests': ['tp5o']}, 04:22:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'tests': ['tp5o']}, 04:22:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'talos_options': ['--disable-e10s', 04:22:17 INFO - '--xperf_path', 04:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:17 INFO - 'tests': ['tp5n']}, 04:22:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:17 INFO - 'talos_options': ['--xperf_path', 04:22:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:17 INFO - 'tests': ['tp5n']}}, 04:22:17 INFO - 'talos.zip': {'path': '', 04:22:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:17 INFO - Running post-action listener: _resource_record_post_action 04:22:17 INFO - [mozharness: 2016-07-21 11:22:17.608067Z] Finished populate-webroot step (success) 04:22:17 INFO - [mozharness: 2016-07-21 11:22:17.608157Z] Running create-virtualenv step. 04:22:17 INFO - Running pre-action listener: _resource_record_pre_action 04:22:17 INFO - Running main action method: create_virtualenv 04:22:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:22:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:17 INFO - Using real prefix '/usr' 04:22:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:18 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:20 INFO - Installing pip.................done. 04:22:20 INFO - Return code: 0 04:22:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22:20 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')]} 04:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:20 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')]} 04:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:20 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:22:20 INFO - Using env: {'DISPLAY': ':0', 04:22:20 INFO - 'HOME': '/home/cltbld', 04:22:20 INFO - 'LANG': 'en_US.UTF-8', 04:22:20 INFO - 'LANGUAGE': 'en_US:en', 04:22:20 INFO - 'LOGNAME': 'cltbld', 04:22:20 INFO - 'MAIL': '/var/mail/cltbld', 04:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:20 INFO - 'MOZ_NO_REMOTE': '1', 04:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:20 INFO - 'NO_EM_RESTART': '1', 04:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:20 INFO - 'PWD': '/builds/slave/test', 04:22:20 INFO - 'SHELL': '/bin/bash', 04:22:20 INFO - 'SHLVL': '1', 04:22:20 INFO - 'TERM': 'linux', 04:22:20 INFO - 'TMOUT': '86400', 04:22:20 INFO - 'USER': 'cltbld', 04:22:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:20 INFO - '_': '/tools/buildbot/bin/python'} 04:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:22:20 INFO - Cleaning up... 04:22:20 INFO - Return code: 0 04:22:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22:20 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')]} 04:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:20 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')]} 04:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:20 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:22:20 INFO - Using env: {'DISPLAY': ':0', 04:22:20 INFO - 'HOME': '/home/cltbld', 04:22:20 INFO - 'LANG': 'en_US.UTF-8', 04:22:20 INFO - 'LANGUAGE': 'en_US:en', 04:22:20 INFO - 'LOGNAME': 'cltbld', 04:22:20 INFO - 'MAIL': '/var/mail/cltbld', 04:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:20 INFO - 'MOZ_NO_REMOTE': '1', 04:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:20 INFO - 'NO_EM_RESTART': '1', 04:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:20 INFO - 'PWD': '/builds/slave/test', 04:22:20 INFO - 'SHELL': '/bin/bash', 04:22:20 INFO - 'SHLVL': '1', 04:22:20 INFO - 'TERM': 'linux', 04:22:20 INFO - 'TMOUT': '86400', 04:22:20 INFO - 'USER': 'cltbld', 04:22:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:20 INFO - '_': '/tools/buildbot/bin/python'} 04:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:20 INFO - Downloading/unpacking psutil>=3.1.1 04:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:22 INFO - Installing collected packages: psutil 04:22:22 INFO - Running setup.py install for psutil 04:22:22 INFO - building 'psutil._psutil_linux' extension 04:22:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:22:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:22:22 INFO - building 'psutil._psutil_posix' extension 04:22:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:22:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:22:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:23 INFO - Successfully installed psutil 04:22:23 INFO - Cleaning up... 04:22:23 INFO - Return code: 0 04:22:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:22:23 INFO - Using env: {'DISPLAY': ':0', 04:22:23 INFO - 'HOME': '/home/cltbld', 04:22:23 INFO - 'LANG': 'en_US.UTF-8', 04:22:23 INFO - 'LANGUAGE': 'en_US:en', 04:22:23 INFO - 'LOGNAME': 'cltbld', 04:22:23 INFO - 'MAIL': '/var/mail/cltbld', 04:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:23 INFO - 'MOZ_NO_REMOTE': '1', 04:22:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:23 INFO - 'NO_EM_RESTART': '1', 04:22:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:23 INFO - 'PWD': '/builds/slave/test', 04:22:23 INFO - 'SHELL': '/bin/bash', 04:22:23 INFO - 'SHLVL': '1', 04:22:23 INFO - 'TERM': 'linux', 04:22:23 INFO - 'TMOUT': '86400', 04:22:23 INFO - 'USER': 'cltbld', 04:22:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:23 INFO - '_': '/tools/buildbot/bin/python'} 04:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:25 INFO - Installing collected packages: mozsystemmonitor 04:22:25 INFO - Running setup.py install for mozsystemmonitor 04:22:25 INFO - Successfully installed mozsystemmonitor 04:22:25 INFO - Cleaning up... 04:22:25 INFO - Return code: 0 04:22:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:22: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 jsonschema==2.5.1 04:22:25 INFO - Using env: {'DISPLAY': ':0', 04:22:25 INFO - 'HOME': '/home/cltbld', 04:22:25 INFO - 'LANG': 'en_US.UTF-8', 04:22:25 INFO - 'LANGUAGE': 'en_US:en', 04:22:25 INFO - 'LOGNAME': 'cltbld', 04:22:25 INFO - 'MAIL': '/var/mail/cltbld', 04:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:25 INFO - 'MOZ_NO_REMOTE': '1', 04:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:25 INFO - 'NO_EM_RESTART': '1', 04:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:25 INFO - 'PWD': '/builds/slave/test', 04:22:25 INFO - 'SHELL': '/bin/bash', 04:22:25 INFO - 'SHLVL': '1', 04:22:25 INFO - 'TERM': 'linux', 04:22:25 INFO - 'TMOUT': '86400', 04:22:25 INFO - 'USER': 'cltbld', 04:22:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:25 INFO - '_': '/tools/buildbot/bin/python'} 04:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:27 INFO - warning: no files found matching '*.txt' 04:22:27 INFO - no previously-included directories found matching 'build' 04:22:27 INFO - no previously-included directories found matching 'dist' 04:22:27 INFO - no previously-included directories found matching '.git*' 04:22:27 INFO - Installing collected packages: jsonschema, functools32 04:22:28 INFO - Running setup.py install for functools32 04:22:28 INFO - warning: no files found matching '*.txt' 04:22:28 INFO - no previously-included directories found matching 'build' 04:22:28 INFO - no previously-included directories found matching 'dist' 04:22:28 INFO - no previously-included directories found matching '.git*' 04:22:28 INFO - Successfully installed jsonschema functools32 04:22:28 INFO - Cleaning up... 04:22:28 INFO - Return code: 0 04:22:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:28 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')]} 04:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:28 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')]} 04:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:28 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:22:28 INFO - Using env: {'DISPLAY': ':0', 04:22:28 INFO - 'HOME': '/home/cltbld', 04:22:28 INFO - 'LANG': 'en_US.UTF-8', 04:22:28 INFO - 'LANGUAGE': 'en_US:en', 04:22:28 INFO - 'LOGNAME': 'cltbld', 04:22:28 INFO - 'MAIL': '/var/mail/cltbld', 04:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:28 INFO - 'MOZ_NO_REMOTE': '1', 04:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:28 INFO - 'NO_EM_RESTART': '1', 04:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:28 INFO - 'PWD': '/builds/slave/test', 04:22:28 INFO - 'SHELL': '/bin/bash', 04:22:28 INFO - 'SHLVL': '1', 04:22:28 INFO - 'TERM': 'linux', 04:22:28 INFO - 'TMOUT': '86400', 04:22:28 INFO - 'USER': 'cltbld', 04:22:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:28 INFO - '_': '/tools/buildbot/bin/python'} 04:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22: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 04:22:31 INFO - Downloading docopt-0.6.1.tar.gz 04:22:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:31 INFO - Running setup.py install for blobuploader 04:22:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:31 INFO - Running setup.py install for requests 04:22:31 INFO - Running setup.py install for docopt 04:22:31 INFO - Successfully installed blobuploader requests docopt 04:22:31 INFO - Cleaning up... 04:22:31 INFO - Return code: 0 04:22:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:31 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:22:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:31 INFO - Using env: {'DISPLAY': ':0', 04:22:31 INFO - 'HOME': '/home/cltbld', 04:22:31 INFO - 'LANG': 'en_US.UTF-8', 04:22:31 INFO - 'LANGUAGE': 'en_US:en', 04:22:31 INFO - 'LOGNAME': 'cltbld', 04:22:31 INFO - 'MAIL': '/var/mail/cltbld', 04:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:31 INFO - 'MOZ_NO_REMOTE': '1', 04:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:31 INFO - 'NO_EM_RESTART': '1', 04:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:31 INFO - 'PWD': '/builds/slave/test', 04:22:31 INFO - 'SHELL': '/bin/bash', 04:22:31 INFO - 'SHLVL': '1', 04:22:31 INFO - 'TERM': 'linux', 04:22:31 INFO - 'TMOUT': '86400', 04:22:31 INFO - 'USER': 'cltbld', 04:22:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:31 INFO - '_': '/tools/buildbot/bin/python'} 04:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:32 INFO - Running setup.py (path:/tmp/pip-qBVwlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:32 INFO - Running setup.py (path:/tmp/pip-h4yV1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:32 INFO - Running setup.py (path:/tmp/pip-TLTBOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:32 INFO - Running setup.py (path:/tmp/pip-WrLoBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:32 INFO - Running setup.py (path:/tmp/pip-bORZLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:32 INFO - Running setup.py (path:/tmp/pip-mSv2w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:32 INFO - Running setup.py (path:/tmp/pip-FVeejY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:32 INFO - Running setup.py (path:/tmp/pip-BaORFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:32 INFO - Running setup.py (path:/tmp/pip-t5byfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:32 INFO - Running setup.py (path:/tmp/pip-JmuJ7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:32 INFO - Running setup.py (path:/tmp/pip-vLYTGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:32 INFO - Running setup.py (path:/tmp/pip-FKYeTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:32 INFO - Running setup.py (path:/tmp/pip-DNSkoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:33 INFO - Running setup.py (path:/tmp/pip-bMTD8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:33 INFO - Running setup.py (path:/tmp/pip-AOIAjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:33 INFO - Running setup.py (path:/tmp/pip-f8R3tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:33 INFO - Running setup.py (path:/tmp/pip-FZ8eZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:33 INFO - Running setup.py install for manifestparser 04:22:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:33 INFO - Running setup.py install for mozcrash 04:22:33 INFO - Running setup.py install for mozdebug 04:22:33 INFO - Running setup.py install for mozdevice 04:22:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:33 INFO - Running setup.py install for mozfile 04:22:33 INFO - Running setup.py install for mozhttpd 04:22:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:33 INFO - Running setup.py install for mozinfo 04:22:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:33 INFO - Running setup.py install for mozInstall 04:22:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Running setup.py install for mozleak 04:22:34 INFO - Running setup.py install for mozlog 04:22:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Running setup.py install for moznetwork 04:22:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Running setup.py install for mozprocess 04:22:34 INFO - Running setup.py install for mozprofile 04:22:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Running setup.py install for mozrunner 04:22:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:34 INFO - Running setup.py install for mozscreenshot 04:22:34 INFO - Running setup.py install for moztest 04:22:34 INFO - Running setup.py install for mozversion 04:22:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:35 INFO - Cleaning up... 04:22:35 INFO - Return code: 0 04:22:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:35 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:22:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:35 INFO - Using env: {'DISPLAY': ':0', 04:22:35 INFO - 'HOME': '/home/cltbld', 04:22:35 INFO - 'LANG': 'en_US.UTF-8', 04:22:35 INFO - 'LANGUAGE': 'en_US:en', 04:22:35 INFO - 'LOGNAME': 'cltbld', 04:22:35 INFO - 'MAIL': '/var/mail/cltbld', 04:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:35 INFO - 'MOZ_NO_REMOTE': '1', 04:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:35 INFO - 'NO_EM_RESTART': '1', 04:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:35 INFO - 'PWD': '/builds/slave/test', 04:22:35 INFO - 'SHELL': '/bin/bash', 04:22:35 INFO - 'SHLVL': '1', 04:22:35 INFO - 'TERM': 'linux', 04:22:35 INFO - 'TMOUT': '86400', 04:22:35 INFO - 'USER': 'cltbld', 04:22:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:35 INFO - '_': '/tools/buildbot/bin/python'} 04:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:35 INFO - Running setup.py (path:/tmp/pip-Pgt7oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:35 INFO - Running setup.py (path:/tmp/pip-x9bIph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:35 INFO - Running setup.py (path:/tmp/pip-vs0jIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:35 INFO - Running setup.py (path:/tmp/pip-d275HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:35 INFO - Running setup.py (path:/tmp/pip-iHohe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:35 INFO - Running setup.py (path:/tmp/pip-xD6uSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:35 INFO - Running setup.py (path:/tmp/pip-0Rb8Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:35 INFO - Running setup.py (path:/tmp/pip-5s19HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:35 INFO - Running setup.py (path:/tmp/pip-VeN_GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:35 INFO - Running setup.py (path:/tmp/pip-1K7i2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:36 INFO - Running setup.py (path:/tmp/pip-Fy7miq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:36 INFO - Running setup.py (path:/tmp/pip-FdbnnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:36 INFO - Running setup.py (path:/tmp/pip-iRp__5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:36 INFO - Running setup.py (path:/tmp/pip-BrHyNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:36 INFO - Running setup.py (path:/tmp/pip-TNyGIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:36 INFO - Running setup.py (path:/tmp/pip-qyhaN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:36 INFO - Running setup.py (path:/tmp/pip-3kMTSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:22:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:38 INFO - Downloading blessings-1.6.tar.gz 04:22:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:38 INFO - Installing collected packages: blessings 04:22:38 INFO - Running setup.py install for blessings 04:22:38 INFO - Successfully installed blessings 04:22:38 INFO - Cleaning up... 04:22:38 INFO - Return code: 0 04:22:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:39 INFO - Reading from file tmpfile_stdout 04:22:39 INFO - Current package versions: 04:22:39 INFO - argparse == 1.2.1 04:22:39 INFO - blessings == 1.6 04:22:39 INFO - blobuploader == 1.2.4 04:22:39 INFO - docopt == 0.6.1 04:22:39 INFO - functools32 == 3.2.3-2 04:22:39 INFO - jsonschema == 2.5.1 04:22:39 INFO - manifestparser == 1.1 04:22:39 INFO - mozInstall == 1.12 04:22:39 INFO - mozcrash == 0.17 04:22:39 INFO - mozdebug == 0.1 04:22:39 INFO - mozdevice == 0.48 04:22:39 INFO - mozfile == 1.2 04:22:39 INFO - mozhttpd == 0.7 04:22:39 INFO - mozinfo == 0.9 04:22:39 INFO - mozleak == 0.1 04:22:39 INFO - mozlog == 3.3 04:22:39 INFO - moznetwork == 0.27 04:22:39 INFO - mozprocess == 0.23 04:22:39 INFO - mozprofile == 0.28 04:22:39 INFO - mozrunner == 6.12 04:22:39 INFO - mozscreenshot == 0.1 04:22:39 INFO - mozsystemmonitor == 0.3 04:22:39 INFO - moztest == 0.7 04:22:39 INFO - mozversion == 1.4 04:22:39 INFO - psutil == 3.1.1 04:22:39 INFO - requests == 1.2.3 04:22:39 INFO - wsgiref == 0.1.2 04:22:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:39 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')]} 04:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:39 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')]} 04:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:39 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:22:39 INFO - Using env: {'DISPLAY': ':0', 04:22:39 INFO - 'HOME': '/home/cltbld', 04:22:39 INFO - 'LANG': 'en_US.UTF-8', 04:22:39 INFO - 'LANGUAGE': 'en_US:en', 04:22:39 INFO - 'LOGNAME': 'cltbld', 04:22:39 INFO - 'MAIL': '/var/mail/cltbld', 04:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:39 INFO - 'MOZ_NO_REMOTE': '1', 04:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:39 INFO - 'NO_EM_RESTART': '1', 04:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:39 INFO - 'PWD': '/builds/slave/test', 04:22:39 INFO - 'SHELL': '/bin/bash', 04:22:39 INFO - 'SHLVL': '1', 04:22:39 INFO - 'TERM': 'linux', 04:22:39 INFO - 'TMOUT': '86400', 04:22:39 INFO - 'USER': 'cltbld', 04:22:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:39 INFO - '_': '/tools/buildbot/bin/python'} 04:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:22:39 INFO - Cleaning up... 04:22:39 INFO - Return code: 0 04:22:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:39 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')]} 04:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:39 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')]} 04:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:39 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 0x1734030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f5180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:22:39 INFO - Using env: {'DISPLAY': ':0', 04:22:39 INFO - 'HOME': '/home/cltbld', 04:22:39 INFO - 'LANG': 'en_US.UTF-8', 04:22:39 INFO - 'LANGUAGE': 'en_US:en', 04:22:39 INFO - 'LOGNAME': 'cltbld', 04:22:39 INFO - 'MAIL': '/var/mail/cltbld', 04:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:39 INFO - 'MOZ_NO_REMOTE': '1', 04:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:39 INFO - 'NO_EM_RESTART': '1', 04:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:39 INFO - 'PWD': '/builds/slave/test', 04:22:39 INFO - 'SHELL': '/bin/bash', 04:22:39 INFO - 'SHLVL': '1', 04:22:39 INFO - 'TERM': 'linux', 04:22:39 INFO - 'TMOUT': '86400', 04:22:39 INFO - 'USER': 'cltbld', 04:22:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:39 INFO - '_': '/tools/buildbot/bin/python'} 04:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:22:39 INFO - Cleaning up... 04:22:39 INFO - Return code: 0 04:22:39 INFO - Running post-action listener: _resource_record_post_action 04:22:39 INFO - Running post-action listener: _start_resource_monitoring 04:22:39 INFO - Starting resource monitoring. 04:22:39 INFO - [mozharness: 2016-07-21 11:22:39.480818Z] Finished create-virtualenv step (success) 04:22:39 INFO - [mozharness: 2016-07-21 11:22:39.481250Z] Running install step. 04:22:39 INFO - Running pre-action listener: _resource_record_pre_action 04:22:39 INFO - Running main action method: install 04:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:39 INFO - Reading from file tmpfile_stdout 04:22:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:39 INFO - Reading from file tmpfile_stdout 04:22:39 INFO - Output received: 04:22:39 INFO - Usage: mozinstall [options] installer 04:22:39 INFO - Options: 04:22:39 INFO - -h, --help show this help message and exit 04:22:39 INFO - -d DEST, --destination=DEST 04:22:39 INFO - Directory to install application into. [default: 04:22:39 INFO - "/builds/slave/test"] 04:22:39 INFO - --app=APP Application being installed. [default: firefox] 04:22:39 INFO - mkdir: /builds/slave/test/build/application 04:22:39 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'] 04:22:39 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 04:22:57 INFO - Reading from file tmpfile_stdout 04:22:57 INFO - Output received: 04:22:57 INFO - /builds/slave/test/build/application/firefox/firefox 04:22:57 INFO - Running post-action listener: _resource_record_post_action 04:22:57 INFO - [mozharness: 2016-07-21 11:22:57.066454Z] Finished install step (success) 04:22:57 INFO - [mozharness: 2016-07-21 11:22:57.066733Z] Running run-tests step. 04:22:57 INFO - Running pre-action listener: _resource_record_pre_action 04:22:57 INFO - Running main action method: run_tests 04:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:57 INFO - Python 2.7.3 04:22:57 INFO - Return code: 0 04:22:57 INFO - grabbing minidump binary from tooltool 04:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:22:57 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 0x19f33b0>, '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 0x19f42b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f4740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:22:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:22:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:22:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:57 INFO - Return code: 0 04:22:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:22:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:22:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:57 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/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:22:57 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/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:22:57 INFO - Using env: {'DISPLAY': ':0', 04:22:57 INFO - 'HOME': '/home/cltbld', 04:22:57 INFO - 'LANG': 'en_US.UTF-8', 04:22:57 INFO - 'LANGUAGE': 'en_US:en', 04:22:57 INFO - 'LOGNAME': 'cltbld', 04:22:57 INFO - 'MAIL': '/var/mail/cltbld', 04:22:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:57 INFO - 'MOZ_NO_REMOTE': '1', 04:22:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:57 INFO - 'NO_EM_RESTART': '1', 04:22:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:57 INFO - 'PWD': '/builds/slave/test', 04:22:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:57 INFO - 'SHELL': '/bin/bash', 04:22:57 INFO - 'SHLVL': '1', 04:22:57 INFO - 'TERM': 'linux', 04:22:57 INFO - 'TMOUT': '86400', 04:22:57 INFO - 'USER': 'cltbld', 04:22:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940', 04:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:57 INFO - '_': '/tools/buildbot/bin/python'} 04:22:57 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/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:22:57 INFO - mozversion application_buildid: 20160721013053 04:22:57 INFO - mozversion application_changeset: 79b1ba1f1f4bcc68801315438fa632e6c916549e 04:22:57 INFO - mozversion application_display_name: Nightly 04:22:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:57 INFO - mozversion application_name: Firefox 04:22:57 INFO - mozversion application_remotingname: firefox 04:22:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:22:57 INFO - mozversion application_vendor: Mozilla 04:22:57 INFO - mozversion application_version: 50.0a1 04:22:57 INFO - mozversion platform_buildid: 20160721013053 04:22:57 INFO - mozversion platform_changeset: 79b1ba1f1f4bcc68801315438fa632e6c916549e 04:22:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:22:57 INFO - mozversion platform_version: 50.0a1 04:22:57 INFO - using testdate: 1469100177 04:22:57 INFO - actual date: 1469100177 04:22:57 INFO - starting webserver on 'localhost:36202' 04:22:57 INFO - SUITE-START | Running 2 tests 04:22:57 INFO - TEST-START | dromaeo_css 04:22:57 INFO - operating with platform_type : linux_ 04:22:57 INFO - Initialising browser for dromaeo_css test... 04:22:57 INFO - TEST-INFO | started process 11586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNrWhq3/profile http://localhost:36202/getInfo.html) 04:23:00 INFO - PROCESS | 11586 | __metrics Screen width/height:1600/1200 04:23:00 INFO - PROCESS | 11586 | colorDepth:24 04:23:00 INFO - PROCESS | 11586 | Browser inner width/height: 1024/697 04:23:00 INFO - PROCESS | 11586 | __metrics 04:23:01 INFO - PROCESS | 11586 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:23:01 INFO - PROCESS | 11586 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:23:02 INFO - TEST-INFO | 11586: exit 0 04:23:02 INFO - Browser initialized. 04:23:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:02 INFO - TEST-INFO | started process 11669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNrWhq3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:14 INFO - PROCESS | 11669 | RSS: Main: 157249536 04:23:14 INFO - PROCESS | 11669 | 04:24:05 INFO - PROCESS | 11669 | 1469100245662 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:26:13 INFO - PROCESS | 11669 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36202/tests/dromaeo/cssquery-ext.html) 04:26:14 INFO - PROCESS | 11669 | RSS: Main: 263372800 04:26:14 INFO - PROCESS | 11669 | 04:29:17 INFO - PROCESS | 11669 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-ext.html (next: http://localhost:36202/tests/dromaeo/cssquery-jquery.html) 04:29:17 INFO - PROCESS | 11669 | RSS: Main: 243826688 04:29:17 INFO - PROCESS | 11669 | 04:32:19 INFO - PROCESS | 11669 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36202/tests/dromaeo/cssquery-mootools.html) 04:32:20 INFO - PROCESS | 11669 | RSS: Main: 249143296 04:32:20 INFO - PROCESS | 11669 | 04:35:22 INFO - PROCESS | 11669 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36202/tests/dromaeo/cssquery-prototype.html) 04:35:23 INFO - PROCESS | 11669 | RSS: Main: 184635392 04:35:23 INFO - PROCESS | 11669 | 04:38:25 INFO - PROCESS | 11669 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36202/tests/dromaeo/cssquery-yui.html) 04:38:26 INFO - PROCESS | 11669 | RSS: Main: 185720832 04:38:26 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-yui.html (next: http://localhost:36202/tests/dromaeo/cssquery-dojo.html) 04:41:29 INFO - PROCESS | 11669 | RSS: Main: 274190336 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | __start_tp_report 04:41:29 INFO - PROCESS | 11669 | _x_x_mozilla_page_load 04:41:29 INFO - PROCESS | 11669 | _x_x_mozilla_page_load_details 04:41:29 INFO - PROCESS | 11669 | |i|pagename|runs| 04:41:29 INFO - PROCESS | 11669 | |0;dojo.html;2991.56622289768;3009.458297506451;3039.5744595756582;3048.2988912550104;3057.5719399284103;5167.379914410267;5201.739913004349;5213.2701421800975;5356.437574054722;5390.110631745767;5271.4464981177;5295.549878260353;5304.071787437202;5333.946660533403;5401.567874570035;4744.335792988984;4821.951780482203;4829.68607040543;4848.612111031127;4880.170371036915;4828.903421931559;4857.902841943159;4859.076775412678;4876.512348765131;4878.0731660984475;4734.573888350048;4776.617870570363;4809.519048095198;4851.442084160331;4877.341558889558;4804.711717296974;4806.519348065165;4810.6151507879285;4820.6143508519235;4906.484819094015;4797.352357431737;4818.204996175627;4828.155072862271;4843.24929635907;4886.047220791947;5126.5898728101665;5179.378474583036;5292.814751483679;5304.575633949275;5305.522502974751;5736.541076713853;5748.827535173951;5749.856253593652;5756.30924289088;5767.942320576783;5788.623739456922;5792.971035144839;5803.303603567557;5804;5813.6802475863815;5131.435542090367;5265.578753699695;5375.677459352412;5382.757775900094;5443.292371991695;5966.612170208922;5975.342712301644;5984.491318237911;5984.521238300926;5999.610025348338;5674.1488776683;5714.3999880012;5716.399778023331;5727.541796656257;5738.454846789548;5512.118061110203;5613.607047506717;5660.094384898479;5673.432656734293;5772.105323674838;5676.148577713376;5685.744141513642;5688.0330343840815;5692.345380281238;5696.031674615326;5646.887062258814;5668.206451096849;5703.515201207943;5705.258316418839;5719.942800572025;4223.746575205498;4262.168877068942;4276.593723596254;4318.222719910446;4333.393324934512;3854.4603755474254;3858.5369755629504;3895.922081558353;3905.37513997759;3932.390479475686;5379.085555455582;5380.757865896044;5387;5389.380221274603;5440.401555828856;5596.776128954878;5651.406602306781;5673.914891276634;5728.885422291614;5733.942660573341;5453.291072160594;5453.754581043862;5460.590455715837;5486.753096110685;5499.532539734088;4945.703257804544;4967.379077615298;4975.353204083446;4978.303037574742;5026.246063090565;5729.942700573024;5777.133429985536;5831.183634291203;5911.0542313230535;5931.347551769302;5711;5712.80005199816;5716.171155182558;5738.483536481736;5763.8559036024435;5843.503302219359;5849.853753656193;5856.326522449803;5861.267341582302;5878.617889837147;5453.972730136324;5486.067368547277;5546.223528705904;5551.555875530029;5593.692346920959;5727.198192253171;5730.226419433323;5731.340895797037;5752.942470575241;5783.913241301468;5555.833325000256;5596.552275817843;5599.8880022400135;5605.5795815313195;5609.971950140386;5402.351717793733;5404.621676482609;5431.864203394946;5609.859753506032;5636.4927156556105;5461.644993075437;5473.972630136824;5490.231367608458;5520.889582208253;5537.058700021086;5476.808311709071;5515.200295957144;5516.917246241229;5566.165075238747;5566.52684521804;5300.416954134965;5343.679379237258;5351.892962140813;5393.164059570773;5443.047466693392 04:41:29 INFO - PROCESS | 11669 | |1;ext.html;593.6200831467859;617.1483352972898;623.35794132044;636.8471566823964;653.5392548253482;30583.235419114535;38601.806990965044;44004;44809.77595112028;45065.77467112668;42846.357304640456;46619.53380466194;46689.29966050512;46762.298565521545;46812.76593617027;8154.347652187811;8996.82006359874;9194.402363846362;9195.586198621044;10788.244822862403;10629.734256643607;11102.389368584765;11105.333679979187;11115.221934464591;11118.388488633122;11136.220464567483;11176.329420234772;11201.271917325388;11203.60787372442;11206.495707693173;11095.778084438307;11132.999999999918;11153.609623663215;11160.497777599987;11165.609203677914;10869.945650271698;10931.234813563055;10945.45272736368;10952.233343665946;10955.726106847313;43319.783401082794;43467.78266108681;43627.34558981618;43629.34555981631;43689.34465983013;3449.862005519776;3495.440729483296;3531.434970404723;3539.203679172191;3684.1342284563107;30405.543916841267;33373.33253334944;33571.664283357095;34100;35435.11412214689;4052.371882358239;4104.835806567734;4131.814068366931;4169.749815011079;4262.339337402707;387856;391729;393570;393626;394996;59344;60362.09456858151;60502.394976049676;60616;60662.39337606656;63151.368486314546;63274.367256327765;63314;63698;63709.36290637127;16981.83018169827;17172.39896603613;17239.22423490946;17258.395956141474;17284.135793210287;13364.198148111145;13430.127041742255;13464.192148470927;13464.528741494196;13464.596062118153;15096.622584435478;16990.32038718462;17035.914820426067;17082.914585427243;17126.14369281531;5743.655380677089;5776.624519406225;5796.449337312949;5809.448102430262;5814;933.6265493802533;945.3807755919884;988.2983082011708;1036.9688909332733;1092.202692034819;33625.32749345048;33901.49147762785;36028.459573106426;36207.818960905024;36559.81720091382;865.446114486729;1013.4527355228095;1082.8407946125903;1137.2266858536275;1232.7287996640725;16457.91771041137;17412.303507859542;17434.738478922827;17489.38787142444;17638.470845874643;579583;582692;583826;584528;584715;59281.70359148177;59338.70330648406;59345.70327148423;59351;59417.70291148517;1225.0934308611563;1361.394179590073;1378.63466181462;1397.182648150843;1409.2742237747568;32326.35347293088;33739.662603374636;34040.82979585086;34361.31277374489;34424.13939651529;50944.235836463224;51746;51749.741251293504;51805;52016.479835201164;408096;409576;409888;410010;410023;27842.721572784012;28041.43917121687;28131.43737125205;28284.575731363635;28401.857990709916;47733;48197;48907.51092489172;49089.754551227015;50178.24732629087;41291;41329.58670413258;42256.36615450709;42989.14021719486;43289.567104328555;41054.86258295437;41854.37218441665;41918;42908.853225319464;43485.782571086944;32465.35069298648;35119;42066.15867682568;42378;42658.146837062464;31327.686723132476;38744.6125538741;38864.80567597144;38898;39039.60960390473;28485.287867803472;28993.56509652399;29087.272818179714;29299.85350073236;29457.410851783272 04:41:29 INFO - PROCESS | 11669 | |2;jquery.html;362.56130082600055;372.25177393439196;383.9673627741642;388.29136825293835;410.36803322882764;15428.845711542881;17629.82370176298;19108.90445547772;19502;19774.604507909833;17826.910865445687;18110.185041673125;18262.634747305045;18281.268749250015;18301.176447059883;5727.627704199213;5825.912611310834;5966.642001479925;5971.37300583439;5973.581849270553;5694.117411801178;5755.769769209248;5779.162021506879;5852.67810270435;5855.619384739978;5588.273524441817;5793.594448388614;5800.332961709415;5814.418558144194;5816.82549523515;5749.022666146765;5776.855578610547;5783.710814459302;5791.102379131242;5826.504747096481;5155.871103222449;5172.844814655528;5173.3533308336455;6786.219584747768;7151.606661633608;24727.134550290655;25814;26011;26331.605025924626;26758.464830703473;2350.6826578411865;2394.616861302183;2496.6504689343506;2865.426914617064;3278.6721327867263;15643.374265029384;15892.966957147748;16491.17544122789;16895.746563801553;17059;2023.4435530229157;2054.845886558499;2109.314472796347;2143.6034333648327;2194.1771835561663;72559.27440725578;88133.55933220357;98406.50796745971;99255.05214634979;102907.48546257295;17180.656386872444;18079.27682892696;18346.63306733858;18402.723959140625;18495.722564161548;32239.838800805846;32516.83741581277;32560.023199304058;32582.83708581442;32707.50938735921;9986.600535978625;10178.949105254427;10198.286119971532;10390.109727603425;10445.84331235032;8352.8329433411;8656.740297791077;8660.913390866137;8956.507392093497;8962.775930601787;8688.26149777276;8743.387962842668;9037.096290371042;9100.408473449204;9206;3457.681548227553;3465.5098307727417;3515.54297941266;3521.6126226115107;3720.739548231598;919.6413398774483;994.9353292035994;1009.1170226052204;1046.99476502617;1061.0291583201285;19177.290548855013;19494;19756;19790.109445075006;20084.397468075982;971.4705485510414;984.1192133040888;992.5583115513527;1007.3905287301224;1028.8456731490337;10529.42088185157;10778.353298802096;10798.892011079788;10838;10963.83554246687;521337;532161;541991;544324;544661;68814.65592672105;90041.54979225062;97348.51325743325;97708;100270.49864750629;955.2167222877174;980.0836218135923;981.7202097402206;1011.4487604255551;1013.9493025348703;16994.405195818086;17687.82312176862;17895.821041789415;17963.461096167135;18465.90767046156;41907.161856763305;42352.97646723557;42431.36352954646;42868.78565607277;43338.349924750524;59531.107033393666;59620;60224.69887650534;60230.69884650549;62680;8350.540720260444;8479.067302596586;8634.309255259439;8773.298136148966;8811.823763524822;12064.396780161132;13098.672533186747;13108.606741797761;13243.933780331037;13411.664708382368;11740.765184696429;11777.705557361134;12018.609459808707;12060.577879774166;12200.145989780985;11390.25963312382;11391.487383067948;11646.94176529112;11803.055755539708;11935.866092721177;11769.941150294193;11795.292282462737;11904.583339583072;12060.396980151132;12183.939080304543;8410.369222308229;8428.620712067848;8678.305735541267;8706.390552661253;8706.738797836075;10754.569817207224;11127.221094523306;11725.355105469282;11849.466773995364;11942.223755455867 04:41:29 INFO - PROCESS | 11669 | |3;mootools.html;1465.1794994802908;1494.1110039526482;1651.6283836136863;1725.3443691397267;1797.3529529369432;8431.747047588575;9058.682946096871;9084.091590840913;9087.909120908796;9099.135582119705;7731.497452665572;8440.873386899186;8710.520921349324;8725.738227853159;8909;2332.276994131816;2338.6608941703444;2339;2359.8584084954873;2361.421451744325;2180.9890950545223;2206.591780520601;2208.094681180716;2210.2264207527396;2276.9658455123185;1975.8814471131707;2253.50422906961;2299.4596269876647;2306.3772781349026;2310.480141968052;2169.1323470611724;2179.705739725133;2185.344396681005;2185.967210491836;2187.453136715821;2221.1115553778454;2274.9886250568807;2275.067222438792;2278.031836469494;2281.3840263128864;8888;8892.421992570462;8910.821783564357;8931.240844528224;8949.463032218022;5078.339815823956;5083.212102124176;5121.487851214886;5147.768350424202;5149.45930677281;3129.890453834105;3212.437823380899;3288.473844184919;3293.320406592631;3304.619968703606;922.1746536849549;966.6665000574791;979.4808751361718;980.4117529482324;999.5551979369184;12264.448099835528;12296.692582685504;12346.320952347707;12386.442610082568;12448.62654120378;4357.43353364067;4555.749433781174;4667.486576476585;4684.250519916797;4740.28895665646;10544.894551054545;10550.261481696207;10560.52477638508;10561.577536898438;10566.31318964265;5240;5259.973700131475;5269.894602108013;5275.525202731773;5276.445973172838;4268.103698223408;4692.296155576691;4734.597559207437;4778.307145463888;4811.302361157613;3706.703463722896;3852.8844134676006;3855.4409610606303;3874.728768986144;3901.7463864848696;1236.4250623459955;1239.6652903715947;1239.6776838022;1240.2000709542294;1265.6203139058246;737.8598066367373;831.5925196653717;963.7060696487498;973.5764942250144;993.6273897288517;5803.216565763568;6068.878622427526;6087.4521293083835;6107.175531303306;6208.913440147956;981.455292312759;985.522021819417;985.935914165577;989.7674046599044;999.7200783780553;3880.2433525462266;3963.9801800991386;3968.8688723713603;3988.960110398917;4013.678905687538;10564.10205132557;11027.338359698444;11088.445577721082;11098.667039988813;11099.167562432689;10665.200109991627;10951.3429194247;11000.284981476178;11041.061509771598;11041.944790276159;8354.081051084377;8433.241008309158;8433.662653493915;8435.915640843636;8442.282405995558;5769.68266745333;5803.8549036274435;5921.171036055042;5931.3178984417345;5931.970340148272;9695;10076.294659373774;10094;10102.444365559964;10219.846702299323;10450.895491044992;10481.580736770444;10488.68533943983;10496.002879726413;10518.211134165122;7024.578525288294;7247.9637601811655;7273.054502914587;7638.350740187147;7732.420068494998;7117.39502142303;8072.798180045545;8532.061473237814;8610.82778344417;8733.388662793543;7269.491135620668;7413.740519081806;7526.623668816646;7656.5788881609815;7722.073351197892;7443.144038435649;7455.0681164854395;7505.549667019996;7513.699452021858;7531.962340188264;6863.553868998499;6896.241413444617;6918.135233095863;6970.477214208853;7004.264552222147;5126;5247.16045432729;5274.261603375608;5322.828977624917;5443.047466693392;5335.733213339395;5339.172428273624;5432.728363581726;5497.285352904097;5550.306211723535 04:41:29 INFO - PROCESS | 11669 | |4;prototype.html;324.4824504914662;327.96720327967205;335.7247057412921;337.3303991576721;340.4399762390867;5406.243125962368;5406.4593540645965;5421.349438067427;5421.7289135543215;5455.672659640424;5335.986162629108;5356.9732151339185;5427.592930530206;5432.293801805759;5436.91844622331;3992.6207010334115;4196.769177695225;4278.786060696961;4289.399484072233;4295.4201182840225;4199.685023623225;4212.3260278355465;4212.726172798773;4230;4242.639375653073;4144.378343248522;4152.6055024772595;4172.207280616673;4204.096119334343;4215.59951804578;4017.216642754664;4081.4694489566414;4171.416001759756;4171.687123465752;4190.622843944045;3657.5428071491065;3658.579263384718;3667.5782285037294;3670.9816450917574;3699.7420876901715;5197.532222100029;5237.16205407133;5242.973785131088;5244.921326180111;5254.185601231777;4547.08986248801;4550.840720574764;4680.251159814414;4741.596964258042;4768;5518.454832646866;5540.667559946416;5546.584006199551;5552.250446189793;5565.777368905239;4041.8585349512628;4045.7572545647354;4047.7166598338126;4054.2702313583545;4057.1885622875543;5737.320053147396;5760.164776107483;5796.652200867961;5799.565032622528;5818.2436283282905;4096.73371230869;4097.405876147942;4101.85643502476;4105.988065847773;4109;4155.252054630196;4178.185253875526;4193.412922190896;4197.916041679149;4201.663866890642;4691.601213896857;4728.905421891543;4761.809527618926;4795.880102997453;4818.734969576707;5594.622285528634;5598.972005139948;5601.983286017031;5609.1305847593685;5624.128260119688;1424.978625320621;1447.2040377792382;1453.14264583896;1454.0330680097616;1455.7889106079558;884.6299049652072;924.2144177449248;931.0642803981955;932.48247222792;948.0945696859483;4800.4719480857075;4832.661713680079;4863.270509423614;4869.70781753096;4878.829240976549;5040.873978150502;5050.4949505049935;5064.746762661852;5094.719790411489;5117.437081920985;4540.72755634663;4838.588719958772;4841.176999910023;4885.047415753894;4894.681845680019;2709.756121949034;2723.305557082931;2726.7136950619897;2734.8906043758025;2749.312671832042;5197.440767769654;5236.554892834151;5247.422783493813;5247.527722504993;5256.526912577886;4781.2350023996;5051.913838524735;5074.340335756402;5118;5118.387707872009;5233.273019903423;5269.762860671279;5276.129438642581;5282.7622756976025;5293.285406470154;5035.773390197377;5037.899242015213;5051.4443411224;5060;5120.923186152137;4810.4708482067645;5029.64792464524;5034.823781167788;5074.391073071255;5083.313752643346;5196.53231209193;5202.713850738246;5217.200065977232;5224.58203343724;5224.712640804641;3747.5197297068053;3761.8119094045737;3763.510743603314;3779.4519794629073;3784.5458544973676;4888.437829649636;5025.447200807835;5033.496650334937;5086.745662716923;5139.768710407966;4921.975390123026;4956.910548797185;4968.875778105432;4974.4579180454175;4979.701217926936;4953.72754498506;4955.2567114933045;4958.355413796184;4984.476629953802;5024.271480635361;4630.768461576975;4939.925901111558;4963.057019166346;4963.70217786934;5007.574356179765;4979.576735977483;5352.170413585901;5504.80733174337;5602.187682785891;5668.348139963792;5521.668699878021;5526.972365138148;5590.86022849432;5591.944080559305;5601 04:41:29 INFO - PROCESS | 11669 | |5;yui.html;730.346340025677;730.7551970090019;758.7496126278329;815.4984684419082;864.6541383446616;12937.223766574001;13847.09993850399;14673.339699713499;14759.409623615069;14917.552473425787;14322.069065510734;14446.422143114263;14474.927625361885;14482.42070317186;14494.782578261334;795.7930937956115;807.112176605732;808.8786681997689;809.2797410304834;809.7085049382217;659.650385295794;787.2009909941386;807.8142027333716;813.7599408174602;822.6010384963288;864.5029108262743;867.8915135608049;868.1448772958631;868.7480630617114;868.9304855611567;861.6984055580529;862.8015556422058;863.2705363967438;864.191980498233;866.0343716755772;506.3619839002846;607.3744043635063;620.2340109964191;621.7233331167632;625.2372106030635;12164.391780410944;12239.571614993522;12258.632241032783;12265.26408415498;12265.632031039084;13856.515021974183;14353.641158971004;14459.493917712829;14469.131852088803;14524.128552286897;12909.160904541268;13418.26199559024;13452.529161479399;13504.932475337659;13519.526816561372;4451.198784218839;4463.531329210451;4536.455625324949;4595.149897269016;4695.060987802419;56166;56467.15299270473;63930.360696392905;72982.27017729808;73036.63481682558;10972.890271097187;10997.230193886351;11007.559697612005;11208.607698730506;11402.315861048364;20304.89847550753;20448.38654840357;20530.589388212153;20572.485687857923;20623.8968805158;8298.21166989135;8320.875186872201;8359.247667709935;8428;8663;4636.744979026119;4675.976620116878;4730.716157030589;4769.332293478916;4787.42550893895;3493.7729047611824;3596.17288023756;3598.0824889653495;3600.6759391654878;3600.9279814403567;595.9553033522503;597.1430996520007;597.623497196772;619.2661695890384;621.0963048764128;684.5071548485083;710.7086094701251;713.6217804563589;718.5042320798632;729.1177675013188;8906.688265910661;9137.725868223964;9378.85931711025;9732.12410883024;10001.099901008944;691.6023286610118;715.506300652548;775.3603277296253;812.8902598149292;821.6877586517086;4566.680332376768;4986.152354099811;5003.674761140514;5073.746312684351;5126.256692779526;110844;113688.43155784169;113725.4313728426;113892;117988.41005794916;97408.51295743618;98103.50948245214;99469.50265248628;99714.5014274924;99931.99999999854;80388.19611803807;81070.18929810745;81326;81745.59127204445;83227;9854.11312981835;9935;9947.353422027545;9975.102240798364;10010.699679009642;48665.5133448661;50661;51022.744886276814;51278;52045.47954520558;70257.64871175612;71951.28048719655;75413;77206.6139669298;77456;12566.497340106658;12570.43433045497;12620.684482888002;12698.428570714155;12805.103642744918;14007.929960350133;14112.858871411565;14231.715365692835;14322.856771432153;14590.708185836436;12952;12965.740685186433;13137.34313284351;13259.66850828737;13520.459181632625;12974.351282435651;13053.34733263314;13199.67000824987;13358.532451364155;13411.195328280335;12568;12650.493980240688;12876.163049401759;12884.48462061507;12999.1550549214;10619.787604248026;10897.29167604135;11040.019194817514;11340.546378145113;11452.484638191134;9438.38650487716;11118.555257789598;11202.21584489078;11502.137339699724;11552.826707599224 04:41:29 INFO - PROCESS | 11669 | __end_tp_report 04:41:29 INFO - PROCESS | 11669 | __start_cc_report 04:41:29 INFO - PROCESS | 11669 | _x_x_mozilla_cycle_collect,1025 04:41:29 INFO - PROCESS | 11669 | __end_cc_report 04:41:29 INFO - PROCESS | 11669 | __startTimestamp1469101289251__endTimestamp 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | ------- Summary: start ------- 04:41:29 INFO - PROCESS | 11669 | Number of tests: 6 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | [#0] dojo.html Cycles:165 Average:5287.23 Median:5461.64 stddev:614.91 (11.3%) stddev-sans-first:589.84 04:41:29 INFO - PROCESS | 11669 | Values: 2991.6 3009.5 3039.6 3048.3 3057.6 5167.4 5201.7 5213.3 5356.4 5390.1 5271.4 5295.5 5304.1 5333.9 5401.6 4744.3 4822.0 4829.7 4848.6 4880.2 4828.9 4857.9 4859.1 4876.5 4878.1 4734.6 4776.6 4809.5 4851.4 4877.3 4804.7 4806.5 4810.6 4820.6 4906.5 4797.4 4818.2 4828.2 4843.2 4886.0 5126.6 5179.4 5292.8 5304.6 5305.5 5736.5 5748.8 5749.9 5756.3 5767.9 5788.6 5793.0 5803.3 5804.0 5813.7 5131.4 5265.6 5375.7 5382.8 5443.3 5966.6 5975.3 5984.5 5984.5 5999.6 5674.1 5714.4 5716.4 5727.5 5738.5 5512.1 5613.6 5660.1 5673.4 5772.1 5676.1 5685.7 5688.0 5692.3 5696.0 5646.9 5668.2 5703.5 5705.3 5719.9 4223.7 4262.2 4276.6 4318.2 4333.4 3854.5 3858.5 3895.9 3905.4 3932.4 5379.1 5380.8 5387.0 5389.4 5440.4 5596.8 5651.4 5673.9 5728.9 5733.9 5453.3 5453.8 5460.6 5486.8 5499.5 4945.7 4967.4 4975.4 4978.3 5026.2 5729.9 5777.1 5831.2 5911.1 5931.3 5711.0 5712.8 5716.2 5738.5 5763.9 5843.5 5849.9 5856.3 5861.3 5878.6 5454.0 5486.1 5546.2 5551.6 5593.7 5727.2 5730.2 5731.3 5752.9 5783.9 5555.8 5596.6 5599.9 5605.6 5610.0 5402.4 5404.6 5431.9 5609.9 5636.5 5461.6 5474.0 5490.2 5520.9 5537.1 5476.8 5515.2 5516.9 5566.2 5566.5 5300.4 5343.7 5351.9 5393.2 5443.0 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | [#1] ext.html Cycles:180 Average:62628.92 Median:38968.80 stddev:124587.98 (319.7%) stddev-sans-first:124850.41 04:41:29 INFO - PROCESS | 11669 | Values: 593.6 617.1 623.4 636.8 653.5 30583.2 38601.8 44004.0 44809.8 45065.8 42846.4 46619.5 46689.3 46762.3 46812.8 8154.3 8996.8 9194.4 9195.6 10788.2 10629.7 11102.4 11105.3 11115.2 11118.4 11136.2 11176.3 11201.3 11203.6 11206.5 11095.8 11133.0 11153.6 11160.5 11165.6 10869.9 10931.2 10945.5 10952.2 10955.7 43319.8 43467.8 43627.3 43629.3 43689.3 3449.9 3495.4 3531.4 3539.2 3684.1 30405.5 33373.3 33571.7 34100.0 35435.1 4052.4 4104.8 4131.8 4169.7 4262.3 387856.0 391729.0 393570.0 393626.0 394996.0 59344.0 60362.1 60502.4 60616.0 60662.4 63151.4 63274.4 63314.0 63698.0 63709.4 16981.8 17172.4 17239.2 17258.4 17284.1 13364.2 13430.1 13464.2 13464.5 13464.6 15096.6 16990.3 17035.9 17082.9 17126.1 5743.7 5776.6 5796.4 5809.4 5814.0 933.6 945.4 988.3 1037.0 1092.2 33625.3 33901.5 36028.5 36207.8 36559.8 865.4 1013.5 1082.8 1137.2 1232.7 16457.9 17412.3 17434.7 17489.4 17638.5 579583.0 582692.0 583826.0 584528.0 584715.0 59281.7 59338.7 59345.7 59351.0 59417.7 1225.1 1361.4 1378.6 1397.2 1409.3 32326.4 33739.7 34040.8 34361.3 34424.1 50944.2 51746.0 51749.7 51805.0 52016.5 408096.0 409576.0 409888.0 410010.0 410023.0 27842.7 28041.4 28131.4 28284.6 28401.9 47733.0 48197.0 48907.5 49089.8 50178.2 41291.0 41329.6 42256.4 42989.1 43289.6 41054.9 41854.4 41918.0 42908.9 43485.8 32465.4 35119.0 42066.2 42378.0 42658.1 31327.7 38744.6 38864.8 38898.0 39039.6 28485.3 28993.6 29087.3 29299.9 29457.4 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | [#2] jquery.html Cycles:180 Average:31849.37 Median:32645.17 stddev:88350.46 (270.6%) stddev-sans-first:88566.68 04:41:29 INFO - PROCESS | 11669 | Values: 362.6 372.3 384.0 388.3 410.4 15428.8 17629.8 19108.9 19502.0 19774.6 17826.9 18110.2 18262.6 18281.3 18301.2 5727.6 5825.9 5966.6 5971.4 5973.6 5694.1 5755.8 5779.2 5852.7 5855.6 5588.3 5793.6 5800.3 5814.4 5816.8 5749.0 5776.9 5783.7 5791.1 5826.5 5155.9 5172.8 5173.4 6786.2 7151.6 24727.1 25814.0 26011.0 26331.6 26758.5 2350.7 2394.6 2496.7 2865.4 3278.7 15643.4 15893.0 16491.2 16895.7 17059.0 2023.4 2054.8 2109.3 2143.6 2194.2 72559.3 88133.6 98406.5 99255.1 102907.5 17180.7 18079.3 18346.6 18402.7 18495.7 32239.8 32516.8 32560.0 32582.8 32707.5 9986.6 10178.9 10198.3 10390.1 10445.8 8352.8 8656.7 8660.9 8956.5 8962.8 8688.3 8743.4 9037.1 9100.4 9206.0 3457.7 3465.5 3515.5 3521.6 3720.7 919.6 994.9 1009.1 1047.0 1061.0 19177.3 19494.0 19756.0 19790.1 20084.4 971.5 984.1 992.6 1007.4 1028.8 10529.4 10778.4 10798.9 10838.0 10963.8 521337.0 532161.0 541991.0 544324.0 544661.0 68814.7 90041.5 97348.5 97708.0 100270.5 955.2 980.1 981.7 1011.4 1013.9 16994.4 17687.8 17895.8 17963.5 18465.9 41907.2 42353.0 42431.4 42868.8 43338.3 59531.1 59620.0 60224.7 60230.7 62680.0 8350.5 8479.1 8634.3 8773.3 8811.8 12064.4 13098.7 13108.6 13243.9 13411.7 11740.8 11777.7 12018.6 12060.6 12200.1 11390.3 11391.5 11646.9 11803.1 11935.9 11769.9 11795.3 11904.6 12060.4 12183.9 8410.4 8428.6 8678.3 8706.4 8706.7 10754.6 11127.2 11725.4 11849.5 11942.2 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | [#3] mootools.html Cycles:180 Average:5776.80 Median:5102.35 stddev:3335.42 (65.4%) stddev-sans-first:3329.04 04:41:29 INFO - PROCESS | 11669 | Values: 1465.2 1494.1 1651.6 1725.3 1797.4 8431.7 9058.7 9084.1 9087.9 9099.1 7731.5 8440.9 8710.5 8725.7 8909.0 2332.3 2338.7 2339.0 2359.9 2361.4 2181.0 2206.6 2208.1 2210.2 2277.0 1975.9 2253.5 2299.5 2306.4 2310.5 2169.1 2179.7 2185.3 2186.0 2187.5 2221.1 2275.0 2275.1 2278.0 2281.4 8888.0 8892.4 8910.8 8931.2 8949.5 5078.3 5083.2 5121.5 5147.8 5149.5 3129.9 3212.4 3288.5 3293.3 3304.6 922.2 966.7 979.5 980.4 999.6 12264.4 12296.7 12346.3 12386.4 12448.6 4357.4 4555.7 4667.5 4684.3 4740.3 10544.9 10550.3 10560.5 10561.6 10566.3 5240.0 5260.0 5269.9 5275.5 5276.4 4268.1 4692.3 4734.6 4778.3 4811.3 3706.7 3852.9 3855.4 3874.7 3901.7 1236.4 1239.7 1239.7 1240.2 1265.6 737.9 831.6 963.7 973.6 993.6 5803.2 6068.9 6087.5 6107.2 6208.9 981.5 985.5 985.9 989.8 999.7 3880.2 3964.0 3968.9 3989.0 4013.7 10564.1 11027.3 11088.4 11098.7 11099.2 10665.2 10951.3 11000.3 11041.1 11041.9 8354.1 8433.2 8433.7 8435.9 8442.3 5769.7 5803.9 5921.2 5931.3 5932.0 9695.0 10076.3 10094.0 10102.4 10219.8 10450.9 10481.6 10488.7 10496.0 10518.2 7024.6 7248.0 7273.1 7638.4 7732.4 7117.4 8072.8 8532.1 8610.8 8733.4 7269.5 7413.7 7526.6 7656.6 7722.1 7443.1 7455.1 7505.5 7513.7 7532.0 6863.6 6896.2 6918.1 6970.5 7004.3 5126.0 5247.2 5274.3 5322.8 5443.0 5335.7 5339.2 5432.7 5497.3 5550.3 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | [#4] prototype.html Cycles:180 Average:4465.22 Median:4963.38 stddev:1261.61 (25.4%) stddev-sans-first:1226.27 04:41:29 INFO - PROCESS | 11669 | Values: 324.5 328.0 335.7 337.3 340.4 5406.2 5406.5 5421.3 5421.7 5455.7 5336.0 5357.0 5427.6 5432.3 5436.9 3992.6 4196.8 4278.8 4289.4 4295.4 4199.7 4212.3 4212.7 4230.0 4242.6 4144.4 4152.6 4172.2 4204.1 4215.6 4017.2 4081.5 4171.4 4171.7 4190.6 3657.5 3658.6 3667.6 3671.0 3699.7 5197.5 5237.2 5243.0 5244.9 5254.2 4547.1 4550.8 4680.3 4741.6 4768.0 5518.5 5540.7 5546.6 5552.3 5565.8 4041.9 4045.8 4047.7 4054.3 4057.2 5737.3 5760.2 5796.7 5799.6 5818.2 4096.7 4097.4 4101.9 4106.0 4109.0 4155.3 4178.2 4193.4 4197.9 4201.7 4691.6 4728.9 4761.8 4795.9 4818.7 5594.6 5599.0 5602.0 5609.1 5624.1 1425.0 1447.2 1453.1 1454.0 1455.8 884.6 924.2 931.1 932.5 948.1 4800.5 4832.7 4863.3 4869.7 4878.8 5040.9 5050.5 5064.7 5094.7 5117.4 4540.7 4838.6 4841.2 4885.0 4894.7 2709.8 2723.3 2726.7 2734.9 2749.3 5197.4 5236.6 5247.4 5247.5 5256.5 4781.2 5051.9 5074.3 5118.0 5118.4 5233.3 5269.8 5276.1 5282.8 5293.3 5035.8 5037.9 5051.4 5060.0 5120.9 4810.5 5029.6 5034.8 5074.4 5083.3 5196.5 5202.7 5217.2 5224.6 5224.7 3747.5 3761.8 3763.5 3779.5 3784.5 4888.4 5025.4 5033.5 5086.7 5139.8 4922.0 4956.9 4968.9 4974.5 4979.7 4953.7 4955.3 4958.4 4984.5 5024.3 4630.8 4939.9 4963.1 4963.7 5007.6 4979.6 5352.2 5504.8 5602.2 5668.3 5521.7 5527.0 5590.9 5591.9 5601.0 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - PROCESS | 11669 | [#5] yui.html Cycles:180 Average:20135.83 Median:4778.38 stddev:29018.99 (607.3%) stddev-sans-first:29063.82 04:41:29 INFO - PROCESS | 11669 | Values: 730.3 730.8 758.7 815.5 864.7 12937.2 13847.1 14673.3 14759.4 14917.6 14322.1 14446.4 14474.9 14482.4 14494.8 795.8 807.1 808.9 809.3 809.7 659.7 787.2 807.8 813.8 822.6 864.5 867.9 868.1 868.7 868.9 861.7 862.8 863.3 864.2 866.0 506.4 607.4 620.2 621.7 625.2 12164.4 12239.6 12258.6 12265.3 12265.6 13856.5 14353.6 14459.5 14469.1 14524.1 12909.2 13418.3 13452.5 13504.9 13519.5 4451.2 4463.5 4536.5 4595.1 4695.1 56166.0 56467.2 63930.4 72982.3 73036.6 10972.9 10997.2 11007.6 11208.6 11402.3 20304.9 20448.4 20530.6 20572.5 20623.9 8298.2 8320.9 8359.2 8428.0 8663.0 4636.7 4676.0 4730.7 4769.3 4787.4 3493.8 3596.2 3598.1 3600.7 3600.9 596.0 597.1 597.6 619.3 621.1 684.5 710.7 713.6 718.5 729.1 8906.7 9137.7 9378.9 9732.1 10001.1 691.6 715.5 775.4 812.9 821.7 4566.7 4986.2 5003.7 5073.7 5126.3 110844.0 113688.4 113725.4 113892.0 117988.4 97408.5 98103.5 99469.5 99714.5 99932.0 80388.2 81070.2 81326.0 81745.6 83227.0 9854.1 9935.0 9947.4 9975.1 10010.7 48665.5 50661.0 51022.7 51278.0 52045.5 70257.6 71951.3 75413.0 77206.6 77456.0 12566.5 12570.4 12620.7 12698.4 12805.1 14007.9 14112.9 14231.7 14322.9 14590.7 12952.0 12965.7 13137.3 13259.7 13520.5 12974.4 13053.3 13199.7 13358.5 13411.2 12568.0 12650.5 12876.2 12884.5 12999.2 10619.8 10897.3 11040.0 11340.5 11452.5 9438.4 11118.6 11202.2 11502.1 11552.8 04:41:29 INFO - PROCESS | 11669 | -------- Summary: end -------- 04:41:29 INFO - PROCESS | 11669 | 04:41:29 INFO - TEST-INFO | 11669: exit 0 04:41:29 INFO - TEST-OK | dromaeo_css | took 1112655ms 04:41:29 INFO - TEST-START | kraken 04:41:30 INFO - operating with platform_type : linux_ 04:41:30 INFO - Initialising browser for kraken test... 04:41:30 INFO - TEST-INFO | started process 11861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmRNaR/profile http://localhost:36202/getInfo.html) 04:41:33 INFO - PROCESS | 11861 | __metrics Screen width/height:1600/1200 04:41:33 INFO - PROCESS | 11861 | colorDepth:24 04:41:33 INFO - PROCESS | 11861 | Browser inner width/height: 1024/697 04:41:33 INFO - PROCESS | 11861 | __metrics 04:41:34 INFO - PROCESS | 11861 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:41:34 INFO - PROCESS | 11861 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:35 INFO - TEST-INFO | 11861: exit 0 04:41:35 INFO - Browser initialized. 04:41:35 INFO - Running cycle 1/1 for kraken test... 04:41:35 INFO - TEST-INFO | started process 11944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmRNaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:47 INFO - PROCESS | 11944 | RSS: Main: 157622272 04:41:47 INFO - PROCESS | 11944 | 04:41:49 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:50 INFO - PROCESS | 11944 | RSS: Main: 213835776 04:41:50 INFO - PROCESS | 11944 | 04:41:52 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-dft) 04:41:53 INFO - PROCESS | 11944 | RSS: Main: 192323584 04:41:53 INFO - PROCESS | 11944 | 04:41:56 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-fft) 04:41:57 INFO - PROCESS | 11944 | RSS: Main: 269926400 04:41:57 INFO - PROCESS | 11944 | 04:41:59 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-oscillator) 04:42:00 INFO - PROCESS | 11944 | RSS: Main: 180084736 04:42:00 INFO - PROCESS | 11944 | 04:42:02 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:02 INFO - PROCESS | 11944 | RSS: Main: 184782848 04:42:02 INFO - PROCESS | 11944 | 04:42:05 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36202/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:06 INFO - PROCESS | 11944 | RSS: Main: 219738112 04:42:06 INFO - PROCESS | 11944 | 04:42:09 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36202/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:10 INFO - PROCESS | 11944 | RSS: Main: 220172288 04:42:10 INFO - PROCESS | 11944 | 04:42:13 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36202/tests/kraken/driver.html?testName=json-parse-financial) 04:42:13 INFO - PROCESS | 11944 | RSS: Main: 220852224 04:42:13 INFO - PROCESS | 11944 | 04:42:15 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:16 INFO - PROCESS | 11944 | RSS: Main: 184840192 04:42:16 INFO - PROCESS | 11944 | 04:42:17 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:18 INFO - PROCESS | 11944 | RSS: Main: 189059072 04:42:18 INFO - PROCESS | 11944 | 04:42:20 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:21 INFO - PROCESS | 11944 | RSS: Main: 194580480 04:42:21 INFO - PROCESS | 11944 | 04:42:23 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:24 INFO - PROCESS | 11944 | RSS: Main: 189276160 04:42:24 INFO - PROCESS | 11944 | 04:42:26 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:27 INFO - PROCESS | 11944 | RSS: Main: 193261568 04:42:27 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36202/tests/kraken/driver.html?testName=ai-astar) 04:42:29 INFO - PROCESS | 11944 | RSS: Main: 244084736 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | __start_tp_report 04:42:29 INFO - PROCESS | 11944 | _x_x_mozilla_page_load 04:42:29 INFO - PROCESS | 11944 | _x_x_mozilla_page_load_details 04:42:29 INFO - PROCESS | 11944 | |i|pagename|runs| 04:42:29 INFO - PROCESS | 11944 | |0;ai-astar;101;118;111;111;111;112;110;112;110;110 04:42:29 INFO - PROCESS | 11944 | |1;audio-beat-detection;144;117;119;184;122;118;144;121;157;121 04:42:29 INFO - PROCESS | 11944 | |2;audio-dft;162;161;162;160;163;163;162;162;160;161 04:42:29 INFO - PROCESS | 11944 | |3;audio-fft;75;76;77;114;75;74;74;75;101;75 04:42:29 INFO - PROCESS | 11944 | |4;audio-oscillator;84;86;118;84;84;85;121;83;84;129 04:42:29 INFO - PROCESS | 11944 | |5;imaging-gaussian-blur;117;118;117;118;118;118;117;117;118;117 04:42:29 INFO - PROCESS | 11944 | |6;imaging-darkroom;146;146;146;146;147;146;145;145;146;146 04:42:29 INFO - PROCESS | 11944 | |7;imaging-desaturate;95;96;95;96;95;95;96;96;95;95 04:42:29 INFO - PROCESS | 11944 | |8;json-parse-financial;54;52;51;51;52;53;54;51;52;51 04:42:29 INFO - PROCESS | 11944 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;66;65;64 04:42:29 INFO - PROCESS | 11944 | |10;stanford-crypto-aes;77;77;76;76;85;79;81;76;79;78 04:42:29 INFO - PROCESS | 11944 | |11;stanford-crypto-ccm;135;127;122;135;121;131;135;119;213;120 04:42:29 INFO - PROCESS | 11944 | |12;stanford-crypto-pbkdf2;161;159;160;157;158;157;159;166;158;162 04:42:29 INFO - PROCESS | 11944 | |13;stanford-crypto-sha256-iterative;67;67;64;63;62;63;63;62;62;61 04:42:29 INFO - PROCESS | 11944 | __end_tp_report 04:42:29 INFO - PROCESS | 11944 | __start_cc_report 04:42:29 INFO - PROCESS | 11944 | _x_x_mozilla_cycle_collect,1668 04:42:29 INFO - PROCESS | 11944 | __end_cc_report 04:42:29 INFO - PROCESS | 11944 | __startTimestamp1469101349505__endTimestamp 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | ------- Summary: start ------- 04:42:29 INFO - PROCESS | 11944 | Number of tests: 14 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:2.50 04:42:29 INFO - PROCESS | 11944 | Values: 101.0 118.0 111.0 111.0 111.0 112.0 110.0 112.0 110.0 110.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:133.00 stddev:22.30 (16.8%) stddev-sans-first:23.40 04:42:29 INFO - PROCESS | 11944 | Values: 144.0 117.0 119.0 184.0 122.0 118.0 144.0 121.0 157.0 121.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 04:42:29 INFO - PROCESS | 11944 | Values: 162.0 161.0 162.0 160.0 163.0 163.0 162.0 162.0 160.0 161.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:14.02 (18.7%) stddev-sans-first:14.66 04:42:29 INFO - PROCESS | 11944 | Values: 75.0 76.0 77.0 114.0 75.0 74.0 74.0 75.0 101.0 75.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.00 stddev:18.75 (22.3%) stddev-sans-first:19.39 04:42:29 INFO - PROCESS | 11944 | Values: 84.0 86.0 118.0 84.0 84.0 85.0 121.0 83.0 84.0 129.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:42:29 INFO - PROCESS | 11944 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:42:29 INFO - PROCESS | 11944 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 145.0 145.0 146.0 146.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:42:29 INFO - PROCESS | 11944 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.20 (2.3%) stddev-sans-first:1.05 04:42:29 INFO - PROCESS | 11944 | Values: 54.0 52.0 51.0 51.0 52.0 53.0 54.0 51.0 52.0 51.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:42:29 INFO - PROCESS | 11944 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 66.0 65.0 64.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:2.84 (3.6%) stddev-sans-first:2.96 04:42:29 INFO - PROCESS | 11944 | Values: 77.0 77.0 76.0 76.0 85.0 79.0 81.0 76.0 79.0 78.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:133.00 stddev:27.90 (21.0%) stddev-sans-first:29.59 04:42:29 INFO - PROCESS | 11944 | Values: 135.0 127.0 122.0 135.0 121.0 131.0 135.0 119.0 213.0 120.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:159.50 stddev:2.75 (1.7%) stddev-sans-first:2.88 04:42:29 INFO - PROCESS | 11944 | Values: 161.0 159.0 160.0 157.0 158.0 157.0 159.0 166.0 158.0 162.0 04:42:29 INFO - PROCESS | 11944 | 04:42:29 INFO - PROCESS | 11944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:1.73 04:42:29 INFO - PROCESS | 11944 | Values: 67.0 67.0 64.0 63.0 62.0 63.0 63.0 62.0 62.0 61.0 04:42:29 INFO - PROCESS | 11944 | -------- Summary: end -------- 04:42:29 INFO - PROCESS | 11944 | 04:42:30 INFO - TEST-INFO | 11944: exit 0 04:42:30 INFO - TEST-OK | kraken | took 60515ms 04:42:30 INFO - SUITE-END | took 1173s 04:42:30 INFO - Completed test suite (00:19:33) 04:42:30 INFO - javascript benchmark 04:42:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2991.56622289768, 3009.458297506451, 3039.5744595756582, 3048.2988912550104, 3057.5719399284103, 5167.379914410267, 5201.739913004349, 5213.2701421800975, 5356.437574054722, 5390.110631745767, 5271.4464981177, 5295.549878260353, 5304.071787437202, 5333.946660533403, 5401.567874570035, 4744.335792988984, 4821.951780482203, 4829.68607040543, 4848.612111031127, 4880.170371036915, 4828.903421931559, 4857.902841943159, 4859.076775412678, 4876.512348765131, 4878.0731660984475, 4734.573888350048, 4776.617870570363, 4809.519048095198, 4851.442084160331, 4877.341558889558, 4804.711717296974, 4806.519348065165, 4810.6151507879285, 4820.6143508519235, 4906.484819094015, 4797.352357431737, 4818.204996175627, 4828.155072862271, 4843.24929635907, 4886.047220791947, 5126.5898728101665, 5179.378474583036, 5292.814751483679, 5304.575633949275, 5305.522502974751, 5736.541076713853, 5748.827535173951, 5749.856253593652, 5756.30924289088, 5767.942320576783, 5788.623739456922, 5792.971035144839, 5803.303603567557, 5804.0, 5813.6802475863815, 5131.435542090367, 5265.578753699695, 5375.677459352412, 5382.757775900094, 5443.292371991695, 5966.612170208922, 5975.342712301644, 5984.491318237911, 5984.521238300926, 5999.610025348338, 5674.1488776683, 5714.3999880012, 5716.399778023331, 5727.541796656257, 5738.454846789548, 5512.118061110203, 5613.607047506717, 5660.094384898479, 5673.432656734293, 5772.105323674838, 5676.148577713376, 5685.744141513642, 5688.0330343840815, 5692.345380281238, 5696.031674615326, 5646.887062258814, 5668.206451096849, 5703.515201207943, 5705.258316418839, 5719.942800572025, 4223.746575205498, 4262.168877068942, 4276.593723596254, 4318.222719910446, 4333.393324934512, 3854.4603755474254, 3858.5369755629504, 3895.922081558353, 3905.37513997759, 3932.390479475686, 5379.085555455582, 5380.757865896044, 5387.0, 5389.380221274603, 5440.401555828856, 5596.776128954878, 5651.406602306781, 5673.914891276634, 5728.885422291614, 5733.942660573341, 5453.291072160594, 5453.754581043862, 5460.590455715837, 5486.753096110685, 5499.532539734088, 4945.703257804544, 4967.379077615298, 4975.353204083446, 4978.303037574742, 5026.246063090565, 5729.942700573024, 5777.133429985536, 5831.183634291203, 5911.0542313230535, 5931.347551769302, 5711.0, 5712.80005199816, 5716.171155182558, 5738.483536481736, 5763.8559036024435, 5843.503302219359, 5849.853753656193, 5856.326522449803, 5861.267341582302, 5878.617889837147, 5453.972730136324, 5486.067368547277, 5546.223528705904, 5551.555875530029, 5593.692346920959, 5727.198192253171, 5730.226419433323, 5731.340895797037, 5752.942470575241, 5783.913241301468, 5555.833325000256, 5596.552275817843, 5599.8880022400135, 5605.5795815313195, 5609.971950140386, 5402.351717793733, 5404.621676482609, 5431.864203394946, 5609.859753506032, 5636.4927156556105, 5461.644993075437, 5473.972630136824, 5490.231367608458, 5520.889582208253, 5537.058700021086, 5476.808311709071, 5515.200295957144, 5516.917246241229, 5566.165075238747, 5566.52684521804, 5300.416954134965, 5343.679379237258, 5351.892962140813, 5393.164059570773, 5443.047466693392], "value": 5244.533153573811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.6200831467859, 617.1483352972898, 623.35794132044, 636.8471566823964, 653.5392548253482, 30583.235419114535, 38601.806990965044, 44004.0, 44809.77595112028, 45065.77467112668, 42846.357304640456, 46619.53380466194, 46689.29966050512, 46762.298565521545, 46812.76593617027, 8154.347652187811, 8996.82006359874, 9194.402363846362, 9195.586198621044, 10788.244822862403, 10629.734256643607, 11102.389368584765, 11105.333679979187, 11115.221934464591, 11118.388488633122, 11136.220464567483, 11176.329420234772, 11201.271917325388, 11203.60787372442, 11206.495707693173, 11095.778084438307, 11132.999999999918, 11153.609623663215, 11160.497777599987, 11165.609203677914, 10869.945650271698, 10931.234813563055, 10945.45272736368, 10952.233343665946, 10955.726106847313, 43319.783401082794, 43467.78266108681, 43627.34558981618, 43629.34555981631, 43689.34465983013, 3449.862005519776, 3495.440729483296, 3531.434970404723, 3539.203679172191, 3684.1342284563107, 30405.543916841267, 33373.33253334944, 33571.664283357095, 34100.0, 35435.11412214689, 4052.371882358239, 4104.835806567734, 4131.814068366931, 4169.749815011079, 4262.339337402707, 387856.0, 391729.0, 393570.0, 393626.0, 394996.0, 59344.0, 60362.09456858151, 60502.394976049676, 60616.0, 60662.39337606656, 63151.368486314546, 63274.367256327765, 63314.0, 63698.0, 63709.36290637127, 16981.83018169827, 17172.39896603613, 17239.22423490946, 17258.395956141474, 17284.135793210287, 13364.198148111145, 13430.127041742255, 13464.192148470927, 13464.528741494196, 13464.596062118153, 15096.622584435478, 16990.32038718462, 17035.914820426067, 17082.914585427243, 17126.14369281531, 5743.655380677089, 5776.624519406225, 5796.449337312949, 5809.448102430262, 5814.0, 933.6265493802533, 945.3807755919884, 988.2983082011708, 1036.9688909332733, 1092.202692034819, 33625.32749345048, 33901.49147762785, 36028.459573106426, 36207.818960905024, 36559.81720091382, 865.446114486729, 1013.4527355228095, 1082.8407946125903, 1137.2266858536275, 1232.7287996640725, 16457.91771041137, 17412.303507859542, 17434.738478922827, 17489.38787142444, 17638.470845874643, 579583.0, 582692.0, 583826.0, 584528.0, 584715.0, 59281.70359148177, 59338.70330648406, 59345.70327148423, 59351.0, 59417.70291148517, 1225.0934308611563, 1361.394179590073, 1378.63466181462, 1397.182648150843, 1409.2742237747568, 32326.35347293088, 33739.662603374636, 34040.82979585086, 34361.31277374489, 34424.13939651529, 50944.235836463224, 51746.0, 51749.741251293504, 51805.0, 52016.479835201164, 408096.0, 409576.0, 409888.0, 410010.0, 410023.0, 27842.721572784012, 28041.43917121687, 28131.43737125205, 28284.575731363635, 28401.857990709916, 47733.0, 48197.0, 48907.51092489172, 49089.754551227015, 50178.24732629087, 41291.0, 41329.58670413258, 42256.36615450709, 42989.14021719486, 43289.567104328555, 41054.86258295437, 41854.37218441665, 41918.0, 42908.853225319464, 43485.782571086944, 32465.35069298648, 35119.0, 42066.15867682568, 42378.0, 42658.146837062464, 31327.686723132476, 38744.6125538741, 38864.80567597144, 38898.0, 39039.60960390473, 28485.287867803472, 28993.56509652399, 29087.272818179714, 29299.85350073236, 29457.410851783272], "value": 20756.901164352796, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.56130082600055, 372.25177393439196, 383.9673627741642, 388.29136825293835, 410.36803322882764, 15428.845711542881, 17629.82370176298, 19108.90445547772, 19502.0, 19774.604507909833, 17826.910865445687, 18110.185041673125, 18262.634747305045, 18281.268749250015, 18301.176447059883, 5727.627704199213, 5825.912611310834, 5966.642001479925, 5971.37300583439, 5973.581849270553, 5694.117411801178, 5755.769769209248, 5779.162021506879, 5852.67810270435, 5855.619384739978, 5588.273524441817, 5793.594448388614, 5800.332961709415, 5814.418558144194, 5816.82549523515, 5749.022666146765, 5776.855578610547, 5783.710814459302, 5791.102379131242, 5826.504747096481, 5155.871103222449, 5172.844814655528, 5173.3533308336455, 6786.219584747768, 7151.606661633608, 24727.134550290655, 25814.0, 26011.0, 26331.605025924626, 26758.464830703473, 2350.6826578411865, 2394.616861302183, 2496.6504689343506, 2865.426914617064, 3278.6721327867263, 15643.374265029384, 15892.966957147748, 16491.17544122789, 16895.746563801553, 17059.0, 2023.4435530229157, 2054.845886558499, 2109.314472796347, 2143.6034333648327, 2194.1771835561663, 72559.27440725578, 88133.55933220357, 98406.50796745971, 99255.05214634979, 102907.48546257295, 17180.656386872444, 18079.27682892696, 18346.63306733858, 18402.723959140625, 18495.722564161548, 32239.838800805846, 32516.83741581277, 32560.023199304058, 32582.83708581442, 32707.50938735921, 9986.600535978625, 10178.949105254427, 10198.286119971532, 10390.109727603425, 10445.84331235032, 8352.8329433411, 8656.740297791077, 8660.913390866137, 8956.507392093497, 8962.775930601787, 8688.26149777276, 8743.387962842668, 9037.096290371042, 9100.408473449204, 9206.0, 3457.681548227553, 3465.5098307727417, 3515.54297941266, 3521.6126226115107, 3720.739548231598, 919.6413398774483, 994.9353292035994, 1009.1170226052204, 1046.99476502617, 1061.0291583201285, 19177.290548855013, 19494.0, 19756.0, 19790.109445075006, 20084.397468075982, 971.4705485510414, 984.1192133040888, 992.5583115513527, 1007.3905287301224, 1028.8456731490337, 10529.42088185157, 10778.353298802096, 10798.892011079788, 10838.0, 10963.83554246687, 521337.0, 532161.0, 541991.0, 544324.0, 544661.0, 68814.65592672105, 90041.54979225062, 97348.51325743325, 97708.0, 100270.49864750629, 955.2167222877174, 980.0836218135923, 981.7202097402206, 1011.4487604255551, 1013.9493025348703, 16994.405195818086, 17687.82312176862, 17895.821041789415, 17963.461096167135, 18465.90767046156, 41907.161856763305, 42352.97646723557, 42431.36352954646, 42868.78565607277, 43338.349924750524, 59531.107033393666, 59620.0, 60224.69887650534, 60230.69884650549, 62680.0, 8350.540720260444, 8479.067302596586, 8634.309255259439, 8773.298136148966, 8811.823763524822, 12064.396780161132, 13098.672533186747, 13108.606741797761, 13243.933780331037, 13411.664708382368, 11740.765184696429, 11777.705557361134, 12018.609459808707, 12060.577879774166, 12200.145989780985, 11390.25963312382, 11391.487383067948, 11646.94176529112, 11803.055755539708, 11935.866092721177, 11769.941150294193, 11795.292282462737, 11904.583339583072, 12060.396980151132, 12183.939080304543, 8410.369222308229, 8428.620712067848, 8678.305735541267, 8706.390552661253, 8706.738797836075, 10754.569817207224, 11127.221094523306, 11725.355105469282, 11849.466773995364, 11942.223755455867], "value": 10281.09748197667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.1794994802908, 1494.1110039526482, 1651.6283836136863, 1725.3443691397267, 1797.3529529369432, 8431.747047588575, 9058.682946096871, 9084.091590840913, 9087.909120908796, 9099.135582119705, 7731.497452665572, 8440.873386899186, 8710.520921349324, 8725.738227853159, 8909.0, 2332.276994131816, 2338.6608941703444, 2339.0, 2359.8584084954873, 2361.421451744325, 2180.9890950545223, 2206.591780520601, 2208.094681180716, 2210.2264207527396, 2276.9658455123185, 1975.8814471131707, 2253.50422906961, 2299.4596269876647, 2306.3772781349026, 2310.480141968052, 2169.1323470611724, 2179.705739725133, 2185.344396681005, 2185.967210491836, 2187.453136715821, 2221.1115553778454, 2274.9886250568807, 2275.067222438792, 2278.031836469494, 2281.3840263128864, 8888.0, 8892.421992570462, 8910.821783564357, 8931.240844528224, 8949.463032218022, 5078.339815823956, 5083.212102124176, 5121.487851214886, 5147.768350424202, 5149.45930677281, 3129.890453834105, 3212.437823380899, 3288.473844184919, 3293.320406592631, 3304.619968703606, 922.1746536849549, 966.6665000574791, 979.4808751361718, 980.4117529482324, 999.5551979369184, 12264.448099835528, 12296.692582685504, 12346.320952347707, 12386.442610082568, 12448.62654120378, 4357.43353364067, 4555.749433781174, 4667.486576476585, 4684.250519916797, 4740.28895665646, 10544.894551054545, 10550.261481696207, 10560.52477638508, 10561.577536898438, 10566.31318964265, 5240.0, 5259.973700131475, 5269.894602108013, 5275.525202731773, 5276.445973172838, 4268.103698223408, 4692.296155576691, 4734.597559207437, 4778.307145463888, 4811.302361157613, 3706.703463722896, 3852.8844134676006, 3855.4409610606303, 3874.728768986144, 3901.7463864848696, 1236.4250623459955, 1239.6652903715947, 1239.6776838022, 1240.2000709542294, 1265.6203139058246, 737.8598066367373, 831.5925196653717, 963.7060696487498, 973.5764942250144, 993.6273897288517, 5803.216565763568, 6068.878622427526, 6087.4521293083835, 6107.175531303306, 6208.913440147956, 981.455292312759, 985.522021819417, 985.935914165577, 989.7674046599044, 999.7200783780553, 3880.2433525462266, 3963.9801800991386, 3968.8688723713603, 3988.960110398917, 4013.678905687538, 10564.10205132557, 11027.338359698444, 11088.445577721082, 11098.667039988813, 11099.167562432689, 10665.200109991627, 10951.3429194247, 11000.284981476178, 11041.061509771598, 11041.944790276159, 8354.081051084377, 8433.241008309158, 8433.662653493915, 8435.915640843636, 8442.282405995558, 5769.68266745333, 5803.8549036274435, 5921.171036055042, 5931.3178984417345, 5931.970340148272, 9695.0, 10076.294659373774, 10094.0, 10102.444365559964, 10219.846702299323, 10450.895491044992, 10481.580736770444, 10488.68533943983, 10496.002879726413, 10518.211134165122, 7024.578525288294, 7247.9637601811655, 7273.054502914587, 7638.350740187147, 7732.420068494998, 7117.39502142303, 8072.798180045545, 8532.061473237814, 8610.82778344417, 8733.388662793543, 7269.491135620668, 7413.740519081806, 7526.623668816646, 7656.5788881609815, 7722.073351197892, 7443.144038435649, 7455.0681164854395, 7505.549667019996, 7513.699452021858, 7531.962340188264, 6863.553868998499, 6896.241413444617, 6918.135233095863, 6970.477214208853, 7004.264552222147, 5126.0, 5247.16045432729, 5274.261603375608, 5322.828977624917, 5443.047466693392, 5335.733213339395, 5339.172428273624, 5432.728363581726, 5497.285352904097, 5550.306211723535], "value": 4586.365014639865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.4824504914662, 327.96720327967205, 335.7247057412921, 337.3303991576721, 340.4399762390867, 5406.243125962368, 5406.4593540645965, 5421.349438067427, 5421.7289135543215, 5455.672659640424, 5335.986162629108, 5356.9732151339185, 5427.592930530206, 5432.293801805759, 5436.91844622331, 3992.6207010334115, 4196.769177695225, 4278.786060696961, 4289.399484072233, 4295.4201182840225, 4199.685023623225, 4212.3260278355465, 4212.726172798773, 4230.0, 4242.639375653073, 4144.378343248522, 4152.6055024772595, 4172.207280616673, 4204.096119334343, 4215.59951804578, 4017.216642754664, 4081.4694489566414, 4171.416001759756, 4171.687123465752, 4190.622843944045, 3657.5428071491065, 3658.579263384718, 3667.5782285037294, 3670.9816450917574, 3699.7420876901715, 5197.532222100029, 5237.16205407133, 5242.973785131088, 5244.921326180111, 5254.185601231777, 4547.08986248801, 4550.840720574764, 4680.251159814414, 4741.596964258042, 4768.0, 5518.454832646866, 5540.667559946416, 5546.584006199551, 5552.250446189793, 5565.777368905239, 4041.8585349512628, 4045.7572545647354, 4047.7166598338126, 4054.2702313583545, 4057.1885622875543, 5737.320053147396, 5760.164776107483, 5796.652200867961, 5799.565032622528, 5818.2436283282905, 4096.73371230869, 4097.405876147942, 4101.85643502476, 4105.988065847773, 4109.0, 4155.252054630196, 4178.185253875526, 4193.412922190896, 4197.916041679149, 4201.663866890642, 4691.601213896857, 4728.905421891543, 4761.809527618926, 4795.880102997453, 4818.734969576707, 5594.622285528634, 5598.972005139948, 5601.983286017031, 5609.1305847593685, 5624.128260119688, 1424.978625320621, 1447.2040377792382, 1453.14264583896, 1454.0330680097616, 1455.7889106079558, 884.6299049652072, 924.2144177449248, 931.0642803981955, 932.48247222792, 948.0945696859483, 4800.4719480857075, 4832.661713680079, 4863.270509423614, 4869.70781753096, 4878.829240976549, 5040.873978150502, 5050.4949505049935, 5064.746762661852, 5094.719790411489, 5117.437081920985, 4540.72755634663, 4838.588719958772, 4841.176999910023, 4885.047415753894, 4894.681845680019, 2709.756121949034, 2723.305557082931, 2726.7136950619897, 2734.8906043758025, 2749.312671832042, 5197.440767769654, 5236.554892834151, 5247.422783493813, 5247.527722504993, 5256.526912577886, 4781.2350023996, 5051.913838524735, 5074.340335756402, 5118.0, 5118.387707872009, 5233.273019903423, 5269.762860671279, 5276.129438642581, 5282.7622756976025, 5293.285406470154, 5035.773390197377, 5037.899242015213, 5051.4443411224, 5060.0, 5120.923186152137, 4810.4708482067645, 5029.64792464524, 5034.823781167788, 5074.391073071255, 5083.313752643346, 5196.53231209193, 5202.713850738246, 5217.200065977232, 5224.58203343724, 5224.712640804641, 3747.5197297068053, 3761.8119094045737, 3763.510743603314, 3779.4519794629073, 3784.5458544973676, 4888.437829649636, 5025.447200807835, 5033.496650334937, 5086.745662716923, 5139.768710407966, 4921.975390123026, 4956.910548797185, 4968.875778105432, 4974.4579180454175, 4979.701217926936, 4953.72754498506, 4955.2567114933045, 4958.355413796184, 4984.476629953802, 5024.271480635361, 4630.768461576975, 4939.925901111558, 4963.057019166346, 4963.70217786934, 5007.574356179765, 4979.576735977483, 5352.170413585901, 5504.80733174337, 5602.187682785891, 5668.348139963792, 5521.668699878021, 5526.972365138148, 5590.86022849432, 5591.944080559305, 5601.0], "value": 4068.790132609776, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.346340025677, 730.7551970090019, 758.7496126278329, 815.4984684419082, 864.6541383446616, 12937.223766574001, 13847.09993850399, 14673.339699713499, 14759.409623615069, 14917.552473425787, 14322.069065510734, 14446.422143114263, 14474.927625361885, 14482.42070317186, 14494.782578261334, 795.7930937956115, 807.112176605732, 808.8786681997689, 809.2797410304834, 809.7085049382217, 659.650385295794, 787.2009909941386, 807.8142027333716, 813.7599408174602, 822.6010384963288, 864.5029108262743, 867.8915135608049, 868.1448772958631, 868.7480630617114, 868.9304855611567, 861.6984055580529, 862.8015556422058, 863.2705363967438, 864.191980498233, 866.0343716755772, 506.3619839002846, 607.3744043635063, 620.2340109964191, 621.7233331167632, 625.2372106030635, 12164.391780410944, 12239.571614993522, 12258.632241032783, 12265.26408415498, 12265.632031039084, 13856.515021974183, 14353.641158971004, 14459.493917712829, 14469.131852088803, 14524.128552286897, 12909.160904541268, 13418.26199559024, 13452.529161479399, 13504.932475337659, 13519.526816561372, 4451.198784218839, 4463.531329210451, 4536.455625324949, 4595.149897269016, 4695.060987802419, 56166.0, 56467.15299270473, 63930.360696392905, 72982.27017729808, 73036.63481682558, 10972.890271097187, 10997.230193886351, 11007.559697612005, 11208.607698730506, 11402.315861048364, 20304.89847550753, 20448.38654840357, 20530.589388212153, 20572.485687857923, 20623.8968805158, 8298.21166989135, 8320.875186872201, 8359.247667709935, 8428.0, 8663.0, 4636.744979026119, 4675.976620116878, 4730.716157030589, 4769.332293478916, 4787.42550893895, 3493.7729047611824, 3596.17288023756, 3598.0824889653495, 3600.6759391654878, 3600.9279814403567, 595.9553033522503, 597.1430996520007, 597.623497196772, 619.2661695890384, 621.0963048764128, 684.5071548485083, 710.7086094701251, 713.6217804563589, 718.5042320798632, 729.1177675013188, 8906.688265910661, 9137.725868223964, 9378.85931711025, 9732.12410883024, 10001.099901008944, 691.6023286610118, 715.506300652548, 775.3603277296253, 812.8902598149292, 821.6877586517086, 4566.680332376768, 4986.152354099811, 5003.674761140514, 5073.746312684351, 5126.256692779526, 110844.0, 113688.43155784169, 113725.4313728426, 113892.0, 117988.41005794916, 97408.51295743618, 98103.50948245214, 99469.50265248628, 99714.5014274924, 99931.99999999854, 80388.19611803807, 81070.18929810745, 81326.0, 81745.59127204445, 83227.0, 9854.11312981835, 9935.0, 9947.353422027545, 9975.102240798364, 10010.699679009642, 48665.5133448661, 50661.0, 51022.744886276814, 51278.0, 52045.47954520558, 70257.64871175612, 71951.28048719655, 75413.0, 77206.6139669298, 77456.0, 12566.497340106658, 12570.43433045497, 12620.684482888002, 12698.428570714155, 12805.103642744918, 14007.929960350133, 14112.858871411565, 14231.715365692835, 14322.856771432153, 14590.708185836436, 12952.0, 12965.740685186433, 13137.34313284351, 13259.66850828737, 13520.459181632625, 12974.351282435651, 13053.34733263314, 13199.67000824987, 13358.532451364155, 13411.195328280335, 12568.0, 12650.493980240688, 12876.163049401759, 12884.48462061507, 12999.1550549214, 10619.787604248026, 10897.29167604135, 11040.019194817514, 11340.546378145113, 11452.484638191134, 9438.38650487716, 11118.555257789598, 11202.21584489078, 11502.137339699724, 11552.826707599224], "value": 7459.168254015356, "unit": "score"}], "name": "dromaeo_css", "value": 7335.514631822398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 118.0, 111.0, 111.0, 111.0, 112.0, 110.0, 112.0, 110.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 119.0, 184.0, 122.0, 118.0, 144.0, 121.0, 157.0, 121.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 163.0, 163.0, 162.0, 162.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 114.0, 75.0, 74.0, 74.0, 75.0, 101.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 118.0, 84.0, 84.0, 85.0, 121.0, 83.0, 84.0, 129.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 51.0, 51.0, 52.0, 53.0, 54.0, 51.0, 52.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 76.0, 85.0, 79.0, 81.0, 76.0, 79.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 127.0, 122.0, 135.0, 121.0, 131.0, 135.0, 119.0, 213.0, 120.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 157.0, 158.0, 157.0, 159.0, 166.0, 158.0, 162.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1497.0, "alertThreshold": 2.0}]} 04:42:30 INFO - Return code: 0 04:42:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:42:30 INFO - # TBPL SUCCESS # 04:42:30 INFO - Running post-action listener: _resource_record_post_action 04:42:30 INFO - [mozharness: 2016-07-21 11:42:30.826115Z] Finished run-tests step (success) 04:42:30 INFO - Running post-run listener: _resource_record_post_run 04:42:30 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 560955392; Read time: 0; Write time: 569392 04:42:30 INFO - TinderboxPrint: CPU usage
13.2% 04:42:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:42:30 INFO - TinderboxPrint: I/O write bytes / time
560,955,392 / 569,392 04:42:30 INFO - TinderboxPrint: CPU idle
8,251.3 (86.8%) 04:42:30 INFO - TinderboxPrint: CPU user
1,204.0 (12.7%) 04:42:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:42:30 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 261574656; Read time: 0; Write time: 349716 04:42:30 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 299380736; Read time: 0; Write time: 219676 04:42:31 INFO - Running post-run listener: _upload_blobber_files 04:42:31 INFO - Blob upload gear active. 04:42:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:42:31 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'] 04:42:31 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 04:42:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:42:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:46 INFO - (blobuploader) - INFO - Done attempting. 04:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:42:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:46 INFO - (blobuploader) - INFO - Done attempting. 04:42:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:42:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:42:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:47 INFO - (blobuploader) - INFO - Done attempting. 04:42:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:47 INFO - Return code: 0 04:42:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1ab9a1ccd408e8c76e3dddf60308e9e5e97f93ed67b89dc8e1298123136f4dc6a2a21eeabd88c4cfb1adc6fb58ddb250a7cff671aec608dbc0ca65c99e2266c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b31ecfb4b707aa10230adb75a5beccc9117aa3a4cd049686a4bbb1d19db74b6bda86f13ee6452a8c5bcef953a73008da35cba3eb09b82388f4b2285410ed98c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/894ef9d21170e47a8fee9deb32c1136f1603b9aaf075c3a18daca2dc33ffddc0f6455fd2dfe5964fa818153eb52ab56797a7a1cc6f1d6868b0011c54d2d97812"} 04:42:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:47 INFO - Contents: 04:42:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f1ab9a1ccd408e8c76e3dddf60308e9e5e97f93ed67b89dc8e1298123136f4dc6a2a21eeabd88c4cfb1adc6fb58ddb250a7cff671aec608dbc0ca65c99e2266c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b31ecfb4b707aa10230adb75a5beccc9117aa3a4cd049686a4bbb1d19db74b6bda86f13ee6452a8c5bcef953a73008da35cba3eb09b82388f4b2285410ed98c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/894ef9d21170e47a8fee9deb32c1136f1603b9aaf075c3a18daca2dc33ffddc0f6455fd2dfe5964fa818153eb52ab56797a7a1cc6f1d6868b0011c54d2d97812"} 04:42:47 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:47 INFO - Copying logs to upload dir... 04:42:47 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.079845 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-21 04:42:47.565198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 04:42:47.569034) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940 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/f1ab9a1ccd408e8c76e3dddf60308e9e5e97f93ed67b89dc8e1298123136f4dc6a2a21eeabd88c4cfb1adc6fb58ddb250a7cff671aec608dbc0ca65c99e2266c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b31ecfb4b707aa10230adb75a5beccc9117aa3a4cd049686a4bbb1d19db74b6bda86f13ee6452a8c5bcef953a73008da35cba3eb09b82388f4b2285410ed98c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/894ef9d21170e47a8fee9deb32c1136f1603b9aaf075c3a18daca2dc33ffddc0f6455fd2dfe5964fa818153eb52ab56797a7a1cc6f1d6868b0011c54d2d97812"} build_url:https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/UTA_XSR8QZWITG-yR4Soag/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/f1ab9a1ccd408e8c76e3dddf60308e9e5e97f93ed67b89dc8e1298123136f4dc6a2a21eeabd88c4cfb1adc6fb58ddb250a7cff671aec608dbc0ca65c99e2266c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2b31ecfb4b707aa10230adb75a5beccc9117aa3a4cd049686a4bbb1d19db74b6bda86f13ee6452a8c5bcef953a73008da35cba3eb09b82388f4b2285410ed98c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/894ef9d21170e47a8fee9deb32c1136f1603b9aaf075c3a18daca2dc33ffddc0f6455fd2dfe5964fa818153eb52ab56797a7a1cc6f1d6868b0011c54d2d97812"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 04:42:47.596446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:42:47.596935) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1469100126.123682-1962265940 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 04:42:47.680608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 04:42:47.681131) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 04:42:47.681615) ========= ========= Total master_lag: 0.18 =========