builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1468030882.62 results: success (0) buildid: 20160708163028 builduid: 7e684ce57b004e89b0920fe47e16f9b3 revision: 9ec9a9682d4680afa2d66281d518edb98908824f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.625006) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.625589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.625880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.672241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.672678) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 19:21:22-- 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-08 19:21:23 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123927 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.814628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.815005) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015869 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:22.869520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 19:21:22.869939) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9ec9a9682d4680afa2d66281d518edb98908824f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9ec9a9682d4680afa2d66281d518edb98908824f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 19:21:23,163 truncating revision to first 12 chars 2016-07-08 19:21:23,163 Setting DEBUG logging. 2016-07-08 19:21:23,163 attempt 1/10 2016-07-08 19:21:23,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9ec9a9682d46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 19:21:24,084 unpacking tar archive at: mozilla-inbound-9ec9a9682d46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.245282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 19:21:24.133360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.133932) ========= script_repo_revision: 9ec9a9682d4680afa2d66281d518edb98908824f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.134600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.135043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 19:21:24.146274) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-08 19:21:24.146822) ========= /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=9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:21:24 INFO - MultiFileLogger online at 20160708 19:21:24 in /builds/slave/test 19:21:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:21:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:21:24 INFO - {'append_to_log': False, 19:21:24 INFO - 'base_work_dir': '/builds/slave/test', 19:21:24 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:21:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:21:24 INFO - 'branch': 'Mozilla-Inbound', 19:21:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:21:24 INFO - 'config_files': ('talos/linux_config.py',), 19:21:24 INFO - 'default_actions': ('clobber', 19:21:24 INFO - 'read-buildbot-config', 19:21:24 INFO - 'download-and-extract', 19:21:24 INFO - 'populate-webroot', 19:21:24 INFO - 'create-virtualenv', 19:21:24 INFO - 'install', 19:21:24 INFO - 'run-tests'), 19:21:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:21:24 INFO - 'download_minidump_stackwalk': True, 19:21:24 INFO - 'download_symbols': 'ondemand', 19:21:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:21:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:21:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:21:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:21:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:21:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:21:24 INFO - 'installer_path': 'installer.exe', 19:21:24 INFO - 'log_level': 'info', 19:21:24 INFO - 'log_name': 'talos', 19:21:24 INFO - 'log_to_console': True, 19:21:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:21:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:21:24 INFO - 'opt_config_files': (), 19:21:24 INFO - 'pip_index': False, 19:21:24 INFO - 'sps_profile': False, 19:21:24 INFO - 'sps_profile_interval': 0, 19:21:24 INFO - 'suite': 'dromaeojs', 19:21:24 INFO - 'system_bits': '32', 19:21:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:21:24 INFO - 'title': 'talos-linux64-ix-029', 19:21:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:21:24 INFO - 'use_talos_json': True, 19:21:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:21:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:21:24 INFO - 'work_dir': 'build'} 19:21:24 INFO - ##### 19:21:24 INFO - ##### Running clobber step. 19:21:24 INFO - ##### 19:21:24 INFO - Running pre-action listener: _resource_record_pre_action 19:21:24 INFO - Running main action method: clobber 19:21:24 INFO - rmtree: /builds/slave/test/build 19:21:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:21:25 INFO - Running post-action listener: _resource_record_post_action 19:21:25 INFO - ##### 19:21:25 INFO - ##### Finished clobber step (success) 19:21:25 INFO - ##### 19:21:25 INFO - ##### 19:21:25 INFO - ##### Running read-buildbot-config step. 19:21:25 INFO - ##### 19:21:25 INFO - Running pre-action listener: _resource_record_pre_action 19:21:25 INFO - Running main action method: read_buildbot_config 19:21:25 INFO - Using buildbot properties: 19:21:25 INFO - { 19:21:25 INFO - "project": "", 19:21:25 INFO - "product": "firefox", 19:21:25 INFO - "script_repo_revision": "production", 19:21:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:21:25 INFO - "repository": "", 19:21:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:21:25 INFO - "buildid": "20160708163028", 19:21:25 INFO - "pgo_build": "True", 19:21:25 INFO - "basedir": "/builds/slave/test", 19:21:25 INFO - "buildnumber": 1304, 19:21:25 INFO - "slavename": "talos-linux64-ix-029", 19:21:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:21:25 INFO - "platform": "ubuntu64_hw", 19:21:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:21:25 INFO - "branch": "mozilla-inbound", 19:21:25 INFO - "repo_path": "integration/mozilla-inbound", 19:21:25 INFO - "revision": "9ec9a9682d4680afa2d66281d518edb98908824f", 19:21:25 INFO - "stage_platform": "linux64-pgo", 19:21:25 INFO - "builduid": "7e684ce57b004e89b0920fe47e16f9b3", 19:21:25 INFO - "slavebuilddir": "test" 19:21:25 INFO - } 19:21:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:21:25 INFO - Running post-action listener: _resource_record_post_action 19:21:25 INFO - ##### 19:21:25 INFO - ##### Finished read-buildbot-config step (success) 19:21:25 INFO - ##### 19:21:25 INFO - ##### 19:21:25 INFO - ##### Running download-and-extract step. 19:21:25 INFO - ##### 19:21:25 INFO - Running pre-action listener: _resource_record_pre_action 19:21:25 INFO - Running main action method: download_and_extract 19:21:25 INFO - mkdir: /builds/slave/test/build/tests 19:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:25 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:21:29 INFO - Downloaded 1361 bytes. 19:21:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:21:29 INFO - Using the following test package requirements: 19:21:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:21:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:21:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'jsshell-linux-x86_64.zip'], 19:21:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:21:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:21:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:21:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:21:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:21:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:21:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:29 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:35 INFO - Downloaded 24307143 bytes. 19:21:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:21:36 INFO - Return code: 0 19:21:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:36 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:21:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:21:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:21:38 INFO - Downloaded 24307143 bytes. 19:21:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:21:40 INFO - Return code: 0 19:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:40 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:21:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:21:40 INFO - Downloaded 14403333 bytes. 19:21:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:21:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:21:41 INFO - Return code: 0 19:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:41 INFO - https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:21:42 INFO - Downloaded 60458563 bytes. 19:21:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:42 INFO - mkdir: /builds/slave/test/properties 19:21:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:21:42 INFO - Writing to file /builds/slave/test/properties/build_url 19:21:42 INFO - Contents: 19:21:42 INFO - build_url:https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:21:43 INFO - Running post-action listener: _resource_record_post_action 19:21:43 INFO - Running post-action listener: set_extra_try_arguments 19:21:43 INFO - ##### 19:21:43 INFO - ##### Finished download-and-extract step (success) 19:21:43 INFO - ##### 19:21:43 INFO - ##### 19:21:43 INFO - ##### Running populate-webroot step. 19:21:43 INFO - ##### 19:21:43 INFO - Running pre-action listener: _resource_record_pre_action 19:21:43 INFO - Running main action method: populate_webroot 19:21:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:21:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:21:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:21:43 INFO - '--tppagecycles', 19:21:43 INFO - '7'], 19:21:43 INFO - 'tests': ['tsvgm']}}, 19:21:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:21:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:21:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:21:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:21:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:21:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['damp', 'tps']}, 19:21:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'tests': ['damp', 'tps']}, 19:21:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['dromaeo_dom']}, 19:21:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:21:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['basic_compositor_video']}, 19:21:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:21:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['a11yr', 19:21:43 INFO - 'ts_paint', 19:21:43 INFO - 'tpaint', 19:21:43 INFO - 'sessionrestore', 19:21:43 INFO - 'sessionrestore_no_auto_restore', 19:21:43 INFO - 'tabpaint']}, 19:21:43 INFO - 'other-e10s': {'tests': ['a11yr', 19:21:43 INFO - 'ts_paint', 19:21:43 INFO - 'tpaint', 19:21:43 INFO - 'sessionrestore', 19:21:43 INFO - 'sessionrestore_no_auto_restore', 19:21:43 INFO - 'tabpaint']}, 19:21:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:21:43 INFO - 'ts_paint', 19:21:43 INFO - 'tpaint', 19:21:43 INFO - 'sessionrestore', 19:21:43 INFO - 'sessionrestore_no_auto_restore', 19:21:43 INFO - 'tabpaint']}, 19:21:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:21:43 INFO - 'ts_paint', 19:21:43 INFO - 'tpaint', 19:21:43 INFO - 'sessionrestore', 19:21:43 INFO - 'sessionrestore_no_auto_restore', 19:21:43 INFO - 'tabpaint']}, 19:21:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['a11yr', 19:21:43 INFO - 'ts_paint', 19:21:43 INFO - 'tpaint', 19:21:43 INFO - 'sessionrestore', 19:21:43 INFO - 'sessionrestore_no_auto_restore', 19:21:43 INFO - 'tabpaint']}, 19:21:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['a11yr', 19:21:43 INFO - 'ts_paint', 19:21:43 INFO - 'tpaint', 19:21:43 INFO - 'sessionrestore', 19:21:43 INFO - 'sessionrestore_no_auto_restore', 19:21:43 INFO - 'tabpaint']}, 19:21:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['tsvgx', 19:21:43 INFO - 'tsvgr_opacity', 19:21:43 INFO - 'tart', 19:21:43 INFO - 'tscrollx', 19:21:43 INFO - 'cart']}, 19:21:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:21:43 INFO - 'tsvgr_opacity', 19:21:43 INFO - 'tart', 19:21:43 INFO - 'tscrollx', 19:21:43 INFO - 'cart']}, 19:21:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'talos_options': ['--disable-e10s'], 19:21:43 INFO - 'tests': ['tp5o']}, 19:21:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'tests': ['tp5o']}, 19:21:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'talos_options': ['--disable-e10s', 19:21:43 INFO - '--xperf_path', 19:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:43 INFO - 'tests': ['tp5n']}, 19:21:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:21:43 INFO - 'talos_options': ['--xperf_path', 19:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:21:43 INFO - 'tests': ['tp5n']}}, 19:21:43 INFO - 'talos.zip': {'path': '', 19:21:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:21:43 INFO - Running post-action listener: _resource_record_post_action 19:21:43 INFO - ##### 19:21:43 INFO - ##### Finished populate-webroot step (success) 19:21:43 INFO - ##### 19:21:43 INFO - ##### 19:21:43 INFO - ##### Running create-virtualenv step. 19:21:43 INFO - ##### 19:21:43 INFO - Running pre-action listener: _resource_record_pre_action 19:21:43 INFO - Running main action method: create_virtualenv 19:21:43 INFO - Creating virtualenv /builds/slave/test/build/venv 19:21:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:21:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:21:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:21:43 INFO - Using real prefix '/usr' 19:21:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:21:43 INFO - Installing distribute.............................................................................................................................................................................................done. 19:21:45 INFO - Installing pip.................done. 19:21:45 INFO - Return code: 0 19:21:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:45 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:21:45 INFO - Using env: {'DISPLAY': ':0', 19:21:45 INFO - 'HOME': '/home/cltbld', 19:21:45 INFO - 'LANG': 'en_US.UTF-8', 19:21:45 INFO - 'LANGUAGE': 'en_US:en', 19:21:45 INFO - 'LOGNAME': 'cltbld', 19:21:45 INFO - 'MAIL': '/var/mail/cltbld', 19:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:45 INFO - 'MOZ_NO_REMOTE': '1', 19:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:45 INFO - 'NO_EM_RESTART': '1', 19:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:45 INFO - 'PWD': '/builds/slave/test', 19:21:45 INFO - 'SHELL': '/bin/bash', 19:21:45 INFO - 'SHLVL': '1', 19:21:45 INFO - 'TERM': 'linux', 19:21:45 INFO - 'TMOUT': '86400', 19:21:45 INFO - 'USER': 'cltbld', 19:21:45 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:45 INFO - '_': '/tools/buildbot/bin/python'} 19:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:21:46 INFO - Cleaning up... 19:21:46 INFO - Return code: 0 19:21:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:21:46 INFO - Using env: {'DISPLAY': ':0', 19:21:46 INFO - 'HOME': '/home/cltbld', 19:21:46 INFO - 'LANG': 'en_US.UTF-8', 19:21:46 INFO - 'LANGUAGE': 'en_US:en', 19:21:46 INFO - 'LOGNAME': 'cltbld', 19:21:46 INFO - 'MAIL': '/var/mail/cltbld', 19:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:46 INFO - 'MOZ_NO_REMOTE': '1', 19:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:46 INFO - 'NO_EM_RESTART': '1', 19:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:46 INFO - 'PWD': '/builds/slave/test', 19:21:46 INFO - 'SHELL': '/bin/bash', 19:21:46 INFO - 'SHLVL': '1', 19:21:46 INFO - 'TERM': 'linux', 19:21:46 INFO - 'TMOUT': '86400', 19:21:46 INFO - 'USER': 'cltbld', 19:21:46 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:46 INFO - '_': '/tools/buildbot/bin/python'} 19:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:46 INFO - Downloading/unpacking psutil>=3.1.1 19:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:48 INFO - Installing collected packages: psutil 19:21:48 INFO - Running setup.py install for psutil 19:21:48 INFO - building 'psutil._psutil_linux' extension 19:21:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:21:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:21:48 INFO - building 'psutil._psutil_posix' extension 19:21:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:21:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:21:48 INFO - Successfully installed psutil 19:21:48 INFO - Cleaning up... 19:21:48 INFO - Return code: 0 19:21:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:48 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:21:48 INFO - Using env: {'DISPLAY': ':0', 19:21:48 INFO - 'HOME': '/home/cltbld', 19:21:48 INFO - 'LANG': 'en_US.UTF-8', 19:21:48 INFO - 'LANGUAGE': 'en_US:en', 19:21:48 INFO - 'LOGNAME': 'cltbld', 19:21:48 INFO - 'MAIL': '/var/mail/cltbld', 19:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:48 INFO - 'MOZ_NO_REMOTE': '1', 19:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:48 INFO - 'NO_EM_RESTART': '1', 19:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:48 INFO - 'PWD': '/builds/slave/test', 19:21:48 INFO - 'SHELL': '/bin/bash', 19:21:48 INFO - 'SHLVL': '1', 19:21:48 INFO - 'TERM': 'linux', 19:21:48 INFO - 'TMOUT': '86400', 19:21:48 INFO - 'USER': 'cltbld', 19:21:48 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:48 INFO - '_': '/tools/buildbot/bin/python'} 19:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:21:51 INFO - Installing collected packages: mozsystemmonitor 19:21:51 INFO - Running setup.py install for mozsystemmonitor 19:21:51 INFO - Successfully installed mozsystemmonitor 19:21:51 INFO - Cleaning up... 19:21:51 INFO - Return code: 0 19:21:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:21:51 INFO - Using env: {'DISPLAY': ':0', 19:21:51 INFO - 'HOME': '/home/cltbld', 19:21:51 INFO - 'LANG': 'en_US.UTF-8', 19:21:51 INFO - 'LANGUAGE': 'en_US:en', 19:21:51 INFO - 'LOGNAME': 'cltbld', 19:21:51 INFO - 'MAIL': '/var/mail/cltbld', 19:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:51 INFO - 'MOZ_NO_REMOTE': '1', 19:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:51 INFO - 'NO_EM_RESTART': '1', 19:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:51 INFO - 'PWD': '/builds/slave/test', 19:21:51 INFO - 'SHELL': '/bin/bash', 19:21:51 INFO - 'SHLVL': '1', 19:21:51 INFO - 'TERM': 'linux', 19:21:51 INFO - 'TMOUT': '86400', 19:21:51 INFO - 'USER': 'cltbld', 19:21:51 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:51 INFO - '_': '/tools/buildbot/bin/python'} 19:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:51 INFO - Downloading/unpacking jsonschema==2.5.1 19:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:21:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:53 INFO - Downloading functools32-3.2.3-2.tar.gz 19:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:21:53 INFO - warning: no files found matching '*.txt' 19:21:53 INFO - no previously-included directories found matching 'build' 19:21:53 INFO - no previously-included directories found matching 'dist' 19:21:53 INFO - no previously-included directories found matching '.git*' 19:21:53 INFO - Installing collected packages: jsonschema, functools32 19:21:53 INFO - Running setup.py install for functools32 19:21:53 INFO - warning: no files found matching '*.txt' 19:21:53 INFO - no previously-included directories found matching 'build' 19:21:53 INFO - no previously-included directories found matching 'dist' 19:21:53 INFO - no previously-included directories found matching '.git*' 19:21:53 INFO - Successfully installed jsonschema functools32 19:21:53 INFO - Cleaning up... 19:21:53 INFO - Return code: 0 19:21:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:53 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:21:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:21:53 INFO - Using env: {'DISPLAY': ':0', 19:21:53 INFO - 'HOME': '/home/cltbld', 19:21:53 INFO - 'LANG': 'en_US.UTF-8', 19:21:53 INFO - 'LANGUAGE': 'en_US:en', 19:21:53 INFO - 'LOGNAME': 'cltbld', 19:21:53 INFO - 'MAIL': '/var/mail/cltbld', 19:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:53 INFO - 'MOZ_NO_REMOTE': '1', 19:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:53 INFO - 'NO_EM_RESTART': '1', 19:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:53 INFO - 'PWD': '/builds/slave/test', 19:21:53 INFO - 'SHELL': '/bin/bash', 19:21:53 INFO - 'SHLVL': '1', 19:21:53 INFO - 'TERM': 'linux', 19:21:53 INFO - 'TMOUT': '86400', 19:21:53 INFO - 'USER': 'cltbld', 19:21:53 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:53 INFO - '_': '/tools/buildbot/bin/python'} 19:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:21:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:21:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:21:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:21:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:21:56 INFO - Downloading docopt-0.6.1.tar.gz 19:21:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:21:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:21:56 INFO - Running setup.py install for blobuploader 19:21:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:21:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:21:56 INFO - Running setup.py install for requests 19:21:57 INFO - Running setup.py install for docopt 19:21:57 INFO - Successfully installed blobuploader requests docopt 19:21:57 INFO - Cleaning up... 19:21:57 INFO - Return code: 0 19:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21: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')]} 19:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21: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')]} 19:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:57 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:21:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:21:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:21:57 INFO - Using env: {'DISPLAY': ':0', 19:21:57 INFO - 'HOME': '/home/cltbld', 19:21:57 INFO - 'LANG': 'en_US.UTF-8', 19:21:57 INFO - 'LANGUAGE': 'en_US:en', 19:21:57 INFO - 'LOGNAME': 'cltbld', 19:21:57 INFO - 'MAIL': '/var/mail/cltbld', 19:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:57 INFO - 'MOZ_NO_REMOTE': '1', 19:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:21:57 INFO - 'NO_EM_RESTART': '1', 19:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:57 INFO - 'PWD': '/builds/slave/test', 19:21:57 INFO - 'SHELL': '/bin/bash', 19:21:57 INFO - 'SHLVL': '1', 19:21:57 INFO - 'TERM': 'linux', 19:21:57 INFO - 'TMOUT': '86400', 19:21:57 INFO - 'USER': 'cltbld', 19:21:57 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:57 INFO - '_': '/tools/buildbot/bin/python'} 19:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:21:57 INFO - Running setup.py (path:/tmp/pip-kA9cR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:21:57 INFO - Running setup.py (path:/tmp/pip-JkJ3Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:21:57 INFO - Running setup.py (path:/tmp/pip-dBaQBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:21:57 INFO - Running setup.py (path:/tmp/pip-loEXpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:21:57 INFO - Running setup.py (path:/tmp/pip-bFarGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:21:57 INFO - Running setup.py (path:/tmp/pip-4UrhZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:21:57 INFO - Running setup.py (path:/tmp/pip-ZZqUas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:21:57 INFO - Running setup.py (path:/tmp/pip-1IV2id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:21:57 INFO - Running setup.py (path:/tmp/pip-Kj1YGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:21:58 INFO - Running setup.py (path:/tmp/pip-yV90f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:21:58 INFO - Running setup.py (path:/tmp/pip-HmGQeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:21:58 INFO - Running setup.py (path:/tmp/pip-jvKwhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:21:58 INFO - Running setup.py (path:/tmp/pip-aRJY6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:21:58 INFO - Running setup.py (path:/tmp/pip-zrZzIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:58 INFO - Running setup.py (path:/tmp/pip-T5gpkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:21:58 INFO - Running setup.py (path:/tmp/pip-fc3ZuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:21:58 INFO - Running setup.py (path:/tmp/pip-tvSZga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:21:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:21:58 INFO - Running setup.py install for manifestparser 19:21:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:21:58 INFO - Running setup.py install for mozcrash 19:21:58 INFO - Running setup.py install for mozdebug 19:21:58 INFO - Running setup.py install for mozdevice 19:21:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for mozfile 19:21:59 INFO - Running setup.py install for mozhttpd 19:21:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for mozinfo 19:21:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for mozInstall 19:21:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for mozleak 19:21:59 INFO - Running setup.py install for mozlog 19:21:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for moznetwork 19:21:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for mozprocess 19:21:59 INFO - Running setup.py install for mozprofile 19:21:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:21:59 INFO - Running setup.py install for mozrunner 19:22:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:22:00 INFO - Running setup.py install for mozscreenshot 19:22:00 INFO - Running setup.py install for moztest 19:22:00 INFO - Running setup.py install for mozversion 19:22:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:22:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:22:00 INFO - Cleaning up... 19:22:00 INFO - Return code: 0 19:22:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:00 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:22:00 INFO - Using env: {'DISPLAY': ':0', 19:22:00 INFO - 'HOME': '/home/cltbld', 19:22:00 INFO - 'LANG': 'en_US.UTF-8', 19:22:00 INFO - 'LANGUAGE': 'en_US:en', 19:22:00 INFO - 'LOGNAME': 'cltbld', 19:22:00 INFO - 'MAIL': '/var/mail/cltbld', 19:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:00 INFO - 'MOZ_NO_REMOTE': '1', 19:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:00 INFO - 'NO_EM_RESTART': '1', 19:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:00 INFO - 'PWD': '/builds/slave/test', 19:22:00 INFO - 'SHELL': '/bin/bash', 19:22:00 INFO - 'SHLVL': '1', 19:22:00 INFO - 'TERM': 'linux', 19:22:00 INFO - 'TMOUT': '86400', 19:22:00 INFO - 'USER': 'cltbld', 19:22:00 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:00 INFO - '_': '/tools/buildbot/bin/python'} 19:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:22:00 INFO - Running setup.py (path:/tmp/pip-REyyL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:22:00 INFO - Running setup.py (path:/tmp/pip-vOGzu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:22:00 INFO - Running setup.py (path:/tmp/pip-rIaSzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:22:00 INFO - Running setup.py (path:/tmp/pip-u1WnzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:22:00 INFO - Running setup.py (path:/tmp/pip-UWd_4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:22:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:22:00 INFO - Running setup.py (path:/tmp/pip-w7Iyif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:22:01 INFO - Running setup.py (path:/tmp/pip-RiDrki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:22:01 INFO - Running setup.py (path:/tmp/pip-ZuOjA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:22:01 INFO - Running setup.py (path:/tmp/pip-LSZ0t4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:22:01 INFO - Running setup.py (path:/tmp/pip-eRG51S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:22:01 INFO - Running setup.py (path:/tmp/pip-U5O3_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:22:01 INFO - Running setup.py (path:/tmp/pip-E_1Bqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:22:01 INFO - Running setup.py (path:/tmp/pip-9ez62Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:22:01 INFO - Running setup.py (path:/tmp/pip-DnIhPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:01 INFO - Running setup.py (path:/tmp/pip-K7Tm39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:22:01 INFO - Running setup.py (path:/tmp/pip-I8OzgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:22:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:22:01 INFO - Running setup.py (path:/tmp/pip-9GRMo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:22:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:22:03 INFO - Downloading blessings-1.6.tar.gz 19:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:22:03 INFO - Installing collected packages: blessings 19:22:03 INFO - Running setup.py install for blessings 19:22:03 INFO - Successfully installed blessings 19:22:03 INFO - Cleaning up... 19:22:04 INFO - Return code: 0 19:22:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:04 INFO - Reading from file tmpfile_stdout 19:22:04 INFO - Current package versions: 19:22:04 INFO - argparse == 1.2.1 19:22:04 INFO - blessings == 1.6 19:22:04 INFO - blobuploader == 1.2.4 19:22:04 INFO - docopt == 0.6.1 19:22:04 INFO - functools32 == 3.2.3-2 19:22:04 INFO - jsonschema == 2.5.1 19:22:04 INFO - manifestparser == 1.1 19:22:04 INFO - mozInstall == 1.12 19:22:04 INFO - mozcrash == 0.17 19:22:04 INFO - mozdebug == 0.1 19:22:04 INFO - mozdevice == 0.48 19:22:04 INFO - mozfile == 1.2 19:22:04 INFO - mozhttpd == 0.7 19:22:04 INFO - mozinfo == 0.9 19:22:04 INFO - mozleak == 0.1 19:22:04 INFO - mozlog == 3.2 19:22:04 INFO - moznetwork == 0.27 19:22:04 INFO - mozprocess == 0.23 19:22:04 INFO - mozprofile == 0.28 19:22:04 INFO - mozrunner == 6.12 19:22:04 INFO - mozscreenshot == 0.1 19:22:04 INFO - mozsystemmonitor == 0.3 19:22:04 INFO - moztest == 0.7 19:22:04 INFO - mozversion == 1.4 19:22:04 INFO - psutil == 3.1.1 19:22:04 INFO - requests == 1.2.3 19:22:04 INFO - wsgiref == 0.1.2 19:22:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:04 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:22:04 INFO - Using env: {'DISPLAY': ':0', 19:22:04 INFO - 'HOME': '/home/cltbld', 19:22:04 INFO - 'LANG': 'en_US.UTF-8', 19:22:04 INFO - 'LANGUAGE': 'en_US:en', 19:22:04 INFO - 'LOGNAME': 'cltbld', 19:22:04 INFO - 'MAIL': '/var/mail/cltbld', 19:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:04 INFO - 'MOZ_NO_REMOTE': '1', 19:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:04 INFO - 'NO_EM_RESTART': '1', 19:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:04 INFO - 'PWD': '/builds/slave/test', 19:22:04 INFO - 'SHELL': '/bin/bash', 19:22:04 INFO - 'SHLVL': '1', 19:22:04 INFO - 'TERM': 'linux', 19:22:04 INFO - 'TMOUT': '86400', 19:22:04 INFO - 'USER': 'cltbld', 19:22:04 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:04 INFO - '_': '/tools/buildbot/bin/python'} 19:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:22:04 INFO - Cleaning up... 19:22:04 INFO - Return code: 0 19:22:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:04 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 0x2553030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2814180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, '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': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:22:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:22:04 INFO - Using env: {'DISPLAY': ':0', 19:22:04 INFO - 'HOME': '/home/cltbld', 19:22:04 INFO - 'LANG': 'en_US.UTF-8', 19:22:04 INFO - 'LANGUAGE': 'en_US:en', 19:22:04 INFO - 'LOGNAME': 'cltbld', 19:22:04 INFO - 'MAIL': '/var/mail/cltbld', 19:22:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:04 INFO - 'MOZ_NO_REMOTE': '1', 19:22:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:04 INFO - 'NO_EM_RESTART': '1', 19:22:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:04 INFO - 'PWD': '/builds/slave/test', 19:22:04 INFO - 'SHELL': '/bin/bash', 19:22:04 INFO - 'SHLVL': '1', 19:22:04 INFO - 'TERM': 'linux', 19:22:04 INFO - 'TMOUT': '86400', 19:22:04 INFO - 'USER': 'cltbld', 19:22:04 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:22:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:04 INFO - '_': '/tools/buildbot/bin/python'} 19:22:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:22:04 INFO - Cleaning up... 19:22:04 INFO - Return code: 0 19:22:04 INFO - Running post-action listener: _resource_record_post_action 19:22:04 INFO - Running post-action listener: _start_resource_monitoring 19:22:04 INFO - Starting resource monitoring. 19:22:04 INFO - ##### 19:22:04 INFO - ##### Finished create-virtualenv step (success) 19:22:04 INFO - ##### 19:22:04 INFO - ##### 19:22:04 INFO - ##### Running install step. 19:22:04 INFO - ##### 19:22:04 INFO - Running pre-action listener: _resource_record_pre_action 19:22:04 INFO - Running main action method: install 19:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:22:04 INFO - Reading from file tmpfile_stdout 19:22:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:22:04 INFO - Reading from file tmpfile_stdout 19:22:04 INFO - Output received: 19:22:04 INFO - Usage: mozinstall [options] installer 19:22:04 INFO - Options: 19:22:04 INFO - -h, --help show this help message and exit 19:22:04 INFO - -d DEST, --destination=DEST 19:22:04 INFO - Directory to install application into. [default: 19:22:04 INFO - "/builds/slave/test"] 19:22:04 INFO - --app=APP Application being installed. [default: firefox] 19:22:04 INFO - mkdir: /builds/slave/test/build/application 19:22:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:22:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:22:22 INFO - Reading from file tmpfile_stdout 19:22:22 INFO - Output received: 19:22:22 INFO - /builds/slave/test/build/application/firefox/firefox 19:22:22 INFO - Running post-action listener: _resource_record_post_action 19:22:22 INFO - ##### 19:22:22 INFO - ##### Finished install step (success) 19:22:22 INFO - ##### 19:22:22 INFO - ##### 19:22:22 INFO - ##### Running run-tests step. 19:22:22 INFO - ##### 19:22:22 INFO - Running pre-action listener: _resource_record_pre_action 19:22:22 INFO - Running main action method: run_tests 19:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:22:22 INFO - Python 2.7.3 19:22:22 INFO - Return code: 0 19:22:22 INFO - grabbing minidump binary from tooltool 19:22:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:22 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 0x28123b0>, '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 0x28132b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2813740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:22:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:22:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:22:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:22:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:22:22 INFO - Return code: 0 19:22:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:22:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:22:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:22:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:22:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:22:22 INFO - Using env: {'DISPLAY': ':0', 19:22:22 INFO - 'HOME': '/home/cltbld', 19:22:22 INFO - 'LANG': 'en_US.UTF-8', 19:22:22 INFO - 'LANGUAGE': 'en_US:en', 19:22:22 INFO - 'LOGNAME': 'cltbld', 19:22:22 INFO - 'MAIL': '/var/mail/cltbld', 19:22:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:22:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:22 INFO - 'MOZ_NO_REMOTE': '1', 19:22:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:22:22 INFO - 'NO_EM_RESTART': '1', 19:22:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:22 INFO - 'PWD': '/builds/slave/test', 19:22:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:22:22 INFO - 'SHELL': '/bin/bash', 19:22:22 INFO - 'SHLVL': '1', 19:22:22 INFO - 'TERM': 'linux', 19:22:22 INFO - 'TMOUT': '86400', 19:22:22 INFO - 'USER': 'cltbld', 19:22:22 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653', 19:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:22 INFO - '_': '/tools/buildbot/bin/python'} 19:22:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:22:22 INFO - mozversion application_buildid: 20160708163028 19:22:22 INFO - mozversion application_changeset: 9ec9a9682d4680afa2d66281d518edb98908824f 19:22:22 INFO - mozversion application_display_name: Nightly 19:22:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:22:22 INFO - mozversion application_name: Firefox 19:22:22 INFO - mozversion application_remotingname: firefox 19:22:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:22:22 INFO - mozversion application_vendor: Mozilla 19:22:22 INFO - mozversion application_version: 50.0a1 19:22:22 INFO - mozversion platform_buildid: 20160708163028 19:22:22 INFO - mozversion platform_changeset: 9ec9a9682d4680afa2d66281d518edb98908824f 19:22:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:22:22 INFO - mozversion platform_version: 50.0a1 19:22:22 INFO - using testdate: 1468030942 19:22:22 INFO - actual date: 1468030942 19:22:22 INFO - starting webserver on 'localhost:52621' 19:22:22 INFO - SUITE-START | Running 2 tests 19:22:22 INFO - TEST-START | dromaeo_css 19:22:22 INFO - operating with platform_type : linux_ 19:22:22 INFO - Initialising browser for dromaeo_css test... 19:22:22 INFO - TEST-INFO | started process 6104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW0QrrN/profile http://localhost:52621/getInfo.html) 19:22:26 INFO - PROCESS | 6104 | __metrics Screen width/height:1600/1200 19:22:26 INFO - PROCESS | 6104 | colorDepth:24 19:22:26 INFO - PROCESS | 6104 | Browser inner width/height: 1024/697 19:22:26 INFO - PROCESS | 6104 | __metrics 19:22:27 INFO - PROCESS | 6104 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:22:28 INFO - TEST-INFO | 6104: exit 0 19:22:28 INFO - Browser initialized. 19:22:28 INFO - Running cycle 1/1 for dromaeo_css test... 19:22:28 INFO - TEST-INFO | started process 6186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW0QrrN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:40 INFO - PROCESS | 6186 | RSS: Main: 157347840 19:22:40 INFO - PROCESS | 6186 | 19:23:31 INFO - PROCESS | 6186 | 1468031011307 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:25:39 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:52621/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52621/tests/dromaeo/cssquery-ext.html) 19:25:40 INFO - PROCESS | 6186 | RSS: Main: 288821248 19:25:40 INFO - PROCESS | 6186 | 19:28:43 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:52621/tests/dromaeo/cssquery-ext.html (next: http://localhost:52621/tests/dromaeo/cssquery-jquery.html) 19:28:44 INFO - PROCESS | 6186 | RSS: Main: 241799168 19:28:44 INFO - PROCESS | 6186 | 19:31:45 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:52621/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52621/tests/dromaeo/cssquery-mootools.html) 19:31:46 INFO - PROCESS | 6186 | RSS: Main: 241430528 19:31:46 INFO - PROCESS | 6186 | 19:34:48 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:52621/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52621/tests/dromaeo/cssquery-prototype.html) 19:34:49 INFO - PROCESS | 6186 | RSS: Main: 241197056 19:34:49 INFO - PROCESS | 6186 | 19:37:51 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:52621/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52621/tests/dromaeo/cssquery-yui.html) 19:37:52 INFO - PROCESS | 6186 | RSS: Main: 211611648 19:37:52 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | Cycle 1(1): loaded http://localhost:52621/tests/dromaeo/cssquery-yui.html (next: http://localhost:52621/tests/dromaeo/cssquery-dojo.html) 19:40:55 INFO - PROCESS | 6186 | RSS: Main: 274964480 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | __start_tp_report 19:40:55 INFO - PROCESS | 6186 | _x_x_mozilla_page_load 19:40:55 INFO - PROCESS | 6186 | _x_x_mozilla_page_load_details 19:40:55 INFO - PROCESS | 6186 | |i|pagename|runs| 19:40:55 INFO - PROCESS | 6186 | |0;dojo.html;3042.300270937683;3046;3084.013115802944;3093.706097920698;3107.0834103939337;5240.895182096356;5268.025415298172;5310;5333.546648534874;5380.166074258486;5314.893702125955;5325.813596524123;5332.066888294552;5340.759665815038;5456.154296084113;4789.185838407461;4827.662063655545;4853.320535125085;4866.416030076396;5006.098902197603;4899.142650036247;4941.085899108659;4973.179425394806;4979.352684151056;4992.525710057539;4775.188218002931;4800.711957282574;4813.181759100961;4870.586000189988;4885.60915126789;4869.220924652039;4870.123377791996;4870.512948705136;4873.415190177201;4875.341828853095;4821.252705830602;4836.371271734687;4842.031593681243;4842.031593681278;4847.709137451764;5231.450697676727;5271.314729085233;5299.125644268691;5339.359276886798;5341.946580534222;5609.467100625434;5622.128570071604;5622.240997465331;5628.943710562883;5680.261565996435;5481.808136715235;5639.8590035249035;5700.543956483471;5705.11570706537;5709.77160913563;5047.268146118829;5271.209318602202;5309.840704778863;5391.73041347931;5404.5946554009;5831.708414579254;5857.062869940874;5891.882162356815;5893.086571581412;5893.852653683693;5369.24830523727;5536.972315138399;5635.971820140873;5641.943580564224;5648.435156484401;5694.515966142924;5747.281589801275;5754.5971781975695;5771.797987070432;5772.769089236467;5682.062459694104;5685.658860468385;5686.886262274731;5716.314042314865;5742.59801813869;5504.2294078829;5679.971600142056;5682.147677848273;5684.715764211773;5684.857878552986;4259.8083086261195;4278.422412974271;4298.78506074695;4310.418093557392;4322.5677432256525;3840.539135303781;3847.134394761212;3847.826847791856;3894.084890050836;3898.2398432305995;5157.613179011589;5236.816711415082;5256.605754568346;5275.815346462856;5325.4940780625775;5631.802886898939;5648.943510564842;5663.292088488939;5679.176519404746;5715.257016587817;5269.815556455505;5288.2596436498925;5293.920591191135;5300.602454815904;5304.92042619361;4815.879603009883;4868.829590964299;4940.283658869444;4941.65408421407;4975.228839529878;5812.82561523155;5853.795117170878;5862.70686465675;5868.090445980794;5923.496502797224;5699.487046165865;5699.943000569941;5717.742701578522;5719.113537401709;5723.370429252695;5720.2849643794525;5797.4782269595935;5815.79644712433;5836.678982655994;5841.036229022334;5616.129499927518;5616.66300022;5621.988042152452;5637.830865074055;5642.520385767091;5704;5704.087346024616;5723.484886360081;5724.656520608777;5725.19847221381;5424.972875135599;5537.861553461195;5555.583331250092;5569.220309156641;5586.497215250647;5517.255170552085;5544.3346798384455;5554.444555544414;5562.860928476821;5564.916526252028;5529.391766905717;5573.247611572386;5585.190147428519;5586.748596313095;5638.407967163389;5479.4520547944885;5491.835244942658;5553.028220061554;5613.831585052455;5615.241942337732;5406.0809662356705;5493.587980901529;5502.367227768857;5502.862428439321;5504.752286147213 19:40:55 INFO - PROCESS | 6186 | |1;ext.html;584.573261519091;612.179679229832;615.9692015399229;637.7417146055847;644.1207751419314;43357.13285734283;43924.56075439245;44883.32675009877;44928.77535612322;46936.53063469364;45145.548544514546;45677.0864582709;45726.54273457264;45801.770991145;45806.7709661452;8096.473729207612;8878.955605221981;9038.18656320931;10769.730756731105;10994.560217591286;10871.239013269074;10998.285111467729;11002.779944401107;11003.61487347943;11019.83470247943;11066.170037247239;11093;11100.111991040738;11107.666769996913;11115.055220306243;10981.670549883516;11032.944835275852;11035.558577656884;11051.889481105167;11053.060489858331;10764.3541387517;10847.294925829796;10850.945745271301;10851.51168197425;10851.891481085167;43118.353224701656;43281.567184328065;43377.783111084245;43552.128957420675;43560.78219608913;3553.8578456861696;3645.65366290202;3656.634336566349;3988.8205030773684;4209.768462734548;32435.837820810746;33129.3374132516;33137.6686233137;34101.48847767286;34222.14444638879;4493.595576398107;4509.6392288616835;4534.41052663155;4547.590716835468;4580.3358513015755;338159;338772;340207;340844;340984;56291.71854140785;57199.42800571941;57221;57388;57460;60279.397206028254;60376.698116509135;60622.69688651529;60655.69672151611;60693;16652.084135372428;17323.740143897852;17323.82676173222;17326.3069477222;17332.480025599252;13053;13131.146475479254;13142.211467311992;13144.474221031243;13153.473861045642;15483.148426836633;15928.92035539815;16149.192540372935;16187.514374568782;16195.838041619432;6482.12491313676;6708.53040287185;6709.329067093252;6751.763688270887;6803.897941530881;926.893407258174;1022.6114076650825;1029.0738335497963;1040.1366865501766;1057.5928267617023;32493;32752.67247327496;32987;33157.66842331594;33364.65601695435;963.426761077158;1113.9944300278446;1135.903448206895;1139.9316041037398;1220.2556440571245;16653.666926661397;17174.22715977784;17205.827941720672;17276.308947642206;17297.394591189248;570581;576561;577014;578443;579986;59196.70401647964;59410.70294648586;59419;59439;59447.702761486784;1258.0941721960173;1349.1365526063328;1385;1390.4438224710198;1409.8308203015704;33111.50332744962;34462.31075378428;34665.82667086648;34697.826510867286;34805.47791783176;49733.50266497434;49801.750991244815;50261.49738502568;50355;50379;433039;434960;437195;438140;438220;34607.82696086604;40622.796886016564;41465.79267103645;41467.37798933079;44439;48267.75866120647;48450.27324590205;48989.51010489992;49255.50744492652;49326.50673493219;41306.38040429456;42362.57637423586;42664.78667606642;43034.35448468338;43701.562984369746;41577.168456631305;41787.37318940157;41852.581474184866;41956.1608767829;42809;41033.79483102685;42001.369979450945;42170.36744448775;42170.78914605407;42221.788891055345;35394;36760.26479470342;37034.62965370419;37037.814810925775;37711.62288377081;28381;28558.571621426112;28610.14169574916;28762.568561471177;28906.85546572338 19:40:55 INFO - PROCESS | 6186 | |2;jquery.html;378.45124569374406;384.22770231834016;390.99619892302826;392.7623787608497;404.2561686496845;18483.353082642112;20175.798242017576;20662.793372066273;20730.27444039459;20770.065347059382;19317.4204773857;19399.806001939978;20122.39632811018;20292.188312467482;20292.39122826314;5651.180578816069;5795.3335366432975;5886.6468011919205;5898.587098903078;5996.2804463464445;5855.23881895353;5863.2670916135485;5910.46805787479;5914.585978981473;5944.227250457435;5652.491275785179;5818.185454036438;5847.5614328925285;5873.735681894325;5878.970605146968;5704.401037891003;5827.271591051119;5830.271216097988;5833.358330583633;5850.327212370568;5183.248428977777;5200.739963001834;5207.921881171786;5208.739563021833;5219.817306394258;23343.766562334327;23391;23665.645015324782;23685.171019014426;24015.879920600284;2406.3984003999;2413.4207790130417;2462.8029757619347;2512.371907023244;2961.4077184562957;14210.147391156564;14595.635109122251;14996.775048374175;15387.538373848802;15439.30523126462;1875.9437216883516;1981.9306324278582;2083.2500299892026;2083.3125068727436;2174.7716489768504;83641;84423;84593.57703211506;86989;89084;10575.730912290574;10642.893571064345;10809.810920798705;10843.620473283398;11027.779444411228;15159.242037898282;15267;15281.388744450098;15282.38870445192;15289.923550382176;8321.375896807764;8483.939507561554;8595.3553483489;8632.654693812177;8700.695475658322;8326.625301861432;8358.707445239388;8405.243528082501;8545.145485451529;8551.657933682707;6638.701258443381;6721.4958878084335;6744.359285867835;6790.287019862942;6841.692123854438;1869.1401955100534;1916.3101283537915;1920.2319072370883;1939.2340025690055;2016.7983201679715;431.0839466134464;456.5525784730982;980.4215512847454;1030.0420608833706;1098.4617537406614;11110.05564527008;11587.942060289814;11614.187006909435;11696.47365868538;11818.940905295418;452.39153338759314;453.11190067467476;455.61728148354877;465.29043209106385;468.5876428742753;6172.629642221481;6237.844053898689;6251.343608921089;6267.435930766253;6337.366263373718;461128.6943565261;463330;511018;540880;543690;59234;67502.66248668823;86766.56616716876;88739;92152.53923730472;469.75337947577793;483.04116329087435;483.7532858242322;485.5241862974305;486.91235577595666;11448.94275528617;11703.531858725897;12123.696907577381;12223.327716975651;12285.69285767863;44463;44628.77685611551;46505;46749.76625116853;47150.528494714614;58973.41026589679;59892.70053649704;66178;66590.33409666036;67299;8892.33307501927;9123.31575131881;9146.49694266795;9231.123043310874;9425.481598512148;13625.591232263048;13856.584302470941;14671.853281467476;14788.704225915206;15033.624159396102;12890.35548222604;12965.546205882749;12976.805347919977;13052.934735326262;13102.148360356547;12556.058295627681;12570.308633025272;12690.23858568452;12813.74372512526;13121.475140994253;13032;13098.607041788762;13178.670533236746;13289.069765116348;13405.865941340851;7646.732364367221;7708.03649543807;8623.698170564001;8655.740327789925;8824.691135810473;12024.639260822189;12560.497580097059;12590.181638193488;12638.747225055631;12670.873291267339 19:40:55 INFO - PROCESS | 6186 | |3;mootools.html;1474.2112969561288;1494.0886059503705;1649.4309463235188;1752.9394716196693;1797.9550511237217;8247.546384948826;8707.25988290996;8788.78028049299;8792.604332805024;8815.20663140318;7503.737369192079;7573.242675732424;7586.96206518968;7793.454458187929;8617.310615150789;2159.6652518859564;2243.147603910512;2246.225052356934;2257.6162052451123;2264.9660255096187;2252.7747225277503;2253.7971582557566;2277.089164334271;2281.954360912781;2286.6684330772027;1974.6544354737935;2177.2814971059593;2262.9773702262933;2313.3985163857433;2328.359701082199;2283.6346184610384;2330.7203135623663;2333.346662934381;2333.8482998605123;2333.988330058356;2120;2168.5120847809117;2169.349195241421;2169.663702126157;2171.4896999205175;8450.535220562866;8564.015138259056;8572.485650860968;8584.8712269316;8586.656533738706;4926.975365123188;5036.798528058874;5036.84889453317;5037.042961837239;5048.62135339851;3115.112193024977;3152.36952609479;3219.7263232625255;3229.1927018245437;3233.4826427771445;1109.2457129152174;1135.3074624479061;1149.8608797981558;1158.4265788434695;1158.7566611011698;11500.597479088276;11733.706657333634;11738.119641026957;11741.295522268605;11742.589009384716;4419;4433.379326894237;4569.840055598038;4586.977065114653;4604.907901841944;10128.898711012796;10130.037646423578;10135.9493202535;10141.340812847142;10142.847857282146;5187.870303242449;5188.351456067991;5191.480851914854;5197.0125676121415;5199.038177937018;4103.117829666577;4594.494605593382;4726.1020406122725;4740.573348398591;4773.7374444405195;3896.5713771485116;3902.297586434412;3990.3216453203027;4009.1981603679383;4014.5182578090817;1239.2564461323313;1262.949482020709;1263.7093468502112;1273.1597145883673;1278.910476266671;737.4690223039403;925.8148370325827;938.4228699349851;957.6408846682494;963.8698775665335;5927.496162826122;6092.847678807977;6119.663418511936;6140.662263575547;6274.215723034621;455.7333959633651;461.0226320201128;473.5998081621025;476.35929674587624;635.463033736492;4007.499062617173;4290.82002449329;4411.316245981878;4418.64650827933;4475.552444755498;10103;10497.055265026032;10590.258681892348;10600.734981625366;10606.15150787935;10236.795264094677;10478.214133939984;10479.10927571165;10488.68533943983;10700.036996670337;8043.959780201179;8097.149799271109;8132.390070744717;8175.71385001534;8181.877271840927;5919.082542205965;6061.454469097803;6065.090236464565;6193.040078787795;6303.432691057827;9309.348345615741;9389.577469013775;9448.858267125861;9550.474723890253;9588.472634005197;10168.593256269667;10186.643467478603;10251.128654064489;10283.84574231402;10325.32885362449;7395.815104622212;7920.762377128695;8075.757727268191;8128.309093727099;8237.093919668952;8433.072362040048;8448.112948140602;8516.105808890225;8532.146785321418;8534.402591818513;7643.503172293783;7752.4573279869865;7804.726834560764;7857.332126769289;7925.603719814101;7536.585487798224;7538.208488108669;7544.547327160388;7616.8476630468185;7631.618419079135;6921.134858142732;6962.094927659372;6998.860022799618;6999.650017499206;6999.755008574675;5102.515261050195;5256.132738098171;5347.1979203119845;5420.05149098914;5446.754896029767;5282.286891269629;5336.573074154136;5342.225377320345;5471.06991811401;5496.477834605706 19:40:55 INFO - PROCESS | 6186 | |4;prototype.html;309.87604958016794;313.4686706033273;313.93564319314555;316.6200559328806;318.8278329701961;5426.213199086135;5438.53772429344;5478.972605136979;5498.725063746807;5503.47716966888;5311.698633834706;5325.360956685203;5397.649152805065;5401.918971215435;5406.972095626452;3966.7223294369405;4015.4378387025695;4119.2997190477545;4139.606737359946;4156.044109854735;4117.9527149909;4134.917301653965;4145.709800313979;4148.087420767426;4161.583841615845;3907.5115610548683;4107.691923105764;4112.424260603518;4119.5880411958715;4121.629053385194;4080.8165631966694;4151.813168407399;4156.210320039183;4156.376543518496;4157.355609880473;3637.7999210043436;3658.0489072840987;3660.432632941898;3696.5564132304294;3703.4629978652943;5228.849653076317;5258.2638430619745;5278.313819203479;5280.128778751501;5288.867778305573;4425.3804467374275;4684.882877928045;4689.742064186468;4738.502457241974;4755.33425320452;5512.834614961557;5581.916271255935;5603.159526071081;5638.351589567212;5644.096944488862;3930.526052730226;3937.3700207966876;3944.3294639911283;3965.7025723070597;3971.940420893689;5616.410276920906;5824.825255242349;5833.941660583425;5834.64992100471;5842.883142337172;3909.9022524436546;3939.6651284641125;3947.3092208863336;3948.9012774680864;3961.1087505311652;3929.862454814068;3972.5301638393403;3982.601739825994;3996.980015099906;4001.8399264029113;4565.246734288871;4675.22858728306;4680.648951328664;4683.648726345537;4694.7417892016265;5575.665460072409;5587.580931430159;5624.606277560531;5661.575381846378;5667.858303542362;1380.5996261084174;1383.266868559665;1386.8890488760876;1395.5115709501797;1402.263811498971;869.591292092728;874.4884242717955;891.2914233184633;908.5184852028435;913.8355096082769;5250.868728281747;5269.156934890476;5276.314079169683;5278.656887302313;5282.735863206824;5604.495595396434;5607.54203906979;5657.4908258256955;5709.172170035322;5714.428557144252;5143.431253467654;5370.597205209625;5388.973055134699;5397.70312632809;5413.242146099549;3032;3033.8028028178096;3052.5573791800066;3061.969380306168;3063;5771.49941015339;5839.883202336015;5842.941570584325;5847.953216374235;5918.881622367615;5807.0998995155815;5823.82528524145;5831.912521312183;5850.4149585042005;5853.765849365977;5821.311819572276;5843.795467158629;5858.121281807763;5895.204147440127;5895.67573783446;5351.331083614548;5636.689982051026;5641.210230567806;5728.2266893970445;5733.569982251264;5598.272224610938;5611.438856114356;5660.801871934627;5663.263775709296;5663.433656634304;5656.717164141859;5865.765369385177;5882.7058647066615;5902.1736956826935;5918.881622367615;4115.2510183172635;4120.567340429332;4139.91720165589;4140.3375459926265;4150.107726838623;5775.9133612995;5830.47525722687;5830.970845145747;5845.473907348359;5884.6469211847425;5493.450654934634;5674.290713660793;5716.314042314949;5726.5418766499415;5757.136429535603;5653.123765816305;5654.3497497788285;5654.6889921054735;5672.262605861211;5674.744636491285;5422.322209723785;5542;5549.334079910436;5616.971915140398;5719.771209151588;5233.3196684432305;5583.637063590853;5722.6852523109965;5737.713114344183;5751.9424805751405;5539.279893613804;5546.084895992116;5587.860303492445;5598.608097433141;5615.887682246251 19:40:55 INFO - PROCESS | 6186 | |5;yui.html;782.5852298281911;806.5714766995967;834.9958250208748;856.8543347630898;865.0916537635483;15067.246637668113;15786.763198552031;16225.18874056297;16239;16546.58633534162;15237.16195609241;15312.540623781304;15431.151286679227;15463.69072618547;15484.612884677888;664.51158398577;783.4985609210081;805.7059173401725;823.0247157118833;826.9338452923752;806.5523634382915;807.834393949239;807.9798005049862;808.720991258018;817.6320655704927;829.7718127514921;833.1127349372929;836.8326334733048;838.4340570115148;838.6016642095017;661.4179522020615;830.2776584371635;842.9367797415188;843.9831203375929;850.3792231670915;621.2358798677607;621.3506885304868;621.6301300726061;621.9067139929001;622.4024936061387;14276.928615356857;14317.78523322151;14336.856631433657;14353.497627582985;14404.207768572724;14125.929370353082;14243.857561424356;14411.78382324266;14412.783808242884;14552.92723536386;13532.864671353258;13591.796123058162;13654.385552650154;13654.726905461934;13945.860541394557;4555.339475775994;4571.794269257892;4622.075584883003;4738.076075165344;4758.714477131349;65322.34677653258;75494;75792;75985.24014759836;77125;10837.403942783065;10843.349399036084;10996.670099897015;11046.171537134747;11352.091832653368;21488.677669834964;21490.032948517353;21491.892540537196;21506.677399839016;21518;8125.634346454423;8411.242988131098;8475;8661.13388661129;8750.912490875136;4956.132676781549;4961.355023846877;5064.7467626619255;5085.949140508547;5234.979179060047;3499.4225952717516;3620.7465477416326;3624.0939765058733;3628.546431696038;3640.180959284193;621.5462712220104;624.8625302433458;641.3650486018901;645.1194120026131;647.1813156357211;476.71158948835455;596.6092209602717;605.7788907048983;622.2004723929819;640.4812102197235;8974;9516.524173791282;9624.855627165458;9833.4099954003;10089;505.7724024189056;538.8841399099134;631.4948041566728;639.8560323927079;656.5071443424536;4396.494403143615;4459.888502787457;4665.090307390026;4684.367610372556;4714.929276060861;66837.33162668311;90908.09091909128;113870;116351;116923;105117.47441262745;105142.13984348932;106031.46984265029;106512;106606.46696766622;91031.5448422767;91516;92804;93222;94519;8868.86696699537;9066.727998160066;9110.661497214129;9113.77215569616;9149.22231610294;52421;52751.20873186982;53754.462455374945;54454.72772636112;55616;73200;78844.60577697075;80569.59715201621;81895;82180.17819821725;11452.370119643167;11713.414329283672;11746.530138794353;11782.11634127461;11908.106891983309;12772.361381930681;12926.612201633967;14263;14475.493357732428;14547.05444146127;13791.724165516835;14324.641883952985;14364.281785910454;14616.780748288571;14716.117032978056;12794.232346059267;13436.596902092953;13602.659933501742;14142.929285353508;14506.202158881362;13925.930370348084;14418.351174196976;14545.709085818437;14631.26843657834;14878.776818347516;11370.393279725482;11416.42132809914;11555.4800033997;12123.272603643809;12282.754344912873;11860.822087668865;12286.324252166216;12326.938365308475;12400.255984640951;12605.30670813114 19:40:55 INFO - PROCESS | 6186 | __end_tp_report 19:40:55 INFO - PROCESS | 6186 | __start_cc_report 19:40:55 INFO - PROCESS | 6186 | _x_x_mozilla_cycle_collect,1199 19:40:55 INFO - PROCESS | 6186 | __end_cc_report 19:40:55 INFO - PROCESS | 6186 | __startTimestamp1468032055725__endTimestamp 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | ------- Summary: start ------- 19:40:55 INFO - PROCESS | 6186 | Number of tests: 6 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | [#0] dojo.html Cycles:165 Average:5278.70 Median:5502.37 stddev:598.08 (10.9%) stddev-sans-first:573.61 19:40:55 INFO - PROCESS | 6186 | Values: 3042.3 3046.0 3084.0 3093.7 3107.1 5240.9 5268.0 5310.0 5333.5 5380.2 5314.9 5325.8 5332.1 5340.8 5456.2 4789.2 4827.7 4853.3 4866.4 5006.1 4899.1 4941.1 4973.2 4979.4 4992.5 4775.2 4800.7 4813.2 4870.6 4885.6 4869.2 4870.1 4870.5 4873.4 4875.3 4821.3 4836.4 4842.0 4842.0 4847.7 5231.5 5271.3 5299.1 5339.4 5341.9 5609.5 5622.1 5622.2 5628.9 5680.3 5481.8 5639.9 5700.5 5705.1 5709.8 5047.3 5271.2 5309.8 5391.7 5404.6 5831.7 5857.1 5891.9 5893.1 5893.9 5369.2 5537.0 5636.0 5641.9 5648.4 5694.5 5747.3 5754.6 5771.8 5772.8 5682.1 5685.7 5686.9 5716.3 5742.6 5504.2 5680.0 5682.1 5684.7 5684.9 4259.8 4278.4 4298.8 4310.4 4322.6 3840.5 3847.1 3847.8 3894.1 3898.2 5157.6 5236.8 5256.6 5275.8 5325.5 5631.8 5648.9 5663.3 5679.2 5715.3 5269.8 5288.3 5293.9 5300.6 5304.9 4815.9 4868.8 4940.3 4941.7 4975.2 5812.8 5853.8 5862.7 5868.1 5923.5 5699.5 5699.9 5717.7 5719.1 5723.4 5720.3 5797.5 5815.8 5836.7 5841.0 5616.1 5616.7 5622.0 5637.8 5642.5 5704.0 5704.1 5723.5 5724.7 5725.2 5425.0 5537.9 5555.6 5569.2 5586.5 5517.3 5544.3 5554.4 5562.9 5564.9 5529.4 5573.2 5585.2 5586.7 5638.4 5479.5 5491.8 5553.0 5613.8 5615.2 5406.1 5493.6 5502.4 5502.9 5504.8 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | [#1] ext.html Cycles:180 Average:61990.91 Median:40828.30 stddev:122293.82 (299.5%) stddev-sans-first:122549.98 19:40:55 INFO - PROCESS | 6186 | Values: 584.6 612.2 616.0 637.7 644.1 43357.1 43924.6 44883.3 44928.8 46936.5 45145.5 45677.1 45726.5 45801.8 45806.8 8096.5 8879.0 9038.2 10769.7 10994.6 10871.2 10998.3 11002.8 11003.6 11019.8 11066.2 11093.0 11100.1 11107.7 11115.1 10981.7 11032.9 11035.6 11051.9 11053.1 10764.4 10847.3 10850.9 10851.5 10851.9 43118.4 43281.6 43377.8 43552.1 43560.8 3553.9 3645.7 3656.6 3988.8 4209.8 32435.8 33129.3 33137.7 34101.5 34222.1 4493.6 4509.6 4534.4 4547.6 4580.3 338159.0 338772.0 340207.0 340844.0 340984.0 56291.7 57199.4 57221.0 57388.0 57460.0 60279.4 60376.7 60622.7 60655.7 60693.0 16652.1 17323.7 17323.8 17326.3 17332.5 13053.0 13131.1 13142.2 13144.5 13153.5 15483.1 15928.9 16149.2 16187.5 16195.8 6482.1 6708.5 6709.3 6751.8 6803.9 926.9 1022.6 1029.1 1040.1 1057.6 32493.0 32752.7 32987.0 33157.7 33364.7 963.4 1114.0 1135.9 1139.9 1220.3 16653.7 17174.2 17205.8 17276.3 17297.4 570581.0 576561.0 577014.0 578443.0 579986.0 59196.7 59410.7 59419.0 59439.0 59447.7 1258.1 1349.1 1385.0 1390.4 1409.8 33111.5 34462.3 34665.8 34697.8 34805.5 49733.5 49801.8 50261.5 50355.0 50379.0 433039.0 434960.0 437195.0 438140.0 438220.0 34607.8 40622.8 41465.8 41467.4 44439.0 48267.8 48450.3 48989.5 49255.5 49326.5 41306.4 42362.6 42664.8 43034.4 43701.6 41577.2 41787.4 41852.6 41956.2 42809.0 41033.8 42001.4 42170.4 42170.8 42221.8 35394.0 36760.3 37034.6 37037.8 37711.6 28381.0 28558.6 28610.1 28762.6 28906.9 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | [#2] jquery.html Cycles:180 Average:29360.56 Median:452.75 stddev:83208.37 (18378.4%) stddev-sans-first:83413.34 19:40:55 INFO - PROCESS | 6186 | Values: 378.5 384.2 391.0 392.8 404.3 18483.4 20175.8 20662.8 20730.3 20770.1 19317.4 19399.8 20122.4 20292.2 20292.4 5651.2 5795.3 5886.6 5898.6 5996.3 5855.2 5863.3 5910.5 5914.6 5944.2 5652.5 5818.2 5847.6 5873.7 5879.0 5704.4 5827.3 5830.3 5833.4 5850.3 5183.2 5200.7 5207.9 5208.7 5219.8 23343.8 23391.0 23665.6 23685.2 24015.9 2406.4 2413.4 2462.8 2512.4 2961.4 14210.1 14595.6 14996.8 15387.5 15439.3 1875.9 1981.9 2083.3 2083.3 2174.8 83641.0 84423.0 84593.6 86989.0 89084.0 10575.7 10642.9 10809.8 10843.6 11027.8 15159.2 15267.0 15281.4 15282.4 15289.9 8321.4 8483.9 8595.4 8632.7 8700.7 8326.6 8358.7 8405.2 8545.1 8551.7 6638.7 6721.5 6744.4 6790.3 6841.7 1869.1 1916.3 1920.2 1939.2 2016.8 431.1 456.6 980.4 1030.0 1098.5 11110.1 11587.9 11614.2 11696.5 11818.9 452.4 453.1 455.6 465.3 468.6 6172.6 6237.8 6251.3 6267.4 6337.4 461128.7 463330.0 511018.0 540880.0 543690.0 59234.0 67502.7 86766.6 88739.0 92152.5 469.8 483.0 483.8 485.5 486.9 11448.9 11703.5 12123.7 12223.3 12285.7 44463.0 44628.8 46505.0 46749.8 47150.5 58973.4 59892.7 66178.0 66590.3 67299.0 8892.3 9123.3 9146.5 9231.1 9425.5 13625.6 13856.6 14671.9 14788.7 15033.6 12890.4 12965.5 12976.8 13052.9 13102.1 12556.1 12570.3 12690.2 12813.7 13121.5 13032.0 13098.6 13178.7 13289.1 13405.9 7646.7 7708.0 8623.7 8655.7 8824.7 12024.6 12560.5 12590.2 12638.7 12670.9 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | [#3] mootools.html Cycles:180 Average:5688.74 Median:2607.09 stddev:3207.71 (123.0%) stddev-sans-first:3201.08 19:40:55 INFO - PROCESS | 6186 | Values: 1474.2 1494.1 1649.4 1752.9 1798.0 8247.5 8707.3 8788.8 8792.6 8815.2 7503.7 7573.2 7587.0 7793.5 8617.3 2159.7 2243.1 2246.2 2257.6 2265.0 2252.8 2253.8 2277.1 2282.0 2286.7 1974.7 2177.3 2263.0 2313.4 2328.4 2283.6 2330.7 2333.3 2333.8 2334.0 2120.0 2168.5 2169.3 2169.7 2171.5 8450.5 8564.0 8572.5 8584.9 8586.7 4927.0 5036.8 5036.8 5037.0 5048.6 3115.1 3152.4 3219.7 3229.2 3233.5 1109.2 1135.3 1149.9 1158.4 1158.8 11500.6 11733.7 11738.1 11741.3 11742.6 4419.0 4433.4 4569.8 4587.0 4604.9 10128.9 10130.0 10135.9 10141.3 10142.8 5187.9 5188.4 5191.5 5197.0 5199.0 4103.1 4594.5 4726.1 4740.6 4773.7 3896.6 3902.3 3990.3 4009.2 4014.5 1239.3 1262.9 1263.7 1273.2 1278.9 737.5 925.8 938.4 957.6 963.9 5927.5 6092.8 6119.7 6140.7 6274.2 455.7 461.0 473.6 476.4 635.5 4007.5 4290.8 4411.3 4418.6 4475.6 10103.0 10497.1 10590.3 10600.7 10606.2 10236.8 10478.2 10479.1 10488.7 10700.0 8044.0 8097.1 8132.4 8175.7 8181.9 5919.1 6061.5 6065.1 6193.0 6303.4 9309.3 9389.6 9448.9 9550.5 9588.5 10168.6 10186.6 10251.1 10283.8 10325.3 7395.8 7920.8 8075.8 8128.3 8237.1 8433.1 8448.1 8516.1 8532.1 8534.4 7643.5 7752.5 7804.7 7857.3 7925.6 7536.6 7538.2 7544.5 7616.8 7631.6 6921.1 6962.1 6998.9 6999.7 6999.8 5102.5 5256.1 5347.2 5420.1 5446.8 5282.3 5336.6 5342.2 5471.1 5496.5 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | [#4] prototype.html Cycles:180 Average:4695.13 Median:5410.11 stddev:1402.02 (25.9%) stddev-sans-first:1366.77 19:40:55 INFO - PROCESS | 6186 | Values: 309.9 313.5 313.9 316.6 318.8 5426.2 5438.5 5479.0 5498.7 5503.5 5311.7 5325.4 5397.6 5401.9 5407.0 3966.7 4015.4 4119.3 4139.6 4156.0 4118.0 4134.9 4145.7 4148.1 4161.6 3907.5 4107.7 4112.4 4119.6 4121.6 4080.8 4151.8 4156.2 4156.4 4157.4 3637.8 3658.0 3660.4 3696.6 3703.5 5228.8 5258.3 5278.3 5280.1 5288.9 4425.4 4684.9 4689.7 4738.5 4755.3 5512.8 5581.9 5603.2 5638.4 5644.1 3930.5 3937.4 3944.3 3965.7 3971.9 5616.4 5824.8 5833.9 5834.6 5842.9 3909.9 3939.7 3947.3 3948.9 3961.1 3929.9 3972.5 3982.6 3997.0 4001.8 4565.2 4675.2 4680.6 4683.6 4694.7 5575.7 5587.6 5624.6 5661.6 5667.9 1380.6 1383.3 1386.9 1395.5 1402.3 869.6 874.5 891.3 908.5 913.8 5250.9 5269.2 5276.3 5278.7 5282.7 5604.5 5607.5 5657.5 5709.2 5714.4 5143.4 5370.6 5389.0 5397.7 5413.2 3032.0 3033.8 3052.6 3062.0 3063.0 5771.5 5839.9 5842.9 5848.0 5918.9 5807.1 5823.8 5831.9 5850.4 5853.8 5821.3 5843.8 5858.1 5895.2 5895.7 5351.3 5636.7 5641.2 5728.2 5733.6 5598.3 5611.4 5660.8 5663.3 5663.4 5656.7 5865.8 5882.7 5902.2 5918.9 4115.3 4120.6 4139.9 4140.3 4150.1 5775.9 5830.5 5831.0 5845.5 5884.6 5493.5 5674.3 5716.3 5726.5 5757.1 5653.1 5654.3 5654.7 5672.3 5674.7 5422.3 5542.0 5549.3 5617.0 5719.8 5233.3 5583.6 5722.7 5737.7 5751.9 5539.3 5546.1 5587.9 5598.6 5615.9 19:40:55 INFO - PROCESS | 6186 | 19:40:55 INFO - PROCESS | 6186 | [#5] yui.html Cycles:180 Average:21012.50 Median:4699.65 stddev:30080.88 (640.1%) stddev-sans-first:30126.91 19:40:55 INFO - PROCESS | 6186 | Values: 782.6 806.6 835.0 856.9 865.1 15067.2 15786.8 16225.2 16239.0 16546.6 15237.2 15312.5 15431.2 15463.7 15484.6 664.5 783.5 805.7 823.0 826.9 806.6 807.8 808.0 808.7 817.6 829.8 833.1 836.8 838.4 838.6 661.4 830.3 842.9 844.0 850.4 621.2 621.4 621.6 621.9 622.4 14276.9 14317.8 14336.9 14353.5 14404.2 14125.9 14243.9 14411.8 14412.8 14552.9 13532.9 13591.8 13654.4 13654.7 13945.9 4555.3 4571.8 4622.1 4738.1 4758.7 65322.3 75494.0 75792.0 75985.2 77125.0 10837.4 10843.3 10996.7 11046.2 11352.1 21488.7 21490.0 21491.9 21506.7 21518.0 8125.6 8411.2 8475.0 8661.1 8750.9 4956.1 4961.4 5064.7 5085.9 5235.0 3499.4 3620.7 3624.1 3628.5 3640.2 621.5 624.9 641.4 645.1 647.2 476.7 596.6 605.8 622.2 640.5 8974.0 9516.5 9624.9 9833.4 10089.0 505.8 538.9 631.5 639.9 656.5 4396.5 4459.9 4665.1 4684.4 4714.9 66837.3 90908.1 113870.0 116351.0 116923.0 105117.5 105142.1 106031.5 106512.0 106606.5 91031.5 91516.0 92804.0 93222.0 94519.0 8868.9 9066.7 9110.7 9113.8 9149.2 52421.0 52751.2 53754.5 54454.7 55616.0 73200.0 78844.6 80569.6 81895.0 82180.2 11452.4 11713.4 11746.5 11782.1 11908.1 12772.4 12926.6 14263.0 14475.5 14547.1 13791.7 14324.6 14364.3 14616.8 14716.1 12794.2 13436.6 13602.7 14142.9 14506.2 13925.9 14418.4 14545.7 14631.3 14878.8 11370.4 11416.4 11555.5 12123.3 12282.8 11860.8 12286.3 12326.9 12400.3 12605.3 19:40:55 INFO - PROCESS | 6186 | -------- Summary: end -------- 19:40:55 INFO - PROCESS | 6186 | 19:40:56 INFO - TEST-INFO | 6186: exit 0 19:40:56 INFO - TEST-OK | dromaeo_css | took 1114006ms 19:40:56 INFO - TEST-START | kraken 19:40:56 INFO - operating with platform_type : linux_ 19:40:56 INFO - Initialising browser for kraken test... 19:40:56 INFO - TEST-INFO | started process 6373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwNHcV7/profile http://localhost:52621/getInfo.html) 19:41:00 INFO - PROCESS | 6373 | __metrics Screen width/height:1600/1200 19:41:00 INFO - PROCESS | 6373 | colorDepth:24 19:41:00 INFO - PROCESS | 6373 | Browser inner width/height: 1024/697 19:41:00 INFO - PROCESS | 6373 | __metrics 19:41:01 INFO - PROCESS | 6373 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:41:02 INFO - TEST-INFO | 6373: exit 0 19:41:02 INFO - Browser initialized. 19:41:02 INFO - Running cycle 1/1 for kraken test... 19:41:02 INFO - TEST-INFO | started process 6453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwNHcV7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:41:14 INFO - PROCESS | 6453 | RSS: Main: 157089792 19:41:14 INFO - PROCESS | 6453 | 19:41:16 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52621/tests/kraken/driver.html?testName=audio-beat-detection) 19:41:17 INFO - PROCESS | 6453 | RSS: Main: 215646208 19:41:17 INFO - PROCESS | 6453 | 19:41:20 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52621/tests/kraken/driver.html?testName=audio-dft) 19:41:20 INFO - PROCESS | 6453 | RSS: Main: 202997760 19:41:20 INFO - PROCESS | 6453 | 19:41:23 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52621/tests/kraken/driver.html?testName=audio-fft) 19:41:24 INFO - PROCESS | 6453 | RSS: Main: 269021184 19:41:24 INFO - PROCESS | 6453 | 19:41:26 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52621/tests/kraken/driver.html?testName=audio-oscillator) 19:41:27 INFO - PROCESS | 6453 | RSS: Main: 180158464 19:41:27 INFO - PROCESS | 6453 | 19:41:29 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52621/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:41:30 INFO - PROCESS | 6453 | RSS: Main: 184578048 19:41:30 INFO - PROCESS | 6453 | 19:41:33 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52621/tests/kraken/driver.html?testName=imaging-darkroom) 19:41:33 INFO - PROCESS | 6453 | RSS: Main: 220626944 19:41:33 INFO - PROCESS | 6453 | 19:41:37 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52621/tests/kraken/driver.html?testName=imaging-desaturate) 19:41:37 INFO - PROCESS | 6453 | RSS: Main: 220852224 19:41:37 INFO - PROCESS | 6453 | 19:41:40 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52621/tests/kraken/driver.html?testName=json-parse-financial) 19:41:41 INFO - PROCESS | 6453 | RSS: Main: 221097984 19:41:41 INFO - PROCESS | 6453 | 19:41:42 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52621/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:41:43 INFO - PROCESS | 6453 | RSS: Main: 206913536 19:41:43 INFO - PROCESS | 6453 | 19:41:44 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:41:45 INFO - PROCESS | 6453 | RSS: Main: 211537920 19:41:45 INFO - PROCESS | 6453 | 19:41:47 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:41:48 INFO - PROCESS | 6453 | RSS: Main: 210112512 19:41:48 INFO - PROCESS | 6453 | 19:41:50 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:41:51 INFO - PROCESS | 6453 | RSS: Main: 228012032 19:41:51 INFO - PROCESS | 6453 | 19:41:54 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:41:54 INFO - PROCESS | 6453 | RSS: Main: 223981568 19:41:54 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | Cycle 1(1): loaded http://localhost:52621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52621/tests/kraken/driver.html?testName=ai-astar) 19:41:56 INFO - PROCESS | 6453 | RSS: Main: 266485760 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | __start_tp_report 19:41:56 INFO - PROCESS | 6453 | _x_x_mozilla_page_load 19:41:56 INFO - PROCESS | 6453 | _x_x_mozilla_page_load_details 19:41:56 INFO - PROCESS | 6453 | |i|pagename|runs| 19:41:56 INFO - PROCESS | 6453 | |0;ai-astar;103;111;111;111;112;110;110;111;112;112 19:41:56 INFO - PROCESS | 6453 | |1;audio-beat-detection;153;117;119;182;119;121;142;115;155;120 19:41:56 INFO - PROCESS | 6453 | |2;audio-dft;161;161;161;160;162;160;159;160;160;160 19:41:56 INFO - PROCESS | 6453 | |3;audio-fft;74;75;77;128;76;75;74;75;108;74 19:41:56 INFO - PROCESS | 6453 | |4;audio-oscillator;84;85;109;83;84;83;119;83;84;130 19:41:56 INFO - PROCESS | 6453 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;118;117;117 19:41:56 INFO - PROCESS | 6453 | |6;imaging-darkroom;146;146;145;146;147;145;146;145;146;146 19:41:56 INFO - PROCESS | 6453 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 19:41:56 INFO - PROCESS | 6453 | |8;json-parse-financial;50;53;53;52;52;51;52;53;54;52 19:41:56 INFO - PROCESS | 6453 | |9;json-stringify-tinderbox;60;60;60;60;61;60;61;61;60;61 19:41:56 INFO - PROCESS | 6453 | |10;stanford-crypto-aes;75;75;75;74;74;75;80;74;75;75 19:41:56 INFO - PROCESS | 6453 | |11;stanford-crypto-ccm;126;133;119;124;118;118;126;119;173;120 19:41:56 INFO - PROCESS | 6453 | |12;stanford-crypto-pbkdf2;161;160;160;159;163;159;159;158;160;164 19:41:56 INFO - PROCESS | 6453 | |13;stanford-crypto-sha256-iterative;64;64;68;63;63;66;63;63;62;67 19:41:56 INFO - PROCESS | 6453 | __end_tp_report 19:41:56 INFO - PROCESS | 6453 | __start_cc_report 19:41:56 INFO - PROCESS | 6453 | _x_x_mozilla_cycle_collect,1672 19:41:56 INFO - PROCESS | 6453 | __end_cc_report 19:41:56 INFO - PROCESS | 6453 | __startTimestamp1468032116678__endTimestamp 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | ------- Summary: start ------- 19:41:56 INFO - PROCESS | 6453 | Number of tests: 14 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 19:41:56 INFO - PROCESS | 6453 | Values: 103.0 111.0 111.0 111.0 112.0 110.0 110.0 111.0 112.0 112.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:131.50 stddev:22.69 (17.3%) stddev-sans-first:23.04 19:41:56 INFO - PROCESS | 6453 | Values: 153.0 117.0 119.0 182.0 119.0 121.0 142.0 115.0 155.0 120.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 19:41:56 INFO - PROCESS | 6453 | Values: 161.0 161.0 161.0 160.0 162.0 160.0 159.0 160.0 160.0 160.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:18.76 (25.0%) stddev-sans-first:19.57 19:41:56 INFO - PROCESS | 6453 | Values: 74.0 75.0 77.0 128.0 76.0 75.0 74.0 75.0 108.0 74.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.50 stddev:17.91 (21.5%) stddev-sans-first:18.60 19:41:56 INFO - PROCESS | 6453 | Values: 84.0 85.0 109.0 83.0 84.0 83.0 119.0 83.0 84.0 130.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:41:56 INFO - PROCESS | 6453 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:41:56 INFO - PROCESS | 6453 | Values: 146.0 146.0 145.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 19:41:56 INFO - PROCESS | 6453 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:1.14 (2.2%) stddev-sans-first:0.88 19:41:56 INFO - PROCESS | 6453 | Values: 50.0 53.0 53.0 52.0 52.0 51.0 52.0 53.0 54.0 52.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 19:41:56 INFO - PROCESS | 6453 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 61.0 61.0 60.0 61.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:1.75 (2.3%) stddev-sans-first:1.86 19:41:56 INFO - PROCESS | 6453 | Values: 75.0 75.0 75.0 74.0 74.0 75.0 80.0 74.0 75.0 75.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.00 stddev:16.66 (13.3%) stddev-sans-first:17.66 19:41:56 INFO - PROCESS | 6453 | Values: 126.0 133.0 119.0 124.0 118.0 118.0 126.0 119.0 173.0 120.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 19:41:56 INFO - PROCESS | 6453 | Values: 161.0 160.0 160.0 159.0 163.0 159.0 159.0 158.0 160.0 164.0 19:41:56 INFO - PROCESS | 6453 | 19:41:56 INFO - PROCESS | 6453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:2.00 (3.1%) stddev-sans-first:2.12 19:41:56 INFO - PROCESS | 6453 | Values: 64.0 64.0 68.0 63.0 63.0 66.0 63.0 63.0 62.0 67.0 19:41:56 INFO - PROCESS | 6453 | -------- Summary: end -------- 19:41:56 INFO - PROCESS | 6453 | 19:41:57 INFO - TEST-INFO | 6453: exit 0 19:41:57 INFO - TEST-OK | kraken | took 61258ms 19:41:57 INFO - SUITE-END | took 1175s 19:41:57 INFO - Completed test suite (00:19:35) 19:41:57 INFO - javascript benchmark 19:41:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.300270937683, 3046.0, 3084.013115802944, 3093.706097920698, 3107.0834103939337, 5240.895182096356, 5268.025415298172, 5310.0, 5333.546648534874, 5380.166074258486, 5314.893702125955, 5325.813596524123, 5332.066888294552, 5340.759665815038, 5456.154296084113, 4789.185838407461, 4827.662063655545, 4853.320535125085, 4866.416030076396, 5006.098902197603, 4899.142650036247, 4941.085899108659, 4973.179425394806, 4979.352684151056, 4992.525710057539, 4775.188218002931, 4800.711957282574, 4813.181759100961, 4870.586000189988, 4885.60915126789, 4869.220924652039, 4870.123377791996, 4870.512948705136, 4873.415190177201, 4875.341828853095, 4821.252705830602, 4836.371271734687, 4842.031593681243, 4842.031593681278, 4847.709137451764, 5231.450697676727, 5271.314729085233, 5299.125644268691, 5339.359276886798, 5341.946580534222, 5609.467100625434, 5622.128570071604, 5622.240997465331, 5628.943710562883, 5680.261565996435, 5481.808136715235, 5639.8590035249035, 5700.543956483471, 5705.11570706537, 5709.77160913563, 5047.268146118829, 5271.209318602202, 5309.840704778863, 5391.73041347931, 5404.5946554009, 5831.708414579254, 5857.062869940874, 5891.882162356815, 5893.086571581412, 5893.852653683693, 5369.24830523727, 5536.972315138399, 5635.971820140873, 5641.943580564224, 5648.435156484401, 5694.515966142924, 5747.281589801275, 5754.5971781975695, 5771.797987070432, 5772.769089236467, 5682.062459694104, 5685.658860468385, 5686.886262274731, 5716.314042314865, 5742.59801813869, 5504.2294078829, 5679.971600142056, 5682.147677848273, 5684.715764211773, 5684.857878552986, 4259.8083086261195, 4278.422412974271, 4298.78506074695, 4310.418093557392, 4322.5677432256525, 3840.539135303781, 3847.134394761212, 3847.826847791856, 3894.084890050836, 3898.2398432305995, 5157.613179011589, 5236.816711415082, 5256.605754568346, 5275.815346462856, 5325.4940780625775, 5631.802886898939, 5648.943510564842, 5663.292088488939, 5679.176519404746, 5715.257016587817, 5269.815556455505, 5288.2596436498925, 5293.920591191135, 5300.602454815904, 5304.92042619361, 4815.879603009883, 4868.829590964299, 4940.283658869444, 4941.65408421407, 4975.228839529878, 5812.82561523155, 5853.795117170878, 5862.70686465675, 5868.090445980794, 5923.496502797224, 5699.487046165865, 5699.943000569941, 5717.742701578522, 5719.113537401709, 5723.370429252695, 5720.2849643794525, 5797.4782269595935, 5815.79644712433, 5836.678982655994, 5841.036229022334, 5616.129499927518, 5616.66300022, 5621.988042152452, 5637.830865074055, 5642.520385767091, 5704.0, 5704.087346024616, 5723.484886360081, 5724.656520608777, 5725.19847221381, 5424.972875135599, 5537.861553461195, 5555.583331250092, 5569.220309156641, 5586.497215250647, 5517.255170552085, 5544.3346798384455, 5554.444555544414, 5562.860928476821, 5564.916526252028, 5529.391766905717, 5573.247611572386, 5585.190147428519, 5586.748596313095, 5638.407967163389, 5479.4520547944885, 5491.835244942658, 5553.028220061554, 5613.831585052455, 5615.241942337732, 5406.0809662356705, 5493.587980901529, 5502.367227768857, 5502.862428439321, 5504.752286147213], "value": 5238.284969463263, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.573261519091, 612.179679229832, 615.9692015399229, 637.7417146055847, 644.1207751419314, 43357.13285734283, 43924.56075439245, 44883.32675009877, 44928.77535612322, 46936.53063469364, 45145.548544514546, 45677.0864582709, 45726.54273457264, 45801.770991145, 45806.7709661452, 8096.473729207612, 8878.955605221981, 9038.18656320931, 10769.730756731105, 10994.560217591286, 10871.239013269074, 10998.285111467729, 11002.779944401107, 11003.61487347943, 11019.83470247943, 11066.170037247239, 11093.0, 11100.111991040738, 11107.666769996913, 11115.055220306243, 10981.670549883516, 11032.944835275852, 11035.558577656884, 11051.889481105167, 11053.060489858331, 10764.3541387517, 10847.294925829796, 10850.945745271301, 10851.51168197425, 10851.891481085167, 43118.353224701656, 43281.567184328065, 43377.783111084245, 43552.128957420675, 43560.78219608913, 3553.8578456861696, 3645.65366290202, 3656.634336566349, 3988.8205030773684, 4209.768462734548, 32435.837820810746, 33129.3374132516, 33137.6686233137, 34101.48847767286, 34222.14444638879, 4493.595576398107, 4509.6392288616835, 4534.41052663155, 4547.590716835468, 4580.3358513015755, 338159.0, 338772.0, 340207.0, 340844.0, 340984.0, 56291.71854140785, 57199.42800571941, 57221.0, 57388.0, 57460.0, 60279.397206028254, 60376.698116509135, 60622.69688651529, 60655.69672151611, 60693.0, 16652.084135372428, 17323.740143897852, 17323.82676173222, 17326.3069477222, 17332.480025599252, 13053.0, 13131.146475479254, 13142.211467311992, 13144.474221031243, 13153.473861045642, 15483.148426836633, 15928.92035539815, 16149.192540372935, 16187.514374568782, 16195.838041619432, 6482.12491313676, 6708.53040287185, 6709.329067093252, 6751.763688270887, 6803.897941530881, 926.893407258174, 1022.6114076650825, 1029.0738335497963, 1040.1366865501766, 1057.5928267617023, 32493.0, 32752.67247327496, 32987.0, 33157.66842331594, 33364.65601695435, 963.426761077158, 1113.9944300278446, 1135.903448206895, 1139.9316041037398, 1220.2556440571245, 16653.666926661397, 17174.22715977784, 17205.827941720672, 17276.308947642206, 17297.394591189248, 570581.0, 576561.0, 577014.0, 578443.0, 579986.0, 59196.70401647964, 59410.70294648586, 59419.0, 59439.0, 59447.702761486784, 1258.0941721960173, 1349.1365526063328, 1385.0, 1390.4438224710198, 1409.8308203015704, 33111.50332744962, 34462.31075378428, 34665.82667086648, 34697.826510867286, 34805.47791783176, 49733.50266497434, 49801.750991244815, 50261.49738502568, 50355.0, 50379.0, 433039.0, 434960.0, 437195.0, 438140.0, 438220.0, 34607.82696086604, 40622.796886016564, 41465.79267103645, 41467.37798933079, 44439.0, 48267.75866120647, 48450.27324590205, 48989.51010489992, 49255.50744492652, 49326.50673493219, 41306.38040429456, 42362.57637423586, 42664.78667606642, 43034.35448468338, 43701.562984369746, 41577.168456631305, 41787.37318940157, 41852.581474184866, 41956.1608767829, 42809.0, 41033.79483102685, 42001.369979450945, 42170.36744448775, 42170.78914605407, 42221.788891055345, 35394.0, 36760.26479470342, 37034.62965370419, 37037.814810925775, 37711.62288377081, 28381.0, 28558.571621426112, 28610.14169574916, 28762.568561471177, 28906.85546572338], "value": 21055.831399637238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.45124569374406, 384.22770231834016, 390.99619892302826, 392.7623787608497, 404.2561686496845, 18483.353082642112, 20175.798242017576, 20662.793372066273, 20730.27444039459, 20770.065347059382, 19317.4204773857, 19399.806001939978, 20122.39632811018, 20292.188312467482, 20292.39122826314, 5651.180578816069, 5795.3335366432975, 5886.6468011919205, 5898.587098903078, 5996.2804463464445, 5855.23881895353, 5863.2670916135485, 5910.46805787479, 5914.585978981473, 5944.227250457435, 5652.491275785179, 5818.185454036438, 5847.5614328925285, 5873.735681894325, 5878.970605146968, 5704.401037891003, 5827.271591051119, 5830.271216097988, 5833.358330583633, 5850.327212370568, 5183.248428977777, 5200.739963001834, 5207.921881171786, 5208.739563021833, 5219.817306394258, 23343.766562334327, 23391.0, 23665.645015324782, 23685.171019014426, 24015.879920600284, 2406.3984003999, 2413.4207790130417, 2462.8029757619347, 2512.371907023244, 2961.4077184562957, 14210.147391156564, 14595.635109122251, 14996.775048374175, 15387.538373848802, 15439.30523126462, 1875.9437216883516, 1981.9306324278582, 2083.2500299892026, 2083.3125068727436, 2174.7716489768504, 83641.0, 84423.0, 84593.57703211506, 86989.0, 89084.0, 10575.730912290574, 10642.893571064345, 10809.810920798705, 10843.620473283398, 11027.779444411228, 15159.242037898282, 15267.0, 15281.388744450098, 15282.38870445192, 15289.923550382176, 8321.375896807764, 8483.939507561554, 8595.3553483489, 8632.654693812177, 8700.695475658322, 8326.625301861432, 8358.707445239388, 8405.243528082501, 8545.145485451529, 8551.657933682707, 6638.701258443381, 6721.4958878084335, 6744.359285867835, 6790.287019862942, 6841.692123854438, 1869.1401955100534, 1916.3101283537915, 1920.2319072370883, 1939.2340025690055, 2016.7983201679715, 431.0839466134464, 456.5525784730982, 980.4215512847454, 1030.0420608833706, 1098.4617537406614, 11110.05564527008, 11587.942060289814, 11614.187006909435, 11696.47365868538, 11818.940905295418, 452.39153338759314, 453.11190067467476, 455.61728148354877, 465.29043209106385, 468.5876428742753, 6172.629642221481, 6237.844053898689, 6251.343608921089, 6267.435930766253, 6337.366263373718, 461128.6943565261, 463330.0, 511018.0, 540880.0, 543690.0, 59234.0, 67502.66248668823, 86766.56616716876, 88739.0, 92152.53923730472, 469.75337947577793, 483.04116329087435, 483.7532858242322, 485.5241862974305, 486.91235577595666, 11448.94275528617, 11703.531858725897, 12123.696907577381, 12223.327716975651, 12285.69285767863, 44463.0, 44628.77685611551, 46505.0, 46749.76625116853, 47150.528494714614, 58973.41026589679, 59892.70053649704, 66178.0, 66590.33409666036, 67299.0, 8892.33307501927, 9123.31575131881, 9146.49694266795, 9231.123043310874, 9425.481598512148, 13625.591232263048, 13856.584302470941, 14671.853281467476, 14788.704225915206, 15033.624159396102, 12890.35548222604, 12965.546205882749, 12976.805347919977, 13052.934735326262, 13102.148360356547, 12556.058295627681, 12570.308633025272, 12690.23858568452, 12813.74372512526, 13121.475140994253, 13032.0, 13098.607041788762, 13178.670533236746, 13289.069765116348, 13405.865941340851, 7646.732364367221, 7708.03649543807, 8623.698170564001, 8655.740327789925, 8824.691135810473, 12024.639260822189, 12560.497580097059, 12590.181638193488, 12638.747225055631, 12670.873291267339], "value": 8851.328392571084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.2112969561288, 1494.0886059503705, 1649.4309463235188, 1752.9394716196693, 1797.9550511237217, 8247.546384948826, 8707.25988290996, 8788.78028049299, 8792.604332805024, 8815.20663140318, 7503.737369192079, 7573.242675732424, 7586.96206518968, 7793.454458187929, 8617.310615150789, 2159.6652518859564, 2243.147603910512, 2246.225052356934, 2257.6162052451123, 2264.9660255096187, 2252.7747225277503, 2253.7971582557566, 2277.089164334271, 2281.954360912781, 2286.6684330772027, 1974.6544354737935, 2177.2814971059593, 2262.9773702262933, 2313.3985163857433, 2328.359701082199, 2283.6346184610384, 2330.7203135623663, 2333.346662934381, 2333.8482998605123, 2333.988330058356, 2120.0, 2168.5120847809117, 2169.349195241421, 2169.663702126157, 2171.4896999205175, 8450.535220562866, 8564.015138259056, 8572.485650860968, 8584.8712269316, 8586.656533738706, 4926.975365123188, 5036.798528058874, 5036.84889453317, 5037.042961837239, 5048.62135339851, 3115.112193024977, 3152.36952609479, 3219.7263232625255, 3229.1927018245437, 3233.4826427771445, 1109.2457129152174, 1135.3074624479061, 1149.8608797981558, 1158.4265788434695, 1158.7566611011698, 11500.597479088276, 11733.706657333634, 11738.119641026957, 11741.295522268605, 11742.589009384716, 4419.0, 4433.379326894237, 4569.840055598038, 4586.977065114653, 4604.907901841944, 10128.898711012796, 10130.037646423578, 10135.9493202535, 10141.340812847142, 10142.847857282146, 5187.870303242449, 5188.351456067991, 5191.480851914854, 5197.0125676121415, 5199.038177937018, 4103.117829666577, 4594.494605593382, 4726.1020406122725, 4740.573348398591, 4773.7374444405195, 3896.5713771485116, 3902.297586434412, 3990.3216453203027, 4009.1981603679383, 4014.5182578090817, 1239.2564461323313, 1262.949482020709, 1263.7093468502112, 1273.1597145883673, 1278.910476266671, 737.4690223039403, 925.8148370325827, 938.4228699349851, 957.6408846682494, 963.8698775665335, 5927.496162826122, 6092.847678807977, 6119.663418511936, 6140.662263575547, 6274.215723034621, 455.7333959633651, 461.0226320201128, 473.5998081621025, 476.35929674587624, 635.463033736492, 4007.499062617173, 4290.82002449329, 4411.316245981878, 4418.64650827933, 4475.552444755498, 10103.0, 10497.055265026032, 10590.258681892348, 10600.734981625366, 10606.15150787935, 10236.795264094677, 10478.214133939984, 10479.10927571165, 10488.68533943983, 10700.036996670337, 8043.959780201179, 8097.149799271109, 8132.390070744717, 8175.71385001534, 8181.877271840927, 5919.082542205965, 6061.454469097803, 6065.090236464565, 6193.040078787795, 6303.432691057827, 9309.348345615741, 9389.577469013775, 9448.858267125861, 9550.474723890253, 9588.472634005197, 10168.593256269667, 10186.643467478603, 10251.128654064489, 10283.84574231402, 10325.32885362449, 7395.815104622212, 7920.762377128695, 8075.757727268191, 8128.309093727099, 8237.093919668952, 8433.072362040048, 8448.112948140602, 8516.105808890225, 8532.146785321418, 8534.402591818513, 7643.503172293783, 7752.4573279869865, 7804.726834560764, 7857.332126769289, 7925.603719814101, 7536.585487798224, 7538.208488108669, 7544.547327160388, 7616.8476630468185, 7631.618419079135, 6921.134858142732, 6962.094927659372, 6998.860022799618, 6999.650017499206, 6999.755008574675, 5102.515261050195, 5256.132738098171, 5347.1979203119845, 5420.05149098914, 5446.754896029767, 5282.286891269629, 5336.573074154136, 5342.225377320345, 5471.06991811401, 5496.477834605706], "value": 4494.644118829215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.87604958016794, 313.4686706033273, 313.93564319314555, 316.6200559328806, 318.8278329701961, 5426.213199086135, 5438.53772429344, 5478.972605136979, 5498.725063746807, 5503.47716966888, 5311.698633834706, 5325.360956685203, 5397.649152805065, 5401.918971215435, 5406.972095626452, 3966.7223294369405, 4015.4378387025695, 4119.2997190477545, 4139.606737359946, 4156.044109854735, 4117.9527149909, 4134.917301653965, 4145.709800313979, 4148.087420767426, 4161.583841615845, 3907.5115610548683, 4107.691923105764, 4112.424260603518, 4119.5880411958715, 4121.629053385194, 4080.8165631966694, 4151.813168407399, 4156.210320039183, 4156.376543518496, 4157.355609880473, 3637.7999210043436, 3658.0489072840987, 3660.432632941898, 3696.5564132304294, 3703.4629978652943, 5228.849653076317, 5258.2638430619745, 5278.313819203479, 5280.128778751501, 5288.867778305573, 4425.3804467374275, 4684.882877928045, 4689.742064186468, 4738.502457241974, 4755.33425320452, 5512.834614961557, 5581.916271255935, 5603.159526071081, 5638.351589567212, 5644.096944488862, 3930.526052730226, 3937.3700207966876, 3944.3294639911283, 3965.7025723070597, 3971.940420893689, 5616.410276920906, 5824.825255242349, 5833.941660583425, 5834.64992100471, 5842.883142337172, 3909.9022524436546, 3939.6651284641125, 3947.3092208863336, 3948.9012774680864, 3961.1087505311652, 3929.862454814068, 3972.5301638393403, 3982.601739825994, 3996.980015099906, 4001.8399264029113, 4565.246734288871, 4675.22858728306, 4680.648951328664, 4683.648726345537, 4694.7417892016265, 5575.665460072409, 5587.580931430159, 5624.606277560531, 5661.575381846378, 5667.858303542362, 1380.5996261084174, 1383.266868559665, 1386.8890488760876, 1395.5115709501797, 1402.263811498971, 869.591292092728, 874.4884242717955, 891.2914233184633, 908.5184852028435, 913.8355096082769, 5250.868728281747, 5269.156934890476, 5276.314079169683, 5278.656887302313, 5282.735863206824, 5604.495595396434, 5607.54203906979, 5657.4908258256955, 5709.172170035322, 5714.428557144252, 5143.431253467654, 5370.597205209625, 5388.973055134699, 5397.70312632809, 5413.242146099549, 3032.0, 3033.8028028178096, 3052.5573791800066, 3061.969380306168, 3063.0, 5771.49941015339, 5839.883202336015, 5842.941570584325, 5847.953216374235, 5918.881622367615, 5807.0998995155815, 5823.82528524145, 5831.912521312183, 5850.4149585042005, 5853.765849365977, 5821.311819572276, 5843.795467158629, 5858.121281807763, 5895.204147440127, 5895.67573783446, 5351.331083614548, 5636.689982051026, 5641.210230567806, 5728.2266893970445, 5733.569982251264, 5598.272224610938, 5611.438856114356, 5660.801871934627, 5663.263775709296, 5663.433656634304, 5656.717164141859, 5865.765369385177, 5882.7058647066615, 5902.1736956826935, 5918.881622367615, 4115.2510183172635, 4120.567340429332, 4139.91720165589, 4140.3375459926265, 4150.107726838623, 5775.9133612995, 5830.47525722687, 5830.970845145747, 5845.473907348359, 5884.6469211847425, 5493.450654934634, 5674.290713660793, 5716.314042314949, 5726.5418766499415, 5757.136429535603, 5653.123765816305, 5654.3497497788285, 5654.6889921054735, 5672.262605861211, 5674.744636491285, 5422.322209723785, 5542.0, 5549.334079910436, 5616.971915140398, 5719.771209151588, 5233.3196684432305, 5583.637063590853, 5722.6852523109965, 5737.713114344183, 5751.9424805751405, 5539.279893613804, 5546.084895992116, 5587.860303492445, 5598.608097433141, 5615.887682246251], "value": 4237.263293431372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.5852298281911, 806.5714766995967, 834.9958250208748, 856.8543347630898, 865.0916537635483, 15067.246637668113, 15786.763198552031, 16225.18874056297, 16239.0, 16546.58633534162, 15237.16195609241, 15312.540623781304, 15431.151286679227, 15463.69072618547, 15484.612884677888, 664.51158398577, 783.4985609210081, 805.7059173401725, 823.0247157118833, 826.9338452923752, 806.5523634382915, 807.834393949239, 807.9798005049862, 808.720991258018, 817.6320655704927, 829.7718127514921, 833.1127349372929, 836.8326334733048, 838.4340570115148, 838.6016642095017, 661.4179522020615, 830.2776584371635, 842.9367797415188, 843.9831203375929, 850.3792231670915, 621.2358798677607, 621.3506885304868, 621.6301300726061, 621.9067139929001, 622.4024936061387, 14276.928615356857, 14317.78523322151, 14336.856631433657, 14353.497627582985, 14404.207768572724, 14125.929370353082, 14243.857561424356, 14411.78382324266, 14412.783808242884, 14552.92723536386, 13532.864671353258, 13591.796123058162, 13654.385552650154, 13654.726905461934, 13945.860541394557, 4555.339475775994, 4571.794269257892, 4622.075584883003, 4738.076075165344, 4758.714477131349, 65322.34677653258, 75494.0, 75792.0, 75985.24014759836, 77125.0, 10837.403942783065, 10843.349399036084, 10996.670099897015, 11046.171537134747, 11352.091832653368, 21488.677669834964, 21490.032948517353, 21491.892540537196, 21506.677399839016, 21518.0, 8125.634346454423, 8411.242988131098, 8475.0, 8661.13388661129, 8750.912490875136, 4956.132676781549, 4961.355023846877, 5064.7467626619255, 5085.949140508547, 5234.979179060047, 3499.4225952717516, 3620.7465477416326, 3624.0939765058733, 3628.546431696038, 3640.180959284193, 621.5462712220104, 624.8625302433458, 641.3650486018901, 645.1194120026131, 647.1813156357211, 476.71158948835455, 596.6092209602717, 605.7788907048983, 622.2004723929819, 640.4812102197235, 8974.0, 9516.524173791282, 9624.855627165458, 9833.4099954003, 10089.0, 505.7724024189056, 538.8841399099134, 631.4948041566728, 639.8560323927079, 656.5071443424536, 4396.494403143615, 4459.888502787457, 4665.090307390026, 4684.367610372556, 4714.929276060861, 66837.33162668311, 90908.09091909128, 113870.0, 116351.0, 116923.0, 105117.47441262745, 105142.13984348932, 106031.46984265029, 106512.0, 106606.46696766622, 91031.5448422767, 91516.0, 92804.0, 93222.0, 94519.0, 8868.86696699537, 9066.727998160066, 9110.661497214129, 9113.77215569616, 9149.22231610294, 52421.0, 52751.20873186982, 53754.462455374945, 54454.72772636112, 55616.0, 73200.0, 78844.60577697075, 80569.59715201621, 81895.0, 82180.17819821725, 11452.370119643167, 11713.414329283672, 11746.530138794353, 11782.11634127461, 11908.106891983309, 12772.361381930681, 12926.612201633967, 14263.0, 14475.493357732428, 14547.05444146127, 13791.724165516835, 14324.641883952985, 14364.281785910454, 14616.780748288571, 14716.117032978056, 12794.232346059267, 13436.596902092953, 13602.659933501742, 14142.929285353508, 14506.202158881362, 13925.930370348084, 14418.351174196976, 14545.709085818437, 14631.26843657834, 14878.776818347516, 11370.393279725482, 11416.42132809914, 11555.4800033997, 12123.272603643809, 12282.754344912873, 11860.822087668865, 12286.324252166216, 12326.938365308475, 12400.255984640951, 12605.30670813114], "value": 7587.275930585438, "unit": "score"}], "name": "dromaeo_css", "value": 7215.183829951798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 111.0, 112.0, 110.0, 110.0, 111.0, 112.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 119.0, 182.0, 119.0, 121.0, 142.0, 115.0, 155.0, 120.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 159.0, 160.0, 160.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 128.0, 76.0, 75.0, 74.0, 75.0, 108.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 83.0, 84.0, 83.0, 119.0, 83.0, 84.0, 130.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 53.0, 52.0, 52.0, 51.0, 52.0, 53.0, 54.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 74.0, 75.0, 80.0, 74.0, 75.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 119.0, 124.0, 118.0, 118.0, 126.0, 119.0, 173.0, 120.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 163.0, 159.0, 159.0, 158.0, 160.0, 164.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 68.0, 63.0, 63.0, 66.0, 63.0, 63.0, 62.0, 67.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1480.9, "alertThreshold": 2.0}]} 19:41:57 INFO - Return code: 0 19:41:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:41:57 INFO - # TBPL SUCCESS # 19:41:57 INFO - Running post-action listener: _resource_record_post_action 19:41:57 INFO - ##### 19:41:57 INFO - ##### Finished run-tests step (success) 19:41:57 INFO - ##### 19:41:57 INFO - Running post-run listener: _resource_record_post_run 19:41:58 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 551563264; Read time: 268; Write time: 550356 19:41:58 INFO - TinderboxPrint: CPU usage
13.0% 19:41:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 268 19:41:58 INFO - TinderboxPrint: I/O write bytes / time
551,563,264 / 550,356 19:41:58 INFO - TinderboxPrint: CPU idle
8,285.1 (87.0%) 19:41:58 INFO - TinderboxPrint: CPU user
1,193.7 (12.5%) 19:41:58 INFO - TinderboxPrint: Swap in / out
0 / 0 19:41:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256634880; Read time: 0; Write time: 335292 19:41:58 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 294928384; Read time: 268; Write time: 215064 19:41:58 INFO - Running post-run listener: _upload_blobber_files 19:41:58 INFO - Blob upload gear active. 19:41:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:41:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:41:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:41:58 INFO - (blobuploader) - INFO - Open directory for files ... 19:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:02 INFO - (blobuploader) - INFO - Done attempting. 19:42:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:42:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:03 INFO - (blobuploader) - INFO - Done attempting. 19:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:42:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:42:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:42:04 INFO - (blobuploader) - INFO - Done attempting. 19:42:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:42:04 INFO - Return code: 0 19:42:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:42:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:42:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39272b9c4ec74f2a9b515a0bc0aab60108e0d9226e3b0d14d2635b2f6b8fbcd63fb9d121c553641803c6c6c0f23ac74dab1342141dba1db79186b3933d39f175", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efb8340e3790abf0ce35e726abd786fb727700e3d5435d3b20babc40f3c02558a8d54d37fe523577e6dbcc2e634652ac30c2c93157d4f6cf6e2ecea08fa65692", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6909859671f8217af9791ca6ed8612d256d32f5ae352f9dc8a36e7fbcf439c4c565c87e88fa224f75c10de480cf87d5b252e93bb9a3e366d5618116502eed8a2"} 19:42:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:42:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:42:04 INFO - Contents: 19:42:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39272b9c4ec74f2a9b515a0bc0aab60108e0d9226e3b0d14d2635b2f6b8fbcd63fb9d121c553641803c6c6c0f23ac74dab1342141dba1db79186b3933d39f175", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efb8340e3790abf0ce35e726abd786fb727700e3d5435d3b20babc40f3c02558a8d54d37fe523577e6dbcc2e634652ac30c2c93157d4f6cf6e2ecea08fa65692", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6909859671f8217af9791ca6ed8612d256d32f5ae352f9dc8a36e7fbcf439c4c565c87e88fa224f75c10de480cf87d5b252e93bb9a3e366d5618116502eed8a2"} 19:42:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:42:04 INFO - Copying logs to upload dir... 19:42:04 INFO - mkdir: /builds/slave/test/build/upload/logs 19:42:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.735925 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-08 19:42:03.903052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:03.906771) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653 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/39272b9c4ec74f2a9b515a0bc0aab60108e0d9226e3b0d14d2635b2f6b8fbcd63fb9d121c553641803c6c6c0f23ac74dab1342141dba1db79186b3933d39f175", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efb8340e3790abf0ce35e726abd786fb727700e3d5435d3b20babc40f3c02558a8d54d37fe523577e6dbcc2e634652ac30c2c93157d4f6cf6e2ecea08fa65692", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6909859671f8217af9791ca6ed8612d256d32f5ae352f9dc8a36e7fbcf439c4c565c87e88fa224f75c10de480cf87d5b252e93bb9a3e366d5618116502eed8a2"} build_url:https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011456 build_url: 'https://queue.taskcluster.net/v1/task/NsZSXoqJT-KNGPKs90--lA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/39272b9c4ec74f2a9b515a0bc0aab60108e0d9226e3b0d14d2635b2f6b8fbcd63fb9d121c553641803c6c6c0f23ac74dab1342141dba1db79186b3933d39f175", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/efb8340e3790abf0ce35e726abd786fb727700e3d5435d3b20babc40f3c02558a8d54d37fe523577e6dbcc2e634652ac30c2c93157d4f6cf6e2ecea08fa65692", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6909859671f8217af9791ca6ed8612d256d32f5ae352f9dc8a36e7fbcf439c4c565c87e88fa224f75c10de480cf87d5b252e93bb9a3e366d5618116502eed8a2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:03.933092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:03.933477) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1468030807.365115-1433445653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 19:42:04.019070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 19:42:04.019483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 19:42:04.019828) ========= ========= Total master_lag: 0.19 =========