builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1462500190.16 results: success (0) buildid: 20160505125249 builduid: a3dd1cc9a3854de78713575edee1a4e7 revision: 609000bcc11211d7c27ceea36fa2d2262fa0523f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.164286) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.164797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.165138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.180022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.180728) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 19:03:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.2M=0s 2016-05-05 19:03:10 (68.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117794 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.313498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.313813) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:10.363426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 19:03:10.363828) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 609000bcc11211d7c27ceea36fa2d2262fa0523f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 609000bcc11211d7c27ceea36fa2d2262fa0523f --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=5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 19:03:10,713 truncating revision to first 12 chars 2016-05-05 19:03:10,713 Setting DEBUG logging. 2016-05-05 19:03:10,713 attempt 1/10 2016-05-05 19:03:10,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/609000bcc112?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 19:03:11,469 unpacking tar archive at: mozilla-beta-609000bcc112/testing/mozharness/ program finished with exit code 0 elapsedTime=1.045281 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 19:03:11.423292) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:11.423712) ========= script_repo_revision: 609000bcc11211d7c27ceea36fa2d2262fa0523f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:11.424162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:11.424472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 19:03:11.435163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-05 19:03:11.435546) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:03:11 INFO - MultiFileLogger online at 20160505 19:03:11 in /builds/slave/test 19:03:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:03:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:03:11 INFO - {'append_to_log': False, 19:03:11 INFO - 'base_work_dir': '/builds/slave/test', 19:03:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:03:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:03:11 INFO - 'branch': 'Mozilla-Beta', 19:03:11 INFO - 'buildbot_json_path': 'buildprops.json', 19:03:11 INFO - 'config_files': ('talos/linux_config.py',), 19:03:11 INFO - 'default_actions': ('clobber', 19:03:11 INFO - 'read-buildbot-config', 19:03:11 INFO - 'download-and-extract', 19:03:11 INFO - 'populate-webroot', 19:03:11 INFO - 'create-virtualenv', 19:03:11 INFO - 'install', 19:03:11 INFO - 'run-tests'), 19:03:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:03:11 INFO - 'download_minidump_stackwalk': True, 19:03:11 INFO - 'download_symbols': 'ondemand', 19:03:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:03:11 INFO - 'tooltool.py': '/tools/tooltool.py', 19:03:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:03:11 INFO - '/tools/misc-python/virtualenv.py')}, 19:03:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:03:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:03:11 INFO - 'installer_path': 'installer.exe', 19:03:11 INFO - 'log_level': 'info', 19:03:11 INFO - 'log_name': 'talos', 19:03:11 INFO - 'log_to_console': True, 19:03:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:03:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:03:11 INFO - 'opt_config_files': (), 19:03:11 INFO - 'pip_index': False, 19:03:11 INFO - 'sps_profile': False, 19:03:11 INFO - 'sps_profile_interval': 0, 19:03:11 INFO - 'suite': 'dromaeojs', 19:03:11 INFO - 'system_bits': '32', 19:03:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:03:11 INFO - 'title': 'talos-linux64-ix-051', 19:03:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:03:11 INFO - 'use_talos_json': True, 19:03:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:03:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:03:11 INFO - 'work_dir': 'build'} 19:03:11 INFO - ##### 19:03:11 INFO - ##### Running clobber step. 19:03:11 INFO - ##### 19:03:11 INFO - Running pre-action listener: _resource_record_pre_action 19:03:11 INFO - Running main action method: clobber 19:03:11 INFO - rmtree: /builds/slave/test/build 19:03:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:03:12 INFO - Running post-action listener: _resource_record_post_action 19:03:12 INFO - ##### 19:03:12 INFO - ##### Running read-buildbot-config step. 19:03:12 INFO - ##### 19:03:12 INFO - Running pre-action listener: _resource_record_pre_action 19:03:12 INFO - Running main action method: read_buildbot_config 19:03:12 INFO - Using buildbot properties: 19:03:12 INFO - { 19:03:12 INFO - "project": "", 19:03:12 INFO - "product": "firefox", 19:03:12 INFO - "script_repo_revision": "production", 19:03:12 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 19:03:12 INFO - "repository": "", 19:03:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 19:03:12 INFO - "buildid": "20160505125249", 19:03:12 INFO - "pgo_build": "True", 19:03:12 INFO - "basedir": "/builds/slave/test", 19:03:12 INFO - "buildnumber": 8, 19:03:12 INFO - "slavename": "talos-linux64-ix-051", 19:03:12 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:03:12 INFO - "platform": "ubuntu64_hw", 19:03:12 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:03:12 INFO - "branch": "mozilla-beta", 19:03:12 INFO - "repo_path": "releases/mozilla-beta", 19:03:12 INFO - "revision": "609000bcc11211d7c27ceea36fa2d2262fa0523f", 19:03:12 INFO - "stage_platform": "linux64-pgo", 19:03:12 INFO - "builduid": "a3dd1cc9a3854de78713575edee1a4e7", 19:03:12 INFO - "slavebuilddir": "test" 19:03:12 INFO - } 19:03:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 19:03:12 INFO - Running post-action listener: _resource_record_post_action 19:03:12 INFO - ##### 19:03:12 INFO - ##### Running download-and-extract step. 19:03:12 INFO - ##### 19:03:12 INFO - Running pre-action listener: _resource_record_pre_action 19:03:12 INFO - Running main action method: download_and_extract 19:03:12 INFO - mkdir: /builds/slave/test/build/tests 19:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:12 INFO - https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:03:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:03:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:03:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:03:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:03:17 INFO - Downloaded 1412 bytes. 19:03:17 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:03:17 INFO - Using the following test package requirements: 19:03:17 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:03:17 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:03:17 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 19:03:17 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'jsshell-linux-x86_64.zip'], 19:03:17 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:03:17 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:03:17 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 19:03:17 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 19:03:17 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:03:17 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:03:17 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:03:17 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:03:17 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:17 INFO - https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:03:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:03:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:03:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:03:23 INFO - Downloaded 23365308 bytes. 19:03:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:03:24 INFO - Return code: 0 19:03:24 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:03: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')]} 19:03:24 INFO - https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:03:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:03:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:03:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:03:34 INFO - Downloaded 23365308 bytes. 19:03:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:03:36 INFO - Return code: 0 19:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:36 INFO - https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:03:37 INFO - Downloaded 10845194 bytes. 19:03:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:03:37 INFO - Return code: 0 19:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:37 INFO - https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:03:38 INFO - Downloaded 53795386 bytes. 19:03:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:03:38 INFO - mkdir: /builds/slave/test/properties 19:03:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:03:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:03:38 INFO - Contents: 19:03:38 INFO - build_url:https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:03:39 INFO - Running post-action listener: _resource_record_post_action 19:03:39 INFO - Running post-action listener: set_extra_try_arguments 19:03:39 INFO - ##### 19:03:39 INFO - ##### Running populate-webroot step. 19:03:39 INFO - ##### 19:03:39 INFO - Running pre-action listener: _resource_record_pre_action 19:03:39 INFO - Running main action method: populate_webroot 19:03:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:03:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:03:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:03:39 INFO - '--tppagecycles', 19:03:39 INFO - '7'], 19:03:39 INFO - 'tests': ['tsvgm']}}, 19:03:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:03:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:03:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:03:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:03:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'tests': ['damp', 'tps']}, 19:03:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['damp', 'tps']}, 19:03:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:03:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:03:39 INFO - 'other': {'tests': ['a11yr', 19:03:39 INFO - 'ts_paint', 19:03:39 INFO - 'tpaint', 19:03:39 INFO - 'sessionrestore', 19:03:39 INFO - 'sessionrestore_no_auto_restore', 19:03:39 INFO - 'tabpaint']}, 19:03:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['a11yr', 19:03:39 INFO - 'ts_paint', 19:03:39 INFO - 'tpaint', 19:03:39 INFO - 'sessionrestore', 19:03:39 INFO - 'sessionrestore_no_auto_restore', 19:03:39 INFO - 'tabpaint']}, 19:03:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['a11yr', 19:03:39 INFO - 'ts_paint', 19:03:39 INFO - 'tpaint', 19:03:39 INFO - 'sessionrestore', 19:03:39 INFO - 'sessionrestore_no_auto_restore', 19:03:39 INFO - 'tabpaint']}, 19:03:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['a11yr', 19:03:39 INFO - 'ts_paint', 19:03:39 INFO - 'tpaint', 19:03:39 INFO - 'sessionrestore', 19:03:39 INFO - 'sessionrestore_no_auto_restore', 19:03:39 INFO - 'tabpaint']}, 19:03:39 INFO - 'other_l64': {'tests': ['a11yr', 19:03:39 INFO - 'ts_paint', 19:03:39 INFO - 'tpaint', 19:03:39 INFO - 'sessionrestore', 19:03:39 INFO - 'sessionrestore_no_auto_restore', 19:03:39 INFO - 'tabpaint']}, 19:03:39 INFO - 'other_nol64': {'tests': ['a11yr', 19:03:39 INFO - 'ts_paint', 19:03:39 INFO - 'tpaint', 19:03:39 INFO - 'sessionrestore', 19:03:39 INFO - 'sessionrestore_no_auto_restore', 19:03:39 INFO - 'tabpaint']}, 19:03:39 INFO - 'svgr': {'tests': ['tsvgx', 19:03:39 INFO - 'tsvgr_opacity', 19:03:39 INFO - 'tart', 19:03:39 INFO - 'tscrollx', 19:03:39 INFO - 'cart']}, 19:03:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['tsvgx', 19:03:39 INFO - 'tsvgr_opacity', 19:03:39 INFO - 'tart', 19:03:39 INFO - 'tscrollx', 19:03:39 INFO - 'cart']}, 19:03:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'tests': ['tp5o']}, 19:03:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'talos_options': ['--e10s'], 19:03:39 INFO - 'tests': ['tp5o']}, 19:03:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'talos_options': ['--xperf_path', 19:03:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:39 INFO - 'tests': ['tp5n']}, 19:03:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:39 INFO - 'talos_options': ['--e10s', 19:03:39 INFO - '--xperf_path', 19:03:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:39 INFO - 'tests': ['tp5n']}}, 19:03:39 INFO - 'talos.zip': {'path': '', 19:03:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:03:39 INFO - Running post-action listener: _resource_record_post_action 19:03:39 INFO - ##### 19:03:39 INFO - ##### Running create-virtualenv step. 19:03:39 INFO - ##### 19:03:39 INFO - Running pre-action listener: _resource_record_pre_action 19:03:39 INFO - Running main action method: create_virtualenv 19:03:39 INFO - Creating virtualenv /builds/slave/test/build/venv 19:03:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:03:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:03:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:03:39 INFO - Using real prefix '/usr' 19:03:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:03:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:03:42 INFO - Installing pip.................done. 19:03:42 INFO - Return code: 0 19:03:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:42 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:03:42 INFO - Using env: {'DISPLAY': ':0', 19:03:42 INFO - 'HOME': '/home/cltbld', 19:03:42 INFO - 'LANG': 'en_US.UTF-8', 19:03:42 INFO - 'LANGUAGE': 'en_US:en', 19:03:42 INFO - 'LOGNAME': 'cltbld', 19:03:42 INFO - 'MAIL': '/var/mail/cltbld', 19:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:42 INFO - 'MOZ_NO_REMOTE': '1', 19:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:42 INFO - 'NO_EM_RESTART': '1', 19:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:42 INFO - 'PWD': '/builds/slave/test', 19:03:42 INFO - 'SHELL': '/bin/bash', 19:03:42 INFO - 'SHLVL': '1', 19:03:42 INFO - 'TERM': 'linux', 19:03:42 INFO - 'TMOUT': '86400', 19:03:42 INFO - 'USER': 'cltbld', 19:03:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:42 INFO - '_': '/tools/buildbot/bin/python'} 19:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:03:42 INFO - Cleaning up... 19:03:42 INFO - Return code: 0 19:03:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:42 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:42 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 19:03:42 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 19:03:42 INFO - Using env: {'DISPLAY': ':0', 19:03:42 INFO - 'HOME': '/home/cltbld', 19:03:42 INFO - 'LANG': 'en_US.UTF-8', 19:03:42 INFO - 'LANGUAGE': 'en_US:en', 19:03:42 INFO - 'LOGNAME': 'cltbld', 19:03:42 INFO - 'MAIL': '/var/mail/cltbld', 19:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:42 INFO - 'MOZ_NO_REMOTE': '1', 19:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:42 INFO - 'NO_EM_RESTART': '1', 19:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:42 INFO - 'PWD': '/builds/slave/test', 19:03:42 INFO - 'SHELL': '/bin/bash', 19:03:42 INFO - 'SHLVL': '1', 19:03:42 INFO - 'TERM': 'linux', 19:03:42 INFO - 'TMOUT': '86400', 19:03:42 INFO - 'USER': 'cltbld', 19:03:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:42 INFO - '_': '/tools/buildbot/bin/python'} 19:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:42 INFO - Downloading/unpacking psutil>=0.7.1 19:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:03:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:44 INFO - Installing collected packages: psutil 19:03:44 INFO - Running setup.py install for psutil 19:03:44 INFO - building 'psutil._psutil_linux' extension 19:03:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:03:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:03:45 INFO - building 'psutil._psutil_posix' extension 19:03:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:03:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:03:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:45 INFO - Successfully installed psutil 19:03:45 INFO - Cleaning up... 19:03:45 INFO - Return code: 0 19:03:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:03:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:03:45 INFO - Using env: {'DISPLAY': ':0', 19:03:45 INFO - 'HOME': '/home/cltbld', 19:03:45 INFO - 'LANG': 'en_US.UTF-8', 19:03:45 INFO - 'LANGUAGE': 'en_US:en', 19:03:45 INFO - 'LOGNAME': 'cltbld', 19:03:45 INFO - 'MAIL': '/var/mail/cltbld', 19:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:45 INFO - 'MOZ_NO_REMOTE': '1', 19:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:45 INFO - 'NO_EM_RESTART': '1', 19:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:45 INFO - 'PWD': '/builds/slave/test', 19:03:45 INFO - 'SHELL': '/bin/bash', 19:03:45 INFO - 'SHLVL': '1', 19:03:45 INFO - 'TERM': 'linux', 19:03:45 INFO - 'TMOUT': '86400', 19:03:45 INFO - 'USER': 'cltbld', 19:03:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:45 INFO - '_': '/tools/buildbot/bin/python'} 19:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:03:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:03:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:03:47 INFO - Installing collected packages: mozsystemmonitor 19:03:47 INFO - Running setup.py install for mozsystemmonitor 19:03:47 INFO - Successfully installed mozsystemmonitor 19:03:47 INFO - Cleaning up... 19:03:47 INFO - Return code: 0 19:03:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:47 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:03:47 INFO - Using env: {'DISPLAY': ':0', 19:03:47 INFO - 'HOME': '/home/cltbld', 19:03:47 INFO - 'LANG': 'en_US.UTF-8', 19:03:47 INFO - 'LANGUAGE': 'en_US:en', 19:03:47 INFO - 'LOGNAME': 'cltbld', 19:03:47 INFO - 'MAIL': '/var/mail/cltbld', 19:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:47 INFO - 'MOZ_NO_REMOTE': '1', 19:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:47 INFO - 'NO_EM_RESTART': '1', 19:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:47 INFO - 'PWD': '/builds/slave/test', 19:03:47 INFO - 'SHELL': '/bin/bash', 19:03:47 INFO - 'SHLVL': '1', 19:03:47 INFO - 'TERM': 'linux', 19:03:47 INFO - 'TMOUT': '86400', 19:03:47 INFO - 'USER': 'cltbld', 19:03:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:47 INFO - '_': '/tools/buildbot/bin/python'} 19:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 19:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:50 INFO - Downloading docopt-0.6.1.tar.gz 19:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:03:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:03:50 INFO - Running setup.py install for blobuploader 19:03:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:03:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:03:50 INFO - Running setup.py install for requests 19:03:50 INFO - Running setup.py install for docopt 19:03:51 INFO - Successfully installed blobuploader requests docopt 19:03:51 INFO - Cleaning up... 19:03:51 INFO - Return code: 0 19:03:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:51 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:51 INFO - Using env: {'DISPLAY': ':0', 19:03:51 INFO - 'HOME': '/home/cltbld', 19:03:51 INFO - 'LANG': 'en_US.UTF-8', 19:03:51 INFO - 'LANGUAGE': 'en_US:en', 19:03:51 INFO - 'LOGNAME': 'cltbld', 19:03:51 INFO - 'MAIL': '/var/mail/cltbld', 19:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:51 INFO - 'MOZ_NO_REMOTE': '1', 19:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:51 INFO - 'NO_EM_RESTART': '1', 19:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:51 INFO - 'PWD': '/builds/slave/test', 19:03:51 INFO - 'SHELL': '/bin/bash', 19:03:51 INFO - 'SHLVL': '1', 19:03:51 INFO - 'TERM': 'linux', 19:03:51 INFO - 'TMOUT': '86400', 19:03:51 INFO - 'USER': 'cltbld', 19:03:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:51 INFO - '_': '/tools/buildbot/bin/python'} 19:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:51 INFO - Running setup.py (path:/tmp/pip-hdZ1as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:51 INFO - Running setup.py (path:/tmp/pip-zFht7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:51 INFO - Running setup.py (path:/tmp/pip-TbnUXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:51 INFO - Running setup.py (path:/tmp/pip-HiS_aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:51 INFO - Running setup.py (path:/tmp/pip-BkWRRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:51 INFO - Running setup.py (path:/tmp/pip-GwQrii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:51 INFO - Running setup.py (path:/tmp/pip-AmLt6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:51 INFO - Running setup.py (path:/tmp/pip-20DJ3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:51 INFO - Running setup.py (path:/tmp/pip-lFDFX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:51 INFO - Running setup.py (path:/tmp/pip-J8XTaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:52 INFO - Running setup.py (path:/tmp/pip-ud243T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:52 INFO - Running setup.py (path:/tmp/pip-9OObaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:52 INFO - Running setup.py (path:/tmp/pip-BKMGqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:52 INFO - Running setup.py (path:/tmp/pip-G2cUvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:52 INFO - Running setup.py (path:/tmp/pip-hEsj4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:52 INFO - Running setup.py (path:/tmp/pip-tKtBrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:52 INFO - Running setup.py (path:/tmp/pip-DrxKuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:03:52 INFO - Running setup.py install for manifestparser 19:03:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:03:52 INFO - Running setup.py install for mozcrash 19:03:52 INFO - Running setup.py install for mozdebug 19:03:52 INFO - Running setup.py install for mozdevice 19:03:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:03:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozfile 19:03:53 INFO - Running setup.py install for mozhttpd 19:03:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozinfo 19:03:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozInstall 19:03:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozleak 19:03:53 INFO - Running setup.py install for mozlog 19:03:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for moznetwork 19:03:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozprocess 19:03:53 INFO - Running setup.py install for mozprofile 19:03:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:03:53 INFO - Running setup.py install for mozrunner 19:03:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Running setup.py install for mozscreenshot 19:03:54 INFO - Running setup.py install for moztest 19:03:54 INFO - Running setup.py install for mozversion 19:03:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:03:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:03:54 INFO - Cleaning up... 19:03:54 INFO - Return code: 0 19:03:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03: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')]} 19:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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')]} 19:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:54 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:54 INFO - Using env: {'DISPLAY': ':0', 19:03:54 INFO - 'HOME': '/home/cltbld', 19:03:54 INFO - 'LANG': 'en_US.UTF-8', 19:03:54 INFO - 'LANGUAGE': 'en_US:en', 19:03:54 INFO - 'LOGNAME': 'cltbld', 19:03:54 INFO - 'MAIL': '/var/mail/cltbld', 19:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:54 INFO - 'MOZ_NO_REMOTE': '1', 19:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:54 INFO - 'NO_EM_RESTART': '1', 19:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:54 INFO - 'PWD': '/builds/slave/test', 19:03:54 INFO - 'SHELL': '/bin/bash', 19:03:54 INFO - 'SHLVL': '1', 19:03:54 INFO - 'TERM': 'linux', 19:03:54 INFO - 'TMOUT': '86400', 19:03:54 INFO - 'USER': 'cltbld', 19:03:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:54 INFO - '_': '/tools/buildbot/bin/python'} 19:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:03:54 INFO - Running setup.py (path:/tmp/pip-7iVcd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:03:54 INFO - Running setup.py (path:/tmp/pip-dJKMJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:03:54 INFO - Running setup.py (path:/tmp/pip-m5LYU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:03:54 INFO - Running setup.py (path:/tmp/pip-Jv7csJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:03:54 INFO - Running setup.py (path:/tmp/pip-IPPdzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:03:54 INFO - Running setup.py (path:/tmp/pip-sg4ILC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:03:54 INFO - Running setup.py (path:/tmp/pip-exWYMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:03:55 INFO - Running setup.py (path:/tmp/pip-DLpMgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:03:55 INFO - Running setup.py (path:/tmp/pip-ZsDlho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:03:55 INFO - Running setup.py (path:/tmp/pip-MMOg9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:03:55 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)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:03:55 INFO - Running setup.py (path:/tmp/pip-NLlCh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:03:55 INFO - Running setup.py (path:/tmp/pip-VgIunD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:03:55 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)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:03:55 INFO - Running setup.py (path:/tmp/pip-zmHPlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:03:55 INFO - Running setup.py (path:/tmp/pip-9DR3dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:03:55 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)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:55 INFO - Running setup.py (path:/tmp/pip-XX1Eps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:03:55 INFO - Running setup.py (path:/tmp/pip-k6XGmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:03:55 INFO - Running setup.py (path:/tmp/pip-GHzAiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:03:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:57 INFO - Downloading blessings-1.6.tar.gz 19:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:03:57 INFO - Installing collected packages: blessings 19:03:57 INFO - Running setup.py install for blessings 19:03:57 INFO - Successfully installed blessings 19:03:57 INFO - Cleaning up... 19:03:57 INFO - Return code: 0 19:03:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:03:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:03:58 INFO - Reading from file tmpfile_stdout 19:03:58 INFO - Current package versions: 19:03:58 INFO - argparse == 1.2.1 19:03:58 INFO - blessings == 1.6 19:03:58 INFO - blobuploader == 1.2.4 19:03:58 INFO - docopt == 0.6.1 19:03:58 INFO - manifestparser == 1.1 19:03:58 INFO - mozInstall == 1.12 19:03:58 INFO - mozcrash == 0.17 19:03:58 INFO - mozdebug == 0.1 19:03:58 INFO - mozdevice == 0.48 19:03:58 INFO - mozfile == 1.2 19:03:58 INFO - mozhttpd == 0.7 19:03:58 INFO - mozinfo == 0.9 19:03:58 INFO - mozleak == 0.1 19:03:58 INFO - mozlog == 3.1 19:03:58 INFO - moznetwork == 0.27 19:03:58 INFO - mozprocess == 0.22 19:03:58 INFO - mozprofile == 0.28 19:03:58 INFO - mozrunner == 6.11 19:03:58 INFO - mozscreenshot == 0.1 19:03:58 INFO - mozsystemmonitor == 0.0 19:03:58 INFO - moztest == 0.7 19:03:58 INFO - mozversion == 1.4 19:03:58 INFO - psutil == 3.1.1 19:03:58 INFO - requests == 1.2.3 19:03:58 INFO - wsgiref == 0.1.2 19:03:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:58 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:03:58 INFO - Using env: {'DISPLAY': ':0', 19:03:58 INFO - 'HOME': '/home/cltbld', 19:03:58 INFO - 'LANG': 'en_US.UTF-8', 19:03:58 INFO - 'LANGUAGE': 'en_US:en', 19:03:58 INFO - 'LOGNAME': 'cltbld', 19:03:58 INFO - 'MAIL': '/var/mail/cltbld', 19:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:58 INFO - 'MOZ_NO_REMOTE': '1', 19:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:58 INFO - 'NO_EM_RESTART': '1', 19:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:58 INFO - 'PWD': '/builds/slave/test', 19:03:58 INFO - 'SHELL': '/bin/bash', 19:03:58 INFO - 'SHLVL': '1', 19:03:58 INFO - 'TERM': 'linux', 19:03:58 INFO - 'TMOUT': '86400', 19:03:58 INFO - 'USER': 'cltbld', 19:03:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:58 INFO - '_': '/tools/buildbot/bin/python'} 19:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:03:58 INFO - Cleaning up... 19:03:58 INFO - Return code: 0 19:03:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:58 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 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:03:58 INFO - Using env: {'DISPLAY': ':0', 19:03:58 INFO - 'HOME': '/home/cltbld', 19:03:58 INFO - 'LANG': 'en_US.UTF-8', 19:03:58 INFO - 'LANGUAGE': 'en_US:en', 19:03:58 INFO - 'LOGNAME': 'cltbld', 19:03:58 INFO - 'MAIL': '/var/mail/cltbld', 19:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:58 INFO - 'MOZ_NO_REMOTE': '1', 19:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:58 INFO - 'NO_EM_RESTART': '1', 19:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:58 INFO - 'PWD': '/builds/slave/test', 19:03:58 INFO - 'SHELL': '/bin/bash', 19:03:58 INFO - 'SHLVL': '1', 19:03:58 INFO - 'TERM': 'linux', 19:03:58 INFO - 'TMOUT': '86400', 19:03:58 INFO - 'USER': 'cltbld', 19:03:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:58 INFO - '_': '/tools/buildbot/bin/python'} 19:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:58 INFO - Downloading/unpacking jsonschema 19:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:04:00 INFO - Downloading/unpacking functools32 (from jsonschema) 19:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:04:00 INFO - warning: no files found matching '*.txt' 19:04:00 INFO - no previously-included directories found matching 'build' 19:04:00 INFO - no previously-included directories found matching 'dist' 19:04:00 INFO - no previously-included directories found matching '.git*' 19:04:00 INFO - Installing collected packages: jsonschema, functools32 19:04:00 INFO - Running setup.py install for functools32 19:04:00 INFO - warning: no files found matching '*.txt' 19:04:00 INFO - no previously-included directories found matching 'build' 19:04:00 INFO - no previously-included directories found matching 'dist' 19:04:00 INFO - no previously-included directories found matching '.git*' 19:04:00 INFO - Successfully installed jsonschema functools32 19:04:00 INFO - Cleaning up... 19:04:00 INFO - Return code: 0 19:04:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff191a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2815410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:04:00 INFO - Using env: {'DISPLAY': ':0', 19:04:00 INFO - 'HOME': '/home/cltbld', 19:04:00 INFO - 'LANG': 'en_US.UTF-8', 19:04:00 INFO - 'LANGUAGE': 'en_US:en', 19:04:00 INFO - 'LOGNAME': 'cltbld', 19:04:00 INFO - 'MAIL': '/var/mail/cltbld', 19:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:00 INFO - 'MOZ_NO_REMOTE': '1', 19:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:00 INFO - 'NO_EM_RESTART': '1', 19:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:00 INFO - 'PWD': '/builds/slave/test', 19:04:00 INFO - 'SHELL': '/bin/bash', 19:04:00 INFO - 'SHLVL': '1', 19:04:00 INFO - 'TERM': 'linux', 19:04:00 INFO - 'TMOUT': '86400', 19:04:00 INFO - 'USER': 'cltbld', 19:04:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:00 INFO - '_': '/tools/buildbot/bin/python'} 19:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:01 INFO - Downloading/unpacking flake8 19:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:04:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:04:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:04:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:04:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:04:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:04:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:04:03 INFO - no previously-included directories found matching 'docs/_build' 19:04:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:04:03 INFO - Running setup.py install for pep8 19:04:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:04:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:04:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:04:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:04:03 INFO - no previously-included directories found matching 'docs/_build' 19:04:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:04:03 INFO - Cleaning up... 19:04:03 INFO - Return code: 0 19:04:03 INFO - Running post-action listener: _resource_record_post_action 19:04:03 INFO - Running post-action listener: _start_resource_monitoring 19:04:04 INFO - Starting resource monitoring. 19:04:04 INFO - ##### 19:04:04 INFO - ##### Running install step. 19:04:04 INFO - ##### 19:04:04 INFO - Running pre-action listener: _resource_record_pre_action 19:04:04 INFO - Running main action method: install 19:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:04 INFO - Reading from file tmpfile_stdout 19:04:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:04:04 INFO - Reading from file tmpfile_stdout 19:04:04 INFO - Output received: 19:04:04 INFO - Usage: mozinstall [options] installer 19:04:04 INFO - Options: 19:04:04 INFO - -h, --help show this help message and exit 19:04:04 INFO - -d DEST, --destination=DEST 19:04:04 INFO - Directory to install application into. [default: 19:04:04 INFO - "/builds/slave/test"] 19:04:04 INFO - --app=APP Application being installed. [default: firefox] 19:04:04 INFO - mkdir: /builds/slave/test/build/application 19:04:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:04:16 INFO - Reading from file tmpfile_stdout 19:04:16 INFO - Output received: 19:04:16 INFO - /builds/slave/test/build/application/firefox/firefox 19:04:16 INFO - Running post-action listener: _resource_record_post_action 19:04:16 INFO - ##### 19:04:16 INFO - ##### Running run-tests step. 19:04:16 INFO - ##### 19:04:16 INFO - Running pre-action listener: _resource_record_pre_action 19:04:16 INFO - Running main action method: run_tests 19:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:04:16 INFO - Python 2.7.3 19:04:16 INFO - Return code: 0 19:04:16 INFO - grabbing minidump binary from tooltool 19:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:16 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 0x28a4160>, '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 0x28a5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28a54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:04:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:04:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:04:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:04:17 INFO - Return code: 0 19:04:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:04:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:04:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:04:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:04:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:04:18 INFO - Return code: 0 19:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:04:18 INFO - Using env: {'DISPLAY': ':0', 19:04:18 INFO - 'HOME': '/home/cltbld', 19:04:18 INFO - 'LANG': 'en_US.UTF-8', 19:04:18 INFO - 'LANGUAGE': 'en_US:en', 19:04:18 INFO - 'LOGNAME': 'cltbld', 19:04:18 INFO - 'MAIL': '/var/mail/cltbld', 19:04:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:04:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:18 INFO - 'MOZ_NO_REMOTE': '1', 19:04:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:18 INFO - 'NO_EM_RESTART': '1', 19:04:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:18 INFO - 'PWD': '/builds/slave/test', 19:04:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:04:18 INFO - 'SHELL': '/bin/bash', 19:04:18 INFO - 'SHLVL': '1', 19:04:18 INFO - 'TERM': 'linux', 19:04:18 INFO - 'TMOUT': '86400', 19:04:18 INFO - 'USER': 'cltbld', 19:04:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267', 19:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:18 INFO - '_': '/tools/buildbot/bin/python'} 19:04:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:04:18 INFO - mozversion application_buildid: 20160505125249 19:04:18 INFO - mozversion application_changeset: 609000bcc11211d7c27ceea36fa2d2262fa0523f 19:04:18 INFO - mozversion application_display_name: Firefox 19:04:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:04:18 INFO - mozversion application_name: Firefox 19:04:18 INFO - mozversion application_remotingname: firefox 19:04:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:04:18 INFO - mozversion application_vendor: Mozilla 19:04:18 INFO - mozversion application_version: 47.0 19:04:18 INFO - mozversion platform_buildid: 20160505125249 19:04:18 INFO - mozversion platform_changeset: 609000bcc11211d7c27ceea36fa2d2262fa0523f 19:04:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:04:18 INFO - mozversion platform_version: 47.0 19:04:18 INFO - using testdate: 1462500258 19:04:18 INFO - actual date: 1462500258 19:04:18 INFO - starting webserver on 'localhost:45070' 19:04:18 INFO - SUITE-START | Running 2 tests 19:04:18 INFO - TEST-START | dromaeo_css 19:04:18 INFO - operating with platform_type : linux_ 19:04:18 INFO - Initialising browser for dromaeo_css test... 19:04:18 INFO - TEST-INFO | started process 24470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz5wgH2/profile http://localhost:45070/getInfo.html) 19:04:22 INFO - PROCESS | 24470 | __metrics Screen width/height:1600/1200 19:04:22 INFO - PROCESS | 24470 | colorDepth:24 19:04:22 INFO - PROCESS | 24470 | Browser inner width/height: 1024/697 19:04:22 INFO - PROCESS | 24470 | __metrics 19:04:23 INFO - PROCESS | 24470 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:04:24 INFO - TEST-INFO | 24470: exit 0 19:04:24 INFO - Browser initialized. 19:04:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:04:24 INFO - TEST-INFO | started process 24557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz5wgH2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:35 INFO - PROCESS | 24557 | RSS: Main: 139300864 19:04:35 INFO - PROCESS | 24557 | 19:05:26 INFO - PROCESS | 24557 | 1462500326950 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:07:34 INFO - PROCESS | 24557 | Cycle 1(1): loaded http://localhost:45070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45070/tests/dromaeo/cssquery-ext.html) 19:07:35 INFO - PROCESS | 24557 | RSS: Main: 252387328 19:07:35 INFO - PROCESS | 24557 | 19:10:37 INFO - PROCESS | 24557 | Cycle 1(1): loaded http://localhost:45070/tests/dromaeo/cssquery-ext.html (next: http://localhost:45070/tests/dromaeo/cssquery-jquery.html) 19:10:37 INFO - PROCESS | 24557 | RSS: Main: 226959360 19:10:37 INFO - PROCESS | 24557 | 19:13:39 INFO - PROCESS | 24557 | Cycle 1(1): loaded http://localhost:45070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45070/tests/dromaeo/cssquery-mootools.html) 19:13:40 INFO - PROCESS | 24557 | RSS: Main: 240427008 19:13:40 INFO - PROCESS | 24557 | 19:16:41 INFO - PROCESS | 24557 | Cycle 1(1): loaded http://localhost:45070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45070/tests/dromaeo/cssquery-prototype.html) 19:16:42 INFO - PROCESS | 24557 | RSS: Main: 198184960 19:16:42 INFO - PROCESS | 24557 | 19:19:45 INFO - PROCESS | 24557 | Cycle 1(1): loaded http://localhost:45070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45070/tests/dromaeo/cssquery-yui.html) 19:19:45 INFO - PROCESS | 24557 | RSS: Main: 209203200 19:19:45 INFO - PROCESS | 24557 | 19:22:47 INFO - PROCESS | 24557 | Cycle 1(1): loaded http://localhost:45070/tests/dromaeo/cssquery-yui.html (next: http://localhost:45070/tests/dromaeo/cssquery-dojo.html) 19:22:48 INFO - PROCESS | 24557 | RSS: Main: 254275584 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | __start_tp_report 19:22:48 INFO - PROCESS | 24557 | _x_x_mozilla_page_load 19:22:48 INFO - PROCESS | 24557 | _x_x_mozilla_page_load_details 19:22:48 INFO - PROCESS | 24557 | |i|pagename|runs| 19:22:48 INFO - PROCESS | 24557 | |0;dojo.html;3211.6788321167887;3275.0993476793865;3290.9177270568216;3295.6869097435733;3326.5010248462727;5246.921296180561;5250.684958902464;5285.709285989274;5297.44376840432;5328.973355133228;5305.814296499623;5327.467253274671;5342.305500284967;5359.30329057222;5364.490373414519;4697.4832768395445;4865;4885.022995400916;4942.986687729007;4975.12935236334;4769.5468930451725;4865.978144589641;4867.36724225852;4870.293807397925;4871.196252618313;4834;4874.585660218886;4878.56092951636;4891.608671306287;4904.435989861158;4945.703257804544;4957.801687932479;4979.576735977446;4985.277134815467;4986.975065124688;4744.478107408182;4798.424189097295;4906.484819093979;4909.067277217353;4929.334539837112;5112.693238405707;5134.229865520165;5134.332536770234;5173.663711858717;5174.637775355726;5607.383187849333;5662.660240385549;5720.513756330717;5720.771169153229;5724.084146536534;5744.4829965303325;5758.971205143947;5762.884742305172;5778.508826749731;5808.477237048686;5394.757235924393;5405.00007498614;5409.972950135263;5410.675359478444;5412.9458705412835;5708.058170401837;5733.569982251264;5825.88348233033;5837.88324233513;5847.561432892465;5604.8038318658655;5612.607117501817;5616.719164041781;5619.522340601013;5631.71841407928;5748.827535173951;5749.8562535936935;5754.568407369464;5773.451522105393;5774;5485;5653.406392328829;5667.773289068474;5749.9937510935415;5757.740901659436;5717.142428635738;5717.342505611825;5718;5718.313802343745;5721.199032135504;4380.627646650007;4390.495093064274;4394.36281739146;4397.164538737629;4403.361512580658;3874.380099184117;3899.2786334528205;3915.530136383652;3936.626020528045;3946.625070618287;5363.389040031164;5395.055865223649;5396.163594642837;5401.7029063401105;5427.48438898304;5587.44125587438;5709.429057094258;5765.827025189251;5773.480386765127;5777.595568310178;5301.363836339587;5308.522232998971;5347.25138480613;5359.490848369399;5397.27136836522;4897.632677549198;4900.240462728283;4904.215325547895;4925.655204135748;4926.014797040606;5668.518175955008;5681.119426488901;5849.1226316052935;5857.092150716646;5863.941360586425;5740.1102829061565;5746.396628353963;5753.252077229933;5786.681732504584;5815.883682326415;5774;5903.675297858659;5905.468507834144;5908.438698323653;5912.320083190488;5504.862378440571;5655.123455864347;5683;5701.543876489954;5724.885502289848;5755.971220143872;5767.884642307215;5769.307683078057;5772.134179873053;5776.220210271559;5630.380658127685;5631.1271752878365;5633.380328163817;5635.154726791015;5635.380108188178;5432.674039557639;5585.3297604287745;5617.466340697627;5641.12562552805;5674.687892165971;5484.287042684426;5499.257600223918;5507.862303442446;5514.338279406497;5520.585956053393;5588.916166257428;5636.323641163087;5639;5641.069223578063;5658.85852853682;5305.761240744253;5388.46115388458;5471.50756431923;5534.501894829485;5569.136783798518 19:22:48 INFO - PROCESS | 24557 | |1;ext.html;570.9885802283957;572.2303501790092;586.9991664212516;600.3846057790764;624.668925469501;40236.1952760945;40871.38692919605;40940.181196376056;40954.18091638166;41016.794916025414;43741.7812910935;44420.77789611048;44421.33367999482;44441.77779111108;44488;8782.91217087829;9083.409578377417;9087.091290870892;9095.181433670969;9098.590563424661;8697.826043479126;8872.245859101984;8882.866756998617;9093.909060909373;9125.954370228139;9118.635254589808;9127.817443651156;9182.173604375605;9191.08089191079;9195.21840643546;9040.502772347518;9089.818203635956;9093.40892841963;9099.863502047474;9128.315376346767;9098.090190980914;9256.398334108262;9269.582868770922;9272.07279272074;9272.675456358995;43738.12523749539;44746.88132796674;44775.77612111951;44776.3283550747;44792;3688.4651725499652;3743.513343265358;3765.5669597996307;3773.660370566662;3805.086779173006;33397.16507087318;33647.15882102943;33681.326373472395;33779.83110084458;34425;3632.654897784706;3655.689266412358;3698.33429982603;3702.129999450127;3761.4733937248807;290018;293051;293857;294277;295023.52488237637;46279.768601157455;47022.529774702496;66949;67339.3266067333;67454.32545674579;45552.77223613927;45643.08713825771;45794;45818.541814581426;45852;16773.412930547373;17001.914990424968;17048.914755426144;17062.57343566396;17066.57333566646;12946.805797913039;12979.221246725227;12985.870141298656;12989.220646761225;13014.21914685122;15358.846411535742;15735.44925927587;15781;15825.129617870898;15899.523014309589;5797.130420441908;5976.581639285208;6124.6325220486915;6165.075238714228;6243.406876346739;1106.0322218059198;1112.4271000434783;1132.377192544114;1171.2796630072614;1223.5534030079134;29202.269943251165;29425.411491770046;29805;29810.701892980793;29838.55242171369;1192.24292574216;1203.2419575667448;1225.1240363140398;1269.6635391621228;1326.5887574851827;15554.611134721723;15766.369345226292;15809.209539523208;16161.272742726605;16323.183840807913;342448;348217;348526;348555;349424;58248;58732.7063364689;58737.41262587405;58743;58763.41236587665;1375.6354566040006;1452.847451017628;1461.3789139615621;1483.206484530771;1541.9845801541842;30295.394092118477;30347.642954815856;32610.347793044482;32837.83581082079;33434.49848252327;52236;52945;53042;53102.203466947256;53113;305886;318793;319762;320442;320620;31367.686323136477;35572.110697232776;35952.82023589865;36001.27997439984;36680.63319366772;48564.51435485741;48857.51142488672;49490.25764613462;49794.75102624464;49948.25077623911;40131.799341004276;40134.59865401308;40805;41185.176296473306;41313.79343103385;38823.417648735856;39348.40977385284;39879.601203987586;40110.59889401068;40437.79781101076;40596.39105413362;40634.187316252915;40789;41745.37381939212;42258.78870605627;35818;35911;36788;36850;37231;27686;27938.720612794426;28136.29659258535;28169.718302817528;28280.15159545217 19:22:48 INFO - PROCESS | 24557 | |2;jquery.html;381.4640430195576;384.9114703618168;393.94681717968064;394.63890540155757;397.731531216429;17043.147842607865;19213.23147074119;19573.804261957375;19829.10769015394;19844.30544930926;18005.09974501276;18455.538611534685;18561.257549697995;18775.24899004038;18798.43604691858;5433.646812957145;5589.944100558983;5612.242347283126;5634.943650563483;5636.633618814764;4239.682023848209;6003.0395136778125;6246.968765156191;6283.120363149163;6286.088517165032;6008.279006519224;6217.160683307763;6223.875522489548;6254.718537665816;6256.655883926383;6208.534359923001;6210.534209934273;6244.906326405107;6246.937530624681;6247.812565623039;3881.1655494068627;5306.893862122774;5489.560835133179;5498.3127109111365;5502.642328248651;21004.47488812792;21056.157753689833;23008;23758.168464103674;23915.760842391526;2370.8221883358815;2563.4360440703017;2685.6508653875067;2839.9858000709864;3252.560904277916;14458.421663133462;14745;14759.852401475955;15035;15588.454404095915;2030.5025268809236;2069.9482512937147;2110.5778844231213;2124.617568837609;2168.4712277844083;77885;80985.59507202485;81478;81686;81873.9999999994;14956.102633842005;15013.69972600542;15079.698406032037;15328.310226039855;15395.384184632489;27352.179434616595;27602.723972760417;27654.446911061666;27674;27703.30741731473;9158.129977652112;9510.762230944281;9980.500974951223;10016.49917504122;10126.44304563256;8777.473351598925;8784.385093043553;8785.253253473526;8841.336899732545;8889.155530224618;7674.083848137672;7766.184550622103;7873.173316801768;7901.407394445439;7932.444728869039;2773.9722602773713;2982.0457453615068;3033.135556366425;3113.9065828025196;3125.420720123276;881.3213825354442;981.6564202529057;1011.4993078426226;1020.5407566595062;1020.8923318199688;17071.231794569274;17402.56493587645;17492.12539373026;17847.107644617718;18098;959.2757468111531;985.9950700246453;999.165696643311;1007.6825799873017;1023.790123024793;8531.530765807816;10213.33613315132;10257.794844103077;10279.897201028043;10389.94805025985;395199;396204;396418;397223;420706;76388;77086.61456692792;77606.6119669398;78866.6056669713;79724.60137699274;1047.4239168457318;1065.7282392989894;1068.1668298727006;1073.6456969200144;1088.1349327284827;15894.761578576561;15963.361465541248;16027.519174424786;16116.758248626515;16190.433334833224;34073;34075.48886766651;34369.65630343665;34526.13684657904;36270.8186459066;47870.76064619655;49469.752651236515;49507;49725.25412118893;50188.247176291654;8597.226249637562;8798.296136309207;8828.911710882809;8834.514101724468;9072.092790720875;8938.46369217849;9506.857397139187;13121.93439032837;13422.39599218018;13562.321883905568;11430.25703329281;11989.160758746804;12095.274283543016;12128.090393220367;12382.51409830826;11421.428928553372;11776.82334764962;11852.940735296268;11960.76078478408;12063.75872482563;11912.681912681845;12033.518659253532;12246.265224086583;12427.875721242672;12540.749185016432;8917.777055573662;9098.59056342453;9120.908790912272;9133.817323653622;9162.31282653817;9467.952660236655;11862.762744744885;12005.939970300093;12161.69595760113;12242.387880606113 19:22:48 INFO - PROCESS | 24557 | |3;mootools.html;1402.2287741742039;1508.0574640849466;1512.52355508015;1784.5181800913754;1987.2051179528187;8250.504969701815;8458.746237612873;8480;8488.363372747053;8488.830223395536;8243.175682431754;8405.789855253623;8405.87391189131;8430.620622072007;8433.19884610961;2457.3365191398357;2486.676732024834;2488.9546390515934;2491.4394261291154;2494.900203991838;2433.902643894242;2516.8364056336372;2523.3817714659936;2528.5575024370755;2530.595104783235;2374.560706269337;2376.8811559422047;2481.3424442522746;2483.987580062097;2487.340854673513;2410.710714714228;2412.4089598048504;2438.085717855804;2496.875156242199;2502.2993561802723;2430.9756902430927;2448.485817978227;2465.272744540347;2466.297105324974;2492.6011838105815;8504.404691671585;8541.701040463555;8543.444676096035;8560.871586926201;8563.828723425559;5255.343082114736;5403.2705584746345;5413.296271484721;5414.16080507518;5422.349318081816;3216.96783032169;3223.7904536205074;3247.610286765603;3274.1650879025933;3331.7001469867587;1024.6464969585481;1985.3547597031022;2019.1923230707835;2022.4438279473115;2027.8479114066504;11392.658220253406;11452.599159029394;11470.713232169262;11471.942640286828;11474.139439541985;4289.198536614629;4432.113577284492;4534.478534968455;4594.287885377772;4598.655100867449;9124.315676324302;9142.405743626643;9159.267258619295;9176.90823091774;9207.125323094295;5103.693778373309;5141.76862041209;5149.6910185389;5150.098732721759;5150.4592017837585;4284.464441944757;4433.958019865329;4443.133588950188;4694.460137084211;4728.40894888139;3741.7754934704003;3755.793431361247;3825.0437390652337;3843.9807800961376;3870.013146647587;1121.1647322744607;1167.3637867362308;1177.4524845946676;1181.497863408048;1189.5955375172482;1217.6286232698935;1255.9309237991815;1262.9115961882765;1538.9461368852037;1539.1611571693454;7933.642986065641;8322.62548185333;8324.25081742634;8326.50040997542;8332.66669333232;553.9446055394428;559.2506041903869;566.2384093394378;571.2060236271586;571.5199232644599;6440.227172739301;6478.190226221723;6495.0582165586675;6496.6426846522945;6545.509086818508;10336.638217662496;10658.78682426347;10826.458677066115;10834.404107774148;10838.241323107464;10407.21945854064;10438.791224175475;10472.947635261775;10655.254132210826;10691.625793097204;8329.375296852639;8365.58172091393;8376.874346884802;8403.201695838885;8425.747227583182;7842.803929901798;7924.4056695746895;8029.518228906284;8060.838783224185;8068.3545316373375;9310.48792316402;9535.952320238355;9543.713688589354;9601.32790704644;9621.9037809621;9570.856437153587;9781.706548803548;9833.5083245836;9972.052654997764;9975.251856110966;6112.480439162721;6883.036374907617;7128.394086502498;7216.819579510554;7314.195438501867;8067.233612806774;8076.111627721063;8092.797680058045;8134.75595732129;8135.959320203361;7439.256074392734;7574.734884279023;7594.134281568343;7660.616969151632;7677.117131529945;7428.814279643052;7456.403487721078;7466.36535894455;7524.398048156025;7572.507786994048;7795.41534384912;7818.687252509836;7871.212878712083;7874;7879.212078792075;7027.7188912442925;7090.503664743418;7092.078029856086;7097.82255443618;7144.1784194818265;7256.492045556972;7261.673224705007;7289.380402665621;7317.707291708272;7337.523061001231 19:22:48 INFO - PROCESS | 24557 | |4;prototype.html;360.8830669079199;370.7497439228521;372.93660077786774;376.536859662615;381.8167279705741;5932;5951.1668366428685;5971.522278217743;5973.641581505112;5978.163057172;5914.792982245623;5916.201312822767;5917.704114794254;5919;5934.436228558291;4434.889127771799;4546.272596384579;4610.953890461103;4667.06658668266;4668.4631267404175;4643.187442197602;4643.442786865581;4653.86038418848;4654.604358629521;4678.087772884289;4646.651501137411;4655.4180727409075;4656.976715116437;4661.65037622178;4670.719756814585;4461.442319710036;4507.954920450803;4637.907241855178;4650.697704649187;4664.416947881515;4127.9174416511805;4141.213169497816;4147.419361289422;4148.502179738421;4149.6265336119895;5698.51562617178;5698.772049118031;5707.400722924116;5713.74288157034;5714.885702285931;5410.323709536308;5417.10617748075;5425.077736784756;5425.593080518937;5427.83716488506;6243.344448832852;6244.0633904914175;6248.0627905814035;6250.937490625081;6253.405926436982;4458.554144585548;4591.4260717410325;4600.585947264763;4609.539046095397;4615.676902616819;6416.133821934026;6477.255115661665;6507.804765857032;6512.772052978123;6522.217333919913;4738.668293219511;4745.715257084586;4748.738819364969;4751.00228951924;4755.5719985201495;4812.085703716282;4813.4945830687975;4816.036792641486;4817.566419022305;4819.638527110411;5413.621046526705;5415.539679127318;5419.268398766195;5422.728863556807;5423.484768946943;6161.661108639068;6277.2153480814895;6309.747610095545;6320.810375688737;6327.746890124436;1685.7471379292958;1692.2638652186092;1702.114900251862;1702.914854257307;1704.0883127526713;1094.8850370710961;1145.707844499664;1153.700037990112;1160.2458402038742;1177.4466000979526;5985.431384018599;5996.130561068708;6017.488513476316;6019.819405417845;6020.969895150496;6458.903116453257;6525.836854078686;6532.6733663316645;6533.052707357501;6536;6012.068129439944;6013.609115407485;6017.736275382219;6021.638701677914;6022.57841951068;3454.809985450824;3454.9309013819584;3484.843182056763;3488.4767284907466;3492.5634295713035;6577.408033276933;6603.438707709898;6711.060451536789;6720.932790672128;6780.254172041072;6702.095217145623;6724.697388617524;6728.687905858408;6732.831679207961;6749.32506749331;6745.696443660047;6746.628935408501;6760.560563563353;6771.052052712625;6771.153605799275;6574.211094668671;6578.375054369827;6580.7038683260325;6582.934170658424;6597.1423714916755;6284.905726414016;6445.581037232565;6447.9032814508755;6452.709628066655;6465.515086368635;6716.992451132369;6754.3921047106;6760.560563563353;6767.729290828312;6769.3907548320885;4603.723776573416;4629.976850115728;4636.049609830045;4645.279981602857;4649.790759415902;6599.60402375859;6601.174853143357;6607.2071351438135;6613.900791488228;6615.106960560262;6123.479504242011;6400.583962042452;6404.231492220963;6419.293877673359;6431.549791514549;6350.7777227796805;6363.236411630634;6392.456641185366;6396.744130234739;6407.807765767035;6251.6561589113035;6262.874742505033;6264.404881536247;6269.62382257066;6271.874562508816;6409.519286053472;6426.29310775805;6430.067640192239;6442.420182183626;6443.194600674916;5995.640261584319;6072.514198864169;6230.50155987529;6268.686565671789;6272.6236425814595 19:22:48 INFO - PROCESS | 24557 | |5;yui.html;850.5789634131106;925.3984909808628;926.4811705444955;946.3612061858244;947.3984020147207;14301;14747.852521474782;14756.852431475681;14785.778213326808;14800;13892.305384730773;13911;13922.303884805744;13937.094088884216;13956.79064814026;764.3808515102756;922.6171138977317;941.1247539787994;962.191758922505;963.2727290895364;936.2650319499195;938.249400479617;938.2540880000382;940.3041749105681;940.9482478463716;990.5790039233333;1000.924930630202;1001.7295330260825;1001.8096561653299;1003.413003393016;813.2193094629133;991.2813210422422;1007.1489591295343;1008.4201584089104;1010.9342892711987;743.8661041012616;745.7501736918139;747.1855677311702;747.2266204478393;747.3908764357031;13450.730985380336;13460.663483412894;13504.662383440493;13515.729685406335;13523.39144738489;13560.321983900863;13932.512362067278;13981.860181398259;14012.579622611338;14691.485797997018;10957.123866589904;11063.446827658585;11078.833817492745;11170.329780213213;11170.776584468347;3893.435451859493;3898.9805050974564;3899.863504777319;3934.2721596504452;3956.307646161939;50002.49997500015;50602;51735.22397164046;51801.48198518004;52101.99999999962;10565.313254638424;10872.238943273895;11021.83467247992;11207.943960280309;11604.071674266039;19103.331383401513;19105.331313404244;19141.90429047846;19151.616967660568;19173;8029.076656184497;8160.795980100545;8172.18278172178;8336.124706905808;8625.698100566575;4365.367021781887;4477.19410506112;4489.573490518395;4493.752843593568;4626.629869610423;3318.950215746766;3384.509246159293;3414.6414626463866;3414.7438942078948;3420;590.3181824992141;662.0367365483211;662.6786008785735;688.4079691465336;698.5040621159034;588.3496791499884;738.1990540263766;740.0896896816945;750.3921823323126;756.383547408871;8774.649014039494;8899;9050.909490905138;9114.544272786334;9117.680881169128;609.8627808742997;623.2925629410652;704.3168126916883;721.469719755979;727.6652739739673;4098.364753463218;4153.854615088458;4162.188373267244;4207.596022888902;4247.129338485603;56160.71919640457;58815.11777323343;58978.41021589815;59274.70362648246;59318;50244;50884.745576272624;51320;51351;51793;46776.5322346779;47069.29396059062;47369.5263047372;48667;49366.50633493691;9090.500022498825;9181.632734690806;9314.394564353295;9344.205742511962;9404.482753448352;34617.480737789454;35105.82447087748;37435.812820935724;38605.80697096609;39277;42557.57442425536;43526.782366087966;43583;44006.339904900815;44786.55213447954;12231.510739570318;12560.874391255971;12650.620481385573;12685.302308373128;12963.15739476931;12759.170653907466;13111.27887966171;13116.540921067717;13244;13430.93284533571;12754.936225318814;12889.226646401246;12889.8066529004;12915.547955821501;13370.197788132744;12421.441035153259;12445.128840981044;12782.936085319514;13110.672233194246;13363.53227637028;12317.815232771336;12436.378181090728;12510.687232819253;12820.487180512675;12866.549670761478;10513.106385957279;10539.935655336558;10769.299995500267;10823.56705731762;11314.660560183207;10437.373757574569;10546.314489558154;10651.840222396826;10671.253012289066;10881.347119172875 19:22:48 INFO - PROCESS | 24557 | __end_tp_report 19:22:48 INFO - PROCESS | 24557 | __start_cc_report 19:22:48 INFO - PROCESS | 24557 | _x_x_mozilla_cycle_collect,881 19:22:48 INFO - PROCESS | 24557 | __end_cc_report 19:22:48 INFO - PROCESS | 24557 | __startTimestamp1462501368064__endTimestamp 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | ------- Summary: start ------- 19:22:48 INFO - PROCESS | 24557 | Number of tests: 6 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | [#0] dojo.html Cycles:165 Average:5310.30 Median:5504.86 stddev:576.03 (10.5%) stddev-sans-first:553.77 19:22:48 INFO - PROCESS | 24557 | Values: 3211.7 3275.1 3290.9 3295.7 3326.5 5246.9 5250.7 5285.7 5297.4 5329.0 5305.8 5327.5 5342.3 5359.3 5364.5 4697.5 4865.0 4885.0 4943.0 4975.1 4769.5 4866.0 4867.4 4870.3 4871.2 4834.0 4874.6 4878.6 4891.6 4904.4 4945.7 4957.8 4979.6 4985.3 4987.0 4744.5 4798.4 4906.5 4909.1 4929.3 5112.7 5134.2 5134.3 5173.7 5174.6 5607.4 5662.7 5720.5 5720.8 5724.1 5744.5 5759.0 5762.9 5778.5 5808.5 5394.8 5405.0 5410.0 5410.7 5412.9 5708.1 5733.6 5825.9 5837.9 5847.6 5604.8 5612.6 5616.7 5619.5 5631.7 5748.8 5749.9 5754.6 5773.5 5774.0 5485.0 5653.4 5667.8 5750.0 5757.7 5717.1 5717.3 5718.0 5718.3 5721.2 4380.6 4390.5 4394.4 4397.2 4403.4 3874.4 3899.3 3915.5 3936.6 3946.6 5363.4 5395.1 5396.2 5401.7 5427.5 5587.4 5709.4 5765.8 5773.5 5777.6 5301.4 5308.5 5347.3 5359.5 5397.3 4897.6 4900.2 4904.2 4925.7 4926.0 5668.5 5681.1 5849.1 5857.1 5863.9 5740.1 5746.4 5753.3 5786.7 5815.9 5774.0 5903.7 5905.5 5908.4 5912.3 5504.9 5655.1 5683.0 5701.5 5724.9 5756.0 5767.9 5769.3 5772.1 5776.2 5630.4 5631.1 5633.4 5635.2 5635.4 5432.7 5585.3 5617.5 5641.1 5674.7 5484.3 5499.3 5507.9 5514.3 5520.6 5588.9 5636.3 5639.0 5641.1 5658.9 5305.8 5388.5 5471.5 5534.5 5569.1 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | [#1] ext.html Cycles:180 Average:49852.81 Median:39085.91 stddev:83658.84 (214.0%) stddev-sans-first:83811.69 19:22:48 INFO - PROCESS | 24557 | Values: 571.0 572.2 587.0 600.4 624.7 40236.2 40871.4 40940.2 40954.2 41016.8 43741.8 44420.8 44421.3 44441.8 44488.0 8782.9 9083.4 9087.1 9095.2 9098.6 8697.8 8872.2 8882.9 9093.9 9126.0 9118.6 9127.8 9182.2 9191.1 9195.2 9040.5 9089.8 9093.4 9099.9 9128.3 9098.1 9256.4 9269.6 9272.1 9272.7 43738.1 44746.9 44775.8 44776.3 44792.0 3688.5 3743.5 3765.6 3773.7 3805.1 33397.2 33647.2 33681.3 33779.8 34425.0 3632.7 3655.7 3698.3 3702.1 3761.5 290018.0 293051.0 293857.0 294277.0 295023.5 46279.8 47022.5 66949.0 67339.3 67454.3 45552.8 45643.1 45794.0 45818.5 45852.0 16773.4 17001.9 17048.9 17062.6 17066.6 12946.8 12979.2 12985.9 12989.2 13014.2 15358.8 15735.4 15781.0 15825.1 15899.5 5797.1 5976.6 6124.6 6165.1 6243.4 1106.0 1112.4 1132.4 1171.3 1223.6 29202.3 29425.4 29805.0 29810.7 29838.6 1192.2 1203.2 1225.1 1269.7 1326.6 15554.6 15766.4 15809.2 16161.3 16323.2 342448.0 348217.0 348526.0 348555.0 349424.0 58248.0 58732.7 58737.4 58743.0 58763.4 1375.6 1452.8 1461.4 1483.2 1542.0 30295.4 30347.6 32610.3 32837.8 33434.5 52236.0 52945.0 53042.0 53102.2 53113.0 305886.0 318793.0 319762.0 320442.0 320620.0 31367.7 35572.1 35952.8 36001.3 36680.6 48564.5 48857.5 49490.3 49794.8 49948.3 40131.8 40134.6 40805.0 41185.2 41313.8 38823.4 39348.4 39879.6 40110.6 40437.8 40596.4 40634.2 40789.0 41745.4 42258.8 35818.0 35911.0 36788.0 36850.0 37231.0 27686.0 27938.7 28136.3 28169.7 28280.2 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | [#2] jquery.html Cycles:180 Average:26365.03 Median:3119.66 stddev:66145.18 (2120.3%) stddev-sans-first:66301.96 19:22:48 INFO - PROCESS | 24557 | Values: 381.5 384.9 393.9 394.6 397.7 17043.1 19213.2 19573.8 19829.1 19844.3 18005.1 18455.5 18561.3 18775.2 18798.4 5433.6 5589.9 5612.2 5634.9 5636.6 4239.7 6003.0 6247.0 6283.1 6286.1 6008.3 6217.2 6223.9 6254.7 6256.7 6208.5 6210.5 6244.9 6246.9 6247.8 3881.2 5306.9 5489.6 5498.3 5502.6 21004.5 21056.2 23008.0 23758.2 23915.8 2370.8 2563.4 2685.7 2840.0 3252.6 14458.4 14745.0 14759.9 15035.0 15588.5 2030.5 2069.9 2110.6 2124.6 2168.5 77885.0 80985.6 81478.0 81686.0 81874.0 14956.1 15013.7 15079.7 15328.3 15395.4 27352.2 27602.7 27654.4 27674.0 27703.3 9158.1 9510.8 9980.5 10016.5 10126.4 8777.5 8784.4 8785.3 8841.3 8889.2 7674.1 7766.2 7873.2 7901.4 7932.4 2774.0 2982.0 3033.1 3113.9 3125.4 881.3 981.7 1011.5 1020.5 1020.9 17071.2 17402.6 17492.1 17847.1 18098.0 959.3 986.0 999.2 1007.7 1023.8 8531.5 10213.3 10257.8 10279.9 10389.9 395199.0 396204.0 396418.0 397223.0 420706.0 76388.0 77086.6 77606.6 78866.6 79724.6 1047.4 1065.7 1068.2 1073.6 1088.1 15894.8 15963.4 16027.5 16116.8 16190.4 34073.0 34075.5 34369.7 34526.1 36270.8 47870.8 49469.8 49507.0 49725.3 50188.2 8597.2 8798.3 8828.9 8834.5 9072.1 8938.5 9506.9 13121.9 13422.4 13562.3 11430.3 11989.2 12095.3 12128.1 12382.5 11421.4 11776.8 11852.9 11960.8 12063.8 11912.7 12033.5 12246.3 12427.9 12540.7 8917.8 9098.6 9120.9 9133.8 9162.3 9468.0 11862.8 12005.9 12161.7 12242.4 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | [#3] mootools.html Cycles:180 Average:5985.82 Median:556.60 stddev:3128.95 (562.2%) stddev-sans-first:3118.76 19:22:48 INFO - PROCESS | 24557 | Values: 1402.2 1508.1 1512.5 1784.5 1987.2 8250.5 8458.7 8480.0 8488.4 8488.8 8243.2 8405.8 8405.9 8430.6 8433.2 2457.3 2486.7 2489.0 2491.4 2494.9 2433.9 2516.8 2523.4 2528.6 2530.6 2374.6 2376.9 2481.3 2484.0 2487.3 2410.7 2412.4 2438.1 2496.9 2502.3 2431.0 2448.5 2465.3 2466.3 2492.6 8504.4 8541.7 8543.4 8560.9 8563.8 5255.3 5403.3 5413.3 5414.2 5422.3 3217.0 3223.8 3247.6 3274.2 3331.7 1024.6 1985.4 2019.2 2022.4 2027.8 11392.7 11452.6 11470.7 11471.9 11474.1 4289.2 4432.1 4534.5 4594.3 4598.7 9124.3 9142.4 9159.3 9176.9 9207.1 5103.7 5141.8 5149.7 5150.1 5150.5 4284.5 4434.0 4443.1 4694.5 4728.4 3741.8 3755.8 3825.0 3844.0 3870.0 1121.2 1167.4 1177.5 1181.5 1189.6 1217.6 1255.9 1262.9 1538.9 1539.2 7933.6 8322.6 8324.3 8326.5 8332.7 553.9 559.3 566.2 571.2 571.5 6440.2 6478.2 6495.1 6496.6 6545.5 10336.6 10658.8 10826.5 10834.4 10838.2 10407.2 10438.8 10472.9 10655.3 10691.6 8329.4 8365.6 8376.9 8403.2 8425.7 7842.8 7924.4 8029.5 8060.8 8068.4 9310.5 9536.0 9543.7 9601.3 9621.9 9570.9 9781.7 9833.5 9972.1 9975.3 6112.5 6883.0 7128.4 7216.8 7314.2 8067.2 8076.1 8092.8 8134.8 8136.0 7439.3 7574.7 7594.1 7660.6 7677.1 7428.8 7456.4 7466.4 7524.4 7572.5 7795.4 7818.7 7871.2 7874.0 7879.2 7027.7 7090.5 7092.1 7097.8 7144.2 7256.5 7261.7 7289.4 7317.7 7337.5 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | [#4] prototype.html Cycles:180 Average:5339.00 Median:5990.54 stddev:1562.18 (26.1%) stddev-sans-first:1521.22 19:22:48 INFO - PROCESS | 24557 | Values: 360.9 370.7 372.9 376.5 381.8 5932.0 5951.2 5971.5 5973.6 5978.2 5914.8 5916.2 5917.7 5919.0 5934.4 4434.9 4546.3 4611.0 4667.1 4668.5 4643.2 4643.4 4653.9 4654.6 4678.1 4646.7 4655.4 4657.0 4661.7 4670.7 4461.4 4508.0 4637.9 4650.7 4664.4 4127.9 4141.2 4147.4 4148.5 4149.6 5698.5 5698.8 5707.4 5713.7 5714.9 5410.3 5417.1 5425.1 5425.6 5427.8 6243.3 6244.1 6248.1 6250.9 6253.4 4458.6 4591.4 4600.6 4609.5 4615.7 6416.1 6477.3 6507.8 6512.8 6522.2 4738.7 4745.7 4748.7 4751.0 4755.6 4812.1 4813.5 4816.0 4817.6 4819.6 5413.6 5415.5 5419.3 5422.7 5423.5 6161.7 6277.2 6309.7 6320.8 6327.7 1685.7 1692.3 1702.1 1702.9 1704.1 1094.9 1145.7 1153.7 1160.2 1177.4 5985.4 5996.1 6017.5 6019.8 6021.0 6458.9 6525.8 6532.7 6533.1 6536.0 6012.1 6013.6 6017.7 6021.6 6022.6 3454.8 3454.9 3484.8 3488.5 3492.6 6577.4 6603.4 6711.1 6720.9 6780.3 6702.1 6724.7 6728.7 6732.8 6749.3 6745.7 6746.6 6760.6 6771.1 6771.2 6574.2 6578.4 6580.7 6582.9 6597.1 6284.9 6445.6 6447.9 6452.7 6465.5 6717.0 6754.4 6760.6 6767.7 6769.4 4603.7 4630.0 4636.0 4645.3 4649.8 6599.6 6601.2 6607.2 6613.9 6615.1 6123.5 6400.6 6404.2 6419.3 6431.5 6350.8 6363.2 6392.5 6396.7 6407.8 6251.7 6262.9 6264.4 6269.6 6271.9 6409.5 6426.3 6430.1 6442.4 6443.2 5995.6 6072.5 6230.5 6268.7 6272.6 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - PROCESS | 24557 | [#5] yui.html Cycles:180 Average:14511.68 Median:3945.29 stddev:16217.73 (411.1%) stddev-sans-first:16230.77 19:22:48 INFO - PROCESS | 24557 | Values: 850.6 925.4 926.5 946.4 947.4 14301.0 14747.9 14756.9 14785.8 14800.0 13892.3 13911.0 13922.3 13937.1 13956.8 764.4 922.6 941.1 962.2 963.3 936.3 938.2 938.3 940.3 940.9 990.6 1000.9 1001.7 1001.8 1003.4 813.2 991.3 1007.1 1008.4 1010.9 743.9 745.8 747.2 747.2 747.4 13450.7 13460.7 13504.7 13515.7 13523.4 13560.3 13932.5 13981.9 14012.6 14691.5 10957.1 11063.4 11078.8 11170.3 11170.8 3893.4 3899.0 3899.9 3934.3 3956.3 50002.5 50602.0 51735.2 51801.5 52102.0 10565.3 10872.2 11021.8 11207.9 11604.1 19103.3 19105.3 19141.9 19151.6 19173.0 8029.1 8160.8 8172.2 8336.1 8625.7 4365.4 4477.2 4489.6 4493.8 4626.6 3319.0 3384.5 3414.6 3414.7 3420.0 590.3 662.0 662.7 688.4 698.5 588.3 738.2 740.1 750.4 756.4 8774.6 8899.0 9050.9 9114.5 9117.7 609.9 623.3 704.3 721.5 727.7 4098.4 4153.9 4162.2 4207.6 4247.1 56160.7 58815.1 58978.4 59274.7 59318.0 50244.0 50884.7 51320.0 51351.0 51793.0 46776.5 47069.3 47369.5 48667.0 49366.5 9090.5 9181.6 9314.4 9344.2 9404.5 34617.5 35105.8 37435.8 38605.8 39277.0 42557.6 43526.8 43583.0 44006.3 44786.6 12231.5 12560.9 12650.6 12685.3 12963.2 12759.2 13111.3 13116.5 13244.0 13430.9 12754.9 12889.2 12889.8 12915.5 13370.2 12421.4 12445.1 12782.9 13110.7 13363.5 12317.8 12436.4 12510.7 12820.5 12866.5 10513.1 10539.9 10769.3 10823.6 11314.7 10437.4 10546.3 10651.8 10671.3 10881.3 19:22:48 INFO - PROCESS | 24557 | -------- Summary: end -------- 19:22:48 INFO - PROCESS | 24557 | 19:22:48 INFO - TEST-INFO | 24557: exit 0 19:22:48 INFO - TEST-OK | dromaeo_css | took 1110448ms 19:22:48 INFO - TEST-START | kraken 19:22:48 INFO - operating with platform_type : linux_ 19:22:48 INFO - Initialising browser for kraken test... 19:22:48 INFO - TEST-INFO | started process 24754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7krLEJ/profile http://localhost:45070/getInfo.html) 19:22:52 INFO - PROCESS | 24754 | __metrics Screen width/height:1600/1200 19:22:52 INFO - PROCESS | 24754 | colorDepth:24 19:22:52 INFO - PROCESS | 24754 | Browser inner width/height: 1024/697 19:22:52 INFO - PROCESS | 24754 | __metrics 19:22:53 INFO - PROCESS | 24754 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:22:54 INFO - TEST-INFO | 24754: exit 0 19:22:54 INFO - Browser initialized. 19:22:54 INFO - Running cycle 1/1 for kraken test... 19:22:54 INFO - TEST-INFO | started process 24847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7krLEJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:06 INFO - PROCESS | 24847 | RSS: Main: 139632640 19:23:06 INFO - PROCESS | 24847 | 19:23:08 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45070/tests/kraken/driver.html?testName=audio-beat-detection) 19:23:09 INFO - PROCESS | 24847 | RSS: Main: 177147904 19:23:09 INFO - PROCESS | 24847 | 19:23:11 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45070/tests/kraken/driver.html?testName=audio-dft) 19:23:12 INFO - PROCESS | 24847 | RSS: Main: 174514176 19:23:12 INFO - PROCESS | 24847 | 19:23:15 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45070/tests/kraken/driver.html?testName=audio-fft) 19:23:15 INFO - PROCESS | 24847 | RSS: Main: 170471424 19:23:15 INFO - PROCESS | 24847 | 19:23:17 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45070/tests/kraken/driver.html?testName=audio-oscillator) 19:23:18 INFO - PROCESS | 24847 | RSS: Main: 171642880 19:23:18 INFO - PROCESS | 24847 | 19:23:20 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:23:21 INFO - PROCESS | 24847 | RSS: Main: 169484288 19:23:21 INFO - PROCESS | 24847 | 19:23:24 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45070/tests/kraken/driver.html?testName=imaging-darkroom) 19:23:24 INFO - PROCESS | 24847 | RSS: Main: 169078784 19:23:24 INFO - PROCESS | 24847 | 19:23:27 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45070/tests/kraken/driver.html?testName=imaging-desaturate) 19:23:28 INFO - PROCESS | 24847 | RSS: Main: 168939520 19:23:28 INFO - PROCESS | 24847 | 19:23:31 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45070/tests/kraken/driver.html?testName=json-parse-financial) 19:23:31 INFO - PROCESS | 24847 | RSS: Main: 169435136 19:23:31 INFO - PROCESS | 24847 | 19:23:33 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:33 INFO - PROCESS | 24847 | RSS: Main: 175681536 19:23:33 INFO - PROCESS | 24847 | 19:23:35 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:36 INFO - PROCESS | 24847 | RSS: Main: 173535232 19:23:36 INFO - PROCESS | 24847 | 19:23:38 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:38 INFO - PROCESS | 24847 | RSS: Main: 179204096 19:23:38 INFO - PROCESS | 24847 | 19:23:41 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:23:41 INFO - PROCESS | 24847 | RSS: Main: 184160256 19:23:41 INFO - PROCESS | 24847 | 19:23:44 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:23:44 INFO - PROCESS | 24847 | RSS: Main: 183115776 19:23:44 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | Cycle 1(1): loaded http://localhost:45070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45070/tests/kraken/driver.html?testName=ai-astar) 19:23:46 INFO - PROCESS | 24847 | RSS: Main: 246063104 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | __start_tp_report 19:23:46 INFO - PROCESS | 24847 | _x_x_mozilla_page_load 19:23:46 INFO - PROCESS | 24847 | _x_x_mozilla_page_load_details 19:23:46 INFO - PROCESS | 24847 | |i|pagename|runs| 19:23:46 INFO - PROCESS | 24847 | |0;ai-astar;111;110;102;109;109;110;97;109;109;107 19:23:46 INFO - PROCESS | 24847 | |1;audio-beat-detection;161;127;150;178;126;162;156;135;170;128 19:23:46 INFO - PROCESS | 24847 | |2;audio-dft;159;161;161;161;162;160;160;165;160;161 19:23:46 INFO - PROCESS | 24847 | |3;audio-fft;74;75;76;167;77;75;74;75;167;73 19:23:46 INFO - PROCESS | 24847 | |4;audio-oscillator;94;93;137;93;93;93;150;93;94;136 19:23:46 INFO - PROCESS | 24847 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;117;117 19:23:46 INFO - PROCESS | 24847 | |6;imaging-darkroom;146;145;146;145;145;146;145;145;145;146 19:23:46 INFO - PROCESS | 24847 | |7;imaging-desaturate;95;95;97;95;95;96;95;96;95;96 19:23:46 INFO - PROCESS | 24847 | |8;json-parse-financial;56;56;57;56;56;57;56;57;56;54 19:23:46 INFO - PROCESS | 24847 | |9;json-stringify-tinderbox;66;66;66;66;67;67;67;66;67;66 19:23:46 INFO - PROCESS | 24847 | |10;stanford-crypto-aes;84;78;78;79;79;78;78;77;78;78 19:23:46 INFO - PROCESS | 24847 | |11;stanford-crypto-ccm;114;119;119;123;120;120;112;111;114;111 19:23:46 INFO - PROCESS | 24847 | |12;stanford-crypto-pbkdf2;151;140;149;146;149;135;145;145;148;146 19:23:46 INFO - PROCESS | 24847 | |13;stanford-crypto-sha256-iterative;71;68;68;70;71;66;66;70;69;66 19:23:46 INFO - PROCESS | 24847 | __end_tp_report 19:23:46 INFO - PROCESS | 24847 | __start_cc_report 19:23:46 INFO - PROCESS | 24847 | _x_x_mozilla_cycle_collect,1035 19:23:46 INFO - PROCESS | 24847 | __end_cc_report 19:23:46 INFO - PROCESS | 24847 | __startTimestamp1462501426903__endTimestamp 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | ------- Summary: start ------- 19:23:46 INFO - PROCESS | 24847 | Number of tests: 14 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:4.40 (4.0%) stddev-sans-first:4.46 19:23:46 INFO - PROCESS | 24847 | Values: 111.0 110.0 102.0 109.0 109.0 110.0 97.0 109.0 109.0 107.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:158.50 stddev:19.13 (12.1%) stddev-sans-first:19.82 19:23:46 INFO - PROCESS | 24847 | Values: 161.0 127.0 150.0 178.0 126.0 162.0 156.0 135.0 170.0 128.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.63 (1.0%) stddev-sans-first:1.56 19:23:46 INFO - PROCESS | 24847 | Values: 159.0 161.0 161.0 161.0 162.0 160.0 160.0 165.0 160.0 161.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#3] audio-fft Cycles:10 Average:93.30 Median:75.00 stddev:38.86 (51.8%) stddev-sans-first:40.58 19:23:46 INFO - PROCESS | 24847 | Values: 74.0 75.0 76.0 167.0 77.0 75.0 74.0 75.0 167.0 73.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:93.00 stddev:23.34 (25.1%) stddev-sans-first:24.24 19:23:46 INFO - PROCESS | 24847 | Values: 94.0 93.0 137.0 93.0 93.0 93.0 150.0 93.0 94.0 136.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 19:23:46 INFO - PROCESS | 24847 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:23:46 INFO - PROCESS | 24847 | Values: 146.0 145.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 19:23:46 INFO - PROCESS | 24847 | Values: 95.0 95.0 97.0 95.0 95.0 96.0 95.0 96.0 95.0 96.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 19:23:46 INFO - PROCESS | 24847 | Values: 56.0 56.0 57.0 56.0 56.0 57.0 56.0 57.0 56.0 54.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 19:23:46 INFO - PROCESS | 24847 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 66.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:1.95 (2.5%) stddev-sans-first:0.60 19:23:46 INFO - PROCESS | 24847 | Values: 84.0 78.0 78.0 79.0 79.0 78.0 78.0 77.0 78.0 78.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:119.00 stddev:4.37 (3.7%) stddev-sans-first:4.56 19:23:46 INFO - PROCESS | 24847 | Values: 114.0 119.0 119.0 123.0 120.0 120.0 112.0 111.0 114.0 111.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:147.00 stddev:4.74 (3.2%) stddev-sans-first:4.58 19:23:46 INFO - PROCESS | 24847 | Values: 151.0 140.0 149.0 146.0 149.0 135.0 145.0 145.0 148.0 146.0 19:23:46 INFO - PROCESS | 24847 | 19:23:46 INFO - PROCESS | 24847 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.50 stddev:2.01 (2.9%) stddev-sans-first:1.92 19:23:46 INFO - PROCESS | 24847 | Values: 71.0 68.0 68.0 70.0 71.0 66.0 66.0 70.0 69.0 66.0 19:23:46 INFO - PROCESS | 24847 | -------- Summary: end -------- 19:23:46 INFO - PROCESS | 24847 | 19:23:47 INFO - TEST-INFO | 24847: exit 0 19:23:47 INFO - TEST-OK | kraken | took 59155ms 19:23:47 INFO - SUITE-END | took 1169s 19:23:48 INFO - Completed test suite (00:19:29) 19:23:48 INFO - javascript benchmark 19:23:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3211.6788321167887, 3275.0993476793865, 3290.9177270568216, 3295.6869097435733, 3326.5010248462727, 5246.921296180561, 5250.684958902464, 5285.709285989274, 5297.44376840432, 5328.973355133228, 5305.814296499623, 5327.467253274671, 5342.305500284967, 5359.30329057222, 5364.490373414519, 4697.4832768395445, 4865.0, 4885.022995400916, 4942.986687729007, 4975.12935236334, 4769.5468930451725, 4865.978144589641, 4867.36724225852, 4870.293807397925, 4871.196252618313, 4834.0, 4874.585660218886, 4878.56092951636, 4891.608671306287, 4904.435989861158, 4945.703257804544, 4957.801687932479, 4979.576735977446, 4985.277134815467, 4986.975065124688, 4744.478107408182, 4798.424189097295, 4906.484819093979, 4909.067277217353, 4929.334539837112, 5112.693238405707, 5134.229865520165, 5134.332536770234, 5173.663711858717, 5174.637775355726, 5607.383187849333, 5662.660240385549, 5720.513756330717, 5720.771169153229, 5724.084146536534, 5744.4829965303325, 5758.971205143947, 5762.884742305172, 5778.508826749731, 5808.477237048686, 5394.757235924393, 5405.00007498614, 5409.972950135263, 5410.675359478444, 5412.9458705412835, 5708.058170401837, 5733.569982251264, 5825.88348233033, 5837.88324233513, 5847.561432892465, 5604.8038318658655, 5612.607117501817, 5616.719164041781, 5619.522340601013, 5631.71841407928, 5748.827535173951, 5749.8562535936935, 5754.568407369464, 5773.451522105393, 5774.0, 5485.0, 5653.406392328829, 5667.773289068474, 5749.9937510935415, 5757.740901659436, 5717.142428635738, 5717.342505611825, 5718.0, 5718.313802343745, 5721.199032135504, 4380.627646650007, 4390.495093064274, 4394.36281739146, 4397.164538737629, 4403.361512580658, 3874.380099184117, 3899.2786334528205, 3915.530136383652, 3936.626020528045, 3946.625070618287, 5363.389040031164, 5395.055865223649, 5396.163594642837, 5401.7029063401105, 5427.48438898304, 5587.44125587438, 5709.429057094258, 5765.827025189251, 5773.480386765127, 5777.595568310178, 5301.363836339587, 5308.522232998971, 5347.25138480613, 5359.490848369399, 5397.27136836522, 4897.632677549198, 4900.240462728283, 4904.215325547895, 4925.655204135748, 4926.014797040606, 5668.518175955008, 5681.119426488901, 5849.1226316052935, 5857.092150716646, 5863.941360586425, 5740.1102829061565, 5746.396628353963, 5753.252077229933, 5786.681732504584, 5815.883682326415, 5774.0, 5903.675297858659, 5905.468507834144, 5908.438698323653, 5912.320083190488, 5504.862378440571, 5655.123455864347, 5683.0, 5701.543876489954, 5724.885502289848, 5755.971220143872, 5767.884642307215, 5769.307683078057, 5772.134179873053, 5776.220210271559, 5630.380658127685, 5631.1271752878365, 5633.380328163817, 5635.154726791015, 5635.380108188178, 5432.674039557639, 5585.3297604287745, 5617.466340697627, 5641.12562552805, 5674.687892165971, 5484.287042684426, 5499.257600223918, 5507.862303442446, 5514.338279406497, 5520.585956053393, 5588.916166257428, 5636.323641163087, 5639.0, 5641.069223578063, 5658.85852853682, 5305.761240744253, 5388.46115388458, 5471.50756431923, 5534.501894829485, 5569.136783798518], "unit": "score", "name": "dojo.html", "value": 5274.0450293153435}, {"lowerIsBetter": false, "replicates": [570.9885802283957, 572.2303501790092, 586.9991664212516, 600.3846057790764, 624.668925469501, 40236.1952760945, 40871.38692919605, 40940.181196376056, 40954.18091638166, 41016.794916025414, 43741.7812910935, 44420.77789611048, 44421.33367999482, 44441.77779111108, 44488.0, 8782.91217087829, 9083.409578377417, 9087.091290870892, 9095.181433670969, 9098.590563424661, 8697.826043479126, 8872.245859101984, 8882.866756998617, 9093.909060909373, 9125.954370228139, 9118.635254589808, 9127.817443651156, 9182.173604375605, 9191.08089191079, 9195.21840643546, 9040.502772347518, 9089.818203635956, 9093.40892841963, 9099.863502047474, 9128.315376346767, 9098.090190980914, 9256.398334108262, 9269.582868770922, 9272.07279272074, 9272.675456358995, 43738.12523749539, 44746.88132796674, 44775.77612111951, 44776.3283550747, 44792.0, 3688.4651725499652, 3743.513343265358, 3765.5669597996307, 3773.660370566662, 3805.086779173006, 33397.16507087318, 33647.15882102943, 33681.326373472395, 33779.83110084458, 34425.0, 3632.654897784706, 3655.689266412358, 3698.33429982603, 3702.129999450127, 3761.4733937248807, 290018.0, 293051.0, 293857.0, 294277.0, 295023.52488237637, 46279.768601157455, 47022.529774702496, 66949.0, 67339.3266067333, 67454.32545674579, 45552.77223613927, 45643.08713825771, 45794.0, 45818.541814581426, 45852.0, 16773.412930547373, 17001.914990424968, 17048.914755426144, 17062.57343566396, 17066.57333566646, 12946.805797913039, 12979.221246725227, 12985.870141298656, 12989.220646761225, 13014.21914685122, 15358.846411535742, 15735.44925927587, 15781.0, 15825.129617870898, 15899.523014309589, 5797.130420441908, 5976.581639285208, 6124.6325220486915, 6165.075238714228, 6243.406876346739, 1106.0322218059198, 1112.4271000434783, 1132.377192544114, 1171.2796630072614, 1223.5534030079134, 29202.269943251165, 29425.411491770046, 29805.0, 29810.701892980793, 29838.55242171369, 1192.24292574216, 1203.2419575667448, 1225.1240363140398, 1269.6635391621228, 1326.5887574851827, 15554.611134721723, 15766.369345226292, 15809.209539523208, 16161.272742726605, 16323.183840807913, 342448.0, 348217.0, 348526.0, 348555.0, 349424.0, 58248.0, 58732.7063364689, 58737.41262587405, 58743.0, 58763.41236587665, 1375.6354566040006, 1452.847451017628, 1461.3789139615621, 1483.206484530771, 1541.9845801541842, 30295.394092118477, 30347.642954815856, 32610.347793044482, 32837.83581082079, 33434.49848252327, 52236.0, 52945.0, 53042.0, 53102.203466947256, 53113.0, 305886.0, 318793.0, 319762.0, 320442.0, 320620.0, 31367.686323136477, 35572.110697232776, 35952.82023589865, 36001.27997439984, 36680.63319366772, 48564.51435485741, 48857.51142488672, 49490.25764613462, 49794.75102624464, 49948.25077623911, 40131.799341004276, 40134.59865401308, 40805.0, 41185.176296473306, 41313.79343103385, 38823.417648735856, 39348.40977385284, 39879.601203987586, 40110.59889401068, 40437.79781101076, 40596.39105413362, 40634.187316252915, 40789.0, 41745.37381939212, 42258.78870605627, 35818.0, 35911.0, 36788.0, 36850.0, 37231.0, 27686.0, 27938.720612794426, 28136.29659258535, 28169.718302817528, 28280.15159545217], "unit": "score", "name": "ext.html", "value": 19532.9303620235}, {"lowerIsBetter": false, "replicates": [381.4640430195576, 384.9114703618168, 393.94681717968064, 394.63890540155757, 397.731531216429, 17043.147842607865, 19213.23147074119, 19573.804261957375, 19829.10769015394, 19844.30544930926, 18005.09974501276, 18455.538611534685, 18561.257549697995, 18775.24899004038, 18798.43604691858, 5433.646812957145, 5589.944100558983, 5612.242347283126, 5634.943650563483, 5636.633618814764, 4239.682023848209, 6003.0395136778125, 6246.968765156191, 6283.120363149163, 6286.088517165032, 6008.279006519224, 6217.160683307763, 6223.875522489548, 6254.718537665816, 6256.655883926383, 6208.534359923001, 6210.534209934273, 6244.906326405107, 6246.937530624681, 6247.812565623039, 3881.1655494068627, 5306.893862122774, 5489.560835133179, 5498.3127109111365, 5502.642328248651, 21004.47488812792, 21056.157753689833, 23008.0, 23758.168464103674, 23915.760842391526, 2370.8221883358815, 2563.4360440703017, 2685.6508653875067, 2839.9858000709864, 3252.560904277916, 14458.421663133462, 14745.0, 14759.852401475955, 15035.0, 15588.454404095915, 2030.5025268809236, 2069.9482512937147, 2110.5778844231213, 2124.617568837609, 2168.4712277844083, 77885.0, 80985.59507202485, 81478.0, 81686.0, 81873.9999999994, 14956.102633842005, 15013.69972600542, 15079.698406032037, 15328.310226039855, 15395.384184632489, 27352.179434616595, 27602.723972760417, 27654.446911061666, 27674.0, 27703.30741731473, 9158.129977652112, 9510.762230944281, 9980.500974951223, 10016.49917504122, 10126.44304563256, 8777.473351598925, 8784.385093043553, 8785.253253473526, 8841.336899732545, 8889.155530224618, 7674.083848137672, 7766.184550622103, 7873.173316801768, 7901.407394445439, 7932.444728869039, 2773.9722602773713, 2982.0457453615068, 3033.135556366425, 3113.9065828025196, 3125.420720123276, 881.3213825354442, 981.6564202529057, 1011.4993078426226, 1020.5407566595062, 1020.8923318199688, 17071.231794569274, 17402.56493587645, 17492.12539373026, 17847.107644617718, 18098.0, 959.2757468111531, 985.9950700246453, 999.165696643311, 1007.6825799873017, 1023.790123024793, 8531.530765807816, 10213.33613315132, 10257.794844103077, 10279.897201028043, 10389.94805025985, 395199.0, 396204.0, 396418.0, 397223.0, 420706.0, 76388.0, 77086.61456692792, 77606.6119669398, 78866.6056669713, 79724.60137699274, 1047.4239168457318, 1065.7282392989894, 1068.1668298727006, 1073.6456969200144, 1088.1349327284827, 15894.761578576561, 15963.361465541248, 16027.519174424786, 16116.758248626515, 16190.433334833224, 34073.0, 34075.48886766651, 34369.65630343665, 34526.13684657904, 36270.8186459066, 47870.76064619655, 49469.752651236515, 49507.0, 49725.25412118893, 50188.247176291654, 8597.226249637562, 8798.296136309207, 8828.911710882809, 8834.514101724468, 9072.092790720875, 8938.46369217849, 9506.857397139187, 13121.93439032837, 13422.39599218018, 13562.321883905568, 11430.25703329281, 11989.160758746804, 12095.274283543016, 12128.090393220367, 12382.51409830826, 11421.428928553372, 11776.82334764962, 11852.940735296268, 11960.76078478408, 12063.75872482563, 11912.681912681845, 12033.518659253532, 12246.265224086583, 12427.875721242672, 12540.749185016432, 8917.777055573662, 9098.59056342453, 9120.908790912272, 9133.817323653622, 9162.31282653817, 9467.952660236655, 11862.762744744885, 12005.939970300093, 12161.69595760113, 12242.387880606113], "unit": "score", "name": "jquery.html", "value": 9711.752834437446}, {"lowerIsBetter": false, "replicates": [1402.2287741742039, 1508.0574640849466, 1512.52355508015, 1784.5181800913754, 1987.2051179528187, 8250.504969701815, 8458.746237612873, 8480.0, 8488.363372747053, 8488.830223395536, 8243.175682431754, 8405.789855253623, 8405.87391189131, 8430.620622072007, 8433.19884610961, 2457.3365191398357, 2486.676732024834, 2488.9546390515934, 2491.4394261291154, 2494.900203991838, 2433.902643894242, 2516.8364056336372, 2523.3817714659936, 2528.5575024370755, 2530.595104783235, 2374.560706269337, 2376.8811559422047, 2481.3424442522746, 2483.987580062097, 2487.340854673513, 2410.710714714228, 2412.4089598048504, 2438.085717855804, 2496.875156242199, 2502.2993561802723, 2430.9756902430927, 2448.485817978227, 2465.272744540347, 2466.297105324974, 2492.6011838105815, 8504.404691671585, 8541.701040463555, 8543.444676096035, 8560.871586926201, 8563.828723425559, 5255.343082114736, 5403.2705584746345, 5413.296271484721, 5414.16080507518, 5422.349318081816, 3216.96783032169, 3223.7904536205074, 3247.610286765603, 3274.1650879025933, 3331.7001469867587, 1024.6464969585481, 1985.3547597031022, 2019.1923230707835, 2022.4438279473115, 2027.8479114066504, 11392.658220253406, 11452.599159029394, 11470.713232169262, 11471.942640286828, 11474.139439541985, 4289.198536614629, 4432.113577284492, 4534.478534968455, 4594.287885377772, 4598.655100867449, 9124.315676324302, 9142.405743626643, 9159.267258619295, 9176.90823091774, 9207.125323094295, 5103.693778373309, 5141.76862041209, 5149.6910185389, 5150.098732721759, 5150.4592017837585, 4284.464441944757, 4433.958019865329, 4443.133588950188, 4694.460137084211, 4728.40894888139, 3741.7754934704003, 3755.793431361247, 3825.0437390652337, 3843.9807800961376, 3870.013146647587, 1121.1647322744607, 1167.3637867362308, 1177.4524845946676, 1181.497863408048, 1189.5955375172482, 1217.6286232698935, 1255.9309237991815, 1262.9115961882765, 1538.9461368852037, 1539.1611571693454, 7933.642986065641, 8322.62548185333, 8324.25081742634, 8326.50040997542, 8332.66669333232, 553.9446055394428, 559.2506041903869, 566.2384093394378, 571.2060236271586, 571.5199232644599, 6440.227172739301, 6478.190226221723, 6495.0582165586675, 6496.6426846522945, 6545.509086818508, 10336.638217662496, 10658.78682426347, 10826.458677066115, 10834.404107774148, 10838.241323107464, 10407.21945854064, 10438.791224175475, 10472.947635261775, 10655.254132210826, 10691.625793097204, 8329.375296852639, 8365.58172091393, 8376.874346884802, 8403.201695838885, 8425.747227583182, 7842.803929901798, 7924.4056695746895, 8029.518228906284, 8060.838783224185, 8068.3545316373375, 9310.48792316402, 9535.952320238355, 9543.713688589354, 9601.32790704644, 9621.9037809621, 9570.856437153587, 9781.706548803548, 9833.5083245836, 9972.052654997764, 9975.251856110966, 6112.480439162721, 6883.036374907617, 7128.394086502498, 7216.819579510554, 7314.195438501867, 8067.233612806774, 8076.111627721063, 8092.797680058045, 8134.75595732129, 8135.959320203361, 7439.256074392734, 7574.734884279023, 7594.134281568343, 7660.616969151632, 7677.117131529945, 7428.814279643052, 7456.403487721078, 7466.36535894455, 7524.398048156025, 7572.507786994048, 7795.41534384912, 7818.687252509836, 7871.212878712083, 7874.0, 7879.212078792075, 7027.7188912442925, 7090.503664743418, 7092.078029856086, 7097.82255443618, 7144.1784194818265, 7256.492045556972, 7261.673224705007, 7289.380402665621, 7317.707291708272, 7337.523061001231], "unit": "score", "name": "mootools.html", "value": 4861.7817978679}, {"lowerIsBetter": false, "replicates": [360.8830669079199, 370.7497439228521, 372.93660077786774, 376.536859662615, 381.8167279705741, 5932.0, 5951.1668366428685, 5971.522278217743, 5973.641581505112, 5978.163057172, 5914.792982245623, 5916.201312822767, 5917.704114794254, 5919.0, 5934.436228558291, 4434.889127771799, 4546.272596384579, 4610.953890461103, 4667.06658668266, 4668.4631267404175, 4643.187442197602, 4643.442786865581, 4653.86038418848, 4654.604358629521, 4678.087772884289, 4646.651501137411, 4655.4180727409075, 4656.976715116437, 4661.65037622178, 4670.719756814585, 4461.442319710036, 4507.954920450803, 4637.907241855178, 4650.697704649187, 4664.416947881515, 4127.9174416511805, 4141.213169497816, 4147.419361289422, 4148.502179738421, 4149.6265336119895, 5698.51562617178, 5698.772049118031, 5707.400722924116, 5713.74288157034, 5714.885702285931, 5410.323709536308, 5417.10617748075, 5425.077736784756, 5425.593080518937, 5427.83716488506, 6243.344448832852, 6244.0633904914175, 6248.0627905814035, 6250.937490625081, 6253.405926436982, 4458.554144585548, 4591.4260717410325, 4600.585947264763, 4609.539046095397, 4615.676902616819, 6416.133821934026, 6477.255115661665, 6507.804765857032, 6512.772052978123, 6522.217333919913, 4738.668293219511, 4745.715257084586, 4748.738819364969, 4751.00228951924, 4755.5719985201495, 4812.085703716282, 4813.4945830687975, 4816.036792641486, 4817.566419022305, 4819.638527110411, 5413.621046526705, 5415.539679127318, 5419.268398766195, 5422.728863556807, 5423.484768946943, 6161.661108639068, 6277.2153480814895, 6309.747610095545, 6320.810375688737, 6327.746890124436, 1685.7471379292958, 1692.2638652186092, 1702.114900251862, 1702.914854257307, 1704.0883127526713, 1094.8850370710961, 1145.707844499664, 1153.700037990112, 1160.2458402038742, 1177.4466000979526, 5985.431384018599, 5996.130561068708, 6017.488513476316, 6019.819405417845, 6020.969895150496, 6458.903116453257, 6525.836854078686, 6532.6733663316645, 6533.052707357501, 6536.0, 6012.068129439944, 6013.609115407485, 6017.736275382219, 6021.638701677914, 6022.57841951068, 3454.809985450824, 3454.9309013819584, 3484.843182056763, 3488.4767284907466, 3492.5634295713035, 6577.408033276933, 6603.438707709898, 6711.060451536789, 6720.932790672128, 6780.254172041072, 6702.095217145623, 6724.697388617524, 6728.687905858408, 6732.831679207961, 6749.32506749331, 6745.696443660047, 6746.628935408501, 6760.560563563353, 6771.052052712625, 6771.153605799275, 6574.211094668671, 6578.375054369827, 6580.7038683260325, 6582.934170658424, 6597.1423714916755, 6284.905726414016, 6445.581037232565, 6447.9032814508755, 6452.709628066655, 6465.515086368635, 6716.992451132369, 6754.3921047106, 6760.560563563353, 6767.729290828312, 6769.3907548320885, 4603.723776573416, 4629.976850115728, 4636.049609830045, 4645.279981602857, 4649.790759415902, 6599.60402375859, 6601.174853143357, 6607.2071351438135, 6613.900791488228, 6615.106960560262, 6123.479504242011, 6400.583962042452, 6404.231492220963, 6419.293877673359, 6431.549791514549, 6350.7777227796805, 6363.236411630634, 6392.456641185366, 6396.744130234739, 6407.807765767035, 6251.6561589113035, 6262.874742505033, 6264.404881536247, 6269.62382257066, 6271.874562508816, 6409.519286053472, 6426.29310775805, 6430.067640192239, 6442.420182183626, 6443.194600674916, 5995.640261584319, 6072.514198864169, 6230.50155987529, 6268.686565671789, 6272.6236425814595], "unit": "score", "name": "prototype.html", "value": 4846.462112235819}, {"lowerIsBetter": false, "replicates": [850.5789634131106, 925.3984909808628, 926.4811705444955, 946.3612061858244, 947.3984020147207, 14301.0, 14747.852521474782, 14756.852431475681, 14785.778213326808, 14800.0, 13892.305384730773, 13911.0, 13922.303884805744, 13937.094088884216, 13956.79064814026, 764.3808515102756, 922.6171138977317, 941.1247539787994, 962.191758922505, 963.2727290895364, 936.2650319499195, 938.249400479617, 938.2540880000382, 940.3041749105681, 940.9482478463716, 990.5790039233333, 1000.924930630202, 1001.7295330260825, 1001.8096561653299, 1003.413003393016, 813.2193094629133, 991.2813210422422, 1007.1489591295343, 1008.4201584089104, 1010.9342892711987, 743.8661041012616, 745.7501736918139, 747.1855677311702, 747.2266204478393, 747.3908764357031, 13450.730985380336, 13460.663483412894, 13504.662383440493, 13515.729685406335, 13523.39144738489, 13560.321983900863, 13932.512362067278, 13981.860181398259, 14012.579622611338, 14691.485797997018, 10957.123866589904, 11063.446827658585, 11078.833817492745, 11170.329780213213, 11170.776584468347, 3893.435451859493, 3898.9805050974564, 3899.863504777319, 3934.2721596504452, 3956.307646161939, 50002.49997500015, 50602.0, 51735.22397164046, 51801.48198518004, 52101.99999999962, 10565.313254638424, 10872.238943273895, 11021.83467247992, 11207.943960280309, 11604.071674266039, 19103.331383401513, 19105.331313404244, 19141.90429047846, 19151.616967660568, 19173.0, 8029.076656184497, 8160.795980100545, 8172.18278172178, 8336.124706905808, 8625.698100566575, 4365.367021781887, 4477.19410506112, 4489.573490518395, 4493.752843593568, 4626.629869610423, 3318.950215746766, 3384.509246159293, 3414.6414626463866, 3414.7438942078948, 3420.0, 590.3181824992141, 662.0367365483211, 662.6786008785735, 688.4079691465336, 698.5040621159034, 588.3496791499884, 738.1990540263766, 740.0896896816945, 750.3921823323126, 756.383547408871, 8774.649014039494, 8899.0, 9050.909490905138, 9114.544272786334, 9117.680881169128, 609.8627808742997, 623.2925629410652, 704.3168126916883, 721.469719755979, 727.6652739739673, 4098.364753463218, 4153.854615088458, 4162.188373267244, 4207.596022888902, 4247.129338485603, 56160.71919640457, 58815.11777323343, 58978.41021589815, 59274.70362648246, 59318.0, 50244.0, 50884.745576272624, 51320.0, 51351.0, 51793.0, 46776.5322346779, 47069.29396059062, 47369.5263047372, 48667.0, 49366.50633493691, 9090.500022498825, 9181.632734690806, 9314.394564353295, 9344.205742511962, 9404.482753448352, 34617.480737789454, 35105.82447087748, 37435.812820935724, 38605.80697096609, 39277.0, 42557.57442425536, 43526.782366087966, 43583.0, 44006.339904900815, 44786.55213447954, 12231.510739570318, 12560.874391255971, 12650.620481385573, 12685.302308373128, 12963.15739476931, 12759.170653907466, 13111.27887966171, 13116.540921067717, 13244.0, 13430.93284533571, 12754.936225318814, 12889.226646401246, 12889.8066529004, 12915.547955821501, 13370.197788132744, 12421.441035153259, 12445.128840981044, 12782.936085319514, 13110.672233194246, 13363.53227637028, 12317.815232771336, 12436.378181090728, 12510.687232819253, 12820.487180512675, 12866.549670761478, 10513.106385957279, 10539.935655336558, 10769.299995500267, 10823.56705731762, 11314.660560183207, 10437.373757574569, 10546.314489558154, 10651.840222396826, 10671.253012289066, 10881.347119172875], "unit": "score", "name": "yui.html", "value": 6868.789334014671}], "name": "dromaeo_css", "value": 7382.8601306598075}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 102.0, 109.0, 109.0, 110.0, 97.0, 109.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [161.0, 127.0, 150.0, 178.0, 126.0, 162.0, 156.0, 135.0, 170.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 161.0, 161.0, 162.0, 160.0, 160.0, 165.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 76.0, 167.0, 77.0, 75.0, 74.0, 75.0, 167.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 137.0, 93.0, 93.0, 93.0, 150.0, 93.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 57.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [84.0, 78.0, 78.0, 79.0, 79.0, 78.0, 78.0, 77.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [114.0, 119.0, 119.0, 123.0, 120.0, 120.0, 112.0, 111.0, 114.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 149.0, 146.0, 149.0, 135.0, 145.0, 145.0, 148.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 68.0, 70.0, 71.0, 66.0, 66.0, 70.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1507.5000000000002}]} 19:23:48 INFO - Return code: 0 19:23:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:23:48 INFO - # TBPL SUCCESS # 19:23:48 INFO - Running post-action listener: _resource_record_post_action 19:23:48 INFO - Running post-run listener: _resource_record_post_run 19:23:49 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 16384; Write bytes: 460255232; Read time: 24; Write time: 360816 19:23:49 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 235982848; Read time: 0; Write time: 246136 19:23:49 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 16384; Write bytes: 221962240; Read time: 24; Write time: 114580 19:23:49 INFO - Running post-run listener: _upload_blobber_files 19:23:49 INFO - Blob upload gear active. 19:23:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:23:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:23:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:23:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:50 INFO - (blobuploader) - INFO - Done attempting. 19:23:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:23:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:51 INFO - (blobuploader) - INFO - Done attempting. 19:23:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:23:51 INFO - Return code: 0 19:23:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:23:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:23:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd1a09f28c94ad0bd01e4fd09eec228cc63c3e9a0393e72f606a84be07f4d9d2a35f74991f6f2db382d4906792b687ebdb9d7593c994d02d529af4772dba188b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abec98a7aa82c0e0c32cc5d96c9989ef21e7c29f6b5ddc4f02ab514488c9bca1291016318b459e04c73a6d97ded20a8cbb9f47e02ab4e8db329e4771c740b16f"} 19:23:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:23:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:23:51 INFO - Contents: 19:23:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd1a09f28c94ad0bd01e4fd09eec228cc63c3e9a0393e72f606a84be07f4d9d2a35f74991f6f2db382d4906792b687ebdb9d7593c994d02d529af4772dba188b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abec98a7aa82c0e0c32cc5d96c9989ef21e7c29f6b5ddc4f02ab514488c9bca1291016318b459e04c73a6d97ded20a8cbb9f47e02ab4e8db329e4771c740b16f"} 19:23:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:23:51 INFO - Copying logs to upload dir... 19:23:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:23:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.637353 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-05 19:23:51.080765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 19:23:51.083914) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd1a09f28c94ad0bd01e4fd09eec228cc63c3e9a0393e72f606a84be07f4d9d2a35f74991f6f2db382d4906792b687ebdb9d7593c994d02d529af4772dba188b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abec98a7aa82c0e0c32cc5d96c9989ef21e7c29f6b5ddc4f02ab514488c9bca1291016318b459e04c73a6d97ded20a8cbb9f47e02ab4e8db329e4771c740b16f"} build_url:https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/c07wNs3MRaygqyux5eLOgg/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd1a09f28c94ad0bd01e4fd09eec228cc63c3e9a0393e72f606a84be07f4d9d2a35f74991f6f2db382d4906792b687ebdb9d7593c994d02d529af4772dba188b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/abec98a7aa82c0e0c32cc5d96c9989ef21e7c29f6b5ddc4f02ab514488c9bca1291016318b459e04c73a6d97ded20a8cbb9f47e02ab4e8db329e4771c740b16f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 19:23:51.108102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 19:23:51.108410) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1462487310.836617-179750267 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 19:23:51.190317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 19:23:51.190638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 19:23:51.190923) ========= ========= Total master_lag: 0.16 =========