builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1467736656.06 results: success (0) buildid: 20160702073132 builduid: edde2c72410b49e98288152e64ee5222 revision: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.059432) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.060016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.060321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.075111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.075399) ========= 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=32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 09:37:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-05 09:37:36 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.400681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.490467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.490825) ========= 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=32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017120 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:36.540438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-05 09:37:36.540803) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 --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 d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 --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=32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 09:37:36,765 truncating revision to first 12 chars 2016-07-05 09:37:36,765 Setting DEBUG logging. 2016-07-05 09:37:36,765 attempt 1/10 2016-07-05 09:37:36,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d9ecb9d04a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 09:37:38,564 unpacking tar archive at: mozilla-inbound-d9ecb9d04a90/testing/mozharness/ program finished with exit code 0 elapsedTime=2.187914 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-05 09:37:38.742661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:38.743019) ========= script_repo_revision: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:38.743475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:38.743760) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:37:38.753735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 09:37:38.754138) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:37:39 INFO - MultiFileLogger online at 20160705 09:37:39 in /builds/slave/test 09:37:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:37:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:39 INFO - {'append_to_log': False, 09:37:39 INFO - 'base_work_dir': '/builds/slave/test', 09:37:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:37:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:39 INFO - 'branch': 'Mozilla-Inbound', 09:37:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:39 INFO - 'config_files': ('talos/linux_config.py',), 09:37:39 INFO - 'default_actions': ('clobber', 09:37:39 INFO - 'read-buildbot-config', 09:37:39 INFO - 'download-and-extract', 09:37:39 INFO - 'populate-webroot', 09:37:39 INFO - 'create-virtualenv', 09:37:39 INFO - 'install', 09:37:39 INFO - 'run-tests'), 09:37:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:39 INFO - 'download_minidump_stackwalk': True, 09:37:39 INFO - 'download_symbols': 'ondemand', 09:37:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:39 INFO - 'installer_path': 'installer.exe', 09:37:39 INFO - 'log_level': 'info', 09:37:39 INFO - 'log_name': 'talos', 09:37:39 INFO - 'log_to_console': True, 09:37:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:37:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:37:39 INFO - 'opt_config_files': (), 09:37:39 INFO - 'pip_index': False, 09:37:39 INFO - 'sps_profile': False, 09:37:39 INFO - 'sps_profile_interval': 0, 09:37:39 INFO - 'suite': 'dromaeojs-e10s', 09:37:39 INFO - 'system_bits': '32', 09:37:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:39 INFO - 'title': 'talos-linux64-ix-008', 09:37:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:39 INFO - 'use_talos_json': True, 09:37:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:39 INFO - 'work_dir': 'build'} 09:37:39 INFO - ##### 09:37:39 INFO - ##### Running clobber step. 09:37:39 INFO - ##### 09:37:39 INFO - Running pre-action listener: _resource_record_pre_action 09:37:39 INFO - Running main action method: clobber 09:37:39 INFO - rmtree: /builds/slave/test/build 09:37:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:39 INFO - Running post-action listener: _resource_record_post_action 09:37:39 INFO - ##### 09:37:39 INFO - ##### Finished clobber step (success) 09:37:39 INFO - ##### 09:37:39 INFO - ##### 09:37:39 INFO - ##### Running read-buildbot-config step. 09:37:39 INFO - ##### 09:37:39 INFO - Running pre-action listener: _resource_record_pre_action 09:37:39 INFO - Running main action method: read_buildbot_config 09:37:39 INFO - Using buildbot properties: 09:37:39 INFO - { 09:37:39 INFO - "project": "", 09:37:39 INFO - "product": "firefox", 09:37:39 INFO - "script_repo_revision": "production", 09:37:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:37:39 INFO - "repository": "", 09:37:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:37:39 INFO - "buildid": "20160702073132", 09:37:39 INFO - "pgo_build": "True", 09:37:39 INFO - "basedir": "/builds/slave/test", 09:37:39 INFO - "buildnumber": 958, 09:37:39 INFO - "slavename": "talos-linux64-ix-008", 09:37:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:37:39 INFO - "platform": "ubuntu64_hw", 09:37:39 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:37:39 INFO - "branch": "mozilla-inbound", 09:37:39 INFO - "repo_path": "integration/mozilla-inbound", 09:37:39 INFO - "revision": "d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7", 09:37:39 INFO - "stage_platform": "linux64-pgo", 09:37:39 INFO - "builduid": "edde2c72410b49e98288152e64ee5222", 09:37:39 INFO - "slavebuilddir": "test" 09:37:39 INFO - } 09:37:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:37:39 INFO - Running post-action listener: _resource_record_post_action 09:37:39 INFO - ##### 09:37:39 INFO - ##### Finished read-buildbot-config step (success) 09:37:39 INFO - ##### 09:37:39 INFO - ##### 09:37:39 INFO - ##### Running download-and-extract step. 09:37:39 INFO - ##### 09:37:39 INFO - Running pre-action listener: _resource_record_pre_action 09:37:39 INFO - Running main action method: download_and_extract 09:37:39 INFO - mkdir: /builds/slave/test/build/tests 09:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:39 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:40 INFO - Downloaded 1361 bytes. 09:37:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:37:40 INFO - Using the following test package requirements: 09:37:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:37:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:37:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'jsshell-linux-x86_64.zip'], 09:37:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:37:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:37:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:37:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:37:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:37:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:37: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')]} 09:37:40 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:41 INFO - Downloaded 24271881 bytes. 09:37:41 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'] 09:37:41 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 09:37:42 INFO - Return code: 0 09:37:42 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 09:37:42 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')]} 09:37:42 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:37:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:43 INFO - Downloaded 24271881 bytes. 09:37:43 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'] 09:37:43 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 09:37:45 INFO - Return code: 0 09:37: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')]} 09:37:45 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:46 INFO - Downloaded 14405327 bytes. 09:37:46 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'] 09:37:46 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 09:37:46 INFO - Return code: 0 09:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:46 INFO - https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/foBoveFTS1GHSoMYGtxlQQ/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 09:37:48 INFO - Downloaded 60363702 bytes. 09:37:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:48 INFO - mkdir: /builds/slave/test/properties 09:37:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:48 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:48 INFO - Contents: 09:37:48 INFO - build_url:https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:49 INFO - Running post-action listener: _resource_record_post_action 09:37:49 INFO - Running post-action listener: set_extra_try_arguments 09:37:49 INFO - ##### 09:37:49 INFO - ##### Finished download-and-extract step (success) 09:37:49 INFO - ##### 09:37:49 INFO - ##### 09:37:49 INFO - ##### Running populate-webroot step. 09:37:49 INFO - ##### 09:37:49 INFO - Running pre-action listener: _resource_record_pre_action 09:37:49 INFO - Running main action method: populate_webroot 09:37:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:49 INFO - '--tppagecycles', 09:37:49 INFO - '7'], 09:37:49 INFO - 'tests': ['tsvgm']}}, 09:37:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['damp', 'tps']}, 09:37:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'tests': ['damp', 'tps']}, 09:37:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['dromaeo_dom']}, 09:37:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['basic_compositor_video']}, 09:37:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['a11yr', 09:37:49 INFO - 'ts_paint', 09:37:49 INFO - 'tpaint', 09:37:49 INFO - 'sessionrestore', 09:37:49 INFO - 'sessionrestore_no_auto_restore', 09:37:49 INFO - 'tabpaint']}, 09:37:49 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:49 INFO - 'ts_paint', 09:37:49 INFO - 'tpaint', 09:37:49 INFO - 'sessionrestore', 09:37:49 INFO - 'sessionrestore_no_auto_restore', 09:37:49 INFO - 'tabpaint']}, 09:37:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:49 INFO - 'ts_paint', 09:37:49 INFO - 'tpaint', 09:37:49 INFO - 'sessionrestore', 09:37:49 INFO - 'sessionrestore_no_auto_restore', 09:37:49 INFO - 'tabpaint']}, 09:37:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:49 INFO - 'ts_paint', 09:37:49 INFO - 'tpaint', 09:37:49 INFO - 'sessionrestore', 09:37:49 INFO - 'sessionrestore_no_auto_restore', 09:37:49 INFO - 'tabpaint']}, 09:37:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['a11yr', 09:37:49 INFO - 'ts_paint', 09:37:49 INFO - 'tpaint', 09:37:49 INFO - 'sessionrestore', 09:37:49 INFO - 'sessionrestore_no_auto_restore', 09:37:49 INFO - 'tabpaint']}, 09:37:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['a11yr', 09:37:49 INFO - 'ts_paint', 09:37:49 INFO - 'tpaint', 09:37:49 INFO - 'sessionrestore', 09:37:49 INFO - 'sessionrestore_no_auto_restore', 09:37:49 INFO - 'tabpaint']}, 09:37:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['tsvgx', 09:37:49 INFO - 'tsvgr_opacity', 09:37:49 INFO - 'tart', 09:37:49 INFO - 'tscrollx', 09:37:49 INFO - 'cart']}, 09:37:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:49 INFO - 'tsvgr_opacity', 09:37:49 INFO - 'tart', 09:37:49 INFO - 'tscrollx', 09:37:49 INFO - 'cart']}, 09:37:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'talos_options': ['--disable-e10s'], 09:37:49 INFO - 'tests': ['tp5o']}, 09:37:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'tests': ['tp5o']}, 09:37:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'talos_options': ['--disable-e10s', 09:37:49 INFO - '--xperf_path', 09:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:49 INFO - 'tests': ['tp5n']}, 09:37:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:49 INFO - 'talos_options': ['--xperf_path', 09:37:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:49 INFO - 'tests': ['tp5n']}}, 09:37:49 INFO - 'talos.zip': {'path': '', 09:37:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:49 INFO - Running post-action listener: _resource_record_post_action 09:37:49 INFO - ##### 09:37:49 INFO - ##### Finished populate-webroot step (success) 09:37:49 INFO - ##### 09:37:49 INFO - ##### 09:37:49 INFO - ##### Running create-virtualenv step. 09:37:49 INFO - ##### 09:37:49 INFO - Running pre-action listener: _resource_record_pre_action 09:37:49 INFO - Running main action method: create_virtualenv 09:37:49 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:49 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 09:37:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:49 INFO - Using real prefix '/usr' 09:37:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:50 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:52 INFO - Installing pip.................done. 09:37:52 INFO - Return code: 0 09:37:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:52 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')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:37:52 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 09:37:52 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 09:37:52 INFO - Using env: {'DISPLAY': ':0', 09:37:52 INFO - 'HOME': '/home/cltbld', 09:37:52 INFO - 'LANG': 'en_US.UTF-8', 09:37:52 INFO - 'LANGUAGE': 'en_US:en', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MAIL': '/var/mail/cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SHLVL': '1', 09:37:52 INFO - 'TERM': 'linux', 09:37:52 INFO - 'TMOUT': '86400', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - '_': '/tools/buildbot/bin/python'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 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 09:37:52 INFO - Cleaning up... 09:37:52 INFO - Return code: 0 09:37:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:52 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')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:52 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:37:52 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 09:37:52 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 09:37:52 INFO - Using env: {'DISPLAY': ':0', 09:37:52 INFO - 'HOME': '/home/cltbld', 09:37:52 INFO - 'LANG': 'en_US.UTF-8', 09:37:52 INFO - 'LANGUAGE': 'en_US:en', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MAIL': '/var/mail/cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SHLVL': '1', 09:37:52 INFO - 'TERM': 'linux', 09:37:52 INFO - 'TMOUT': '86400', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - '_': '/tools/buildbot/bin/python'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 INFO - Downloading/unpacking psutil>=3.1.1 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:54 INFO - Installing collected packages: psutil 09:37:54 INFO - Running setup.py install for psutil 09:37:54 INFO - building 'psutil._psutil_linux' extension 09:37:54 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 09:37:54 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 09:37:54 INFO - building 'psutil._psutil_posix' extension 09:37:54 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 09:37:55 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 09:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:55 INFO - Successfully installed psutil 09:37:55 INFO - Cleaning up... 09:37:55 INFO - Return code: 0 09:37:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:55 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:37:55 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 09:37:55 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 09:37:55 INFO - Using env: {'DISPLAY': ':0', 09:37:55 INFO - 'HOME': '/home/cltbld', 09:37:55 INFO - 'LANG': 'en_US.UTF-8', 09:37:55 INFO - 'LANGUAGE': 'en_US:en', 09:37:55 INFO - 'LOGNAME': 'cltbld', 09:37:55 INFO - 'MAIL': '/var/mail/cltbld', 09:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:55 INFO - 'MOZ_NO_REMOTE': '1', 09:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:55 INFO - 'NO_EM_RESTART': '1', 09:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:55 INFO - 'PWD': '/builds/slave/test', 09:37:55 INFO - 'SHELL': '/bin/bash', 09:37:55 INFO - 'SHLVL': '1', 09:37:55 INFO - 'TERM': 'linux', 09:37:55 INFO - 'TMOUT': '86400', 09:37:55 INFO - 'USER': 'cltbld', 09:37:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:55 INFO - '_': '/tools/buildbot/bin/python'} 09:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:57 INFO - Installing collected packages: mozsystemmonitor 09:37:57 INFO - Running setup.py install for mozsystemmonitor 09:37:57 INFO - Successfully installed mozsystemmonitor 09:37:57 INFO - Cleaning up... 09:37:57 INFO - Return code: 0 09:37:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:37:57 INFO - Using env: {'DISPLAY': ':0', 09:37:57 INFO - 'HOME': '/home/cltbld', 09:37:57 INFO - 'LANG': 'en_US.UTF-8', 09:37:57 INFO - 'LANGUAGE': 'en_US:en', 09:37:57 INFO - 'LOGNAME': 'cltbld', 09:37:57 INFO - 'MAIL': '/var/mail/cltbld', 09:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:57 INFO - 'MOZ_NO_REMOTE': '1', 09:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:57 INFO - 'NO_EM_RESTART': '1', 09:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:57 INFO - 'PWD': '/builds/slave/test', 09:37:57 INFO - 'SHELL': '/bin/bash', 09:37:57 INFO - 'SHLVL': '1', 09:37:57 INFO - 'TERM': 'linux', 09:37:57 INFO - 'TMOUT': '86400', 09:37:57 INFO - 'USER': 'cltbld', 09:37:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:57 INFO - '_': '/tools/buildbot/bin/python'} 09:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:57 INFO - Downloading/unpacking jsonschema==2.5.1 09:37:57 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 09:37:57 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 09:37:57 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 09:37:57 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 09:37:57 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 09:37:57 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 09:37:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 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 09:37:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:59 INFO - warning: no files found matching '*.txt' 09:37:59 INFO - no previously-included directories found matching 'build' 09:37:59 INFO - no previously-included directories found matching 'dist' 09:37:59 INFO - no previously-included directories found matching '.git*' 09:37:59 INFO - Installing collected packages: jsonschema, functools32 09:37:59 INFO - Running setup.py install for functools32 09:38:00 INFO - warning: no files found matching '*.txt' 09:38:00 INFO - no previously-included directories found matching 'build' 09:38:00 INFO - no previously-included directories found matching 'dist' 09:38:00 INFO - no previously-included directories found matching '.git*' 09:38:00 INFO - Successfully installed jsonschema functools32 09:38:00 INFO - Cleaning up... 09:38:00 INFO - Return code: 0 09:38:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:00 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:38:00 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 09:38:00 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 09:38:00 INFO - Using env: {'DISPLAY': ':0', 09:38:00 INFO - 'HOME': '/home/cltbld', 09:38:00 INFO - 'LANG': 'en_US.UTF-8', 09:38:00 INFO - 'LANGUAGE': 'en_US:en', 09:38:00 INFO - 'LOGNAME': 'cltbld', 09:38:00 INFO - 'MAIL': '/var/mail/cltbld', 09:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:00 INFO - 'MOZ_NO_REMOTE': '1', 09:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:00 INFO - 'NO_EM_RESTART': '1', 09:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:00 INFO - 'PWD': '/builds/slave/test', 09:38:00 INFO - 'SHELL': '/bin/bash', 09:38:00 INFO - 'SHLVL': '1', 09:38:00 INFO - 'TERM': 'linux', 09:38:00 INFO - 'TMOUT': '86400', 09:38:00 INFO - 'USER': 'cltbld', 09:38:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:00 INFO - '_': '/tools/buildbot/bin/python'} 09:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:00 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:00 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 09:38:00 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 09:38:00 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 09:38:00 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 09:38:00 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 09:38:00 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 09:38:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:03 INFO - Downloading docopt-0.6.1.tar.gz 09:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:03 INFO - Running setup.py install for blobuploader 09:38:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:03 INFO - Running setup.py install for requests 09:38:03 INFO - Running setup.py install for docopt 09:38:03 INFO - Successfully installed blobuploader requests docopt 09:38:03 INFO - Cleaning up... 09:38:03 INFO - Return code: 0 09:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:03 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')]} 09:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:03 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')]} 09:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:03 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:38:03 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 09:38:03 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 09:38:03 INFO - Using env: {'DISPLAY': ':0', 09:38:03 INFO - 'HOME': '/home/cltbld', 09:38:03 INFO - 'LANG': 'en_US.UTF-8', 09:38:03 INFO - 'LANGUAGE': 'en_US:en', 09:38:03 INFO - 'LOGNAME': 'cltbld', 09:38:03 INFO - 'MAIL': '/var/mail/cltbld', 09:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:03 INFO - 'MOZ_NO_REMOTE': '1', 09:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:03 INFO - 'NO_EM_RESTART': '1', 09:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:03 INFO - 'PWD': '/builds/slave/test', 09:38:03 INFO - 'SHELL': '/bin/bash', 09:38:03 INFO - 'SHLVL': '1', 09:38:03 INFO - 'TERM': 'linux', 09:38:03 INFO - 'TMOUT': '86400', 09:38:03 INFO - 'USER': 'cltbld', 09:38:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:03 INFO - '_': '/tools/buildbot/bin/python'} 09:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:03 INFO - Running setup.py (path:/tmp/pip-oPJH55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:03 INFO - Running setup.py (path:/tmp/pip-ikEyUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:04 INFO - Running setup.py (path:/tmp/pip-MpYKhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:04 INFO - Running setup.py (path:/tmp/pip-kOnl8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:04 INFO - Running setup.py (path:/tmp/pip-h2zmEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:04 INFO - Running setup.py (path:/tmp/pip-B1oNVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:04 INFO - Running setup.py (path:/tmp/pip-fGMExf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:04 INFO - Running setup.py (path:/tmp/pip-f9RcCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:04 INFO - Running setup.py (path:/tmp/pip-CKDZ5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:04 INFO - Running setup.py (path:/tmp/pip-3agNjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:04 INFO - Running setup.py (path:/tmp/pip-ZX7euk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:04 INFO - Running setup.py (path:/tmp/pip-s5Bslq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:04 INFO - Running setup.py (path:/tmp/pip-qMXSoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:04 INFO - Running setup.py (path:/tmp/pip-PWuN9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:04 INFO - Running setup.py (path:/tmp/pip-kGBqAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:04 INFO - Running setup.py (path:/tmp/pip-LuRbIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:05 INFO - Running setup.py (path:/tmp/pip-tIkVZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:05 INFO - Running setup.py install for manifestparser 09:38:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozcrash 09:38:05 INFO - Running setup.py install for mozdebug 09:38:05 INFO - Running setup.py install for mozdevice 09:38:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozfile 09:38:05 INFO - Running setup.py install for mozhttpd 09:38:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozinfo 09:38:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozInstall 09:38:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:05 INFO - Running setup.py install for mozleak 09:38:06 INFO - Running setup.py install for mozlog 09:38:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for moznetwork 09:38:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozprocess 09:38:06 INFO - Running setup.py install for mozprofile 09:38:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozrunner 09:38:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Running setup.py install for mozscreenshot 09:38:06 INFO - Running setup.py install for moztest 09:38:06 INFO - Running setup.py install for mozversion 09:38:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:06 INFO - Cleaning up... 09:38:06 INFO - Return code: 0 09:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:06 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:38:06 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 09:38:06 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 09:38:06 INFO - Using env: {'DISPLAY': ':0', 09:38:06 INFO - 'HOME': '/home/cltbld', 09:38:06 INFO - 'LANG': 'en_US.UTF-8', 09:38:06 INFO - 'LANGUAGE': 'en_US:en', 09:38:06 INFO - 'LOGNAME': 'cltbld', 09:38:06 INFO - 'MAIL': '/var/mail/cltbld', 09:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:06 INFO - 'MOZ_NO_REMOTE': '1', 09:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:06 INFO - 'NO_EM_RESTART': '1', 09:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:06 INFO - 'PWD': '/builds/slave/test', 09:38:06 INFO - 'SHELL': '/bin/bash', 09:38:06 INFO - 'SHLVL': '1', 09:38:06 INFO - 'TERM': 'linux', 09:38:06 INFO - 'TMOUT': '86400', 09:38:06 INFO - 'USER': 'cltbld', 09:38:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:06 INFO - '_': '/tools/buildbot/bin/python'} 09:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:07 INFO - Running setup.py (path:/tmp/pip-WqP5cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:07 INFO - Running setup.py (path:/tmp/pip-pRhf7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:07 INFO - Running setup.py (path:/tmp/pip-gCgOxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:07 INFO - Running setup.py (path:/tmp/pip-26QYHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:07 INFO - Running setup.py (path:/tmp/pip-9j54yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:07 INFO - Running setup.py (path:/tmp/pip-aRDhRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:07 INFO - Running setup.py (path:/tmp/pip-Z19iVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:07 INFO - Running setup.py (path:/tmp/pip-gkb8za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:07 INFO - Running setup.py (path:/tmp/pip-mg63O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:07 INFO - Running setup.py (path:/tmp/pip-vHpIvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:07 INFO - Running setup.py (path:/tmp/pip-gHlGd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:07 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)) 09:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:07 INFO - Running setup.py (path:/tmp/pip-1lyR5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:08 INFO - Running setup.py (path:/tmp/pip-g7ClWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:08 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)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:08 INFO - Running setup.py (path:/tmp/pip-9nm2OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:08 INFO - Running setup.py (path:/tmp/pip-P3_2rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:08 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)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:08 INFO - Running setup.py (path:/tmp/pip-UazOtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:08 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)) 09:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:08 INFO - Running setup.py (path:/tmp/pip-onRwA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:08 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)) 09:38:08 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)) 09:38:08 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)) 09:38:08 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)) 09:38:08 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)) 09:38:08 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)) 09:38:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38:08 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 09:38:08 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 09:38:08 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 09:38:08 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 09:38:08 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 09:38:08 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 09:38:10 INFO - Downloading blessings-1.6.tar.gz 09:38:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:10 INFO - Installing collected packages: blessings 09:38:10 INFO - Running setup.py install for blessings 09:38:10 INFO - Successfully installed blessings 09:38:10 INFO - Cleaning up... 09:38:10 INFO - Return code: 0 09:38:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:10 INFO - Reading from file tmpfile_stdout 09:38:10 INFO - Current package versions: 09:38:10 INFO - argparse == 1.2.1 09:38:10 INFO - blessings == 1.6 09:38:10 INFO - blobuploader == 1.2.4 09:38:10 INFO - docopt == 0.6.1 09:38:10 INFO - functools32 == 3.2.3-2 09:38:10 INFO - jsonschema == 2.5.1 09:38:10 INFO - manifestparser == 1.1 09:38:10 INFO - mozInstall == 1.12 09:38:10 INFO - mozcrash == 0.17 09:38:10 INFO - mozdebug == 0.1 09:38:10 INFO - mozdevice == 0.48 09:38:10 INFO - mozfile == 1.2 09:38:10 INFO - mozhttpd == 0.7 09:38:10 INFO - mozinfo == 0.9 09:38:10 INFO - mozleak == 0.1 09:38:10 INFO - mozlog == 3.2 09:38:10 INFO - moznetwork == 0.27 09:38:10 INFO - mozprocess == 0.22 09:38:10 INFO - mozprofile == 0.28 09:38:10 INFO - mozrunner == 6.11 09:38:10 INFO - mozscreenshot == 0.1 09:38:10 INFO - mozsystemmonitor == 0.3 09:38:10 INFO - moztest == 0.7 09:38:10 INFO - mozversion == 1.4 09:38:10 INFO - psutil == 3.1.1 09:38:10 INFO - requests == 1.2.3 09:38:10 INFO - wsgiref == 0.1.2 09:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 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 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:38:10 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 09:38:10 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 09:38:10 INFO - Using env: {'DISPLAY': ':0', 09:38:10 INFO - 'HOME': '/home/cltbld', 09:38:10 INFO - 'LANG': 'en_US.UTF-8', 09:38:10 INFO - 'LANGUAGE': 'en_US:en', 09:38:10 INFO - 'LOGNAME': 'cltbld', 09:38:10 INFO - 'MAIL': '/var/mail/cltbld', 09:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:10 INFO - 'MOZ_NO_REMOTE': '1', 09:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:10 INFO - 'NO_EM_RESTART': '1', 09:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:10 INFO - 'PWD': '/builds/slave/test', 09:38:10 INFO - 'SHELL': '/bin/bash', 09:38:10 INFO - 'SHLVL': '1', 09:38:10 INFO - 'TERM': 'linux', 09:38:10 INFO - 'TMOUT': '86400', 09:38:10 INFO - 'USER': 'cltbld', 09:38:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:10 INFO - '_': '/tools/buildbot/bin/python'} 09:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 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)) 09:38:10 INFO - Cleaning up... 09:38:10 INFO - Return code: 0 09:38:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeb1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, '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': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', '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 09:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:38:10 INFO - Using env: {'DISPLAY': ':0', 09:38:10 INFO - 'HOME': '/home/cltbld', 09:38:10 INFO - 'LANG': 'en_US.UTF-8', 09:38:10 INFO - 'LANGUAGE': 'en_US:en', 09:38:10 INFO - 'LOGNAME': 'cltbld', 09:38:10 INFO - 'MAIL': '/var/mail/cltbld', 09:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:10 INFO - 'MOZ_NO_REMOTE': '1', 09:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:10 INFO - 'NO_EM_RESTART': '1', 09:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:10 INFO - 'PWD': '/builds/slave/test', 09:38:10 INFO - 'SHELL': '/bin/bash', 09:38:10 INFO - 'SHLVL': '1', 09:38:10 INFO - 'TERM': 'linux', 09:38:10 INFO - 'TMOUT': '86400', 09:38:10 INFO - 'USER': 'cltbld', 09:38:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:10 INFO - '_': '/tools/buildbot/bin/python'} 09:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:38:11 INFO - Cleaning up... 09:38:11 INFO - Return code: 0 09:38:11 INFO - Running post-action listener: _resource_record_post_action 09:38:11 INFO - Running post-action listener: _start_resource_monitoring 09:38:11 INFO - Starting resource monitoring. 09:38:11 INFO - ##### 09:38:11 INFO - ##### Finished create-virtualenv step (success) 09:38:11 INFO - ##### 09:38:11 INFO - ##### 09:38:11 INFO - ##### Running install step. 09:38:11 INFO - ##### 09:38:11 INFO - Running pre-action listener: _resource_record_pre_action 09:38:11 INFO - Running main action method: install 09:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:11 INFO - Reading from file tmpfile_stdout 09:38:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:38:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:38:11 INFO - Reading from file tmpfile_stdout 09:38:11 INFO - Output received: 09:38:11 INFO - Usage: mozinstall [options] installer 09:38:11 INFO - Options: 09:38:11 INFO - -h, --help show this help message and exit 09:38:11 INFO - -d DEST, --destination=DEST 09:38:11 INFO - Directory to install application into. [default: 09:38:11 INFO - "/builds/slave/test"] 09:38:11 INFO - --app=APP Application being installed. [default: firefox] 09:38:11 INFO - mkdir: /builds/slave/test/build/application 09:38:11 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'] 09:38:11 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 09:38:28 INFO - Reading from file tmpfile_stdout 09:38:28 INFO - Output received: 09:38:28 INFO - /builds/slave/test/build/application/firefox/firefox 09:38:28 INFO - Running post-action listener: _resource_record_post_action 09:38:28 INFO - ##### 09:38:28 INFO - ##### Finished install step (success) 09:38:28 INFO - ##### 09:38:28 INFO - ##### 09:38:28 INFO - ##### Running run-tests step. 09:38:28 INFO - ##### 09:38:28 INFO - Running pre-action listener: _resource_record_pre_action 09:38:28 INFO - Running main action method: run_tests 09:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:28 INFO - Python 2.7.3 09:38:28 INFO - Return code: 0 09:38:28 INFO - grabbing minidump binary from tooltool 09:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:28 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 0x116f570>, '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 0x1170470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1170900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:28 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 09:38:28 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 09:38:28 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 09:38:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:28 INFO - Return code: 0 09:38:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:38:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:38:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:38:28 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:38:28 INFO - Using env: {'DISPLAY': ':0', 09:38:28 INFO - 'HOME': '/home/cltbld', 09:38:28 INFO - 'LANG': 'en_US.UTF-8', 09:38:28 INFO - 'LANGUAGE': 'en_US:en', 09:38:28 INFO - 'LOGNAME': 'cltbld', 09:38:28 INFO - 'MAIL': '/var/mail/cltbld', 09:38:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:28 INFO - 'MOZ_NO_REMOTE': '1', 09:38:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:28 INFO - 'NO_EM_RESTART': '1', 09:38:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:28 INFO - 'PWD': '/builds/slave/test', 09:38:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:28 INFO - 'SHELL': '/bin/bash', 09:38:28 INFO - 'SHLVL': '1', 09:38:28 INFO - 'TERM': 'linux', 09:38:28 INFO - 'TMOUT': '86400', 09:38:28 INFO - 'USER': 'cltbld', 09:38:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721', 09:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:28 INFO - '_': '/tools/buildbot/bin/python'} 09:38:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:38:29 INFO - mozversion application_buildid: 20160702073132 09:38:29 INFO - mozversion application_changeset: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 09:38:29 INFO - mozversion application_display_name: Nightly 09:38:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:29 INFO - mozversion application_name: Firefox 09:38:29 INFO - mozversion application_remotingname: firefox 09:38:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:38:29 INFO - mozversion application_vendor: Mozilla 09:38:29 INFO - mozversion application_version: 50.0a1 09:38:29 INFO - mozversion platform_buildid: 20160702073132 09:38:29 INFO - mozversion platform_changeset: d9ecb9d04a90e5ecddbf85b417d789bf2f5652c7 09:38:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:38:29 INFO - mozversion platform_version: 50.0a1 09:38:29 INFO - using testdate: 1467736709 09:38:29 INFO - actual date: 1467736709 09:38:29 INFO - starting webserver on 'localhost:60925' 09:38:29 INFO - SUITE-START | Running 2 tests 09:38:29 INFO - TEST-START | dromaeo_css 09:38:29 INFO - operating with platform_type : linux_ 09:38:29 INFO - Initialising browser for dromaeo_css test... 09:38:29 INFO - TEST-INFO | started process 14697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbY1mK/profile http://localhost:60925/getInfo.html) 09:38:33 INFO - PROCESS | 14697 | __metrics Screen width/height:1600/1200 09:38:33 INFO - PROCESS | 14697 | colorDepth:24 09:38:33 INFO - PROCESS | 14697 | Browser inner width/height: 1024/697 09:38:33 INFO - PROCESS | 14697 | __metrics 09:38:34 ERROR - PROCESS | 14697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:38:35 INFO - TEST-INFO | 14697: exit 0 09:38:35 INFO - Browser initialized. 09:38:35 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:35 INFO - TEST-INFO | started process 14818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbY1mK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:47 INFO - PROCESS | 14818 | RSS: Main: 168624128 09:38:47 INFO - PROCESS | 14818 | 09:39:36 INFO - PROCESS | 14818 | 1467736776675 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] 09:41:44 INFO - PROCESS | 14818 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60925/tests/dromaeo/cssquery-ext.html) 09:41:45 INFO - PROCESS | 14818 | RSS: Main: 172404736 09:41:45 INFO - PROCESS | 14818 | 09:44:47 INFO - PROCESS | 14818 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-ext.html (next: http://localhost:60925/tests/dromaeo/cssquery-jquery.html) 09:44:48 INFO - PROCESS | 14818 | RSS: Main: 168439808 09:44:48 INFO - PROCESS | 14818 | 09:47:50 INFO - PROCESS | 14818 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60925/tests/dromaeo/cssquery-mootools.html) 09:47:51 INFO - PROCESS | 14818 | RSS: Main: 172126208 09:47:51 INFO - PROCESS | 14818 | 09:50:52 INFO - PROCESS | 14818 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60925/tests/dromaeo/cssquery-prototype.html) 09:50:53 INFO - PROCESS | 14818 | RSS: Main: 167788544 09:50:53 INFO - PROCESS | 14818 | 09:53:55 INFO - PROCESS | 14818 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60925/tests/dromaeo/cssquery-yui.html) 09:53:56 INFO - PROCESS | 14818 | RSS: Main: 169721856 09:53:56 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-yui.html (next: http://localhost:60925/tests/dromaeo/cssquery-dojo.html) 09:56:58 INFO - PROCESS | 14818 | RSS: Main: 171147264 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | __start_tp_report 09:56:58 INFO - PROCESS | 14818 | _x_x_mozilla_page_load 09:56:58 INFO - PROCESS | 14818 | _x_x_mozilla_page_load_details 09:56:58 INFO - PROCESS | 14818 | |i|pagename|runs| 09:56:58 INFO - PROCESS | 14818 | |0;dojo.html;3150.480170771823;3172.349668317995;3190.4895216765317;3202.2954949911014;3222;5376.112941364675;5518.530924871386;5533.0870406383;5533.6956467394275;5573.247611572437;5324;5442.83671489855;5503.422140675231;5515.145152501369;5551.583631227654;5014.072396606631;5030.798768049273;5108.259302401149;5201.453847346031;5235.2147177923425;699.7725959950828;4894.216925291954;4987.625928055392;5054.848354549369;5086.287919691246;5045;5054.671446355994;5058.595312375001;5061.44324124346;5062.190049592047;5051.419086805027;5071.087204303224;5073.568746656539;5079.187330027178;5086.389633243997;4886.70679759212;4940.357753492023;4970.676906001135;4990.800367985313;5043.067032598981;5524.668519888779;5564.248826408423;5587.245721827542;5594.4964953154;5596.300462442195;5730.169125476783;6022.578419510636;6024.126501657279;6024.668643224621;6025.397460253984;5885.352611212763;5921.052631578969;5930.911036334458;5987.491063259628;6013.729382177812;5557.305336832896;5562.249096371978;5572.554195664337;5573.386927437979;5586.888262234733;5817.7382017809305;5952.8809423812145;6056.66688332146;6062.363451837494;6114.510839132859;5760.36635970043;5778;5794.942050579524;5816.47651711348;5838.065909454552;5910.734016969247;5924.881502369928;5936.020556608111;5950.940490595125;5955.166276721263;5671.886562268732;5799.710014499258;5842.795502157404;5889.322727886262;5892.469677729025;5942.435468630473;5981.37195594465;6001.819945401558;6008.098785182257;6045.697715114226;4517.570830771071;4536.432945881765;4543.795529201194;4543.931841022388;4581.610563102107;3931.6461518463475;3967.722259441869;3999.8200080996426;4015.4579131817413;4045.696572757055;5542.418046105101;5567.777288908479;5636.379998200195;5641.26663533738;5646.407127251661;5971.850703732442;5983.640981541122;5988.550858685616;5990.28116625999;5996.640201587918;5526.696031718214;5560.666360018412;5562.916556251659;5680.602357834912;5703.40114288002;5095.133827249377;5137.5376216139975;5162.561182299547;5167.0957582422925;5185.351831021122;6115.938840611537;6116.694165291718;6121.357257487989;6124.724387402578;6125.479334256638;5819.79630712923;5901.5868889177345;5963.970180149072;6020.969895150496;6029.095635654687;6125.632462052291;6191.25704915413;6192.628442293297;6199.16311297969;6200.379962003944;5887.558433117619;5890.383078427658;5910.379410161871;5912.793052243151;5972.044472884318;5715.514181294637;5878.118282257696;5913.822585322448;5996.700164991646;6006.279246490449;5764.942350576441;5792.420757924174;5794.246747922912;5794.7102644866745;5845.824625261249;5778.768849245983;5794.913076303943;5803.216565763568;5812;5830;5540.113581826889;5663;5701.857453563694;5711.914321285267;5718.342390625131;5629.54963602919;5773.826785196451;5804.73878675469;5812.505936995402;5836;5668.971655141698;5700.201971723879;5724.8282551523525;5725.713714314351;5725.740337125826 09:56:58 INFO - PROCESS | 14818 | |1;ext.html;583.7110630238033;596.4512648363506;615.1572345886135;630.5050535329767;642.9421352078313;42761.78619106904;44439.77780111103;44484.77757611207;44588.999999999956;47684;45908.54091459084;46042.769786151104;46342.53657463433;46388.536114638846;46472.3029154563;8943.239824614899;9069.319801014917;9079.682211122612;9094.590743416562;9096;9029.59366828491;9043.728688139334;9056.864147037799;9081.50051747157;9136.817263654722;9120.498372589505;9121;9153.816923661523;9194.988551259356;9199.908000920006;9041.773955651095;9075.228605568502;9088.091190880925;9095.590698418588;9116.316276279273;8911.064338244456;8957.149070838324;8976.596053177558;8991.685291014783;9006.639734410615;42113.157736845395;42721.78639106784;42723.57276427227;42875.571244287785;42908.3563746544;3542.822858857073;3877.4571559981623;4146.709730318879;4267.103908179286;4369.868903932856;32984;33530.497042544135;33759;33876.49185262223;34683.826580867186;4393.253146965024;4446.199684056901;4485.910281794346;4540.909181816378;4555.544445555451;365837;366206;367047;369926;371708;61549.69225153935;61592;61735.38264617296;61752.38247617556;61854.381456185765;36340.09149771224;36898.63101368952;37048.96230707337;38679.22641547153;38772.6122738769;17528.824711752975;17754.37859674905;17834.37579684705;17837.643247135245;17864.821351786315;13566.389512471962;13594.660133496543;13640.590782276548;13693.589192324247;13723.382447789874;20192.28365588912;20295.289664861953;20385.898070509553;20451.897740511202;20491.795082049288;7253.746118885813;7378.631068446556;7426.591537465383;7468.925310746931;7483.289087536676;1004.6885465505717;1042.551702767802;1096.550414330121;1113.3431275547466;1129.3562669278433;32673.50989735156;33259;33284;33407.3318533628;33949.981500555026;1123.3035517978742;1126.8929451702074;1163.406662602079;1193.2363287495837;1282.3075539208724;17456.12719364052;17464.214110365065;17465.301387944593;17468.126593670266;17527.561810954827;579339;580505;585760;586990;587627;58929.70535147383;59647.701761491786;59963.70018149881;60070.39929600735;60086.39913600896;1354.5868510104513;1369.7260547890462;1370.383327502608;1377.3251106957518;1397.4619771388088;31185;31732.682673172974;32610;32754.67245327516;33136.668633313355;52585.7370713144;53046.204306934655;53288;53387;53466.46533534615;441473;450048;450202;450737;451531;29284.853575731984;29335.266618334714;29530.557041643962;29538.261543461584;29679;46179;49453;49992.50007500024;50255.49744502508;50516.49483505118;40549;41542.376864347665;41977.1604567913;42380;43081;41411.37882931698;42498.575014249465;42632.57367426286;42751.57248427476;43053.56946430621;40772.59227407688;42154;43383.34924976065;43712.562874372124;44877.77561112174;35634.64365356313;38275;38692.806535968266;38945.61054389533;39273.80363098166;28838.42323153483;28944.276393090342;29060.56409153822;29080.327576292493;29167.85416072906 09:56:58 INFO - PROCESS | 14818 | |2;jquery.html;380.2490082087876;389.2001936021476;394.1978074618153;394.45805953973365;398.2691760619264;19166.42500724977;20714.27500037499;20785.58428831426;20796.480087997807;21144.462664480285;19468.513287167792;20045.599088018233;20128.59742805143;20202.898985505053;20262;5701.070886278266;5919.763209471637;5950.880982380349;5959.821205363846;5961.105834124873;5728.169415434781;5730.255066841326;5858.2677165354335;5858.56060795442;5881.206037184989;5651.886962260773;5784.30588329399;5843.8246852594275;5850.76596936122;5883.411658834125;5724.62789918656;5787.1608616750755;5791.160281759142;5807.419258074201;5854.970725146347;5040.16837221858;5131.102057139986;5133.871653208662;5149;5150.356205474316;12847.486100555967;13652.931735341259;13731.45074197031;14165;23809;2262.875541845198;2380.5119950410126;2630.4607555451084;3045.4365942300747;3078.9076327710204;10131.89868101317;10223.386596804216;10327.690169294932;10464.267501274913;10620.893791062068;1883.4255552056618;1982.4041646474582;1986.632472992501;2000.9699854502194;2024.2813801100544;81172;85059;88315.55842220748;88779.11220887773;89743;10399.48002599867;10494;10963.671089867317;10977.725556860983;11122.721931951766;14714.043587167014;14798.112113273239;14882.330295136744;14884.851151488563;14921.850781492263;8359.749207523784;8481;8578.604115585826;8618.396712230084;8669.349798765117;8506.106858779864;8526.062133165347;8528.232459078712;8542.316614670812;8746.212840844228;4600;4671.649626278043;4675.859724208279;4775.880602984953;4787.066522028241;1924.9326273580357;1942.8251457368904;1988.1848442138653;1992.352485442208;2018.818306352406;923.2890674180843;994.9850752238722;1035.2184101003695;1057.4448414582405;1066.0405634928472;19455.708164377545;20334.389968300973;20759.273425430038;20774.688379674317;21051.473713157295;988.6885631026204;1025.9127974122134;1067.2102644043352;1080.8811030786608;1088.1729885287239;10899.782004359868;11632.127590430751;11758.412079395996;12218.144729869002;12252.387380630933;495194;496511;505725;506549;525025;70278;87401;90137.09862901419;100605.49697251614;101266;1028.665683652816;1031.6028329093203;1060.3319908457777;1062.2458054781036;1064.5475672839013;15174.388728965394;18518.351857684916;18534.258629655204;18730.25078996825;18849.24603015864;43620.56379436165;43705.56294437015;44199.558004419545;44325;44614.77692611516;61589.69205153945;62242.68878655578;62764;64862.35137648563;65401.67299163664;8792.29661627081;8873.955630221808;8918.821623567623;9006.234470069856;9215.262778977532;10377.273590848568;14360.856391435951;14392.568222953329;14439.494617688331;14576.416943322572;11688.824667630162;11784.70538236551;11834.526618935146;11867.58463453775;11883.524659013543;9947.353422027545;11330.263532870336;12412.937935310265;12523.812142818048;12698.30159341245;11248.493817778057;11437.241928262078;11762.059035277329;11772.941135294268;11960.58137965167;8743.34424918121;8976.192142707188;8981.820363592822;9155.908440915506;9218.953905230432;11420.143489238175;11496.195266331277;11680.70798230051;11774.293542387484;11802.645920622395 09:56:58 INFO - PROCESS | 14818 | |3;mootools.html;1446.7974483572302;1495.5214331413947;1575.401347487955;1758.0682238413644;1759.6656635239303;7105.863061910095;7932.167122452139;7938.841223175533;8493.108223636515;8496.40525163238;7845.411594130449;8082.878756818653;8091.757247282576;8094.109647938722;8110.594470276477;2272.1138755885218;2302.7121609798774;2307.699999000136;2313.7339205991357;2322.7561106083785;2261.852979556332;2269.5914735347633;2316.814654827618;2329.091654254842;2337.637666161748;2302.182725132579;2303.424143964009;2311.179531266401;2322.3497420722224;2331.335569362732;2203.768604296542;2207.5915955548276;2220.5114874727697;2222.277759728087;2228.253535065755;2190.759016508183;2196.527746534503;2205.900734466953;2206.6028114939304;2209.381373215502;8330.250277475056;8433.367497437717;8446.43740907934;8447.197516235949;8493;4865.3675022247235;5004.474530174352;5007.474215207423;5008.774605142741;5016.347874776292;3163.7627177961745;3297.4888892221743;3344.5150453184397;3382.8477718502727;3397.677220664033;1045.2369770067817;1059.5126241928722;1061.3950048472375;1069.9251052426334;1072.908802751767;11018.614348497844;11121.110311175087;11135.554577816958;11189.44052797357;11216.719582010433;4277.460114358828;4322.178786030644;4435.778211089497;4508.549145085465;4525.570070843265;9525.857112143323;9534.666286680073;9548.283878708986;9578.616855325708;9594.616215351447;5054.974725126351;5083.593312534988;5090.10923088458;5091.745412729349;5097.949020509822;4195.391668208093;4496.3705081288645;4644.790984405709;4706.435227772689;4710.740909250024;3846.7499612525658;3855.691544676419;3932.8623498178;3945.940810887839;4087.550369459357;1218.488234941309;1223.0949097667662;1232.4022848918446;1236.2767780848126;1248.0701877101617;955.2310390136007;962;969.4910172159673;971.9562619682131;996.6262651505685;5558.166275058774;5732;5785.305763308345;5829.59192856496;5926.259217597801;440.2823397861465;440.94769072226137;443.44347843456256;446.9843555475543;448.05684035105634;3963.583823698528;3966.643002129822;3975.1453437510495;3986.0234242610745;4038.4749982502676;9735.150321438903;10275.948620256851;10319.94840025795;10329.328593641389;10337.689869303933;9931.106200441995;10069.899301007043;10146.13757830578;10209.438480883622;10262.384256944608;7844.803879902934;7899.289063984269;7904.407169462198;7922.207779222032;7950.324222441157;5547.278853748987;5614.242077319673;5762.1068734346245;5848.64908105515;5852.268466441695;9608.9039109608;9616.230701544;9637.662681806103;9673.661421850202;9688.9031109688;9465.810683786149;9736.707898763048;9806.75483112928;9852.556634951588;9853.310268281151;6556.901646475402;7174.605396703231;7317;7378.926210738038;7392.408607311295;7883.2905038546805;7920.564368959763;7927.286544210818;7948.403869709679;7996.5202087872585;6991.510594258353;7206.783796486114;7240.565566066053;7269.527480713737;7339.559626422431;7006.439484841302;7020.929790702027;7062.71749130029;7074.575525468488;7153.284671532805;6562.114114594468;6730.293319201609;6742.6291553965;6745.089412929192;6784.491163162684;5206.349206349207;5276.577873770166;5341.225522299167;5395.838124856261;5477.780888764405;5145.819896303611;5275.208718692227;5355.518003379714;5478.424765399735;5549.611527193058 09:56:58 INFO - PROCESS | 14818 | |4;prototype.html;326.5999151039975;334.9564556607641;338.47367343780417;340.361821584529;342.2624244752557;5628.971855140729;5754.913676294854;5758.481736643701;5773.902958437894;5860.413958604137;5665.943340566593;5668.943310566893;5717.656940583568;5719.799807006755;5748.425157484249;4430.468343798732;4443.577860103285;4465.040016396474;4467.285234362503;4483.08096840147;4014.498187726534;4321.524632290446;4339.7396156230725;4345.283028300327;4379.408779814716;4272.700910936236;4295.613394794468;4328.372386004027;4332.263515202423;4334.371516130159;4345.761932604712;4345.869623911272;4349.238883195444;4358.256697321065;4360.454943132108;3713.2573485303046;3780.3384407728813;3787.7159213058853;3789.0865113117698;3808.390657494815;5491.780328786844;5553.778168802857;5557.083081291582;5586.664800112007;5598.796258804336;4955.776990035457;4975.154223781929;5000.974995125038;5008.173651347523;5025.69845809249;5856.970715146397;5901.203337549418;5937.495312898409;5937.67342796146;5978.581499295051;4153.54311025787;4161.438205842233;4165.937510937339;4179.975905903073;4187.225363307798;5997.310309314397;6192.28788689302;6206.069089636546;6214.5649804513705;6234.501239900797;4241.300185469425;4263.4031235627035;4271.594198551133;4275.828966841292;4277.443932288783;4299.9570004300185;4321.503027151918;4326.437563116838;4327.718698284664;4329.805158767863;4990.975045124751;4996.500349964975;5001.599872010231;5011.398632164163;5025.974870125699;5641.266635337462;5996.880062398727;6025.698715064229;6042.818715438544;6072.423119803611;1499.1005396761855;1522.9923850380678;1525.023984649825;1528.2664321125699;1534.0948840184344;909.9669193248718;931.7158266728712;933.8645896344992;933.9019402962726;945.4658118163215;5216.347956505437;5237.214417837278;5659.6321239119325;5854.677992710442;5863.648181109062;6111.236095488064;6202.937970620236;6215.844603884849;6216.968915155395;6260.186175797117;5675.404082571353;5807.535397168216;5844.013035567928;5859.560532960045;5888.205092312569;3271.037377573437;3290.1610089427522;3313.436715758327;3331.3010364713687;3332.01705496879;6298.212723409574;6301.873962520724;6310.432061114522;6343.667829755803;6347.492200623939;6119.5104391648565;6203.2245969253845;6267.467265282411;6277.8744425111245;6320.336364681642;6294.874102517924;6323.810285691437;6361.173047503795;6393.858057550772;6422.293547709842;5951.613145145551;6116.17431646722;6135.294441139326;6158.907616385847;6199.380061993765;6085.117657939485;6124.38756124384;6126.448619624255;6141.539384546266;6165.84585385369;6193.6903154841175;6267.6866156692895;6322.146510221061;6323.715432805443;6380.266269379081;4400.801963911696;4412.565916077352;4485.161083955562;4487.708298960557;4489.259272220178;6147.354527774698;6155.1382806406245;6165.198524191826;6168.907466388097;6170.660613666112;5807.274090738658;5918.171455996078;5932.733027013881;5934.139549765347;6022.187004754477;5894.351621321737;5897.292324921037;5897.67562784051;5902.2327097477055;5909.52723782105;5597.720113994365;5778.566607504538;5801.767929282782;5811.82564523065;5828.6502809831545;5968.820935371946;5985.311689155803;5989.730462129128;5997.580169388101;6015.308239552332;5819.738111785065;5822.787340810634;5850.162671104596;5851.853703657443;5852.268466441695 09:56:58 INFO - PROCESS | 14818 | |5;yui.html;775.5501808950809;783.404612494504;819.455062383515;827.8840962265284;877.6489404238308;15242;15692;16530.33878644854;16623;16642.58393540162;15008.099514029165;15142.848571514309;15187.088774673499;15217.54347369578;15285.700715439174;813.9959300203506;823.045267489712;824.2499325613693;841.1630427724423;843.5866425451546;821.0967935271184;821.8479581277453;821.954792486416;822.761399194236;824.4393812207696;863.4128792421151;867.652938824469;868.179570306061;868.622149365025;870.4168207301092;856.4133568505531;860.6686425726078;862.3403096631082;862.5557837713583;863.2058506174335;621.3475850357107;623.2832242920632;627.9120923070774;629.4272212286843;631.8136149835764;15860.365585376687;15908.204589770465;15946.362145514282;15975.201239938073;16056.59858503535;13538.458461661521;13746;14016.789748153786;14281.78577321341;14422.855771442257;12458.875411245952;12554.81167782484;12593.685157871127;12639.810402843965;12711.046671499675;3869.624488784236;3897.2984862724697;3925.1560914403253;3968.6825053995613;3984.7609143451195;76216;77473;77593;78498;78570.6071469639;11804.704882377837;11965.820512692317;11970.940145299217;12224.144309898222;12247;21702.782972170393;21854.562908741736;21912.89043554772;21964.89017554934;22525.324240272817;8589.699360522352;8641.30869530436;8646.308295336357;8737.388382813142;8785.912140878638;4828.565429111397;4891.584215341664;4935.555799978019;4995.500449955048;5023.171176755867;3483.7387195960405;3558.1994051338243;3577.94633080504;3580.2123532823257;3580.749347545699;615.2033117113349;617.3671986214076;629.5687454093869;631.9178506794179;633.2116514938931;758.7154816943646;787.52354825331;790.9604519773989;794.2256300107349;798.9201079891965;10248.795024099476;10372.481375931173;10556.419396933243;10562.260641755003;10619.20355973305;655.0959675647575;726.9060064602845;728.6720975561019;732.0410262556069;790.2509245240805;5058.797648094109;5112.667676601009;5195.454477279907;5238.633295669267;5255.13290307095;108044;118666;121849.39075304566;124834;125327;101324;102115.48942255242;103023;103040;103061.48469257605;56759.71620141873;92636.0736392641;92688;93652;94032.52983735038;9786.118641364867;9880.802383952137;9985.251106166921;10051.396916185053;10138.847917281395;53801.46198537965;54075.72962135164;54079.459205407446;55521.44478555163;55971.440285596625;75420;79336.20663793519;79361.60319198367;79628;80491.59754201192;11500.424978751196;11786.823197652213;11962.880371196177;12445.37773111359;12482.438290276777;12085;13433.328333583477;13600.183988960694;14089.859101408854;14184.574462766133;12611.054170937034;13120.685788332552;13210.933945330213;13713.725725485634;14177.14937103777;12639.05207109452;12644.367781611067;12738.426770795151;13015.804762928754;13091.803622945854;13114.344282785632;13981.720365592835;14336;14631.92684036573;15923.283452244445;11561.248518846585;11746.353950532803;11858.584949526725;12084.75830483403;12763.744725105631;10498.790024199627;10500.579976801147;10654.520546575268;10670.57317707283;10710.89289107099 09:56:58 INFO - PROCESS | 14818 | __end_tp_report 09:56:58 INFO - PROCESS | 14818 | __start_cc_report 09:56:58 INFO - PROCESS | 14818 | _x_x_mozilla_cycle_collect,369 09:56:58 INFO - PROCESS | 14818 | __end_cc_report 09:56:58 INFO - PROCESS | 14818 | __startTimestamp1467737818920__endTimestamp 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | ------- Summary: start ------- 09:56:58 INFO - PROCESS | 14818 | Number of tests: 6 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | [#0] dojo.html Cycles:165 Average:5479.63 Median:5715.51 stddev:733.27 (12.8%) stddev-sans-first:712.39 09:56:58 INFO - PROCESS | 14818 | Values: 3150.5 3172.3 3190.5 3202.3 3222.0 5376.1 5518.5 5533.1 5533.7 5573.2 5324.0 5442.8 5503.4 5515.1 5551.6 5014.1 5030.8 5108.3 5201.5 5235.2 699.8 4894.2 4987.6 5054.8 5086.3 5045.0 5054.7 5058.6 5061.4 5062.2 5051.4 5071.1 5073.6 5079.2 5086.4 4886.7 4940.4 4970.7 4990.8 5043.1 5524.7 5564.2 5587.2 5594.5 5596.3 5730.2 6022.6 6024.1 6024.7 6025.4 5885.4 5921.1 5930.9 5987.5 6013.7 5557.3 5562.2 5572.6 5573.4 5586.9 5817.7 5952.9 6056.7 6062.4 6114.5 5760.4 5778.0 5794.9 5816.5 5838.1 5910.7 5924.9 5936.0 5950.9 5955.2 5671.9 5799.7 5842.8 5889.3 5892.5 5942.4 5981.4 6001.8 6008.1 6045.7 4517.6 4536.4 4543.8 4543.9 4581.6 3931.6 3967.7 3999.8 4015.5 4045.7 5542.4 5567.8 5636.4 5641.3 5646.4 5971.9 5983.6 5988.6 5990.3 5996.6 5526.7 5560.7 5562.9 5680.6 5703.4 5095.1 5137.5 5162.6 5167.1 5185.4 6115.9 6116.7 6121.4 6124.7 6125.5 5819.8 5901.6 5964.0 6021.0 6029.1 6125.6 6191.3 6192.6 6199.2 6200.4 5887.6 5890.4 5910.4 5912.8 5972.0 5715.5 5878.1 5913.8 5996.7 6006.3 5764.9 5792.4 5794.2 5794.7 5845.8 5778.8 5794.9 5803.2 5812.0 5830.0 5540.1 5663.0 5701.9 5711.9 5718.3 5629.5 5773.8 5804.7 5812.5 5836.0 5669.0 5700.2 5724.8 5725.7 5725.7 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | [#1] ext.html Cycles:180 Average:62617.44 Median:42737.57 stddev:126241.99 (295.4%) stddev-sans-first:126510.21 09:56:58 INFO - PROCESS | 14818 | Values: 583.7 596.5 615.2 630.5 642.9 42761.8 44439.8 44484.8 44589.0 47684.0 45908.5 46042.8 46342.5 46388.5 46472.3 8943.2 9069.3 9079.7 9094.6 9096.0 9029.6 9043.7 9056.9 9081.5 9136.8 9120.5 9121.0 9153.8 9195.0 9199.9 9041.8 9075.2 9088.1 9095.6 9116.3 8911.1 8957.1 8976.6 8991.7 9006.6 42113.2 42721.8 42723.6 42875.6 42908.4 3542.8 3877.5 4146.7 4267.1 4369.9 32984.0 33530.5 33759.0 33876.5 34683.8 4393.3 4446.2 4485.9 4540.9 4555.5 365837.0 366206.0 367047.0 369926.0 371708.0 61549.7 61592.0 61735.4 61752.4 61854.4 36340.1 36898.6 37049.0 38679.2 38772.6 17528.8 17754.4 17834.4 17837.6 17864.8 13566.4 13594.7 13640.6 13693.6 13723.4 20192.3 20295.3 20385.9 20451.9 20491.8 7253.7 7378.6 7426.6 7468.9 7483.3 1004.7 1042.6 1096.6 1113.3 1129.4 32673.5 33259.0 33284.0 33407.3 33950.0 1123.3 1126.9 1163.4 1193.2 1282.3 17456.1 17464.2 17465.3 17468.1 17527.6 579339.0 580505.0 585760.0 586990.0 587627.0 58929.7 59647.7 59963.7 60070.4 60086.4 1354.6 1369.7 1370.4 1377.3 1397.5 31185.0 31732.7 32610.0 32754.7 33136.7 52585.7 53046.2 53288.0 53387.0 53466.5 441473.0 450048.0 450202.0 450737.0 451531.0 29284.9 29335.3 29530.6 29538.3 29679.0 46179.0 49453.0 49992.5 50255.5 50516.5 40549.0 41542.4 41977.2 42380.0 43081.0 41411.4 42498.6 42632.6 42751.6 43053.6 40772.6 42154.0 43383.3 43712.6 44877.8 35634.6 38275.0 38692.8 38945.6 39273.8 28838.4 28944.3 29060.6 29080.3 29167.9 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | [#2] jquery.html Cycles:180 Average:29750.60 Median:21097.97 stddev:83471.27 (395.6%) stddev-sans-first:83676.30 09:56:58 INFO - PROCESS | 14818 | Values: 380.2 389.2 394.2 394.5 398.3 19166.4 20714.3 20785.6 20796.5 21144.5 19468.5 20045.6 20128.6 20202.9 20262.0 5701.1 5919.8 5950.9 5959.8 5961.1 5728.2 5730.3 5858.3 5858.6 5881.2 5651.9 5784.3 5843.8 5850.8 5883.4 5724.6 5787.2 5791.2 5807.4 5855.0 5040.2 5131.1 5133.9 5149.0 5150.4 12847.5 13652.9 13731.5 14165.0 23809.0 2262.9 2380.5 2630.5 3045.4 3078.9 10131.9 10223.4 10327.7 10464.3 10620.9 1883.4 1982.4 1986.6 2001.0 2024.3 81172.0 85059.0 88315.6 88779.1 89743.0 10399.5 10494.0 10963.7 10977.7 11122.7 14714.0 14798.1 14882.3 14884.9 14921.9 8359.7 8481.0 8578.6 8618.4 8669.3 8506.1 8526.1 8528.2 8542.3 8746.2 4600.0 4671.6 4675.9 4775.9 4787.1 1924.9 1942.8 1988.2 1992.4 2018.8 923.3 995.0 1035.2 1057.4 1066.0 19455.7 20334.4 20759.3 20774.7 21051.5 988.7 1025.9 1067.2 1080.9 1088.2 10899.8 11632.1 11758.4 12218.1 12252.4 495194.0 496511.0 505725.0 506549.0 525025.0 70278.0 87401.0 90137.1 100605.5 101266.0 1028.7 1031.6 1060.3 1062.2 1064.5 15174.4 18518.4 18534.3 18730.3 18849.2 43620.6 43705.6 44199.6 44325.0 44614.8 61589.7 62242.7 62764.0 64862.4 65401.7 8792.3 8874.0 8918.8 9006.2 9215.3 10377.3 14360.9 14392.6 14439.5 14576.4 11688.8 11784.7 11834.5 11867.6 11883.5 9947.4 11330.3 12412.9 12523.8 12698.3 11248.5 11437.2 11762.1 11772.9 11960.6 8743.3 8976.2 8981.8 9155.9 9219.0 11420.1 11496.2 11680.7 11774.3 11802.6 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | [#3] mootools.html Cycles:180 Average:5499.28 Median:5090.93 stddev:3053.06 (60.0%) stddev-sans-first:3046.43 09:56:58 INFO - PROCESS | 14818 | Values: 1446.8 1495.5 1575.4 1758.1 1759.7 7105.9 7932.2 7938.8 8493.1 8496.4 7845.4 8082.9 8091.8 8094.1 8110.6 2272.1 2302.7 2307.7 2313.7 2322.8 2261.9 2269.6 2316.8 2329.1 2337.6 2302.2 2303.4 2311.2 2322.3 2331.3 2203.8 2207.6 2220.5 2222.3 2228.3 2190.8 2196.5 2205.9 2206.6 2209.4 8330.3 8433.4 8446.4 8447.2 8493.0 4865.4 5004.5 5007.5 5008.8 5016.3 3163.8 3297.5 3344.5 3382.8 3397.7 1045.2 1059.5 1061.4 1069.9 1072.9 11018.6 11121.1 11135.6 11189.4 11216.7 4277.5 4322.2 4435.8 4508.5 4525.6 9525.9 9534.7 9548.3 9578.6 9594.6 5055.0 5083.6 5090.1 5091.7 5097.9 4195.4 4496.4 4644.8 4706.4 4710.7 3846.7 3855.7 3932.9 3945.9 4087.6 1218.5 1223.1 1232.4 1236.3 1248.1 955.2 962.0 969.5 972.0 996.6 5558.2 5732.0 5785.3 5829.6 5926.3 440.3 440.9 443.4 447.0 448.1 3963.6 3966.6 3975.1 3986.0 4038.5 9735.2 10275.9 10319.9 10329.3 10337.7 9931.1 10069.9 10146.1 10209.4 10262.4 7844.8 7899.3 7904.4 7922.2 7950.3 5547.3 5614.2 5762.1 5848.6 5852.3 9608.9 9616.2 9637.7 9673.7 9688.9 9465.8 9736.7 9806.8 9852.6 9853.3 6556.9 7174.6 7317.0 7378.9 7392.4 7883.3 7920.6 7927.3 7948.4 7996.5 6991.5 7206.8 7240.6 7269.5 7339.6 7006.4 7020.9 7062.7 7074.6 7153.3 6562.1 6730.3 6742.6 6745.1 6784.5 5206.3 5276.6 5341.2 5395.8 5477.8 5145.8 5275.2 5355.5 5478.4 5549.6 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | [#4] prototype.html Cycles:180 Average:5004.64 Median:5790.17 stddev:1496.54 (25.8%) stddev-sans-first:1458.96 09:56:58 INFO - PROCESS | 14818 | Values: 326.6 335.0 338.5 340.4 342.3 5629.0 5754.9 5758.5 5773.9 5860.4 5665.9 5668.9 5717.7 5719.8 5748.4 4430.5 4443.6 4465.0 4467.3 4483.1 4014.5 4321.5 4339.7 4345.3 4379.4 4272.7 4295.6 4328.4 4332.3 4334.4 4345.8 4345.9 4349.2 4358.3 4360.5 3713.3 3780.3 3787.7 3789.1 3808.4 5491.8 5553.8 5557.1 5586.7 5598.8 4955.8 4975.2 5001.0 5008.2 5025.7 5857.0 5901.2 5937.5 5937.7 5978.6 4153.5 4161.4 4165.9 4180.0 4187.2 5997.3 6192.3 6206.1 6214.6 6234.5 4241.3 4263.4 4271.6 4275.8 4277.4 4300.0 4321.5 4326.4 4327.7 4329.8 4991.0 4996.5 5001.6 5011.4 5026.0 5641.3 5996.9 6025.7 6042.8 6072.4 1499.1 1523.0 1525.0 1528.3 1534.1 910.0 931.7 933.9 933.9 945.5 5216.3 5237.2 5659.6 5854.7 5863.6 6111.2 6202.9 6215.8 6217.0 6260.2 5675.4 5807.5 5844.0 5859.6 5888.2 3271.0 3290.2 3313.4 3331.3 3332.0 6298.2 6301.9 6310.4 6343.7 6347.5 6119.5 6203.2 6267.5 6277.9 6320.3 6294.9 6323.8 6361.2 6393.9 6422.3 5951.6 6116.2 6135.3 6158.9 6199.4 6085.1 6124.4 6126.4 6141.5 6165.8 6193.7 6267.7 6322.1 6323.7 6380.3 4400.8 4412.6 4485.2 4487.7 4489.3 6147.4 6155.1 6165.2 6168.9 6170.7 5807.3 5918.2 5932.7 5934.1 6022.2 5894.4 5897.3 5897.7 5902.2 5909.5 5597.7 5778.6 5801.8 5811.8 5828.7 5968.8 5985.3 5989.7 5997.6 6015.3 5819.7 5822.8 5850.2 5851.9 5852.3 09:56:58 INFO - PROCESS | 14818 | 09:56:58 INFO - PROCESS | 14818 | [#5] yui.html Cycles:180 Average:21380.50 Median:3580.48 stddev:31048.54 (867.2%) stddev-sans-first:31097.09 09:56:58 INFO - PROCESS | 14818 | Values: 775.6 783.4 819.5 827.9 877.6 15242.0 15692.0 16530.3 16623.0 16642.6 15008.1 15142.8 15187.1 15217.5 15285.7 814.0 823.0 824.2 841.2 843.6 821.1 821.8 822.0 822.8 824.4 863.4 867.7 868.2 868.6 870.4 856.4 860.7 862.3 862.6 863.2 621.3 623.3 627.9 629.4 631.8 15860.4 15908.2 15946.4 15975.2 16056.6 13538.5 13746.0 14016.8 14281.8 14422.9 12458.9 12554.8 12593.7 12639.8 12711.0 3869.6 3897.3 3925.2 3968.7 3984.8 76216.0 77473.0 77593.0 78498.0 78570.6 11804.7 11965.8 11970.9 12224.1 12247.0 21702.8 21854.6 21912.9 21964.9 22525.3 8589.7 8641.3 8646.3 8737.4 8785.9 4828.6 4891.6 4935.6 4995.5 5023.2 3483.7 3558.2 3577.9 3580.2 3580.7 615.2 617.4 629.6 631.9 633.2 758.7 787.5 791.0 794.2 798.9 10248.8 10372.5 10556.4 10562.3 10619.2 655.1 726.9 728.7 732.0 790.3 5058.8 5112.7 5195.5 5238.6 5255.1 108044.0 118666.0 121849.4 124834.0 125327.0 101324.0 102115.5 103023.0 103040.0 103061.5 56759.7 92636.1 92688.0 93652.0 94032.5 9786.1 9880.8 9985.3 10051.4 10138.8 53801.5 54075.7 54079.5 55521.4 55971.4 75420.0 79336.2 79361.6 79628.0 80491.6 11500.4 11786.8 11962.9 12445.4 12482.4 12085.0 13433.3 13600.2 14089.9 14184.6 12611.1 13120.7 13210.9 13713.7 14177.1 12639.1 12644.4 12738.4 13015.8 13091.8 13114.3 13981.7 14336.0 14631.9 15923.3 11561.2 11746.4 11858.6 12084.8 12763.7 10498.8 10500.6 10654.5 10670.6 10710.9 09:56:58 INFO - PROCESS | 14818 | -------- Summary: end -------- 09:56:58 INFO - PROCESS | 14818 | 09:56:59 INFO - TEST-INFO | 14818: exit 0 09:56:59 INFO - TEST-OK | dromaeo_css | took 1110483ms 09:56:59 INFO - TEST-START | kraken 09:56:59 INFO - operating with platform_type : linux_ 09:56:59 INFO - Initialising browser for kraken test... 09:56:59 INFO - TEST-INFO | started process 15066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY8j24G/profile http://localhost:60925/getInfo.html) 09:57:04 INFO - PROCESS | 15066 | __metrics Screen width/height:1600/1200 09:57:04 INFO - PROCESS | 15066 | colorDepth:24 09:57:04 INFO - PROCESS | 15066 | Browser inner width/height: 1024/697 09:57:04 INFO - PROCESS | 15066 | __metrics 09:57:04 ERROR - PROCESS | 15066 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:57:05 INFO - TEST-INFO | 15066: exit 0 09:57:05 INFO - Browser initialized. 09:57:05 INFO - Running cycle 1/1 for kraken test... 09:57:05 INFO - TEST-INFO | started process 15188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY8j24G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:17 INFO - PROCESS | 15188 | RSS: Main: 168415232 09:57:17 INFO - PROCESS | 15188 | 09:57:19 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:20 INFO - PROCESS | 15188 | RSS: Main: 174333952 09:57:20 INFO - PROCESS | 15188 | 09:57:23 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-dft) 09:57:23 INFO - PROCESS | 15188 | RSS: Main: 173682688 09:57:23 INFO - PROCESS | 15188 | 09:57:26 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-fft) 09:57:27 INFO - PROCESS | 15188 | RSS: Main: 168140800 09:57:27 INFO - PROCESS | 15188 | 09:57:29 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-oscillator) 09:57:30 INFO - PROCESS | 15188 | RSS: Main: 168644608 09:57:30 INFO - PROCESS | 15188 | 09:57:32 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:32 INFO - PROCESS | 15188 | RSS: Main: 169656320 09:57:32 INFO - PROCESS | 15188 | 09:57:36 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60925/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:36 INFO - PROCESS | 15188 | RSS: Main: 169549824 09:57:36 INFO - PROCESS | 15188 | 09:57:40 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60925/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:40 INFO - PROCESS | 15188 | RSS: Main: 166952960 09:57:40 INFO - PROCESS | 15188 | 09:57:43 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60925/tests/kraken/driver.html?testName=json-parse-financial) 09:57:44 INFO - PROCESS | 15188 | RSS: Main: 168652800 09:57:44 INFO - PROCESS | 15188 | 09:57:45 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:46 INFO - PROCESS | 15188 | RSS: Main: 169275392 09:57:46 INFO - PROCESS | 15188 | 09:57:48 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:48 INFO - PROCESS | 15188 | RSS: Main: 169418752 09:57:48 INFO - PROCESS | 15188 | 09:57:50 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:51 INFO - PROCESS | 15188 | RSS: Main: 169541632 09:57:51 INFO - PROCESS | 15188 | 09:57:54 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:54 INFO - PROCESS | 15188 | RSS: Main: 169865216 09:57:54 INFO - PROCESS | 15188 | 09:57:57 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:58 INFO - PROCESS | 15188 | RSS: Main: 169713664 09:57:58 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60925/tests/kraken/driver.html?testName=ai-astar) 09:57:59 INFO - PROCESS | 15188 | RSS: Main: 170729472 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | __start_tp_report 09:57:59 INFO - PROCESS | 15188 | _x_x_mozilla_page_load 09:57:59 INFO - PROCESS | 15188 | _x_x_mozilla_page_load_details 09:57:59 INFO - PROCESS | 15188 | |i|pagename|runs| 09:57:59 INFO - PROCESS | 15188 | |0;ai-astar;102;112;105;110;111;112;112;120;111;113 09:57:59 INFO - PROCESS | 15188 | |1;audio-beat-detection;143;117;145;178;119;144;141;117;183;126 09:57:59 INFO - PROCESS | 15188 | |2;audio-dft;162;161;162;162;160;163;175;165;161;169 09:57:59 INFO - PROCESS | 15188 | |3;audio-fft;75;74;74;158;82;76;75;75;157;77 09:57:59 INFO - PROCESS | 15188 | |4;audio-oscillator;84;85;153;84;83;85;135;83;83;142 09:57:59 INFO - PROCESS | 15188 | |5;imaging-gaussian-blur;118;118;117;118;117;117;118;117;117;117 09:57:59 INFO - PROCESS | 15188 | |6;imaging-darkroom;150;146;147;147;149;154;149;150;148;152 09:57:59 INFO - PROCESS | 15188 | |7;imaging-desaturate;95;97;95;95;95;97;95;95;96;96 09:57:59 INFO - PROCESS | 15188 | |8;json-parse-financial;53;52;54;53;53;54;54;53;59;53 09:57:59 INFO - PROCESS | 15188 | |9;json-stringify-tinderbox;63;64;63;64;63;63;63;62;63;63 09:57:59 INFO - PROCESS | 15188 | |10;stanford-crypto-aes;82;76;77;75;75;78;76;75;80;77 09:57:59 INFO - PROCESS | 15188 | |11;stanford-crypto-ccm;121;121;139;120;130;148;129;130;159;127 09:57:59 INFO - PROCESS | 15188 | |12;stanford-crypto-pbkdf2;156;164;156;157;162;165;156;157;155;156 09:57:59 INFO - PROCESS | 15188 | |13;stanford-crypto-sha256-iterative;71;65;66;64;63;63;61;65;62;66 09:57:59 INFO - PROCESS | 15188 | __end_tp_report 09:57:59 INFO - PROCESS | 15188 | __start_cc_report 09:57:59 INFO - PROCESS | 15188 | _x_x_mozilla_cycle_collect,928 09:57:59 INFO - PROCESS | 15188 | __end_cc_report 09:57:59 INFO - PROCESS | 15188 | __startTimestamp1467737879963__endTimestamp 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | ------- Summary: start ------- 09:57:59 INFO - PROCESS | 15188 | Number of tests: 14 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:4.78 (4.3%) stddev-sans-first:3.87 09:57:59 INFO - PROCESS | 15188 | Values: 102.0 112.0 105.0 110.0 111.0 112.0 112.0 120.0 111.0 113.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:143.50 stddev:23.62 (16.5%) stddev-sans-first:25.05 09:57:59 INFO - PROCESS | 15188 | Values: 143.0 117.0 145.0 178.0 119.0 144.0 141.0 117.0 183.0 126.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#2] audio-dft Cycles:10 Average:164.00 Median:162.50 stddev:4.64 (2.9%) stddev-sans-first:4.87 09:57:59 INFO - PROCESS | 15188 | Values: 162.0 161.0 162.0 162.0 160.0 163.0 175.0 165.0 161.0 169.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:34.44 (45.9%) stddev-sans-first:35.96 09:57:59 INFO - PROCESS | 15188 | Values: 75.0 74.0 74.0 158.0 82.0 76.0 75.0 75.0 157.0 77.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:83.50 stddev:29.06 (34.8%) stddev-sans-first:30.10 09:57:59 INFO - PROCESS | 15188 | Values: 84.0 85.0 153.0 84.0 83.0 85.0 135.0 83.0 83.0 142.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:57:59 INFO - PROCESS | 15188 | Values: 118.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.50 stddev:2.44 (1.6%) stddev-sans-first:2.57 09:57:59 INFO - PROCESS | 15188 | Values: 150.0 146.0 147.0 147.0 149.0 154.0 149.0 150.0 148.0 152.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 09:57:59 INFO - PROCESS | 15188 | Values: 95.0 97.0 95.0 95.0 95.0 97.0 95.0 95.0 96.0 96.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:1.93 (3.6%) stddev-sans-first:2.03 09:57:59 INFO - PROCESS | 15188 | Values: 53.0 52.0 54.0 53.0 53.0 54.0 54.0 53.0 59.0 53.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:57:59 INFO - PROCESS | 15188 | Values: 63.0 64.0 63.0 64.0 63.0 63.0 63.0 62.0 63.0 63.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:2.33 (3.0%) stddev-sans-first:1.67 09:57:59 INFO - PROCESS | 15188 | Values: 82.0 76.0 77.0 75.0 75.0 78.0 76.0 75.0 80.0 77.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:130.00 stddev:12.74 (9.8%) stddev-sans-first:12.83 09:57:59 INFO - PROCESS | 15188 | Values: 121.0 121.0 139.0 120.0 130.0 148.0 129.0 130.0 159.0 127.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.40 Median:157.00 stddev:3.75 (2.4%) stddev-sans-first:3.87 09:57:59 INFO - PROCESS | 15188 | Values: 156.0 164.0 156.0 157.0 162.0 165.0 156.0 157.0 155.0 156.0 09:57:59 INFO - PROCESS | 15188 | 09:57:59 INFO - PROCESS | 15188 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:2.80 (4.3%) stddev-sans-first:1.76 09:57:59 INFO - PROCESS | 15188 | Values: 71.0 65.0 66.0 64.0 63.0 63.0 61.0 65.0 62.0 66.0 09:57:59 INFO - PROCESS | 15188 | -------- Summary: end -------- 09:57:59 INFO - PROCESS | 15188 | 09:58:00 INFO - TEST-INFO | 15188: exit 0 09:58:00 INFO - TEST-OK | kraken | took 61288ms 09:58:00 INFO - SUITE-END | took 1171s 09:58:01 INFO - Completed test suite (00:19:31) 09:58:01 INFO - javascript benchmark 09:58:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7373.837859611027, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.480170771823, 3172.349668317995, 3190.4895216765317, 3202.2954949911014, 3222.0, 5376.112941364675, 5518.530924871386, 5533.0870406383, 5533.6956467394275, 5573.247611572437, 5324.0, 5442.83671489855, 5503.422140675231, 5515.145152501369, 5551.583631227654, 5014.072396606631, 5030.798768049273, 5108.259302401149, 5201.453847346031, 5235.2147177923425, 699.7725959950828, 4894.216925291954, 4987.625928055392, 5054.848354549369, 5086.287919691246, 5045.0, 5054.671446355994, 5058.595312375001, 5061.44324124346, 5062.190049592047, 5051.419086805027, 5071.087204303224, 5073.568746656539, 5079.187330027178, 5086.389633243997, 4886.70679759212, 4940.357753492023, 4970.676906001135, 4990.800367985313, 5043.067032598981, 5524.668519888779, 5564.248826408423, 5587.245721827542, 5594.4964953154, 5596.300462442195, 5730.169125476783, 6022.578419510636, 6024.126501657279, 6024.668643224621, 6025.397460253984, 5885.352611212763, 5921.052631578969, 5930.911036334458, 5987.491063259628, 6013.729382177812, 5557.305336832896, 5562.249096371978, 5572.554195664337, 5573.386927437979, 5586.888262234733, 5817.7382017809305, 5952.8809423812145, 6056.66688332146, 6062.363451837494, 6114.510839132859, 5760.36635970043, 5778.0, 5794.942050579524, 5816.47651711348, 5838.065909454552, 5910.734016969247, 5924.881502369928, 5936.020556608111, 5950.940490595125, 5955.166276721263, 5671.886562268732, 5799.710014499258, 5842.795502157404, 5889.322727886262, 5892.469677729025, 5942.435468630473, 5981.37195594465, 6001.819945401558, 6008.098785182257, 6045.697715114226, 4517.570830771071, 4536.432945881765, 4543.795529201194, 4543.931841022388, 4581.610563102107, 3931.6461518463475, 3967.722259441869, 3999.8200080996426, 4015.4579131817413, 4045.696572757055, 5542.418046105101, 5567.777288908479, 5636.379998200195, 5641.26663533738, 5646.407127251661, 5971.850703732442, 5983.640981541122, 5988.550858685616, 5990.28116625999, 5996.640201587918, 5526.696031718214, 5560.666360018412, 5562.916556251659, 5680.602357834912, 5703.40114288002, 5095.133827249377, 5137.5376216139975, 5162.561182299547, 5167.0957582422925, 5185.351831021122, 6115.938840611537, 6116.694165291718, 6121.357257487989, 6124.724387402578, 6125.479334256638, 5819.79630712923, 5901.5868889177345, 5963.970180149072, 6020.969895150496, 6029.095635654687, 6125.632462052291, 6191.25704915413, 6192.628442293297, 6199.16311297969, 6200.379962003944, 5887.558433117619, 5890.383078427658, 5910.379410161871, 5912.793052243151, 5972.044472884318, 5715.514181294637, 5878.118282257696, 5913.822585322448, 5996.700164991646, 6006.279246490449, 5764.942350576441, 5792.420757924174, 5794.246747922912, 5794.7102644866745, 5845.824625261249, 5778.768849245983, 5794.913076303943, 5803.216565763568, 5812.0, 5830.0, 5540.113581826889, 5663.0, 5701.857453563694, 5711.914321285267, 5718.342390625131, 5629.54963602919, 5773.826785196451, 5804.73878675469, 5812.505936995402, 5836.0, 5668.971655141698, 5700.201971723879, 5724.8282551523525, 5725.713714314351, 5725.740337125826], "value": 5431.331713468686, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.7110630238033, 596.4512648363506, 615.1572345886135, 630.5050535329767, 642.9421352078313, 42761.78619106904, 44439.77780111103, 44484.77757611207, 44588.999999999956, 47684.0, 45908.54091459084, 46042.769786151104, 46342.53657463433, 46388.536114638846, 46472.3029154563, 8943.239824614899, 9069.319801014917, 9079.682211122612, 9094.590743416562, 9096.0, 9029.59366828491, 9043.728688139334, 9056.864147037799, 9081.50051747157, 9136.817263654722, 9120.498372589505, 9121.0, 9153.816923661523, 9194.988551259356, 9199.908000920006, 9041.773955651095, 9075.228605568502, 9088.091190880925, 9095.590698418588, 9116.316276279273, 8911.064338244456, 8957.149070838324, 8976.596053177558, 8991.685291014783, 9006.639734410615, 42113.157736845395, 42721.78639106784, 42723.57276427227, 42875.571244287785, 42908.3563746544, 3542.822858857073, 3877.4571559981623, 4146.709730318879, 4267.103908179286, 4369.868903932856, 32984.0, 33530.497042544135, 33759.0, 33876.49185262223, 34683.826580867186, 4393.253146965024, 4446.199684056901, 4485.910281794346, 4540.909181816378, 4555.544445555451, 365837.0, 366206.0, 367047.0, 369926.0, 371708.0, 61549.69225153935, 61592.0, 61735.38264617296, 61752.38247617556, 61854.381456185765, 36340.09149771224, 36898.63101368952, 37048.96230707337, 38679.22641547153, 38772.6122738769, 17528.824711752975, 17754.37859674905, 17834.37579684705, 17837.643247135245, 17864.821351786315, 13566.389512471962, 13594.660133496543, 13640.590782276548, 13693.589192324247, 13723.382447789874, 20192.28365588912, 20295.289664861953, 20385.898070509553, 20451.897740511202, 20491.795082049288, 7253.746118885813, 7378.631068446556, 7426.591537465383, 7468.925310746931, 7483.289087536676, 1004.6885465505717, 1042.551702767802, 1096.550414330121, 1113.3431275547466, 1129.3562669278433, 32673.50989735156, 33259.0, 33284.0, 33407.3318533628, 33949.981500555026, 1123.3035517978742, 1126.8929451702074, 1163.406662602079, 1193.2363287495837, 1282.3075539208724, 17456.12719364052, 17464.214110365065, 17465.301387944593, 17468.126593670266, 17527.561810954827, 579339.0, 580505.0, 585760.0, 586990.0, 587627.0, 58929.70535147383, 59647.701761491786, 59963.70018149881, 60070.39929600735, 60086.39913600896, 1354.5868510104513, 1369.7260547890462, 1370.383327502608, 1377.3251106957518, 1397.4619771388088, 31185.0, 31732.682673172974, 32610.0, 32754.67245327516, 33136.668633313355, 52585.7370713144, 53046.204306934655, 53288.0, 53387.0, 53466.46533534615, 441473.0, 450048.0, 450202.0, 450737.0, 451531.0, 29284.853575731984, 29335.266618334714, 29530.557041643962, 29538.261543461584, 29679.0, 46179.0, 49453.0, 49992.50007500024, 50255.49744502508, 50516.49483505118, 40549.0, 41542.376864347665, 41977.1604567913, 42380.0, 43081.0, 41411.37882931698, 42498.575014249465, 42632.57367426286, 42751.57248427476, 43053.56946430621, 40772.59227407688, 42154.0, 43383.34924976065, 43712.562874372124, 44877.77561112174, 35634.64365356313, 38275.0, 38692.806535968266, 38945.61054389533, 39273.80363098166, 28838.42323153483, 28944.276393090342, 29060.56409153822, 29080.327576292493, 29167.85416072906], "value": 20639.79836115471, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.2490082087876, 389.2001936021476, 394.1978074618153, 394.45805953973365, 398.2691760619264, 19166.42500724977, 20714.27500037499, 20785.58428831426, 20796.480087997807, 21144.462664480285, 19468.513287167792, 20045.599088018233, 20128.59742805143, 20202.898985505053, 20262.0, 5701.070886278266, 5919.763209471637, 5950.880982380349, 5959.821205363846, 5961.105834124873, 5728.169415434781, 5730.255066841326, 5858.2677165354335, 5858.56060795442, 5881.206037184989, 5651.886962260773, 5784.30588329399, 5843.8246852594275, 5850.76596936122, 5883.411658834125, 5724.62789918656, 5787.1608616750755, 5791.160281759142, 5807.419258074201, 5854.970725146347, 5040.16837221858, 5131.102057139986, 5133.871653208662, 5149.0, 5150.356205474316, 12847.486100555967, 13652.931735341259, 13731.45074197031, 14165.0, 23809.0, 2262.875541845198, 2380.5119950410126, 2630.4607555451084, 3045.4365942300747, 3078.9076327710204, 10131.89868101317, 10223.386596804216, 10327.690169294932, 10464.267501274913, 10620.893791062068, 1883.4255552056618, 1982.4041646474582, 1986.632472992501, 2000.9699854502194, 2024.2813801100544, 81172.0, 85059.0, 88315.55842220748, 88779.11220887773, 89743.0, 10399.48002599867, 10494.0, 10963.671089867317, 10977.725556860983, 11122.721931951766, 14714.043587167014, 14798.112113273239, 14882.330295136744, 14884.851151488563, 14921.850781492263, 8359.749207523784, 8481.0, 8578.604115585826, 8618.396712230084, 8669.349798765117, 8506.106858779864, 8526.062133165347, 8528.232459078712, 8542.316614670812, 8746.212840844228, 4600.0, 4671.649626278043, 4675.859724208279, 4775.880602984953, 4787.066522028241, 1924.9326273580357, 1942.8251457368904, 1988.1848442138653, 1992.352485442208, 2018.818306352406, 923.2890674180843, 994.9850752238722, 1035.2184101003695, 1057.4448414582405, 1066.0405634928472, 19455.708164377545, 20334.389968300973, 20759.273425430038, 20774.688379674317, 21051.473713157295, 988.6885631026204, 1025.9127974122134, 1067.2102644043352, 1080.8811030786608, 1088.1729885287239, 10899.782004359868, 11632.127590430751, 11758.412079395996, 12218.144729869002, 12252.387380630933, 495194.0, 496511.0, 505725.0, 506549.0, 525025.0, 70278.0, 87401.0, 90137.09862901419, 100605.49697251614, 101266.0, 1028.665683652816, 1031.6028329093203, 1060.3319908457777, 1062.2458054781036, 1064.5475672839013, 15174.388728965394, 18518.351857684916, 18534.258629655204, 18730.25078996825, 18849.24603015864, 43620.56379436165, 43705.56294437015, 44199.558004419545, 44325.0, 44614.77692611516, 61589.69205153945, 62242.68878655578, 62764.0, 64862.35137648563, 65401.67299163664, 8792.29661627081, 8873.955630221808, 8918.821623567623, 9006.234470069856, 9215.262778977532, 10377.273590848568, 14360.856391435951, 14392.568222953329, 14439.494617688331, 14576.416943322572, 11688.824667630162, 11784.70538236551, 11834.526618935146, 11867.58463453775, 11883.524659013543, 9947.353422027545, 11330.263532870336, 12412.937935310265, 12523.812142818048, 12698.30159341245, 11248.493817778057, 11437.241928262078, 11762.059035277329, 11772.941135294268, 11960.58137965167, 8743.34424918121, 8976.192142707188, 8981.820363592822, 9155.908440915506, 9218.953905230432, 11420.143489238175, 11496.195266331277, 11680.70798230051, 11774.293542387484, 11802.645920622395], "value": 9375.907957176336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.7974483572302, 1495.5214331413947, 1575.401347487955, 1758.0682238413644, 1759.6656635239303, 7105.863061910095, 7932.167122452139, 7938.841223175533, 8493.108223636515, 8496.40525163238, 7845.411594130449, 8082.878756818653, 8091.757247282576, 8094.109647938722, 8110.594470276477, 2272.1138755885218, 2302.7121609798774, 2307.699999000136, 2313.7339205991357, 2322.7561106083785, 2261.852979556332, 2269.5914735347633, 2316.814654827618, 2329.091654254842, 2337.637666161748, 2302.182725132579, 2303.424143964009, 2311.179531266401, 2322.3497420722224, 2331.335569362732, 2203.768604296542, 2207.5915955548276, 2220.5114874727697, 2222.277759728087, 2228.253535065755, 2190.759016508183, 2196.527746534503, 2205.900734466953, 2206.6028114939304, 2209.381373215502, 8330.250277475056, 8433.367497437717, 8446.43740907934, 8447.197516235949, 8493.0, 4865.3675022247235, 5004.474530174352, 5007.474215207423, 5008.774605142741, 5016.347874776292, 3163.7627177961745, 3297.4888892221743, 3344.5150453184397, 3382.8477718502727, 3397.677220664033, 1045.2369770067817, 1059.5126241928722, 1061.3950048472375, 1069.9251052426334, 1072.908802751767, 11018.614348497844, 11121.110311175087, 11135.554577816958, 11189.44052797357, 11216.719582010433, 4277.460114358828, 4322.178786030644, 4435.778211089497, 4508.549145085465, 4525.570070843265, 9525.857112143323, 9534.666286680073, 9548.283878708986, 9578.616855325708, 9594.616215351447, 5054.974725126351, 5083.593312534988, 5090.10923088458, 5091.745412729349, 5097.949020509822, 4195.391668208093, 4496.3705081288645, 4644.790984405709, 4706.435227772689, 4710.740909250024, 3846.7499612525658, 3855.691544676419, 3932.8623498178, 3945.940810887839, 4087.550369459357, 1218.488234941309, 1223.0949097667662, 1232.4022848918446, 1236.2767780848126, 1248.0701877101617, 955.2310390136007, 962.0, 969.4910172159673, 971.9562619682131, 996.6262651505685, 5558.166275058774, 5732.0, 5785.305763308345, 5829.59192856496, 5926.259217597801, 440.2823397861465, 440.94769072226137, 443.44347843456256, 446.9843555475543, 448.05684035105634, 3963.583823698528, 3966.643002129822, 3975.1453437510495, 3986.0234242610745, 4038.4749982502676, 9735.150321438903, 10275.948620256851, 10319.94840025795, 10329.328593641389, 10337.689869303933, 9931.106200441995, 10069.899301007043, 10146.13757830578, 10209.438480883622, 10262.384256944608, 7844.803879902934, 7899.289063984269, 7904.407169462198, 7922.207779222032, 7950.324222441157, 5547.278853748987, 5614.242077319673, 5762.1068734346245, 5848.64908105515, 5852.268466441695, 9608.9039109608, 9616.230701544, 9637.662681806103, 9673.661421850202, 9688.9031109688, 9465.810683786149, 9736.707898763048, 9806.75483112928, 9852.556634951588, 9853.310268281151, 6556.901646475402, 7174.605396703231, 7317.0, 7378.926210738038, 7392.408607311295, 7883.2905038546805, 7920.564368959763, 7927.286544210818, 7948.403869709679, 7996.5202087872585, 6991.510594258353, 7206.783796486114, 7240.565566066053, 7269.527480713737, 7339.559626422431, 7006.439484841302, 7020.929790702027, 7062.71749130029, 7074.575525468488, 7153.284671532805, 6562.114114594468, 6730.293319201609, 6742.6291553965, 6745.089412929192, 6784.491163162684, 5206.349206349207, 5276.577873770166, 5341.225522299167, 5395.838124856261, 5477.780888764405, 5145.819896303611, 5275.208718692227, 5355.518003379714, 5478.424765399735, 5549.611527193058], "value": 4373.179726417838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5999151039975, 334.9564556607641, 338.47367343780417, 340.361821584529, 342.2624244752557, 5628.971855140729, 5754.913676294854, 5758.481736643701, 5773.902958437894, 5860.413958604137, 5665.943340566593, 5668.943310566893, 5717.656940583568, 5719.799807006755, 5748.425157484249, 4430.468343798732, 4443.577860103285, 4465.040016396474, 4467.285234362503, 4483.08096840147, 4014.498187726534, 4321.524632290446, 4339.7396156230725, 4345.283028300327, 4379.408779814716, 4272.700910936236, 4295.613394794468, 4328.372386004027, 4332.263515202423, 4334.371516130159, 4345.761932604712, 4345.869623911272, 4349.238883195444, 4358.256697321065, 4360.454943132108, 3713.2573485303046, 3780.3384407728813, 3787.7159213058853, 3789.0865113117698, 3808.390657494815, 5491.780328786844, 5553.778168802857, 5557.083081291582, 5586.664800112007, 5598.796258804336, 4955.776990035457, 4975.154223781929, 5000.974995125038, 5008.173651347523, 5025.69845809249, 5856.970715146397, 5901.203337549418, 5937.495312898409, 5937.67342796146, 5978.581499295051, 4153.54311025787, 4161.438205842233, 4165.937510937339, 4179.975905903073, 4187.225363307798, 5997.310309314397, 6192.28788689302, 6206.069089636546, 6214.5649804513705, 6234.501239900797, 4241.300185469425, 4263.4031235627035, 4271.594198551133, 4275.828966841292, 4277.443932288783, 4299.9570004300185, 4321.503027151918, 4326.437563116838, 4327.718698284664, 4329.805158767863, 4990.975045124751, 4996.500349964975, 5001.599872010231, 5011.398632164163, 5025.974870125699, 5641.266635337462, 5996.880062398727, 6025.698715064229, 6042.818715438544, 6072.423119803611, 1499.1005396761855, 1522.9923850380678, 1525.023984649825, 1528.2664321125699, 1534.0948840184344, 909.9669193248718, 931.7158266728712, 933.8645896344992, 933.9019402962726, 945.4658118163215, 5216.347956505437, 5237.214417837278, 5659.6321239119325, 5854.677992710442, 5863.648181109062, 6111.236095488064, 6202.937970620236, 6215.844603884849, 6216.968915155395, 6260.186175797117, 5675.404082571353, 5807.535397168216, 5844.013035567928, 5859.560532960045, 5888.205092312569, 3271.037377573437, 3290.1610089427522, 3313.436715758327, 3331.3010364713687, 3332.01705496879, 6298.212723409574, 6301.873962520724, 6310.432061114522, 6343.667829755803, 6347.492200623939, 6119.5104391648565, 6203.2245969253845, 6267.467265282411, 6277.8744425111245, 6320.336364681642, 6294.874102517924, 6323.810285691437, 6361.173047503795, 6393.858057550772, 6422.293547709842, 5951.613145145551, 6116.17431646722, 6135.294441139326, 6158.907616385847, 6199.380061993765, 6085.117657939485, 6124.38756124384, 6126.448619624255, 6141.539384546266, 6165.84585385369, 6193.6903154841175, 6267.6866156692895, 6322.146510221061, 6323.715432805443, 6380.266269379081, 4400.801963911696, 4412.565916077352, 4485.161083955562, 4487.708298960557, 4489.259272220178, 6147.354527774698, 6155.1382806406245, 6165.198524191826, 6168.907466388097, 6170.660613666112, 5807.274090738658, 5918.171455996078, 5932.733027013881, 5934.139549765347, 6022.187004754477, 5894.351621321737, 5897.292324921037, 5897.67562784051, 5902.2327097477055, 5909.52723782105, 5597.720113994365, 5778.566607504538, 5801.767929282782, 5811.82564523065, 5828.6502809831545, 5968.820935371946, 5985.311689155803, 5989.730462129128, 5997.580169388101, 6015.308239552332, 5819.738111785065, 5822.787340810634, 5850.162671104596, 5851.853703657443, 5852.268466441695], "value": 4516.696542233054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.5501808950809, 783.404612494504, 819.455062383515, 827.8840962265284, 877.6489404238308, 15242.0, 15692.0, 16530.33878644854, 16623.0, 16642.58393540162, 15008.099514029165, 15142.848571514309, 15187.088774673499, 15217.54347369578, 15285.700715439174, 813.9959300203506, 823.045267489712, 824.2499325613693, 841.1630427724423, 843.5866425451546, 821.0967935271184, 821.8479581277453, 821.954792486416, 822.761399194236, 824.4393812207696, 863.4128792421151, 867.652938824469, 868.179570306061, 868.622149365025, 870.4168207301092, 856.4133568505531, 860.6686425726078, 862.3403096631082, 862.5557837713583, 863.2058506174335, 621.3475850357107, 623.2832242920632, 627.9120923070774, 629.4272212286843, 631.8136149835764, 15860.365585376687, 15908.204589770465, 15946.362145514282, 15975.201239938073, 16056.59858503535, 13538.458461661521, 13746.0, 14016.789748153786, 14281.78577321341, 14422.855771442257, 12458.875411245952, 12554.81167782484, 12593.685157871127, 12639.810402843965, 12711.046671499675, 3869.624488784236, 3897.2984862724697, 3925.1560914403253, 3968.6825053995613, 3984.7609143451195, 76216.0, 77473.0, 77593.0, 78498.0, 78570.6071469639, 11804.704882377837, 11965.820512692317, 11970.940145299217, 12224.144309898222, 12247.0, 21702.782972170393, 21854.562908741736, 21912.89043554772, 21964.89017554934, 22525.324240272817, 8589.699360522352, 8641.30869530436, 8646.308295336357, 8737.388382813142, 8785.912140878638, 4828.565429111397, 4891.584215341664, 4935.555799978019, 4995.500449955048, 5023.171176755867, 3483.7387195960405, 3558.1994051338243, 3577.94633080504, 3580.2123532823257, 3580.749347545699, 615.2033117113349, 617.3671986214076, 629.5687454093869, 631.9178506794179, 633.2116514938931, 758.7154816943646, 787.52354825331, 790.9604519773989, 794.2256300107349, 798.9201079891965, 10248.795024099476, 10372.481375931173, 10556.419396933243, 10562.260641755003, 10619.20355973305, 655.0959675647575, 726.9060064602845, 728.6720975561019, 732.0410262556069, 790.2509245240805, 5058.797648094109, 5112.667676601009, 5195.454477279907, 5238.633295669267, 5255.13290307095, 108044.0, 118666.0, 121849.39075304566, 124834.0, 125327.0, 101324.0, 102115.48942255242, 103023.0, 103040.0, 103061.48469257605, 56759.71620141873, 92636.0736392641, 92688.0, 93652.0, 94032.52983735038, 9786.118641364867, 9880.802383952137, 9985.251106166921, 10051.396916185053, 10138.847917281395, 53801.46198537965, 54075.72962135164, 54079.459205407446, 55521.44478555163, 55971.440285596625, 75420.0, 79336.20663793519, 79361.60319198367, 79628.0, 80491.59754201192, 11500.424978751196, 11786.823197652213, 11962.880371196177, 12445.37773111359, 12482.438290276777, 12085.0, 13433.328333583477, 13600.183988960694, 14089.859101408854, 14184.574462766133, 12611.054170937034, 13120.685788332552, 13210.933945330213, 13713.725725485634, 14177.14937103777, 12639.05207109452, 12644.367781611067, 12738.426770795151, 13015.804762928754, 13091.803622945854, 13114.344282785632, 13981.720365592835, 14336.0, 14631.92684036573, 15923.283452244445, 11561.248518846585, 11746.353950532803, 11858.584949526725, 12084.75830483403, 12763.744725105631, 10498.790024199627, 10500.579976801147, 10654.520546575268, 10670.57317707283, 10710.89289107099], "value": 7742.34758705142, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 105.0, 110.0, 111.0, 112.0, 112.0, 120.0, 111.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 145.0, 178.0, 119.0, 144.0, 141.0, 117.0, 183.0, 126.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 160.0, 163.0, 175.0, 165.0, 161.0, 169.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 158.0, 82.0, 76.0, 75.0, 75.0, 157.0, 77.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 153.0, 84.0, 83.0, 85.0, 135.0, 83.0, 83.0, 142.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 146.0, 147.0, 147.0, 149.0, 154.0, 149.0, 150.0, 148.0, 152.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 59.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 77.0, 75.0, 75.0, 78.0, 76.0, 75.0, 80.0, 77.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 139.0, 120.0, 130.0, 148.0, 129.0, 130.0, 159.0, 127.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 164.0, 156.0, 157.0, 162.0, 165.0, 156.0, 157.0, 155.0, 156.0], "value": 158.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 66.0, 64.0, 63.0, 63.0, 61.0, 65.0, 62.0, 66.0], "value": 64.6, "unit": "score"}]}]} 09:58:01 INFO - Return code: 0 09:58:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:58:01 ERROR - # TBPL SUCCESS # 09:58:01 INFO - Running post-action listener: _resource_record_post_action 09:58:01 INFO - ##### 09:58:01 INFO - ##### Finished run-tests step (success) 09:58:01 INFO - ##### 09:58:01 INFO - Running post-run listener: _resource_record_post_run 09:58:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 566419456; Read time: 12; Write time: 589136 09:58:01 INFO - TinderboxPrint: CPU usage
13.3% 09:58:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 12 09:58:01 INFO - TinderboxPrint: I/O write bytes / time
566,419,456 / 589,136 09:58:01 INFO - TinderboxPrint: CPU idle
8,227.3 (86.7%) 09:58:01 INFO - TinderboxPrint: CPU user
1,204.9 (12.7%) 09:58:01 INFO - TinderboxPrint: Swap in / out
0 / 0 09:58:01 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 269881344; Read time: 0; Write time: 309464 09:58:01 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 296538112; Read time: 0; Write time: 279672 09:58:01 INFO - Running post-run listener: _upload_blobber_files 09:58:01 INFO - Blob upload gear active. 09:58:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:58:01 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 09:58:01 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'] 09:58:01 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 09:58:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:58:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:06 INFO - (blobuploader) - INFO - Done attempting. 09:58:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:58:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:58:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:07 INFO - (blobuploader) - INFO - Done attempting. 09:58:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:58:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:58:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:08 INFO - (blobuploader) - INFO - Done attempting. 09:58:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:08 INFO - Return code: 0 09:58:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/77f0be52480a2f354c19107d1ad602f4852278422b222a0c642aac170441f711905a6831abc3947bcdfb2e95ac0d677dc9232ff6f3df61df393ef50db14190ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a4cc0f0ffa8dada9f13368091d0e2f1442e8c2284b0c193a5a148a7a89fe72a9697018cb47e35b22fd74ea31fb1b83ffcfa4b487c4753b746528e77ca90af08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17115055441b3f7c989d1e85158a2d4c7007e5733d35d9f73c272f05634a270affbdb148daf5a6be3c79819953292ac78fe74b0120d04d0708151e77beb9d501"} 09:58:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:08 INFO - Contents: 09:58:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/77f0be52480a2f354c19107d1ad602f4852278422b222a0c642aac170441f711905a6831abc3947bcdfb2e95ac0d677dc9232ff6f3df61df393ef50db14190ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a4cc0f0ffa8dada9f13368091d0e2f1442e8c2284b0c193a5a148a7a89fe72a9697018cb47e35b22fd74ea31fb1b83ffcfa4b487c4753b746528e77ca90af08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17115055441b3f7c989d1e85158a2d4c7007e5733d35d9f73c272f05634a270affbdb148daf5a6be3c79819953292ac78fe74b0120d04d0708151e77beb9d501"} 09:58:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:08 INFO - Copying logs to upload dir... 09:58:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.215642 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-05 09:58:07.983761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:58:07.987759) ========= 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=32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/77f0be52480a2f354c19107d1ad602f4852278422b222a0c642aac170441f711905a6831abc3947bcdfb2e95ac0d677dc9232ff6f3df61df393ef50db14190ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a4cc0f0ffa8dada9f13368091d0e2f1442e8c2284b0c193a5a148a7a89fe72a9697018cb47e35b22fd74ea31fb1b83ffcfa4b487c4753b746528e77ca90af08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17115055441b3f7c989d1e85158a2d4c7007e5733d35d9f73c272f05634a270affbdb148daf5a6be3c79819953292ac78fe74b0120d04d0708151e77beb9d501"} build_url:https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/foBoveFTS1GHSoMYGtxlQQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/77f0be52480a2f354c19107d1ad602f4852278422b222a0c642aac170441f711905a6831abc3947bcdfb2e95ac0d677dc9232ff6f3df61df393ef50db14190ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7a4cc0f0ffa8dada9f13368091d0e2f1442e8c2284b0c193a5a148a7a89fe72a9697018cb47e35b22fd74ea31fb1b83ffcfa4b487c4753b746528e77ca90af08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/17115055441b3f7c989d1e85158a2d4c7007e5733d35d9f73c272f05634a270affbdb148daf5a6be3c79819953292ac78fe74b0120d04d0708151e77beb9d501"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:58:08.014334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:58:08.014720) ========= 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=32c5991c409366f7fec8a718000001d2-1467736655.423656-497473721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:58:08.097799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:58:08.098168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:58:08.098512) ========= ========= Total master_lag: 0.17 =========