builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1460826368.53 results: success (0) buildid: 20160416073105 builduid: be9a84cc86d3423a957c553fa4961fb8 revision: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.533067) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.533476) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.533757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.561309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.561575) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-16 10:06:09-- 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% 69.9M=0s 2016-04-16 10:06:09 (69.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.705740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.706037) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014949 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.792667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:08.792995) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 --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=78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-16 10:06:09,690 truncating revision to first 12 chars 2016-04-16 10:06:09,690 Setting DEBUG logging. 2016-04-16 10:06:09,690 attempt 1/10 2016-04-16 10:06:09,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1da1937a9e03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-16 10:06:09,971 unpacking tar archive at: mozilla-central-1da1937a9e03/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571881 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.382763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.383038) ========= script_repo_revision: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.383719) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.383991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-16 10:06:09.396409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-16 10:06:09.396674) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:06:10 INFO - MultiFileLogger online at 20160416 10:06:10 in /builds/slave/test 10:06:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:06:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:06:10 INFO - {'append_to_log': False, 10:06:10 INFO - 'base_work_dir': '/builds/slave/test', 10:06:10 INFO - 'blob_upload_branch': 'Firefox', 10:06:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:06:10 INFO - 'branch': 'Firefox', 10:06:10 INFO - 'buildbot_json_path': 'buildprops.json', 10:06:10 INFO - 'config_files': ('talos/linux_config.py',), 10:06:10 INFO - 'default_actions': ('clobber', 10:06:10 INFO - 'read-buildbot-config', 10:06:10 INFO - 'download-and-extract', 10:06:10 INFO - 'populate-webroot', 10:06:10 INFO - 'create-virtualenv', 10:06:10 INFO - 'install', 10:06:10 INFO - 'run-tests'), 10:06:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:06:10 INFO - 'download_minidump_stackwalk': True, 10:06:10 INFO - 'download_symbols': 'ondemand', 10:06:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:06:10 INFO - 'tooltool.py': '/tools/tooltool.py', 10:06:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:06:10 INFO - '/tools/misc-python/virtualenv.py')}, 10:06:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:06:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:06:10 INFO - 'installer_path': 'installer.exe', 10:06:10 INFO - 'log_level': 'info', 10:06:10 INFO - 'log_name': 'talos', 10:06:10 INFO - 'log_to_console': True, 10:06:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:06:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:06:10 INFO - 'opt_config_files': (), 10:06:10 INFO - 'pip_index': False, 10:06:10 INFO - 'sps_profile': False, 10:06:10 INFO - 'sps_profile_interval': 0, 10:06:10 INFO - 'suite': 'dromaeojs', 10:06:10 INFO - 'system_bits': '32', 10:06:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:06:10 INFO - 'title': 'talos-linux64-ix-019', 10:06:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:06:10 INFO - 'use_talos_json': True, 10:06:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:06:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:06:10 INFO - 'work_dir': 'build'} 10:06:10 INFO - ##### 10:06:10 INFO - ##### Running clobber step. 10:06:10 INFO - ##### 10:06:10 INFO - Running pre-action listener: _resource_record_pre_action 10:06:10 INFO - Running main action method: clobber 10:06:10 INFO - rmtree: /builds/slave/test/build 10:06:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:06:10 INFO - Running post-action listener: _resource_record_post_action 10:06:10 INFO - ##### 10:06:10 INFO - ##### Running read-buildbot-config step. 10:06:10 INFO - ##### 10:06:10 INFO - Running pre-action listener: _resource_record_pre_action 10:06:10 INFO - Running main action method: read_buildbot_config 10:06:10 INFO - Using buildbot properties: 10:06:10 INFO - { 10:06:10 INFO - "project": "", 10:06:10 INFO - "product": "firefox", 10:06:10 INFO - "script_repo_revision": "production", 10:06:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:06:10 INFO - "repository": "", 10:06:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:06:10 INFO - "buildid": "20160416073105", 10:06:10 INFO - "pgo_build": "True", 10:06:10 INFO - "basedir": "/builds/slave/test", 10:06:10 INFO - "buildnumber": 263, 10:06:10 INFO - "slavename": "talos-linux64-ix-019", 10:06:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:06:10 INFO - "platform": "ubuntu64_hw", 10:06:10 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:06:10 INFO - "branch": "mozilla-central", 10:06:10 INFO - "repo_path": "mozilla-central", 10:06:10 INFO - "revision": "1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3", 10:06:10 INFO - "stage_platform": "linux64-pgo", 10:06:10 INFO - "builduid": "be9a84cc86d3423a957c553fa4961fb8", 10:06:10 INFO - "slavebuilddir": "test" 10:06:10 INFO - } 10:06:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:06:10 INFO - Running post-action listener: _resource_record_post_action 10:06:10 INFO - ##### 10:06:10 INFO - ##### Running download-and-extract step. 10:06:10 INFO - ##### 10:06:10 INFO - Running pre-action listener: _resource_record_pre_action 10:06:10 INFO - Running main action method: download_and_extract 10:06:10 INFO - mkdir: /builds/slave/test/build/tests 10:06: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')]} 10:06:10 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:06:16 INFO - Downloaded 1361 bytes. 10:06:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:06:16 INFO - Using the following test package requirements: 10:06:16 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:06:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:06:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'jsshell-linux-x86_64.zip'], 10:06:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:06:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:06:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:06:16 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:06:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:06:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:06:16 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:06:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:16 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:34 INFO - Downloaded 23775092 bytes. 10:06:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:35 INFO - Return code: 0 10:06:35 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:35 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:06:37 INFO - Downloaded 23775092 bytes. 10:06:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:06:38 INFO - Return code: 0 10:06:38 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')]} 10:06:38 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:06:39 INFO - Downloaded 10841076 bytes. 10:06:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:06:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:06:40 INFO - Return code: 0 10:06: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')]} 10:06:40 INFO - https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:06:42 INFO - Downloaded 58235741 bytes. 10:06:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:42 INFO - mkdir: /builds/slave/test/properties 10:06:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:42 INFO - Contents: 10:06:42 INFO - build_url:https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:06:43 INFO - Running post-action listener: _resource_record_post_action 10:06:43 INFO - Running post-action listener: set_extra_try_arguments 10:06:43 INFO - ##### 10:06:43 INFO - ##### Running populate-webroot step. 10:06:43 INFO - ##### 10:06:43 INFO - Running pre-action listener: _resource_record_pre_action 10:06:43 INFO - Running main action method: populate_webroot 10:06:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:43 INFO - '--tppagecycles', 10:06:43 INFO - '7'], 10:06:43 INFO - 'tests': ['tsvgm']}}, 10:06:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:06:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['damp', 'tps']}, 10:06:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'tests': ['damp', 'tps']}, 10:06:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['dromaeo_dom']}, 10:06:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['a11yr', 10:06:43 INFO - 'ts_paint', 10:06:43 INFO - 'tpaint', 10:06:43 INFO - 'sessionrestore', 10:06:43 INFO - 'sessionrestore_no_auto_restore', 10:06:43 INFO - 'tabpaint']}, 10:06:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tsvgx', 10:06:43 INFO - 'tsvgr_opacity', 10:06:43 INFO - 'tart', 10:06:43 INFO - 'tscrollx', 10:06:43 INFO - 'cart']}, 10:06:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:43 INFO - 'tsvgr_opacity', 10:06:43 INFO - 'tart', 10:06:43 INFO - 'tscrollx', 10:06:43 INFO - 'cart']}, 10:06:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s'], 10:06:43 INFO - 'tests': ['tp5o']}, 10:06:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'tests': ['tp5o']}, 10:06:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--disable-e10s', 10:06:43 INFO - '--xperf_path', 10:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:43 INFO - 'tests': ['tp5n']}, 10:06:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:06:43 INFO - 'talos_options': ['--xperf_path', 10:06:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:43 INFO - 'tests': ['tp5n']}}, 10:06:43 INFO - 'talos.zip': {'path': '', 10:06:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:43 INFO - Running post-action listener: _resource_record_post_action 10:06:43 INFO - ##### 10:06:43 INFO - ##### Running create-virtualenv step. 10:06:43 INFO - ##### 10:06:43 INFO - Running pre-action listener: _resource_record_pre_action 10:06:43 INFO - Running main action method: create_virtualenv 10:06:43 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:06:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:43 INFO - Using real prefix '/usr' 10:06:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:46 INFO - Installing pip.................done. 10:06:46 INFO - Return code: 0 10:06:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:06:46 INFO - Using env: {'DISPLAY': ':0', 10:06:46 INFO - 'HOME': '/home/cltbld', 10:06:46 INFO - 'LANG': 'en_US.UTF-8', 10:06:46 INFO - 'LANGUAGE': 'en_US:en', 10:06:46 INFO - 'LOGNAME': 'cltbld', 10:06:46 INFO - 'MAIL': '/var/mail/cltbld', 10:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:46 INFO - 'MOZ_NO_REMOTE': '1', 10:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:46 INFO - 'NO_EM_RESTART': '1', 10:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:46 INFO - 'PWD': '/builds/slave/test', 10:06:46 INFO - 'SHELL': '/bin/bash', 10:06:46 INFO - 'SHLVL': '1', 10:06:46 INFO - 'TERM': 'linux', 10:06:46 INFO - 'TMOUT': '86400', 10:06:46 INFO - 'USER': 'cltbld', 10:06:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:46 INFO - '_': '/tools/buildbot/bin/python'} 10:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:06:46 INFO - Cleaning up... 10:06:46 INFO - Return code: 0 10:06:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06: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')]} 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:06:46 INFO - Using env: {'DISPLAY': ':0', 10:06:46 INFO - 'HOME': '/home/cltbld', 10:06:46 INFO - 'LANG': 'en_US.UTF-8', 10:06:46 INFO - 'LANGUAGE': 'en_US:en', 10:06:46 INFO - 'LOGNAME': 'cltbld', 10:06:46 INFO - 'MAIL': '/var/mail/cltbld', 10:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:46 INFO - 'MOZ_NO_REMOTE': '1', 10:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:46 INFO - 'NO_EM_RESTART': '1', 10:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:46 INFO - 'PWD': '/builds/slave/test', 10:06:46 INFO - 'SHELL': '/bin/bash', 10:06:46 INFO - 'SHLVL': '1', 10:06:46 INFO - 'TERM': 'linux', 10:06:46 INFO - 'TMOUT': '86400', 10:06:46 INFO - 'USER': 'cltbld', 10:06:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:46 INFO - '_': '/tools/buildbot/bin/python'} 10:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:46 INFO - Downloading/unpacking psutil>=0.7.1 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:48 INFO - Installing collected packages: psutil 10:06:48 INFO - Running setup.py install for psutil 10:06:48 INFO - building 'psutil._psutil_linux' extension 10:06:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:06:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:06:48 INFO - building 'psutil._psutil_posix' extension 10:06:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:06:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:49 INFO - Successfully installed psutil 10:06:49 INFO - Cleaning up... 10:06:49 INFO - Return code: 0 10:06:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:06:49 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')]} 10:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:49 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')]} 10:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:49 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:06:49 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.0.0'] in /builds/slave/test/build 10:06:49 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.0.0 10:06:49 INFO - Using env: {'DISPLAY': ':0', 10:06:49 INFO - 'HOME': '/home/cltbld', 10:06:49 INFO - 'LANG': 'en_US.UTF-8', 10:06:49 INFO - 'LANGUAGE': 'en_US:en', 10:06:49 INFO - 'LOGNAME': 'cltbld', 10:06:49 INFO - 'MAIL': '/var/mail/cltbld', 10:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:49 INFO - 'MOZ_NO_REMOTE': '1', 10:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:49 INFO - 'NO_EM_RESTART': '1', 10:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:49 INFO - 'PWD': '/builds/slave/test', 10:06:49 INFO - 'SHELL': '/bin/bash', 10:06:49 INFO - 'SHLVL': '1', 10:06:49 INFO - 'TERM': 'linux', 10:06:49 INFO - 'TMOUT': '86400', 10:06:49 INFO - 'USER': 'cltbld', 10:06:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:49 INFO - '_': '/tools/buildbot/bin/python'} 10:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:06:51 INFO - Installing collected packages: mozsystemmonitor 10:06:51 INFO - Running setup.py install for mozsystemmonitor 10:06:51 INFO - Successfully installed mozsystemmonitor 10:06:51 INFO - Cleaning up... 10:06:51 INFO - Return code: 0 10:06:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:06:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:06:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:06:51 INFO - Using env: {'DISPLAY': ':0', 10:06:51 INFO - 'HOME': '/home/cltbld', 10:06:51 INFO - 'LANG': 'en_US.UTF-8', 10:06:51 INFO - 'LANGUAGE': 'en_US:en', 10:06:51 INFO - 'LOGNAME': 'cltbld', 10:06:51 INFO - 'MAIL': '/var/mail/cltbld', 10:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:51 INFO - 'MOZ_NO_REMOTE': '1', 10:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:51 INFO - 'NO_EM_RESTART': '1', 10:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:51 INFO - 'PWD': '/builds/slave/test', 10:06:51 INFO - 'SHELL': '/bin/bash', 10:06:51 INFO - 'SHLVL': '1', 10:06:51 INFO - 'TERM': 'linux', 10:06:51 INFO - 'TMOUT': '86400', 10:06:51 INFO - 'USER': 'cltbld', 10:06:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:51 INFO - '_': '/tools/buildbot/bin/python'} 10:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:54 INFO - Downloading docopt-0.6.1.tar.gz 10:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:54 INFO - Running setup.py install for blobuploader 10:06:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:54 INFO - Running setup.py install for requests 10:06:54 INFO - Running setup.py install for docopt 10:06:54 INFO - Successfully installed blobuploader requests docopt 10:06:54 INFO - Cleaning up... 10:06:54 INFO - Return code: 0 10:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:54 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')]} 10:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:54 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')]} 10:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:54 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 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:06:54 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 10:06:54 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 10:06:54 INFO - Using env: {'DISPLAY': ':0', 10:06:54 INFO - 'HOME': '/home/cltbld', 10:06:54 INFO - 'LANG': 'en_US.UTF-8', 10:06:54 INFO - 'LANGUAGE': 'en_US:en', 10:06:54 INFO - 'LOGNAME': 'cltbld', 10:06:54 INFO - 'MAIL': '/var/mail/cltbld', 10:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:54 INFO - 'MOZ_NO_REMOTE': '1', 10:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:54 INFO - 'NO_EM_RESTART': '1', 10:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:54 INFO - 'PWD': '/builds/slave/test', 10:06:54 INFO - 'SHELL': '/bin/bash', 10:06:54 INFO - 'SHLVL': '1', 10:06:54 INFO - 'TERM': 'linux', 10:06:54 INFO - 'TMOUT': '86400', 10:06:54 INFO - 'USER': 'cltbld', 10:06:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:54 INFO - '_': '/tools/buildbot/bin/python'} 10:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:55 INFO - Running setup.py (path:/tmp/pip-4Zhzzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:55 INFO - Running setup.py (path:/tmp/pip-xVkZJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:55 INFO - Running setup.py (path:/tmp/pip-MoAkzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:55 INFO - Running setup.py (path:/tmp/pip-UafZYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:55 INFO - Running setup.py (path:/tmp/pip-WXxXNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:55 INFO - Running setup.py (path:/tmp/pip-4oBy2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:55 INFO - Running setup.py (path:/tmp/pip-UI42Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:55 INFO - Running setup.py (path:/tmp/pip-ujmrLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:55 INFO - Running setup.py (path:/tmp/pip-NBmjsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:55 INFO - Running setup.py (path:/tmp/pip-2eYzcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:55 INFO - Running setup.py (path:/tmp/pip-uAnrhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:55 INFO - Running setup.py (path:/tmp/pip-pjpyL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:56 INFO - Running setup.py (path:/tmp/pip-tt7Ul4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:56 INFO - Running setup.py (path:/tmp/pip-kazMJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:56 INFO - Running setup.py (path:/tmp/pip-xvqrfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:56 INFO - Running setup.py (path:/tmp/pip-gnYKHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:56 INFO - Running setup.py (path:/tmp/pip-Dj8v24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:56 INFO - Running setup.py install for manifestparser 10:06:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozcrash 10:06:56 INFO - Running setup.py install for mozdebug 10:06:56 INFO - Running setup.py install for mozdevice 10:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:56 INFO - Running setup.py install for mozfile 10:06:56 INFO - Running setup.py install for mozhttpd 10:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozinfo 10:06:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozInstall 10:06:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozleak 10:06:57 INFO - Running setup.py install for mozlog 10:06:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for moznetwork 10:06:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozprocess 10:06:57 INFO - Running setup.py install for mozprofile 10:06:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozrunner 10:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:57 INFO - Running setup.py install for mozscreenshot 10:06:57 INFO - Running setup.py install for moztest 10:06:58 INFO - Running setup.py install for mozversion 10:06:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:58 INFO - Cleaning up... 10:06:58 INFO - Return code: 0 10:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:58 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 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:06:58 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 10:06:58 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 10:06:58 INFO - Using env: {'DISPLAY': ':0', 10:06:58 INFO - 'HOME': '/home/cltbld', 10:06:58 INFO - 'LANG': 'en_US.UTF-8', 10:06:58 INFO - 'LANGUAGE': 'en_US:en', 10:06:58 INFO - 'LOGNAME': 'cltbld', 10:06:58 INFO - 'MAIL': '/var/mail/cltbld', 10:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:58 INFO - 'MOZ_NO_REMOTE': '1', 10:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:58 INFO - 'NO_EM_RESTART': '1', 10:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:58 INFO - 'PWD': '/builds/slave/test', 10:06:58 INFO - 'SHELL': '/bin/bash', 10:06:58 INFO - 'SHLVL': '1', 10:06:58 INFO - 'TERM': 'linux', 10:06:58 INFO - 'TMOUT': '86400', 10:06:58 INFO - 'USER': 'cltbld', 10:06:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:58 INFO - '_': '/tools/buildbot/bin/python'} 10:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:58 INFO - Running setup.py (path:/tmp/pip-4COI4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:58 INFO - Running setup.py (path:/tmp/pip-yWgHzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:58 INFO - Running setup.py (path:/tmp/pip-53ZIFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:58 INFO - Running setup.py (path:/tmp/pip-EHG6S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:58 INFO - Running setup.py (path:/tmp/pip-4UBl68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:58 INFO - Running setup.py (path:/tmp/pip-obz9NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:58 INFO - Running setup.py (path:/tmp/pip-obStXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:58 INFO - Running setup.py (path:/tmp/pip-SoH7bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:58 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)) 10:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:58 INFO - Running setup.py (path:/tmp/pip-3tqStQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:59 INFO - Running setup.py (path:/tmp/pip-CcJCTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:59 INFO - Running setup.py (path:/tmp/pip-yVTFL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:59 INFO - Running setup.py (path:/tmp/pip-jfKdU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:59 INFO - Running setup.py (path:/tmp/pip-ybqeqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:59 INFO - Running setup.py (path:/tmp/pip-xlndEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:59 INFO - Running setup.py (path:/tmp/pip-z6U8_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:59 INFO - Running setup.py (path:/tmp/pip-jSFyLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:59 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)) 10:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:59 INFO - Running setup.py (path:/tmp/pip-ktc32V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:59 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)) 10:06:59 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)) 10:06:59 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)) 10:06:59 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)) 10:06:59 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)) 10:06:59 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)) 10:06:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:06: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 10:07:01 INFO - Downloading blessings-1.6.tar.gz 10:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:07:01 INFO - Installing collected packages: blessings 10:07:01 INFO - Running setup.py install for blessings 10:07:01 INFO - Successfully installed blessings 10:07:01 INFO - Cleaning up... 10:07:01 INFO - Return code: 0 10:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:01 INFO - Reading from file tmpfile_stdout 10:07:01 INFO - Current package versions: 10:07:01 INFO - argparse == 1.2.1 10:07:01 INFO - blessings == 1.6 10:07:01 INFO - blobuploader == 1.2.4 10:07:01 INFO - docopt == 0.6.1 10:07:01 INFO - manifestparser == 1.1 10:07:01 INFO - mozInstall == 1.12 10:07:01 INFO - mozcrash == 0.17 10:07:01 INFO - mozdebug == 0.1 10:07:01 INFO - mozdevice == 0.48 10:07:01 INFO - mozfile == 1.2 10:07:01 INFO - mozhttpd == 0.7 10:07:01 INFO - mozinfo == 0.9 10:07:01 INFO - mozleak == 0.1 10:07:01 INFO - mozlog == 3.1 10:07:01 INFO - moznetwork == 0.27 10:07:01 INFO - mozprocess == 0.22 10:07:01 INFO - mozprofile == 0.28 10:07:01 INFO - mozrunner == 6.11 10:07:01 INFO - mozscreenshot == 0.1 10:07:01 INFO - mozsystemmonitor == 0.0 10:07:01 INFO - moztest == 0.7 10:07:01 INFO - mozversion == 1.4 10:07:01 INFO - psutil == 3.1.1 10:07:01 INFO - requests == 1.2.3 10:07:01 INFO - wsgiref == 0.1.2 10:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07:01 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')]} 10:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 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')]} 10:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:01 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 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:07:01 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 10:07:01 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 10:07:01 INFO - Using env: {'DISPLAY': ':0', 10:07:01 INFO - 'HOME': '/home/cltbld', 10:07:01 INFO - 'LANG': 'en_US.UTF-8', 10:07:01 INFO - 'LANGUAGE': 'en_US:en', 10:07:01 INFO - 'LOGNAME': 'cltbld', 10:07:01 INFO - 'MAIL': '/var/mail/cltbld', 10:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:01 INFO - 'MOZ_NO_REMOTE': '1', 10:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:01 INFO - 'NO_EM_RESTART': '1', 10:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:01 INFO - 'PWD': '/builds/slave/test', 10:07:01 INFO - 'SHELL': '/bin/bash', 10:07:01 INFO - 'SHLVL': '1', 10:07:01 INFO - 'TERM': 'linux', 10:07:01 INFO - 'TMOUT': '86400', 10:07:01 INFO - 'USER': 'cltbld', 10:07:01 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:01 INFO - '_': '/tools/buildbot/bin/python'} 10:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 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)) 10:07:02 INFO - Cleaning up... 10:07:02 INFO - Return code: 0 10:07:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:07:02 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')]} 10:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:02 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')]} 10:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:02 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 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:07:02 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 10:07:02 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 10:07:02 INFO - Using env: {'DISPLAY': ':0', 10:07:02 INFO - 'HOME': '/home/cltbld', 10:07:02 INFO - 'LANG': 'en_US.UTF-8', 10:07:02 INFO - 'LANGUAGE': 'en_US:en', 10:07:02 INFO - 'LOGNAME': 'cltbld', 10:07:02 INFO - 'MAIL': '/var/mail/cltbld', 10:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:02 INFO - 'MOZ_NO_REMOTE': '1', 10:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:02 INFO - 'NO_EM_RESTART': '1', 10:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:02 INFO - 'PWD': '/builds/slave/test', 10:07:02 INFO - 'SHELL': '/bin/bash', 10:07:02 INFO - 'SHLVL': '1', 10:07:02 INFO - 'TERM': 'linux', 10:07:02 INFO - 'TMOUT': '86400', 10:07:02 INFO - 'USER': 'cltbld', 10:07:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:02 INFO - '_': '/tools/buildbot/bin/python'} 10:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:02 INFO - Downloading/unpacking jsonschema 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07: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 10:07:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:04 INFO - Downloading/unpacking functools32 (from jsonschema) 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:04 INFO - warning: no files found matching '*.txt' 10:07:04 INFO - no previously-included directories found matching 'build' 10:07:04 INFO - no previously-included directories found matching 'dist' 10:07:04 INFO - no previously-included directories found matching '.git*' 10:07:04 INFO - Installing collected packages: jsonschema, functools32 10:07:04 INFO - Running setup.py install for functools32 10:07:04 INFO - warning: no files found matching '*.txt' 10:07:04 INFO - no previously-included directories found matching 'build' 10:07:04 INFO - no previously-included directories found matching 'dist' 10:07:04 INFO - no previously-included directories found matching '.git*' 10:07:04 INFO - Successfully installed jsonschema functools32 10:07:04 INFO - Cleaning up... 10:07:04 INFO - Return code: 0 10:07:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb56802f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26279a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', '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 10:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:07:04 INFO - Using env: {'DISPLAY': ':0', 10:07:04 INFO - 'HOME': '/home/cltbld', 10:07:04 INFO - 'LANG': 'en_US.UTF-8', 10:07:04 INFO - 'LANGUAGE': 'en_US:en', 10:07:04 INFO - 'LOGNAME': 'cltbld', 10:07:04 INFO - 'MAIL': '/var/mail/cltbld', 10:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:04 INFO - 'MOZ_NO_REMOTE': '1', 10:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:04 INFO - 'NO_EM_RESTART': '1', 10:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:04 INFO - 'PWD': '/builds/slave/test', 10:07:04 INFO - 'SHELL': '/bin/bash', 10:07:04 INFO - 'SHLVL': '1', 10:07:04 INFO - 'TERM': 'linux', 10:07:04 INFO - 'TMOUT': '86400', 10:07:04 INFO - 'USER': 'cltbld', 10:07:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:04 INFO - '_': '/tools/buildbot/bin/python'} 10:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:04 INFO - Downloading/unpacking flake8 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 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 10:07:04 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 10:07:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:07:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:07:06 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 10:07:06 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 10:07:06 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 10:07:06 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 10:07:06 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 10:07:06 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 10:07:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:07:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 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 10:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:07 INFO - no previously-included directories found matching 'docs/_build' 10:07:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:07:07 INFO - Running setup.py install for pep8 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:07:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:07:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:07:07 INFO - no previously-included directories found matching 'docs/_build' 10:07:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:07:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:07:07 INFO - Cleaning up... 10:07:07 INFO - Return code: 0 10:07:07 INFO - Running post-action listener: _resource_record_post_action 10:07:07 INFO - Running post-action listener: _start_resource_monitoring 10:07:07 INFO - Starting resource monitoring. 10:07:07 INFO - ##### 10:07:07 INFO - ##### Running install step. 10:07:07 INFO - ##### 10:07:07 INFO - Running pre-action listener: _resource_record_pre_action 10:07:07 INFO - Running main action method: install 10:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:07:08 INFO - Reading from file tmpfile_stdout 10:07:08 INFO - Detecting whether we're running mozinstall >=1.0... 10:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:07:08 INFO - Reading from file tmpfile_stdout 10:07:08 INFO - Output received: 10:07:08 INFO - Usage: mozinstall [options] installer 10:07:08 INFO - Options: 10:07:08 INFO - -h, --help show this help message and exit 10:07:08 INFO - -d DEST, --destination=DEST 10:07:08 INFO - Directory to install application into. [default: 10:07:08 INFO - "/builds/slave/test"] 10:07:08 INFO - --app=APP Application being installed. [default: firefox] 10:07:08 INFO - mkdir: /builds/slave/test/build/application 10:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:07:24 INFO - Reading from file tmpfile_stdout 10:07:24 INFO - Output received: 10:07:24 INFO - /builds/slave/test/build/application/firefox/firefox 10:07:24 INFO - Running post-action listener: _resource_record_post_action 10:07:24 INFO - ##### 10:07:24 INFO - ##### Running run-tests step. 10:07:24 INFO - ##### 10:07:24 INFO - Running pre-action listener: _resource_record_pre_action 10:07:24 INFO - Running main action method: run_tests 10:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:07:24 INFO - Python 2.7.3 10:07:24 INFO - Return code: 0 10:07:24 INFO - grabbing minidump binary from tooltool 10:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:24 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b6810>, '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 0x26b7710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b7ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:07:24 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 10:07:24 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 10:07:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:07:24 INFO - Return code: 0 10:07:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:07:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:07:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:07:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:07:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:07:25 INFO - Return code: 0 10:07:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:07:25 INFO - Using env: {'DISPLAY': ':0', 10:07:25 INFO - 'HOME': '/home/cltbld', 10:07:25 INFO - 'LANG': 'en_US.UTF-8', 10:07:25 INFO - 'LANGUAGE': 'en_US:en', 10:07:25 INFO - 'LOGNAME': 'cltbld', 10:07:25 INFO - 'MAIL': '/var/mail/cltbld', 10:07:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:07:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:25 INFO - 'MOZ_NO_REMOTE': '1', 10:07:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:25 INFO - 'NO_EM_RESTART': '1', 10:07:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:25 INFO - 'PWD': '/builds/slave/test', 10:07:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:07:25 INFO - 'SHELL': '/bin/bash', 10:07:25 INFO - 'SHLVL': '1', 10:07:25 INFO - 'TERM': 'linux', 10:07:25 INFO - 'TMOUT': '86400', 10:07:25 INFO - 'USER': 'cltbld', 10:07:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587', 10:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:25 INFO - '_': '/tools/buildbot/bin/python'} 10:07:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:07:25 INFO - mozversion application_buildid: 20160416073105 10:07:25 INFO - mozversion application_changeset: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 10:07:25 INFO - mozversion application_display_name: Nightly 10:07:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:07:25 INFO - mozversion application_name: Firefox 10:07:25 INFO - mozversion application_remotingname: firefox 10:07:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:07:25 INFO - mozversion application_vendor: Mozilla 10:07:25 INFO - mozversion application_version: 48.0a1 10:07:25 INFO - mozversion platform_buildid: 20160416073105 10:07:25 INFO - mozversion platform_changeset: 1da1937a9e03154ae7c60089f2dcf5ad9ee20fa3 10:07:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:07:25 INFO - mozversion platform_version: 48.0a1 10:07:25 INFO - using testdate: 1460826445 10:07:25 INFO - actual date: 1460826445 10:07:25 INFO - starting webserver on 'localhost:46878' 10:07:25 INFO - SUITE-START | Running 2 tests 10:07:25 INFO - TEST-START | dromaeo_css 10:07:25 INFO - operating with platform_type : linux_ 10:07:25 INFO - Initialising browser for dromaeo_css test... 10:07:25 INFO - TEST-INFO | started process 1020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYhrKt/profile http://localhost:46878/getInfo.html) 10:07:30 INFO - PROCESS | 1020 | __metrics Screen width/height:1600/1200 10:07:30 INFO - PROCESS | 1020 | colorDepth:24 10:07:30 INFO - PROCESS | 1020 | Browser inner width/height: 1024/697 10:07:30 INFO - PROCESS | 1020 | __metrics 10:07:31 ERROR - PROCESS | 1020 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:07:32 INFO - TEST-INFO | 1020: exit 0 10:07:32 INFO - Browser initialized. 10:07:32 INFO - Running cycle 1/1 for dromaeo_css test... 10:07:32 INFO - TEST-INFO | started process 1114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYhrKt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:44 INFO - PROCESS | 1114 | RSS: Main: 152473600 10:07:44 INFO - PROCESS | 1114 | 10:08:34 INFO - PROCESS | 1114 | 1460826514951 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] 10:10:42 INFO - PROCESS | 1114 | Cycle 1(1): loaded http://localhost:46878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46878/tests/dromaeo/cssquery-ext.html) 10:10:43 INFO - PROCESS | 1114 | RSS: Main: 281829376 10:10:43 INFO - PROCESS | 1114 | 10:13:46 INFO - PROCESS | 1114 | Cycle 1(1): loaded http://localhost:46878/tests/dromaeo/cssquery-ext.html (next: http://localhost:46878/tests/dromaeo/cssquery-jquery.html) 10:13:46 INFO - PROCESS | 1114 | RSS: Main: 243605504 10:13:46 INFO - PROCESS | 1114 | 10:16:48 INFO - PROCESS | 1114 | Cycle 1(1): loaded http://localhost:46878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46878/tests/dromaeo/cssquery-mootools.html) 10:16:49 INFO - PROCESS | 1114 | RSS: Main: 242040832 10:16:49 INFO - PROCESS | 1114 | 10:19:51 INFO - PROCESS | 1114 | Cycle 1(1): loaded http://localhost:46878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46878/tests/dromaeo/cssquery-prototype.html) 10:19:51 INFO - PROCESS | 1114 | RSS: Main: 236568576 10:19:51 INFO - PROCESS | 1114 | 10:22:54 INFO - PROCESS | 1114 | Cycle 1(1): loaded http://localhost:46878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46878/tests/dromaeo/cssquery-yui.html) 10:22:54 INFO - PROCESS | 1114 | RSS: Main: 222756864 10:22:54 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | Cycle 1(1): loaded http://localhost:46878/tests/dromaeo/cssquery-yui.html (next: http://localhost:46878/tests/dromaeo/cssquery-dojo.html) 10:25:57 INFO - PROCESS | 1114 | RSS: Main: 268492800 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | __start_tp_report 10:25:57 INFO - PROCESS | 1114 | _x_x_mozilla_page_load 10:25:57 INFO - PROCESS | 1114 | _x_x_mozilla_page_load_details 10:25:57 INFO - PROCESS | 1114 | |i|pagename|runs| 10:25:57 INFO - PROCESS | 1114 | |0;dojo.html;2994.595729576507;3051.61854768154;3081.3837232553497;3086.969130308696;3113.0660801759473;5193.272941788148;5198.636095473323;5223.608229382792;5243.528082472577;5275.709835959021;5206.3231779868565;5211.296474975878;5221.738913054351;5323.653962492445;5325.893482130355;4608.400907881971;4651.674382793198;4763.095011947719;4804;4821.325014497973;4765.976170119162;4767.90464190716;4802.807887684506;4813.133635945528;4861.246506791453;4703.529647035286;4709.670323077386;4749.026449577828;4755.95244047562;4781.5457531534275;4732.219183834663;4749.4063242094735;4755.5719985201495;4756.476787553366;4790.377250957354;4573.47405048417;4666.300054991779;4700.130475861976;4729.858104256878;4758.881027974294;5106.234064890259;5109.770060347256;5111.897762044776;5123.590112791005;5135.563477104451;5649.23735295734;5655.095184770417;5658.122990936411;5683.090705487102;5721.170430287627;5668.631538949996;5686.402927692574;5692.288463942007;5693.572982026365;5696.971515142398;5215.087359712035;5262.8684282892855;5304.230886521472;5315.840524784263;5328.014317351302;5745.368009518949;5775.047117225611;5777.075667893117;5777.364489906107;5782.826515204551;5487.149491828773;5526.123719632367;5533.889322213533;5547.889042219133;5591.189277554732;5557.194206840067;5583.832485025375;5622.32532096151;5645.971770141123;5672.092465205547;5572.5263352614675;5593.664380137205;5604.85987850307;5608.747606357723;5614;5585.273914391103;5587.078132108157;5603.131514615241;5606.243157173811;5614.578906582023;4204.873853784391;4245.23585754561;4269.1034882674985;4300.053988122608;4304.225239456928;3777.527809023872;3837.079101015792;3839.30892439358;3871.032241939515;3871.245107204068;5348.438413966477;5363.356397232357;5369.892602148013;5377.139657654757;5419.485148910847;5568.248286481355;5646.604737668324;5664.122061080539;5698.686572238566;5699.344575373802;5289.153735402394;5346.866328341823;5347.545458636059;5349.037173308841;5358.223057656696;4777.546133117417;4859.028194361142;4863.805447782049;4864.975675121602;4887.780049897763;5841.7371218295275;5843.1235314703135;5843.620164689281;5877.882442351214;5914.290285165722;5640.605157638925;5645.1532270159805;5645.9717701412055;5646.802361917313;5647;5712.6001179917;5766.990776613992;5816.21481100063;5831.241938547962;5844.444777746107;5440.483154100354;5443.074677304789;5454.590905682169;5482.533984611353;5482.862928426662;5506.697131657797;5511.255980442749;5515.7242137893745;5521.861953451196;5531.502164805187;5387.730613469389;5402.621816472966;5447.645903016291;5496.587755918402;5576.414476479911;5351.063563876228;5355.036093503207;5356.035913535445;5369.838904832861;5398.730063496888;5240.921386179134;5281;5283.920741188962;5295.205719142159;5330.760115794721;5394.1099718546;5435.483629055233;5480.314960629921;5583.2462617547735;5587.217789509391;5337.599680023936;5346.304980352529;5353.625246232727;5362;5397.298351214317 10:25:57 INFO - PROCESS | 1114 | |1;ext.html;597.3071237364658;646.1567654211254;650.6909218121393;655.2006552006557;658.6969993802849;28434.57348139777;29036.854815725892;29040.564391534117;29071.854640726793;35316.11709707252;39966.8001659992;40747.59252407475;40884.59115408845;40891;40985.59014409855;8449.873251901212;8666.610002549869;8670.52312122833;8671.349648776335;8673.13268673134;8513.48919064855;8634.568271586395;8636.82726345476;8638.740837774876;8642.65429382824;8630.87053694192;8694.913050869505;8695.869561956575;8699.913000870005;8913.821723565525;8756.781080472976;8847.867281990775;8869.334799890003;8874.156955089256;8887.15572020657;8741.606627701769;8845.469271843709;8861.689840855539;8869.822603547957;8869.822603547957;39246.62636807727;39553.40669889954;39814.40278395826;39889.80055099735;39912.201755965005;3504.5969713483023;3507.7018453431488;3523.894283171509;3642.9453558196647;3730.1607138393915;29449.263768405748;29699.851500742574;29833;30064;30435.69564304351;4150.211459822654;4211.894702632428;4258.914821703549;4337.826486940518;4357.520672725997;243715;244694;245711;245973.77013115;247084;50211;50839.491605084215;50971.49028509742;51063.489365106616;62898.37101629017;56917;57945.42054579485;58004;58105.8378832421;58114.709426453446;16719.83280167207;16999.40502082421;17004.829951700325;17019.829801701824;17022.82977170237;9956.352837065568;12508.74982500345;12809;13102.344882756015;13271.402786874614;17686.380976665754;17698.557536061446;18139.183736731615;18407;18573.535661608566;6782.728690852409;6905.170129915577;6972;7063.693216754917;7080.858382832417;1007.0885848307294;1019.3374306700556;1067.2795862792584;1078.4362674122553;1148.305275308443;27314.5902811458;27634.723652763216;27795.86102069517;27821.304467388072;27880.860595697297;1135.7728454309172;1149.3908228638834;1157.8263260510823;1192.6605504587121;1250.3185763758772;15625.248272026594;15917.840821591868;15974.440894568634;16024.439144629881;16134.838651613569;445716;448236;452153;453009;453284.93793089606;55671.721641392345;56218.71890640521;56547;56584.43415565874;56713;1262.1795832708628;1347.5957212836306;1371.9794203086963;1394.7210557888463;1423.5373503611368;28109.859450702617;29086.418271634873;29680;30185.69814301829;30439;46543.767281163375;47661;47673.04653906972;47772.761136194094;47777.761111195614;292920;295981;298001;298615;299246;24572.50854982926;27336.589951150352;27570.310742231606;27858.721412785613;28124.859375702992;41065.79467102645;41813.372799408644;42201.577984219766;45269;45919;37408.81295593613;37412.06469838276;37777.24445511129;37990;38375;36389.452738309126;37647.2470550582;38110.237795244495;38195;38563;37794.24411511699;38933.41599876061;39124.80437597794;39382.803085984386;39522.40716389314;32071.518927215642;33752.49371259482;33756.49365259474;33988.32023359568;34057.829710851285;26405.867970660023;26485.735142648326;26741.732582673925;26757.598636020084;26941.326466838487 10:25:57 INFO - PROCESS | 1114 | |2;jquery.html;369.8335748912992;378.33790865984525;379.3853956590323;379.5805634773575;381.5897909747022;17701.557461063465;17971.28114875405;18288.817111828877;18968.620627587476;19149;11821.527138914455;11967;12179.45192466339;12185.390730463485;12191.817122743167;4438.844640437577;5261.789528418859;5292.947070529303;5294.92057619136;5299.867503312409;5196.0647083524955;5251.684898906078;5269.920951185716;5279.815206467774;5347.46525347466;5208.947910520884;5547.972260138694;5548.6393384430085;5551.666899986014;5556.222128901957;5396.703181325026;5412.4587541245755;5555.083411237121;5765.682887441189;5769.913451298234;5571.415001424833;5571.4428557144365;5577.888442231173;5600.159976003632;5603.299587551556;13584.252866092362;15502.689946201126;20963;21878.12487500498;22024.339269821932;2095.758987716417;2405.314485371678;2411.216354684717;2427.830051896368;2483.8137139714595;9957.651482198089;9999.450030248334;10113.342632728923;12975.67560810978;13280;1863.3850829226324;1895.649304878602;1957.1584218785915;2019.091408866016;2057.8353731701427;73938;74146;78211.21788782153;78316;78605.21394786036;10500.579976800995;10684.893151068545;10930.726731831768;10964.780704386027;11195.832062519068;15306.923465382602;15364.692706145814;15378.077315361114;15417.845821541641;15422.922885385502;7824.960875195701;8178.754637360888;8184.099749027602;8237.629306681214;8366.330693544502;7718.92281077182;7831.84336313282;7865.803354916058;7923.722669706648;8007.07918589358;4626.537346265414;4689.085628302517;4707.976460117678;4715.528447155326;4772.904541909143;1902.419761972584;1939.4084804134593;1942.98057019428;1962;1970.8029197080464;920.5857364186143;945.8581212818133;993.1310103659298;1035.249444152983;1074.1138560687464;18030.63938721218;18232.726509102373;18383.81616183821;18625.254989800527;18977.525561860788;988.3970777825521;1049.380865289483;1068.1454836131063;1072.5602502973743;1105.2760441910561;10213.540390682438;10449.791004179873;10586.153107751361;10658.733531661615;10659.733506662396;458833;460806;466187;475151;489051;62017.68991155015;77739.61130194312;82331;88347;88460.5576972111;1044.6552637629563;1062.516554967488;1093.8796732359433;1102.0467295789244;1103.4923934989833;15489.612759680647;15496.380144794082;15693.450729224422;15757.606059848595;15853.762193566876;32181.839090804395;32552.18619534436;33342;33685;33992;47358.28962565495;49748.253776192665;49806.25290620716;50115.24827127523;50318;7959.84080318402;8011.359091272568;8040.557769322743;8121.309688676529;8180.0592931811225;8817.118288171132;11144.944275278573;12403.441845117171;12819;12888.226706397647;10790.56837726482;11047.447627618427;11074.944625276821;11093.057090147428;11434.085273178292;10881.564737410416;11032.944835275772;11176.329420234812;11460.255083419552;11670.299782013106;11359.432028398713;11543.36511491876;11758.11814113962;11807.940960295144;12192.207506512048;8172.223638754309;8422.24199822019;8435.198656127657;8608.698695545625;8641.222289993932;10877.401742904216;11215.55137794479;11587.246828956091;11693.824592631288;11741.530338786353 10:25:57 INFO - PROCESS | 1114 | |3;mootools.html;1387.3895485986172;1403.0879928046768;1483.421465628405;1601.9199040048002;1810.085906617159;7429.925700742991;8102.837943241132;8313.127121652231;8323.25090741833;8326.12575679554;8019.799505012363;8150.877736833952;8182.79543011425;8192.83614327713;8194.631241594128;2018.3238615063972;2076.615826072174;2076.6677331626943;2346.061575369853;2377.120465427794;2304.7234331880113;2372.383180373107;2376.95246095078;2378.3340664613934;2379.5597814404305;2314.9884250578725;2343.0744855781954;2351.459164392191;2352.9411764705847;2366.4438856868624;2029.3201777404588;2220.2673117871063;2276.123692378438;2286.5198308355184;2288.61093614086;2391.210900402863;2402.771736685012;2413.2036427978724;2415.384077060356;2415.867127307997;8171.836563268701;8226.547539885303;8230.670773169066;8237.876431853527;8237.917620823775;5026.623003274769;5165.251038599419;5167.638265321429;5172.2241663750365;5174.456682048406;3171.6035495563056;3251.1059458648824;3362.3107263011025;3370.7808992415657;3398.83005849709;1061.5435362793996;1086.8913708017856;1120.78705046041;1129.0290350298737;1135.659302209342;11516.654500365003;11563.364014979088;11564.595239166589;11582.884171158265;11597.6520704379;4406.713563618355;4489.19194544985;4659.836905708284;4663.160631086369;4670.299455081697;9777.364471309484;9793.755156121155;9812.656557020613;9828.11546960777;9841.50792460374;5247.55395791362;5257.395399529103;5264;5285.312909321764;5286.603504737083;4255.659547236213;4640.791164397543;4761.262004389325;4827.324174615556;4866.245731911559;3910.2375036868107;3981.8407263709705;4026.0337518995816;4069.369247766601;4086.6117718816663;1252.4551819958347;1272.9872701273055;1278.9360531973364;1279.8417432223853;1287.0990306785288;889.2574700125467;949.3449519831295;963.677168148664;967.5404183013012;985.0887928665956;5312.07038768214;5425.972870135624;5582;5591.608587398843;5606;893.3300024981264;896.4979611417627;950.1638558068855;957.9042095790504;959.9904000960041;3697.7226707997006;3770.1517158639635;3777.1690228149764;3802.2205447883116;3831.6934645228316;10153.13698335635;10571.154307655523;10600.681979540626;10658.62694805678;10668.253222274521;10454.63408780689;10510.894891051144;10520.684379468628;10533;10536.051755342056;7467;7842.058952925686;7975.122736498981;8107.918920810835;8108.310793582612;5627.155926611041;5630.549556035426;5636.915446268391;5652.943470565242;5769.105788602773;9600.423974561549;9646.951765241129;9647.179989700953;9781.462019588991;9880.061394167542;9881.974195290091;10030.749231269278;10133.898661013296;10136.594536218468;10148.441835699108;6688;7188.28117188277;7398.408127349907;7539.472236943361;7675.654595543102;8262.049864265686;8289.502629842229;8333.166683331618;8350.916490835258;8354;7328.743493977899;7622.31399174077;7633.847323053619;7697.153313135439;7731.806704832424;7165.570065796069;7454.105507338937;7499.2500749924575;7575.583342916192;7592.696292148252;6549.148610680581;6584.078229047841;6605.5376123670885;6612.80969425508;6613.603183808987;4620.54749504576;4762.261849413347;4924.03981223658;4941.036497882878;4954.77703503336;4802.567768900815;4876.634252431011;4879.902401952012;4918.631102667243;4977.925331120108 10:25:57 INFO - PROCESS | 1114 | |4;prototype.html;328.08300799266044;328.42197731991695;330.50259359663704;343.2311621966795;343.7336064549972;5501.14732216506;5507.394186639466;5526.281583394159;5526.816907321606;5573.303337082864;5462.481064298885;5503.449655034495;5514.338279406476;5525.944740552593;5526.696031718264;4087.3460246360587;4155.940235240009;4285.657147428198;4304.397384366192;4318.546552611978;4244.556850670771;4309.978450107745;4315.136972605475;4322.394864718942;4326.949500602068;4074.6740260779065;4274.252005898971;4283.764392958386;4294;4295.441592592959;3953.110550126242;4194.30793919003;4274.5939135782055;4292.785360731951;4293.935590966138;3776.9811150944342;3788.9431658525145;3804.885853424402;3808.1241314497543;3826;5279.553701463792;5336.893262134774;5349.181278365336;5352.91970620441;5355.839324820223;4916.139675556763;4939.061578300148;4978.153713868651;4991.126552853236;5023.799048038074;5775.249217601727;5811.506021988136;5860.120981852713;5872.647641141502;5901.557383196277;4176.4570605821045;4258.723182993095;4264.552222016706;4268.530461649216;4273.807678654468;6105.633661980295;6135.159452164333;6149.723262453155;6162.414570615784;6166.9383306167265;4301.268784306675;4308.116836048603;4311.892202694895;4318.438602981592;4320.1143765527995;4302.720323178984;4345.587169218919;4370.147821174841;4390.209762242827;4399.098184872094;4961.875953101129;4977.1538838397555;4979.128652485801;4986.276989836453;5000.199968005175;5854.560907931837;5898.793542226002;5911.497522710618;5934.37689042653;5950.761969521171;1483.1175450606872;1517.6054225901346;1534.6163459135216;1539.5612250508552;1540.4069433268048;974.936629119105;1015.5277795824829;1041.416806588313;1051.8527406163143;1057.2282233969245;5559.471850174227;5770.451807078321;5775.595708300379;5783.566232532577;5786.218860453869;6075.848103797441;6146.385361463817;6147.66187859663;6151.630902145886;6159.3224745277985;5504.614676972574;5778.728679690461;5796;5802.796902108406;5811.593188476851;3224.613046434443;3230.725388342017;3247;3253.4957081652383;3267.754918381131;6162.414570615784;6225.937740622627;6261.405166509175;6273.18448601688;6324.3043265240785;6186.958303759749;6198.969005154945;6205.627662340274;6210.7515699372425;6224.284207316216;6317.9684101580115;6330.272018717907;6348.523860710465;6355.777547785805;6359.713812878432;5905.616134951214;6067.089936509382;6103.755849765959;6103.84740381494;6113.633182009094;5946.702664866826;5977.970110149421;6000.939990600038;6006.429389208019;6017.548683848641;6093.664848433379;6216.513394642179;6318.810435686937;6327;6357;4189.853355132555;4206.137741762993;4209.095044565433;4212.431321771522;4221.598948099926;6098.237720284965;6102.664353460602;6108.5723999319625;6117.755289788359;6148.077788331786;5837.94162058374;5856.677882716321;5877.23595932526;5895.322037965689;5952.523798096228;5842.649441033552;5856.765729370777;5864.208331875142;5885.352611212677;5925.970370148121;5412.945870541244;5612.102063669793;5805.448482394166;5812.94187058141;5837.241158649348;5939.881202375842;5949.8215053548465;5953;5954.612950158225;5957.404259574181;5842.737076831468;5850.2102216200265;5857.092150716646;5858.150568167677;5882.23530940975 10:25:57 INFO - PROCESS | 1114 | |5;yui.html;659.4691273524813;688.4526801193051;690.3165865792863;719.3633634233703;749.9400047996161;13814.723705525883;13858.514951976684;14022.298885055758;14138.787918181222;14157.929210353946;13000.869991300084;13177.670558236025;13209;13226.603201903934;13232.603021909334;675.9628220447873;794.4915254237293;811.1199348706646;822.6750433578733;822.7531740477863;822.4037572759761;830;830.1988581019315;830.3191383065888;830.393812516863;853.1937319233327;858.8625819868822;859.3168431097262;861.2335021830576;868.2966796894535;701.1446035836271;836.523181786382;860.7331727164599;865.0657290126679;865.5542395666237;628.2774808969675;629.9401556852092;630.1052505442283;630.1461519640912;630.1964994631835;13826.30868456573;13928.094673846168;13942.442302307896;13953.232572208524;13953.372098255602;13539.458421663121;13714.794278085838;13735.656608584766;13775.448982040707;13879.722405551933;11214.66356009321;11275.267107637977;11454.713632159179;11500.827487587692;11541.711457213552;3926.214757048573;3967.1867267210155;4050.696197785178;4131.277026520347;4136.296829538986;49520;49943.50056499425;50065.749671251775;51608.74195629035;54359.72820135874;10824.729381765519;10880.891191088147;10892.61875834342;11036.392998385167;11290;19730.70403943942;19822.20711171566;19960.50098747543;19980.60038799216;20606.072726727332;8060.879086813702;8134.06458257308;8201.71294004707;8221.342292616577;8306.377021723274;4123.463949686521;4123.690723195712;4129.15352352767;4600.5629465200755;4687.218856834381;3265.951010734841;3345.0466617014035;3346.029651401115;3346.3641908037393;3349.3301339731665;580.3789944759068;582.8950788858047;583.7985894866264;593.3858456497504;599.6282304970946;725.8548290341953;755.1919446192632;766.6326601360917;788.9979725748268;808.5350923219172;9022.954885225663;9081.68214112503;9387.812243755086;9492.288078394009;9601.951990240004;725.1407082607127;747.8466914282559;760.5968836516655;779.1468342165319;784.0982869699891;4189.287821070426;4345.86369204975;4352.608265256142;4361.5856493633055;4444.599986001275;57404.425955739905;57422.7128864353;57541.424585754445;57761.71119144378;58637;50206.748966254934;51995.74002129965;52368.73815630897;53435.732821335645;53731.731341343046;47772.522274777504;51161.48838511642;52112.739436302574;52423.21365179525;52933.20600191;8863.379563430755;8864.73405797827;9209.21721653667;9397.29520285995;9403.388779729295;26909.730902690724;27844.911631628114;28116.43767124687;28473.145805625863;28484.572731408633;39953;40112.1977560453;40710.389344159266;40938.590614093475;41216.38175427311;12630.539513450345;12891.41988610496;12999.805002925154;13087.41106650184;13153.276569788753;12218;12243.57147499869;12826.23042617446;13094.083414160918;13158.539451119164;12339.13626046168;12504.562340318045;12877.678058048623;13351.399187036412;13767;13044.478220871439;13101.213927164401;13204.405801738752;13322.733545329233;13382.397792099184;12428.254304741744;12594.24434533931;12715.93642031784;12912.741745164856;12934.676633083871;10457.529411176667;10581.100606448537;10659.25385223058;10690.786184276427;10869.695158398214;10959.890401096205;11314;11362.94318528402;11549.480273387886;11692.181547291608 10:25:57 INFO - PROCESS | 1114 | __end_tp_report 10:25:57 INFO - PROCESS | 1114 | __start_cc_report 10:25:57 INFO - PROCESS | 1114 | _x_x_mozilla_cycle_collect,1061 10:25:57 INFO - PROCESS | 1114 | __end_cc_report 10:25:57 INFO - PROCESS | 1114 | __startTimestamp1460827557661__endTimestamp 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | ------- Summary: start ------- 10:25:57 INFO - PROCESS | 1114 | Number of tests: 6 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | [#0] dojo.html Cycles:165 Average:5203.84 Median:5362.00 stddev:593.46 (11.1%) stddev-sans-first:569.41 10:25:57 INFO - PROCESS | 1114 | Values: 2994.6 3051.6 3081.4 3087.0 3113.1 5193.3 5198.6 5223.6 5243.5 5275.7 5206.3 5211.3 5221.7 5323.7 5325.9 4608.4 4651.7 4763.1 4804.0 4821.3 4766.0 4767.9 4802.8 4813.1 4861.2 4703.5 4709.7 4749.0 4756.0 4781.5 4732.2 4749.4 4755.6 4756.5 4790.4 4573.5 4666.3 4700.1 4729.9 4758.9 5106.2 5109.8 5111.9 5123.6 5135.6 5649.2 5655.1 5658.1 5683.1 5721.2 5668.6 5686.4 5692.3 5693.6 5697.0 5215.1 5262.9 5304.2 5315.8 5328.0 5745.4 5775.0 5777.1 5777.4 5782.8 5487.1 5526.1 5533.9 5547.9 5591.2 5557.2 5583.8 5622.3 5646.0 5672.1 5572.5 5593.7 5604.9 5608.7 5614.0 5585.3 5587.1 5603.1 5606.2 5614.6 4204.9 4245.2 4269.1 4300.1 4304.2 3777.5 3837.1 3839.3 3871.0 3871.2 5348.4 5363.4 5369.9 5377.1 5419.5 5568.2 5646.6 5664.1 5698.7 5699.3 5289.2 5346.9 5347.5 5349.0 5358.2 4777.5 4859.0 4863.8 4865.0 4887.8 5841.7 5843.1 5843.6 5877.9 5914.3 5640.6 5645.2 5646.0 5646.8 5647.0 5712.6 5767.0 5816.2 5831.2 5844.4 5440.5 5443.1 5454.6 5482.5 5482.9 5506.7 5511.3 5515.7 5521.9 5531.5 5387.7 5402.6 5447.6 5496.6 5576.4 5351.1 5355.0 5356.0 5369.8 5398.7 5240.9 5281.0 5283.9 5295.2 5330.8 5394.1 5435.5 5480.3 5583.2 5587.2 5337.6 5346.3 5353.6 5362.0 5397.3 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | [#1] ext.html Cycles:180 Average:49345.61 Median:38050.12 stddev:90362.78 (237.5%) stddev-sans-first:90542.15 10:25:57 INFO - PROCESS | 1114 | Values: 597.3 646.2 650.7 655.2 658.7 28434.6 29036.9 29040.6 29071.9 35316.1 39966.8 40747.6 40884.6 40891.0 40985.6 8449.9 8666.6 8670.5 8671.3 8673.1 8513.5 8634.6 8636.8 8638.7 8642.7 8630.9 8694.9 8695.9 8699.9 8913.8 8756.8 8847.9 8869.3 8874.2 8887.2 8741.6 8845.5 8861.7 8869.8 8869.8 39246.6 39553.4 39814.4 39889.8 39912.2 3504.6 3507.7 3523.9 3642.9 3730.2 29449.3 29699.9 29833.0 30064.0 30435.7 4150.2 4211.9 4258.9 4337.8 4357.5 243715.0 244694.0 245711.0 245973.8 247084.0 50211.0 50839.5 50971.5 51063.5 62898.4 56917.0 57945.4 58004.0 58105.8 58114.7 16719.8 16999.4 17004.8 17019.8 17022.8 9956.4 12508.7 12809.0 13102.3 13271.4 17686.4 17698.6 18139.2 18407.0 18573.5 6782.7 6905.2 6972.0 7063.7 7080.9 1007.1 1019.3 1067.3 1078.4 1148.3 27314.6 27634.7 27795.9 27821.3 27880.9 1135.8 1149.4 1157.8 1192.7 1250.3 15625.2 15917.8 15974.4 16024.4 16134.8 445716.0 448236.0 452153.0 453009.0 453284.9 55671.7 56218.7 56547.0 56584.4 56713.0 1262.2 1347.6 1372.0 1394.7 1423.5 28109.9 29086.4 29680.0 30185.7 30439.0 46543.8 47661.0 47673.0 47772.8 47777.8 292920.0 295981.0 298001.0 298615.0 299246.0 24572.5 27336.6 27570.3 27858.7 28124.9 41065.8 41813.4 42201.6 45269.0 45919.0 37408.8 37412.1 37777.2 37990.0 38375.0 36389.5 37647.2 38110.2 38195.0 38563.0 37794.2 38933.4 39124.8 39382.8 39522.4 32071.5 33752.5 33756.5 33988.3 34057.8 26405.9 26485.7 26741.7 26757.6 26941.3 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | [#2] jquery.html Cycles:180 Average:26989.04 Median:2419.52 stddev:77284.12 (3194.2%) stddev-sans-first:77475.07 10:25:57 INFO - PROCESS | 1114 | Values: 369.8 378.3 379.4 379.6 381.6 17701.6 17971.3 18288.8 18968.6 19149.0 11821.5 11967.0 12179.5 12185.4 12191.8 4438.8 5261.8 5292.9 5294.9 5299.9 5196.1 5251.7 5269.9 5279.8 5347.5 5208.9 5548.0 5548.6 5551.7 5556.2 5396.7 5412.5 5555.1 5765.7 5769.9 5571.4 5571.4 5577.9 5600.2 5603.3 13584.3 15502.7 20963.0 21878.1 22024.3 2095.8 2405.3 2411.2 2427.8 2483.8 9957.7 9999.5 10113.3 12975.7 13280.0 1863.4 1895.6 1957.2 2019.1 2057.8 73938.0 74146.0 78211.2 78316.0 78605.2 10500.6 10684.9 10930.7 10964.8 11195.8 15306.9 15364.7 15378.1 15417.8 15422.9 7825.0 8178.8 8184.1 8237.6 8366.3 7718.9 7831.8 7865.8 7923.7 8007.1 4626.5 4689.1 4708.0 4715.5 4772.9 1902.4 1939.4 1943.0 1962.0 1970.8 920.6 945.9 993.1 1035.2 1074.1 18030.6 18232.7 18383.8 18625.3 18977.5 988.4 1049.4 1068.1 1072.6 1105.3 10213.5 10449.8 10586.2 10658.7 10659.7 458833.0 460806.0 466187.0 475151.0 489051.0 62017.7 77739.6 82331.0 88347.0 88460.6 1044.7 1062.5 1093.9 1102.0 1103.5 15489.6 15496.4 15693.5 15757.6 15853.8 32181.8 32552.2 33342.0 33685.0 33992.0 47358.3 49748.3 49806.3 50115.2 50318.0 7959.8 8011.4 8040.6 8121.3 8180.1 8817.1 11144.9 12403.4 12819.0 12888.2 10790.6 11047.4 11074.9 11093.1 11434.1 10881.6 11032.9 11176.3 11460.3 11670.3 11359.4 11543.4 11758.1 11807.9 12192.2 8172.2 8422.2 8435.2 8608.7 8641.2 10877.4 11215.6 11587.2 11693.8 11741.5 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | [#3] mootools.html Cycles:180 Average:5577.93 Median:4932.54 stddev:3128.42 (63.4%) stddev-sans-first:3121.35 10:25:57 INFO - PROCESS | 1114 | Values: 1387.4 1403.1 1483.4 1601.9 1810.1 7429.9 8102.8 8313.1 8323.3 8326.1 8019.8 8150.9 8182.8 8192.8 8194.6 2018.3 2076.6 2076.7 2346.1 2377.1 2304.7 2372.4 2377.0 2378.3 2379.6 2315.0 2343.1 2351.5 2352.9 2366.4 2029.3 2220.3 2276.1 2286.5 2288.6 2391.2 2402.8 2413.2 2415.4 2415.9 8171.8 8226.5 8230.7 8237.9 8237.9 5026.6 5165.3 5167.6 5172.2 5174.5 3171.6 3251.1 3362.3 3370.8 3398.8 1061.5 1086.9 1120.8 1129.0 1135.7 11516.7 11563.4 11564.6 11582.9 11597.7 4406.7 4489.2 4659.8 4663.2 4670.3 9777.4 9793.8 9812.7 9828.1 9841.5 5247.6 5257.4 5264.0 5285.3 5286.6 4255.7 4640.8 4761.3 4827.3 4866.2 3910.2 3981.8 4026.0 4069.4 4086.6 1252.5 1273.0 1278.9 1279.8 1287.1 889.3 949.3 963.7 967.5 985.1 5312.1 5426.0 5582.0 5591.6 5606.0 893.3 896.5 950.2 957.9 960.0 3697.7 3770.2 3777.2 3802.2 3831.7 10153.1 10571.2 10600.7 10658.6 10668.3 10454.6 10510.9 10520.7 10533.0 10536.1 7467.0 7842.1 7975.1 8107.9 8108.3 5627.2 5630.5 5636.9 5652.9 5769.1 9600.4 9647.0 9647.2 9781.5 9880.1 9882.0 10030.7 10133.9 10136.6 10148.4 6688.0 7188.3 7398.4 7539.5 7675.7 8262.0 8289.5 8333.2 8350.9 8354.0 7328.7 7622.3 7633.8 7697.2 7731.8 7165.6 7454.1 7499.3 7575.6 7592.7 6549.1 6584.1 6605.5 6612.8 6613.6 4620.5 4762.3 4924.0 4941.0 4954.8 4802.6 4876.6 4879.9 4918.6 4977.9 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | [#4] prototype.html Cycles:180 Average:4954.35 Median:5566.39 stddev:1474.63 (26.5%) stddev-sans-first:1437.30 10:25:57 INFO - PROCESS | 1114 | Values: 328.1 328.4 330.5 343.2 343.7 5501.1 5507.4 5526.3 5526.8 5573.3 5462.5 5503.4 5514.3 5525.9 5526.7 4087.3 4155.9 4285.7 4304.4 4318.5 4244.6 4310.0 4315.1 4322.4 4326.9 4074.7 4274.3 4283.8 4294.0 4295.4 3953.1 4194.3 4274.6 4292.8 4293.9 3777.0 3788.9 3804.9 3808.1 3826.0 5279.6 5336.9 5349.2 5352.9 5355.8 4916.1 4939.1 4978.2 4991.1 5023.8 5775.2 5811.5 5860.1 5872.6 5901.6 4176.5 4258.7 4264.6 4268.5 4273.8 6105.6 6135.2 6149.7 6162.4 6166.9 4301.3 4308.1 4311.9 4318.4 4320.1 4302.7 4345.6 4370.1 4390.2 4399.1 4961.9 4977.2 4979.1 4986.3 5000.2 5854.6 5898.8 5911.5 5934.4 5950.8 1483.1 1517.6 1534.6 1539.6 1540.4 974.9 1015.5 1041.4 1051.9 1057.2 5559.5 5770.5 5775.6 5783.6 5786.2 6075.8 6146.4 6147.7 6151.6 6159.3 5504.6 5778.7 5796.0 5802.8 5811.6 3224.6 3230.7 3247.0 3253.5 3267.8 6162.4 6225.9 6261.4 6273.2 6324.3 6187.0 6199.0 6205.6 6210.8 6224.3 6318.0 6330.3 6348.5 6355.8 6359.7 5905.6 6067.1 6103.8 6103.8 6113.6 5946.7 5978.0 6000.9 6006.4 6017.5 6093.7 6216.5 6318.8 6327.0 6357.0 4189.9 4206.1 4209.1 4212.4 4221.6 6098.2 6102.7 6108.6 6117.8 6148.1 5837.9 5856.7 5877.2 5895.3 5952.5 5842.6 5856.8 5864.2 5885.4 5926.0 5412.9 5612.1 5805.4 5812.9 5837.2 5939.9 5949.8 5953.0 5954.6 5957.4 5842.7 5850.2 5857.1 5858.2 5882.2 10:25:57 INFO - PROCESS | 1114 | 10:25:57 INFO - PROCESS | 1114 | [#5] yui.html Cycles:180 Average:14285.54 Median:4130.22 stddev:16027.48 (388.1%) stddev-sans-first:16039.78 10:25:57 INFO - PROCESS | 1114 | Values: 659.5 688.5 690.3 719.4 749.9 13814.7 13858.5 14022.3 14138.8 14157.9 13000.9 13177.7 13209.0 13226.6 13232.6 676.0 794.5 811.1 822.7 822.8 822.4 830.0 830.2 830.3 830.4 853.2 858.9 859.3 861.2 868.3 701.1 836.5 860.7 865.1 865.6 628.3 629.9 630.1 630.1 630.2 13826.3 13928.1 13942.4 13953.2 13953.4 13539.5 13714.8 13735.7 13775.4 13879.7 11214.7 11275.3 11454.7 11500.8 11541.7 3926.2 3967.2 4050.7 4131.3 4136.3 49520.0 49943.5 50065.7 51608.7 54359.7 10824.7 10880.9 10892.6 11036.4 11290.0 19730.7 19822.2 19960.5 19980.6 20606.1 8060.9 8134.1 8201.7 8221.3 8306.4 4123.5 4123.7 4129.2 4600.6 4687.2 3266.0 3345.0 3346.0 3346.4 3349.3 580.4 582.9 583.8 593.4 599.6 725.9 755.2 766.6 789.0 808.5 9023.0 9081.7 9387.8 9492.3 9602.0 725.1 747.8 760.6 779.1 784.1 4189.3 4345.9 4352.6 4361.6 4444.6 57404.4 57422.7 57541.4 57761.7 58637.0 50206.7 51995.7 52368.7 53435.7 53731.7 47772.5 51161.5 52112.7 52423.2 52933.2 8863.4 8864.7 9209.2 9397.3 9403.4 26909.7 27844.9 28116.4 28473.1 28484.6 39953.0 40112.2 40710.4 40938.6 41216.4 12630.5 12891.4 12999.8 13087.4 13153.3 12218.0 12243.6 12826.2 13094.1 13158.5 12339.1 12504.6 12877.7 13351.4 13767.0 13044.5 13101.2 13204.4 13322.7 13382.4 12428.3 12594.2 12715.9 12912.7 12934.7 10457.5 10581.1 10659.3 10690.8 10869.7 10959.9 11314.0 11362.9 11549.5 11692.2 10:25:57 INFO - PROCESS | 1114 | -------- Summary: end -------- 10:25:57 INFO - PROCESS | 1114 | 10:25:58 INFO - TEST-INFO | 1114: exit 0 10:25:58 INFO - TEST-OK | dromaeo_css | took 1112446ms 10:25:58 INFO - TEST-START | kraken 10:25:58 INFO - operating with platform_type : linux_ 10:25:58 INFO - Initialising browser for kraken test... 10:25:58 INFO - TEST-INFO | started process 1366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOkfNt7/profile http://localhost:46878/getInfo.html) 10:26:02 INFO - PROCESS | 1366 | __metrics Screen width/height:1600/1200 10:26:02 INFO - PROCESS | 1366 | colorDepth:24 10:26:02 INFO - PROCESS | 1366 | Browser inner width/height: 1024/697 10:26:02 INFO - PROCESS | 1366 | __metrics 10:26:03 ERROR - PROCESS | 1366 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:26:04 INFO - TEST-INFO | 1366: exit 0 10:26:04 INFO - Browser initialized. 10:26:04 INFO - Running cycle 1/1 for kraken test... 10:26:04 INFO - TEST-INFO | started process 1450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOkfNt7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:26:16 INFO - PROCESS | 1450 | RSS: Main: 153329664 10:26:16 INFO - PROCESS | 1450 | 10:26:18 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46878/tests/kraken/driver.html?testName=audio-beat-detection) 10:26:19 INFO - PROCESS | 1450 | RSS: Main: 208293888 10:26:19 INFO - PROCESS | 1450 | 10:26:22 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46878/tests/kraken/driver.html?testName=audio-dft) 10:26:22 INFO - PROCESS | 1450 | RSS: Main: 194478080 10:26:22 INFO - PROCESS | 1450 | 10:26:26 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46878/tests/kraken/driver.html?testName=audio-fft) 10:26:26 INFO - PROCESS | 1450 | RSS: Main: 263622656 10:26:26 INFO - PROCESS | 1450 | 10:26:28 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46878/tests/kraken/driver.html?testName=audio-oscillator) 10:26:29 INFO - PROCESS | 1450 | RSS: Main: 172589056 10:26:29 INFO - PROCESS | 1450 | 10:26:31 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:26:32 INFO - PROCESS | 1450 | RSS: Main: 177410048 10:26:32 INFO - PROCESS | 1450 | 10:26:35 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46878/tests/kraken/driver.html?testName=imaging-darkroom) 10:26:35 INFO - PROCESS | 1450 | RSS: Main: 213835776 10:26:35 INFO - PROCESS | 1450 | 10:26:38 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46878/tests/kraken/driver.html?testName=imaging-desaturate) 10:26:39 INFO - PROCESS | 1450 | RSS: Main: 214212608 10:26:39 INFO - PROCESS | 1450 | 10:26:42 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46878/tests/kraken/driver.html?testName=json-parse-financial) 10:26:42 INFO - PROCESS | 1450 | RSS: Main: 214568960 10:26:42 INFO - PROCESS | 1450 | 10:26:44 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:45 INFO - PROCESS | 1450 | RSS: Main: 203993088 10:26:45 INFO - PROCESS | 1450 | 10:26:46 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:47 INFO - PROCESS | 1450 | RSS: Main: 203554816 10:26:47 INFO - PROCESS | 1450 | 10:26:49 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:50 INFO - PROCESS | 1450 | RSS: Main: 218308608 10:26:50 INFO - PROCESS | 1450 | 10:26:52 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:53 INFO - PROCESS | 1450 | RSS: Main: 222060544 10:26:53 INFO - PROCESS | 1450 | 10:26:56 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:56 INFO - PROCESS | 1450 | RSS: Main: 219389952 10:26:56 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | Cycle 1(1): loaded http://localhost:46878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46878/tests/kraken/driver.html?testName=ai-astar) 10:26:58 INFO - PROCESS | 1450 | RSS: Main: 282238976 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | __start_tp_report 10:26:58 INFO - PROCESS | 1450 | _x_x_mozilla_page_load 10:26:58 INFO - PROCESS | 1450 | _x_x_mozilla_page_load_details 10:26:58 INFO - PROCESS | 1450 | |i|pagename|runs| 10:26:58 INFO - PROCESS | 1450 | |0;ai-astar;111;112;107;111;111;112;101;111;112;111 10:26:58 INFO - PROCESS | 1450 | |1;audio-beat-detection;152;131;152;180;128;152;159;129;192;128 10:26:58 INFO - PROCESS | 1450 | |2;audio-dft;164;160;161;162;161;161;162;162;162;161 10:26:58 INFO - PROCESS | 1450 | |3;audio-fft;74;77;99;111;77;75;72;113;110;73 10:26:58 INFO - PROCESS | 1450 | |4;audio-oscillator;92;91;148;92;92;93;156;92;92;152 10:26:58 INFO - PROCESS | 1450 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;116;117;117 10:26:58 INFO - PROCESS | 1450 | |6;imaging-darkroom;145;146;146;148;146;146;146;147;145;146 10:26:58 INFO - PROCESS | 1450 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;94;95 10:26:58 INFO - PROCESS | 1450 | |8;json-parse-financial;59;58;57;57;60;57;60;75;56;56 10:26:58 INFO - PROCESS | 1450 | |9;json-stringify-tinderbox;60;61;61;61;61;60;60;60;60;60 10:26:58 INFO - PROCESS | 1450 | |10;stanford-crypto-aes;77;75;77;76;77;78;77;77;91;77 10:26:58 INFO - PROCESS | 1450 | |11;stanford-crypto-ccm;125;124;122;123;122;124;125;130;160;125 10:26:58 INFO - PROCESS | 1450 | |12;stanford-crypto-pbkdf2;168;163;163;165;163;161;162;164;161;161 10:26:58 INFO - PROCESS | 1450 | |13;stanford-crypto-sha256-iterative;69;67;69;74;67;69;68;66;67;68 10:26:58 INFO - PROCESS | 1450 | __end_tp_report 10:26:58 INFO - PROCESS | 1450 | __start_cc_report 10:26:58 INFO - PROCESS | 1450 | _x_x_mozilla_cycle_collect,1623 10:26:58 INFO - PROCESS | 1450 | __end_cc_report 10:26:58 INFO - PROCESS | 1450 | __startTimestamp1460827618665__endTimestamp 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | ------- Summary: start ------- 10:26:58 INFO - PROCESS | 1450 | Number of tests: 14 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.45 (3.1%) stddev-sans-first:3.63 10:26:58 INFO - PROCESS | 1450 | Values: 111.0 112.0 107.0 111.0 111.0 112.0 101.0 111.0 112.0 111.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:152.00 stddev:22.43 (14.8%) stddev-sans-first:23.78 10:26:58 INFO - PROCESS | 1450 | Values: 152.0 131.0 152.0 180.0 128.0 152.0 159.0 129.0 192.0 128.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:0.71 10:26:58 INFO - PROCESS | 1450 | Values: 164.0 160.0 161.0 162.0 161.0 161.0 162.0 162.0 162.0 161.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#3] audio-fft Cycles:10 Average:88.10 Median:74.50 stddev:17.79 (23.9%) stddev-sans-first:18.12 10:26:58 INFO - PROCESS | 1450 | Values: 74.0 77.0 99.0 111.0 77.0 75.0 72.0 113.0 110.0 73.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:29.05 (31.6%) stddev-sans-first:30.07 10:26:58 INFO - PROCESS | 1450 | Values: 92.0 91.0 148.0 92.0 92.0 93.0 156.0 92.0 92.0 152.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:26:58 INFO - PROCESS | 1450 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 10:26:58 INFO - PROCESS | 1450 | Values: 145.0 146.0 146.0 148.0 146.0 146.0 146.0 147.0 145.0 146.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:26:58 INFO - PROCESS | 1450 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.50 stddev:5.64 (9.6%) stddev-sans-first:5.98 10:26:58 INFO - PROCESS | 1450 | Values: 59.0 58.0 57.0 57.0 60.0 57.0 60.0 75.0 56.0 56.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 10:26:58 INFO - PROCESS | 1450 | Values: 60.0 61.0 61.0 61.0 61.0 60.0 60.0 60.0 60.0 60.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.00 stddev:4.57 (5.9%) stddev-sans-first:4.82 10:26:58 INFO - PROCESS | 1450 | Values: 77.0 75.0 77.0 76.0 77.0 78.0 77.0 77.0 91.0 77.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:125.00 stddev:11.47 (9.2%) stddev-sans-first:12.11 10:26:58 INFO - PROCESS | 1450 | Values: 125.0 124.0 122.0 123.0 122.0 124.0 125.0 130.0 160.0 125.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.00 stddev:2.18 (1.3%) stddev-sans-first:1.42 10:26:58 INFO - PROCESS | 1450 | Values: 168.0 163.0 163.0 165.0 163.0 161.0 162.0 164.0 161.0 161.0 10:26:58 INFO - PROCESS | 1450 | 10:26:58 INFO - PROCESS | 1450 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.22 (3.2%) stddev-sans-first:2.35 10:26:58 INFO - PROCESS | 1450 | Values: 69.0 67.0 69.0 74.0 67.0 69.0 68.0 66.0 67.0 68.0 10:26:58 INFO - PROCESS | 1450 | -------- Summary: end -------- 10:26:58 INFO - PROCESS | 1450 | 10:26:59 INFO - TEST-INFO | 1450: exit 0 10:26:59 INFO - TEST-OK | kraken | took 61255ms 10:26:59 INFO - SUITE-END | took 1173s 10:26:59 INFO - Completed test suite (00:19:33) 10:26:59 INFO - javascript benchmark 10:26:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2994.595729576507, 3051.61854768154, 3081.3837232553497, 3086.969130308696, 3113.0660801759473, 5193.272941788148, 5198.636095473323, 5223.608229382792, 5243.528082472577, 5275.709835959021, 5206.3231779868565, 5211.296474975878, 5221.738913054351, 5323.653962492445, 5325.893482130355, 4608.400907881971, 4651.674382793198, 4763.095011947719, 4804.0, 4821.325014497973, 4765.976170119162, 4767.90464190716, 4802.807887684506, 4813.133635945528, 4861.246506791453, 4703.529647035286, 4709.670323077386, 4749.026449577828, 4755.95244047562, 4781.5457531534275, 4732.219183834663, 4749.4063242094735, 4755.5719985201495, 4756.476787553366, 4790.377250957354, 4573.47405048417, 4666.300054991779, 4700.130475861976, 4729.858104256878, 4758.881027974294, 5106.234064890259, 5109.770060347256, 5111.897762044776, 5123.590112791005, 5135.563477104451, 5649.23735295734, 5655.095184770417, 5658.122990936411, 5683.090705487102, 5721.170430287627, 5668.631538949996, 5686.402927692574, 5692.288463942007, 5693.572982026365, 5696.971515142398, 5215.087359712035, 5262.8684282892855, 5304.230886521472, 5315.840524784263, 5328.014317351302, 5745.368009518949, 5775.047117225611, 5777.075667893117, 5777.364489906107, 5782.826515204551, 5487.149491828773, 5526.123719632367, 5533.889322213533, 5547.889042219133, 5591.189277554732, 5557.194206840067, 5583.832485025375, 5622.32532096151, 5645.971770141123, 5672.092465205547, 5572.5263352614675, 5593.664380137205, 5604.85987850307, 5608.747606357723, 5614.0, 5585.273914391103, 5587.078132108157, 5603.131514615241, 5606.243157173811, 5614.578906582023, 4204.873853784391, 4245.23585754561, 4269.1034882674985, 4300.053988122608, 4304.225239456928, 3777.527809023872, 3837.079101015792, 3839.30892439358, 3871.032241939515, 3871.245107204068, 5348.438413966477, 5363.356397232357, 5369.892602148013, 5377.139657654757, 5419.485148910847, 5568.248286481355, 5646.604737668324, 5664.122061080539, 5698.686572238566, 5699.344575373802, 5289.153735402394, 5346.866328341823, 5347.545458636059, 5349.037173308841, 5358.223057656696, 4777.546133117417, 4859.028194361142, 4863.805447782049, 4864.975675121602, 4887.780049897763, 5841.7371218295275, 5843.1235314703135, 5843.620164689281, 5877.882442351214, 5914.290285165722, 5640.605157638925, 5645.1532270159805, 5645.9717701412055, 5646.802361917313, 5647.0, 5712.6001179917, 5766.990776613992, 5816.21481100063, 5831.241938547962, 5844.444777746107, 5440.483154100354, 5443.074677304789, 5454.590905682169, 5482.533984611353, 5482.862928426662, 5506.697131657797, 5511.255980442749, 5515.7242137893745, 5521.861953451196, 5531.502164805187, 5387.730613469389, 5402.621816472966, 5447.645903016291, 5496.587755918402, 5576.414476479911, 5351.063563876228, 5355.036093503207, 5356.035913535445, 5369.838904832861, 5398.730063496888, 5240.921386179134, 5281.0, 5283.920741188962, 5295.205719142159, 5330.760115794721, 5394.1099718546, 5435.483629055233, 5480.314960629921, 5583.2462617547735, 5587.217789509391, 5337.599680023936, 5346.304980352529, 5353.625246232727, 5362.0, 5397.298351214317], "value": 5163.908256021837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.3071237364658, 646.1567654211254, 650.6909218121393, 655.2006552006557, 658.6969993802849, 28434.57348139777, 29036.854815725892, 29040.564391534117, 29071.854640726793, 35316.11709707252, 39966.8001659992, 40747.59252407475, 40884.59115408845, 40891.0, 40985.59014409855, 8449.873251901212, 8666.610002549869, 8670.52312122833, 8671.349648776335, 8673.13268673134, 8513.48919064855, 8634.568271586395, 8636.82726345476, 8638.740837774876, 8642.65429382824, 8630.87053694192, 8694.913050869505, 8695.869561956575, 8699.913000870005, 8913.821723565525, 8756.781080472976, 8847.867281990775, 8869.334799890003, 8874.156955089256, 8887.15572020657, 8741.606627701769, 8845.469271843709, 8861.689840855539, 8869.822603547957, 8869.822603547957, 39246.62636807727, 39553.40669889954, 39814.40278395826, 39889.80055099735, 39912.201755965005, 3504.5969713483023, 3507.7018453431488, 3523.894283171509, 3642.9453558196647, 3730.1607138393915, 29449.263768405748, 29699.851500742574, 29833.0, 30064.0, 30435.69564304351, 4150.211459822654, 4211.894702632428, 4258.914821703549, 4337.826486940518, 4357.520672725997, 243715.0, 244694.0, 245711.0, 245973.77013115, 247084.0, 50211.0, 50839.491605084215, 50971.49028509742, 51063.489365106616, 62898.37101629017, 56917.0, 57945.42054579485, 58004.0, 58105.8378832421, 58114.709426453446, 16719.83280167207, 16999.40502082421, 17004.829951700325, 17019.829801701824, 17022.82977170237, 9956.352837065568, 12508.74982500345, 12809.0, 13102.344882756015, 13271.402786874614, 17686.380976665754, 17698.557536061446, 18139.183736731615, 18407.0, 18573.535661608566, 6782.728690852409, 6905.170129915577, 6972.0, 7063.693216754917, 7080.858382832417, 1007.0885848307294, 1019.3374306700556, 1067.2795862792584, 1078.4362674122553, 1148.305275308443, 27314.5902811458, 27634.723652763216, 27795.86102069517, 27821.304467388072, 27880.860595697297, 1135.7728454309172, 1149.3908228638834, 1157.8263260510823, 1192.6605504587121, 1250.3185763758772, 15625.248272026594, 15917.840821591868, 15974.440894568634, 16024.439144629881, 16134.838651613569, 445716.0, 448236.0, 452153.0, 453009.0, 453284.93793089606, 55671.721641392345, 56218.71890640521, 56547.0, 56584.43415565874, 56713.0, 1262.1795832708628, 1347.5957212836306, 1371.9794203086963, 1394.7210557888463, 1423.5373503611368, 28109.859450702617, 29086.418271634873, 29680.0, 30185.69814301829, 30439.0, 46543.767281163375, 47661.0, 47673.04653906972, 47772.761136194094, 47777.761111195614, 292920.0, 295981.0, 298001.0, 298615.0, 299246.0, 24572.50854982926, 27336.589951150352, 27570.310742231606, 27858.721412785613, 28124.859375702992, 41065.79467102645, 41813.372799408644, 42201.577984219766, 45269.0, 45919.0, 37408.81295593613, 37412.06469838276, 37777.24445511129, 37990.0, 38375.0, 36389.452738309126, 37647.2470550582, 38110.237795244495, 38195.0, 38563.0, 37794.24411511699, 38933.41599876061, 39124.80437597794, 39382.803085984386, 39522.40716389314, 32071.518927215642, 33752.49371259482, 33756.49365259474, 33988.32023359568, 34057.829710851285, 26405.867970660023, 26485.735142648326, 26741.732582673925, 26757.598636020084, 26941.326466838487], "value": 18746.265053763633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.8335748912992, 378.33790865984525, 379.3853956590323, 379.5805634773575, 381.5897909747022, 17701.557461063465, 17971.28114875405, 18288.817111828877, 18968.620627587476, 19149.0, 11821.527138914455, 11967.0, 12179.45192466339, 12185.390730463485, 12191.817122743167, 4438.844640437577, 5261.789528418859, 5292.947070529303, 5294.92057619136, 5299.867503312409, 5196.0647083524955, 5251.684898906078, 5269.920951185716, 5279.815206467774, 5347.46525347466, 5208.947910520884, 5547.972260138694, 5548.6393384430085, 5551.666899986014, 5556.222128901957, 5396.703181325026, 5412.4587541245755, 5555.083411237121, 5765.682887441189, 5769.913451298234, 5571.415001424833, 5571.4428557144365, 5577.888442231173, 5600.159976003632, 5603.299587551556, 13584.252866092362, 15502.689946201126, 20963.0, 21878.12487500498, 22024.339269821932, 2095.758987716417, 2405.314485371678, 2411.216354684717, 2427.830051896368, 2483.8137139714595, 9957.651482198089, 9999.450030248334, 10113.342632728923, 12975.67560810978, 13280.0, 1863.3850829226324, 1895.649304878602, 1957.1584218785915, 2019.091408866016, 2057.8353731701427, 73938.0, 74146.0, 78211.21788782153, 78316.0, 78605.21394786036, 10500.579976800995, 10684.893151068545, 10930.726731831768, 10964.780704386027, 11195.832062519068, 15306.923465382602, 15364.692706145814, 15378.077315361114, 15417.845821541641, 15422.922885385502, 7824.960875195701, 8178.754637360888, 8184.099749027602, 8237.629306681214, 8366.330693544502, 7718.92281077182, 7831.84336313282, 7865.803354916058, 7923.722669706648, 8007.07918589358, 4626.537346265414, 4689.085628302517, 4707.976460117678, 4715.528447155326, 4772.904541909143, 1902.419761972584, 1939.4084804134593, 1942.98057019428, 1962.0, 1970.8029197080464, 920.5857364186143, 945.8581212818133, 993.1310103659298, 1035.249444152983, 1074.1138560687464, 18030.63938721218, 18232.726509102373, 18383.81616183821, 18625.254989800527, 18977.525561860788, 988.3970777825521, 1049.380865289483, 1068.1454836131063, 1072.5602502973743, 1105.2760441910561, 10213.540390682438, 10449.791004179873, 10586.153107751361, 10658.733531661615, 10659.733506662396, 458833.0, 460806.0, 466187.0, 475151.0, 489051.0, 62017.68991155015, 77739.61130194312, 82331.0, 88347.0, 88460.5576972111, 1044.6552637629563, 1062.516554967488, 1093.8796732359433, 1102.0467295789244, 1103.4923934989833, 15489.612759680647, 15496.380144794082, 15693.450729224422, 15757.606059848595, 15853.762193566876, 32181.839090804395, 32552.18619534436, 33342.0, 33685.0, 33992.0, 47358.28962565495, 49748.253776192665, 49806.25290620716, 50115.24827127523, 50318.0, 7959.84080318402, 8011.359091272568, 8040.557769322743, 8121.309688676529, 8180.0592931811225, 8817.118288171132, 11144.944275278573, 12403.441845117171, 12819.0, 12888.226706397647, 10790.56837726482, 11047.447627618427, 11074.944625276821, 11093.057090147428, 11434.085273178292, 10881.564737410416, 11032.944835275772, 11176.329420234812, 11460.255083419552, 11670.299782013106, 11359.432028398713, 11543.36511491876, 11758.11814113962, 11807.940960295144, 12192.207506512048, 8172.223638754309, 8422.24199822019, 8435.198656127657, 8608.698695545625, 8641.222289993932, 10877.401742904216, 11215.55137794479, 11587.246828956091, 11693.824592631288, 11741.530338786353], "value": 8745.903650625796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.3895485986172, 1403.0879928046768, 1483.421465628405, 1601.9199040048002, 1810.085906617159, 7429.925700742991, 8102.837943241132, 8313.127121652231, 8323.25090741833, 8326.12575679554, 8019.799505012363, 8150.877736833952, 8182.79543011425, 8192.83614327713, 8194.631241594128, 2018.3238615063972, 2076.615826072174, 2076.6677331626943, 2346.061575369853, 2377.120465427794, 2304.7234331880113, 2372.383180373107, 2376.95246095078, 2378.3340664613934, 2379.5597814404305, 2314.9884250578725, 2343.0744855781954, 2351.459164392191, 2352.9411764705847, 2366.4438856868624, 2029.3201777404588, 2220.2673117871063, 2276.123692378438, 2286.5198308355184, 2288.61093614086, 2391.210900402863, 2402.771736685012, 2413.2036427978724, 2415.384077060356, 2415.867127307997, 8171.836563268701, 8226.547539885303, 8230.670773169066, 8237.876431853527, 8237.917620823775, 5026.623003274769, 5165.251038599419, 5167.638265321429, 5172.2241663750365, 5174.456682048406, 3171.6035495563056, 3251.1059458648824, 3362.3107263011025, 3370.7808992415657, 3398.83005849709, 1061.5435362793996, 1086.8913708017856, 1120.78705046041, 1129.0290350298737, 1135.659302209342, 11516.654500365003, 11563.364014979088, 11564.595239166589, 11582.884171158265, 11597.6520704379, 4406.713563618355, 4489.19194544985, 4659.836905708284, 4663.160631086369, 4670.299455081697, 9777.364471309484, 9793.755156121155, 9812.656557020613, 9828.11546960777, 9841.50792460374, 5247.55395791362, 5257.395399529103, 5264.0, 5285.312909321764, 5286.603504737083, 4255.659547236213, 4640.791164397543, 4761.262004389325, 4827.324174615556, 4866.245731911559, 3910.2375036868107, 3981.8407263709705, 4026.0337518995816, 4069.369247766601, 4086.6117718816663, 1252.4551819958347, 1272.9872701273055, 1278.9360531973364, 1279.8417432223853, 1287.0990306785288, 889.2574700125467, 949.3449519831295, 963.677168148664, 967.5404183013012, 985.0887928665956, 5312.07038768214, 5425.972870135624, 5582.0, 5591.608587398843, 5606.0, 893.3300024981264, 896.4979611417627, 950.1638558068855, 957.9042095790504, 959.9904000960041, 3697.7226707997006, 3770.1517158639635, 3777.1690228149764, 3802.2205447883116, 3831.6934645228316, 10153.13698335635, 10571.154307655523, 10600.681979540626, 10658.62694805678, 10668.253222274521, 10454.63408780689, 10510.894891051144, 10520.684379468628, 10533.0, 10536.051755342056, 7467.0, 7842.058952925686, 7975.122736498981, 8107.918920810835, 8108.310793582612, 5627.155926611041, 5630.549556035426, 5636.915446268391, 5652.943470565242, 5769.105788602773, 9600.423974561549, 9646.951765241129, 9647.179989700953, 9781.462019588991, 9880.061394167542, 9881.974195290091, 10030.749231269278, 10133.898661013296, 10136.594536218468, 10148.441835699108, 6688.0, 7188.28117188277, 7398.408127349907, 7539.472236943361, 7675.654595543102, 8262.049864265686, 8289.502629842229, 8333.166683331618, 8350.916490835258, 8354.0, 7328.743493977899, 7622.31399174077, 7633.847323053619, 7697.153313135439, 7731.806704832424, 7165.570065796069, 7454.105507338937, 7499.2500749924575, 7575.583342916192, 7592.696292148252, 6549.148610680581, 6584.078229047841, 6605.5376123670885, 6612.80969425508, 6613.603183808987, 4620.54749504576, 4762.261849413347, 4924.03981223658, 4941.036497882878, 4954.77703503336, 4802.567768900815, 4876.634252431011, 4879.902401952012, 4918.631102667243, 4977.925331120108], "value": 4496.326717890036, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.08300799266044, 328.42197731991695, 330.50259359663704, 343.2311621966795, 343.7336064549972, 5501.14732216506, 5507.394186639466, 5526.281583394159, 5526.816907321606, 5573.303337082864, 5462.481064298885, 5503.449655034495, 5514.338279406476, 5525.944740552593, 5526.696031718264, 4087.3460246360587, 4155.940235240009, 4285.657147428198, 4304.397384366192, 4318.546552611978, 4244.556850670771, 4309.978450107745, 4315.136972605475, 4322.394864718942, 4326.949500602068, 4074.6740260779065, 4274.252005898971, 4283.764392958386, 4294.0, 4295.441592592959, 3953.110550126242, 4194.30793919003, 4274.5939135782055, 4292.785360731951, 4293.935590966138, 3776.9811150944342, 3788.9431658525145, 3804.885853424402, 3808.1241314497543, 3826.0, 5279.553701463792, 5336.893262134774, 5349.181278365336, 5352.91970620441, 5355.839324820223, 4916.139675556763, 4939.061578300148, 4978.153713868651, 4991.126552853236, 5023.799048038074, 5775.249217601727, 5811.506021988136, 5860.120981852713, 5872.647641141502, 5901.557383196277, 4176.4570605821045, 4258.723182993095, 4264.552222016706, 4268.530461649216, 4273.807678654468, 6105.633661980295, 6135.159452164333, 6149.723262453155, 6162.414570615784, 6166.9383306167265, 4301.268784306675, 4308.116836048603, 4311.892202694895, 4318.438602981592, 4320.1143765527995, 4302.720323178984, 4345.587169218919, 4370.147821174841, 4390.209762242827, 4399.098184872094, 4961.875953101129, 4977.1538838397555, 4979.128652485801, 4986.276989836453, 5000.199968005175, 5854.560907931837, 5898.793542226002, 5911.497522710618, 5934.37689042653, 5950.761969521171, 1483.1175450606872, 1517.6054225901346, 1534.6163459135216, 1539.5612250508552, 1540.4069433268048, 974.936629119105, 1015.5277795824829, 1041.416806588313, 1051.8527406163143, 1057.2282233969245, 5559.471850174227, 5770.451807078321, 5775.595708300379, 5783.566232532577, 5786.218860453869, 6075.848103797441, 6146.385361463817, 6147.66187859663, 6151.630902145886, 6159.3224745277985, 5504.614676972574, 5778.728679690461, 5796.0, 5802.796902108406, 5811.593188476851, 3224.613046434443, 3230.725388342017, 3247.0, 3253.4957081652383, 3267.754918381131, 6162.414570615784, 6225.937740622627, 6261.405166509175, 6273.18448601688, 6324.3043265240785, 6186.958303759749, 6198.969005154945, 6205.627662340274, 6210.7515699372425, 6224.284207316216, 6317.9684101580115, 6330.272018717907, 6348.523860710465, 6355.777547785805, 6359.713812878432, 5905.616134951214, 6067.089936509382, 6103.755849765959, 6103.84740381494, 6113.633182009094, 5946.702664866826, 5977.970110149421, 6000.939990600038, 6006.429389208019, 6017.548683848641, 6093.664848433379, 6216.513394642179, 6318.810435686937, 6327.0, 6357.0, 4189.853355132555, 4206.137741762993, 4209.095044565433, 4212.431321771522, 4221.598948099926, 6098.237720284965, 6102.664353460602, 6108.5723999319625, 6117.755289788359, 6148.077788331786, 5837.94162058374, 5856.677882716321, 5877.23595932526, 5895.322037965689, 5952.523798096228, 5842.649441033552, 5856.765729370777, 5864.208331875142, 5885.352611212677, 5925.970370148121, 5412.945870541244, 5612.102063669793, 5805.448482394166, 5812.94187058141, 5837.241158649348, 5939.881202375842, 5949.8215053548465, 5953.0, 5954.612950158225, 5957.404259574181, 5842.737076831468, 5850.2102216200265, 5857.092150716646, 5858.150568167677, 5882.23530940975], "value": 4483.033022295611, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.4691273524813, 688.4526801193051, 690.3165865792863, 719.3633634233703, 749.9400047996161, 13814.723705525883, 13858.514951976684, 14022.298885055758, 14138.787918181222, 14157.929210353946, 13000.869991300084, 13177.670558236025, 13209.0, 13226.603201903934, 13232.603021909334, 675.9628220447873, 794.4915254237293, 811.1199348706646, 822.6750433578733, 822.7531740477863, 822.4037572759761, 830.0, 830.1988581019315, 830.3191383065888, 830.393812516863, 853.1937319233327, 858.8625819868822, 859.3168431097262, 861.2335021830576, 868.2966796894535, 701.1446035836271, 836.523181786382, 860.7331727164599, 865.0657290126679, 865.5542395666237, 628.2774808969675, 629.9401556852092, 630.1052505442283, 630.1461519640912, 630.1964994631835, 13826.30868456573, 13928.094673846168, 13942.442302307896, 13953.232572208524, 13953.372098255602, 13539.458421663121, 13714.794278085838, 13735.656608584766, 13775.448982040707, 13879.722405551933, 11214.66356009321, 11275.267107637977, 11454.713632159179, 11500.827487587692, 11541.711457213552, 3926.214757048573, 3967.1867267210155, 4050.696197785178, 4131.277026520347, 4136.296829538986, 49520.0, 49943.50056499425, 50065.749671251775, 51608.74195629035, 54359.72820135874, 10824.729381765519, 10880.891191088147, 10892.61875834342, 11036.392998385167, 11290.0, 19730.70403943942, 19822.20711171566, 19960.50098747543, 19980.60038799216, 20606.072726727332, 8060.879086813702, 8134.06458257308, 8201.71294004707, 8221.342292616577, 8306.377021723274, 4123.463949686521, 4123.690723195712, 4129.15352352767, 4600.5629465200755, 4687.218856834381, 3265.951010734841, 3345.0466617014035, 3346.029651401115, 3346.3641908037393, 3349.3301339731665, 580.3789944759068, 582.8950788858047, 583.7985894866264, 593.3858456497504, 599.6282304970946, 725.8548290341953, 755.1919446192632, 766.6326601360917, 788.9979725748268, 808.5350923219172, 9022.954885225663, 9081.68214112503, 9387.812243755086, 9492.288078394009, 9601.951990240004, 725.1407082607127, 747.8466914282559, 760.5968836516655, 779.1468342165319, 784.0982869699891, 4189.287821070426, 4345.86369204975, 4352.608265256142, 4361.5856493633055, 4444.599986001275, 57404.425955739905, 57422.7128864353, 57541.424585754445, 57761.71119144378, 58637.0, 50206.748966254934, 51995.74002129965, 52368.73815630897, 53435.732821335645, 53731.731341343046, 47772.522274777504, 51161.48838511642, 52112.739436302574, 52423.21365179525, 52933.20600191, 8863.379563430755, 8864.73405797827, 9209.21721653667, 9397.29520285995, 9403.388779729295, 26909.730902690724, 27844.911631628114, 28116.43767124687, 28473.145805625863, 28484.572731408633, 39953.0, 40112.1977560453, 40710.389344159266, 40938.590614093475, 41216.38175427311, 12630.539513450345, 12891.41988610496, 12999.805002925154, 13087.41106650184, 13153.276569788753, 12218.0, 12243.57147499869, 12826.23042617446, 13094.083414160918, 13158.539451119164, 12339.13626046168, 12504.562340318045, 12877.678058048623, 13351.399187036412, 13767.0, 13044.478220871439, 13101.213927164401, 13204.405801738752, 13322.733545329233, 13382.397792099184, 12428.254304741744, 12594.24434533931, 12715.93642031784, 12912.741745164856, 12934.676633083871, 10457.529411176667, 10581.100606448537, 10659.25385223058, 10690.786184276427, 10869.695158398214, 10959.890401096205, 11314.0, 11362.94318528402, 11549.480273387886, 11692.181547291608], "value": 6655.610136121389, "unit": "score"}], "name": "dromaeo_css", "value": 6959.202463019416, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 107.0, 111.0, 111.0, 112.0, 101.0, 111.0, 112.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 152.0, 180.0, 128.0, 152.0, 159.0, 129.0, 192.0, 128.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 99.0, 111.0, 77.0, 75.0, 72.0, 113.0, 110.0, 73.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 148.0, 92.0, 92.0, 93.0, 156.0, 92.0, 92.0, 152.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 57.0, 57.0, 60.0, 57.0, 60.0, 75.0, 56.0, 56.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 76.0, 77.0, 78.0, 77.0, 77.0, 91.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 122.0, 123.0, 122.0, 124.0, 125.0, 130.0, 160.0, 125.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 163.0, 165.0, 163.0, 161.0, 162.0, 164.0, 161.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 74.0, 67.0, 69.0, 68.0, 66.0, 67.0, 68.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1535.0000000000002, "alertThreshold": 2.0}]} 10:26:59 INFO - Return code: 0 10:26:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:26:59 ERROR - # TBPL SUCCESS # 10:26:59 INFO - Running post-action listener: _resource_record_post_action 10:26:59 INFO - Running post-run listener: _resource_record_post_run 10:27:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534290432; Read time: 16; Write time: 532056 10:27:01 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 250617856; Read time: 0; Write time: 298532 10:27:01 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283672576; Read time: 16; Write time: 233524 10:27:01 INFO - Running post-run listener: _upload_blobber_files 10:27:01 INFO - Blob upload gear active. 10:27:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27: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 10:27: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:01 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:02 INFO - (blobuploader) - INFO - Done attempting. 10:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:27:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:27:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:27:03 INFO - (blobuploader) - INFO - Done attempting. 10:27:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:27:03 INFO - Return code: 0 10:27:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:27:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:27:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99554b89e62c67447723f0ff7c76934f8359c0d9a2cb90b20930b9848f68255eb49c92537b08d2d74b87787edd92cbbc5fbcd62361deea17311a55302ebe928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc563685495ad6ff0baa470b446b05b53e8d12792fa784e0674b5b2d0b289c3841e11bdb7dd4bb5677639c2e57530c9429890f7e646463b7e0ebca241831ed3"} 10:27:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:27:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:27:03 INFO - Contents: 10:27:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99554b89e62c67447723f0ff7c76934f8359c0d9a2cb90b20930b9848f68255eb49c92537b08d2d74b87787edd92cbbc5fbcd62361deea17311a55302ebe928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc563685495ad6ff0baa470b446b05b53e8d12792fa784e0674b5b2d0b289c3841e11bdb7dd4bb5677639c2e57530c9429890f7e646463b7e0ebca241831ed3"} 10:27:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:27:03 INFO - Copying logs to upload dir... 10:27:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:27:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.143931 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-16 10:27:02.557251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:02.560531) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99554b89e62c67447723f0ff7c76934f8359c0d9a2cb90b20930b9848f68255eb49c92537b08d2d74b87787edd92cbbc5fbcd62361deea17311a55302ebe928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc563685495ad6ff0baa470b446b05b53e8d12792fa784e0674b5b2d0b289c3841e11bdb7dd4bb5677639c2e57530c9429890f7e646463b7e0ebca241831ed3"} build_url:https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/WNP-MGkpSxKpdv_p6thtfw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f99554b89e62c67447723f0ff7c76934f8359c0d9a2cb90b20930b9848f68255eb49c92537b08d2d74b87787edd92cbbc5fbcd62361deea17311a55302ebe928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afc563685495ad6ff0baa470b446b05b53e8d12792fa784e0674b5b2d0b289c3841e11bdb7dd4bb5677639c2e57530c9429890f7e646463b7e0ebca241831ed3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:02.585157) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:02.585476) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1460826212.824616-567955587 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-16 10:27:02.671695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:27:02.672293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-16 10:27:02.672766) ========= ========= Total master_lag: 0.21 =========