builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1462797519.6 results: success (0) buildid: 20160509005545 builduid: ea7a7eff58c544d79701ff562c295d6e revision: fc51f034e4aca08b76934a832d7dc7db1954b9d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.605305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.605706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.605983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.621901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.622158) ========= 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=745a4373a2a16df560f216e000000264-1462797519.70920-53921241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 05:38:39-- 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% 42.1M=0s 2016-05-09 05:38:39 (42.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.756284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.756597) ========= 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=745a4373a2a16df560f216e000000264-1462797519.70920-53921241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017913 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.805492) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:39.805853) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc51f034e4aca08b76934a832d7dc7db1954b9d2 --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 fc51f034e4aca08b76934a832d7dc7db1954b9d2 --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=745a4373a2a16df560f216e000000264-1462797519.70920-53921241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 05:38:39,929 truncating revision to first 12 chars 2016-05-09 05:38:39,929 Setting DEBUG logging. 2016-05-09 05:38:39,929 attempt 1/10 2016-05-09 05:38:39,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc51f034e4ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:38:40,204 unpacking tar archive at: mozilla-beta-fc51f034e4ac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574967 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:40.393284) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:40.393605) ========= script_repo_revision: fc51f034e4aca08b76934a832d7dc7db1954b9d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:40.394003) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:40.394266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:38:40.404103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-09 05:38:40.404441) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1462797519.70920-53921241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:38:40 INFO - MultiFileLogger online at 20160509 05:38:40 in /builds/slave/test 05:38:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:38:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:40 INFO - {'append_to_log': False, 05:38:40 INFO - 'base_work_dir': '/builds/slave/test', 05:38:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:38:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:40 INFO - 'branch': 'Mozilla-Beta', 05:38:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:40 INFO - 'config_files': ('talos/linux_config.py',), 05:38:40 INFO - 'default_actions': ('clobber', 05:38:40 INFO - 'read-buildbot-config', 05:38:40 INFO - 'download-and-extract', 05:38:40 INFO - 'populate-webroot', 05:38:40 INFO - 'create-virtualenv', 05:38:40 INFO - 'install', 05:38:40 INFO - 'run-tests'), 05:38:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:40 INFO - 'download_minidump_stackwalk': True, 05:38:40 INFO - 'download_symbols': 'ondemand', 05:38:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:40 INFO - 'installer_path': 'installer.exe', 05:38:40 INFO - 'log_level': 'info', 05:38:40 INFO - 'log_name': 'talos', 05:38:40 INFO - 'log_to_console': True, 05:38:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:38:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:38:40 INFO - 'opt_config_files': (), 05:38:40 INFO - 'pip_index': False, 05:38:40 INFO - 'sps_profile': False, 05:38:40 INFO - 'sps_profile_interval': 0, 05:38:40 INFO - 'suite': 'dromaeojs-e10s', 05:38:40 INFO - 'system_bits': '32', 05:38:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:40 INFO - 'title': 'talos-linux64-ix-032', 05:38:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:40 INFO - 'use_talos_json': True, 05:38:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:40 INFO - 'work_dir': 'build'} 05:38:40 INFO - ##### 05:38:40 INFO - ##### Running clobber step. 05:38:40 INFO - ##### 05:38:40 INFO - Running pre-action listener: _resource_record_pre_action 05:38:40 INFO - Running main action method: clobber 05:38:40 INFO - rmtree: /builds/slave/test/build 05:38:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:41 INFO - Running post-action listener: _resource_record_post_action 05:38:41 INFO - ##### 05:38:41 INFO - ##### Running read-buildbot-config step. 05:38:41 INFO - ##### 05:38:41 INFO - Running pre-action listener: _resource_record_pre_action 05:38:41 INFO - Running main action method: read_buildbot_config 05:38:41 INFO - Using buildbot properties: 05:38:41 INFO - { 05:38:41 INFO - "project": "", 05:38:41 INFO - "product": "firefox", 05:38:41 INFO - "script_repo_revision": "production", 05:38:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:38:41 INFO - "repository": "", 05:38:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:38:41 INFO - "buildid": "20160509005545", 05:38:41 INFO - "pgo_build": "True", 05:38:41 INFO - "basedir": "/builds/slave/test", 05:38:41 INFO - "buildnumber": 88, 05:38:41 INFO - "slavename": "talos-linux64-ix-032", 05:38:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:38:41 INFO - "platform": "ubuntu64_hw", 05:38:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:38:41 INFO - "branch": "mozilla-beta", 05:38:41 INFO - "repo_path": "releases/mozilla-beta", 05:38:41 INFO - "revision": "fc51f034e4aca08b76934a832d7dc7db1954b9d2", 05:38:41 INFO - "stage_platform": "linux64-pgo", 05:38:41 INFO - "builduid": "ea7a7eff58c544d79701ff562c295d6e", 05:38:41 INFO - "slavebuilddir": "test" 05:38:41 INFO - } 05:38:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 05:38:41 INFO - Running post-action listener: _resource_record_post_action 05:38:41 INFO - ##### 05:38:41 INFO - ##### Running download-and-extract step. 05:38:41 INFO - ##### 05:38:41 INFO - Running pre-action listener: _resource_record_pre_action 05:38:41 INFO - Running main action method: download_and_extract 05:38:41 INFO - mkdir: /builds/slave/test/build/tests 05:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:41 INFO - https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:43 INFO - Downloaded 1412 bytes. 05:38:43 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:38:43 INFO - Using the following test package requirements: 05:38:43 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:38:43 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:38:43 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 05:38:43 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'jsshell-linux-x86_64.zip'], 05:38:43 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:38:43 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:38:43 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 05:38:43 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 05:38:43 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:38:43 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:38:43 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:38:43 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:38:43 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:38:43 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')]} 05:38:43 INFO - https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:38:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:38:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:38:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:44 INFO - Downloaded 23364546 bytes. 05:38:44 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'] 05:38:44 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 05:38:45 INFO - Return code: 0 05:38:45 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 05:38: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')]} 05:38:45 INFO - https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:38:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:38:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:38:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:46 INFO - Downloaded 23364546 bytes. 05:38:46 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'] 05:38:46 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 05:38:47 INFO - Return code: 0 05:38: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')]} 05:38:47 INFO - https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:38:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:38:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:38:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:48 INFO - Downloaded 10845194 bytes. 05:38:48 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'] 05:38:48 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 05:38:48 INFO - Return code: 0 05:38:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:48 INFO - https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EWijmSvnSMu5d-nG03i7PQ/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 05:38:50 INFO - Downloaded 53797050 bytes. 05:38:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:38:50 INFO - mkdir: /builds/slave/test/properties 05:38:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:38:50 INFO - Writing to file /builds/slave/test/properties/build_url 05:38:50 INFO - Contents: 05:38:50 INFO - build_url:https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:38:51 INFO - Running post-action listener: _resource_record_post_action 05:38:51 INFO - Running post-action listener: set_extra_try_arguments 05:38:51 INFO - ##### 05:38:51 INFO - ##### Running populate-webroot step. 05:38:51 INFO - ##### 05:38:51 INFO - Running pre-action listener: _resource_record_pre_action 05:38:51 INFO - Running main action method: populate_webroot 05:38:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:38:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:38:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:38:51 INFO - '--tppagecycles', 05:38:51 INFO - '7'], 05:38:51 INFO - 'tests': ['tsvgm']}}, 05:38:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:38:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:38:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:38:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:38:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:38:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'tests': ['damp', 'tps']}, 05:38:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['damp', 'tps']}, 05:38:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:38:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:38:51 INFO - 'other': {'tests': ['a11yr', 05:38:51 INFO - 'ts_paint', 05:38:51 INFO - 'tpaint', 05:38:51 INFO - 'sessionrestore', 05:38:51 INFO - 'sessionrestore_no_auto_restore', 05:38:51 INFO - 'tabpaint']}, 05:38:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['a11yr', 05:38:51 INFO - 'ts_paint', 05:38:51 INFO - 'tpaint', 05:38:51 INFO - 'sessionrestore', 05:38:51 INFO - 'sessionrestore_no_auto_restore', 05:38:51 INFO - 'tabpaint']}, 05:38:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['a11yr', 05:38:51 INFO - 'ts_paint', 05:38:51 INFO - 'tpaint', 05:38:51 INFO - 'sessionrestore', 05:38:51 INFO - 'sessionrestore_no_auto_restore', 05:38:51 INFO - 'tabpaint']}, 05:38:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['a11yr', 05:38:51 INFO - 'ts_paint', 05:38:51 INFO - 'tpaint', 05:38:51 INFO - 'sessionrestore', 05:38:51 INFO - 'sessionrestore_no_auto_restore', 05:38:51 INFO - 'tabpaint']}, 05:38:51 INFO - 'other_l64': {'tests': ['a11yr', 05:38:51 INFO - 'ts_paint', 05:38:51 INFO - 'tpaint', 05:38:51 INFO - 'sessionrestore', 05:38:51 INFO - 'sessionrestore_no_auto_restore', 05:38:51 INFO - 'tabpaint']}, 05:38:51 INFO - 'other_nol64': {'tests': ['a11yr', 05:38:51 INFO - 'ts_paint', 05:38:51 INFO - 'tpaint', 05:38:51 INFO - 'sessionrestore', 05:38:51 INFO - 'sessionrestore_no_auto_restore', 05:38:51 INFO - 'tabpaint']}, 05:38:51 INFO - 'svgr': {'tests': ['tsvgx', 05:38:51 INFO - 'tsvgr_opacity', 05:38:51 INFO - 'tart', 05:38:51 INFO - 'tscrollx', 05:38:51 INFO - 'cart']}, 05:38:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['tsvgx', 05:38:51 INFO - 'tsvgr_opacity', 05:38:51 INFO - 'tart', 05:38:51 INFO - 'tscrollx', 05:38:51 INFO - 'cart']}, 05:38:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'tests': ['tp5o']}, 05:38:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'talos_options': ['--e10s'], 05:38:51 INFO - 'tests': ['tp5o']}, 05:38:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'talos_options': ['--xperf_path', 05:38:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:51 INFO - 'tests': ['tp5n']}, 05:38:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:38:51 INFO - 'talos_options': ['--e10s', 05:38:51 INFO - '--xperf_path', 05:38:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:38:51 INFO - 'tests': ['tp5n']}}, 05:38:51 INFO - 'talos.zip': {'path': '', 05:38:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:38:51 INFO - Running post-action listener: _resource_record_post_action 05:38:51 INFO - ##### 05:38:51 INFO - ##### Running create-virtualenv step. 05:38:51 INFO - ##### 05:38:51 INFO - Running pre-action listener: _resource_record_pre_action 05:38:51 INFO - Running main action method: create_virtualenv 05:38:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:38:51 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 05:38:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:38:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:38:51 INFO - Using real prefix '/usr' 05:38:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:38:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:38:53 INFO - Installing pip.................done. 05:38:53 INFO - Return code: 0 05:38:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:38:53 INFO - Using env: {'DISPLAY': ':0', 05:38:53 INFO - 'HOME': '/home/cltbld', 05:38:53 INFO - 'LANG': 'en_US.UTF-8', 05:38:53 INFO - 'LANGUAGE': 'en_US:en', 05:38:53 INFO - 'LOGNAME': 'cltbld', 05:38:53 INFO - 'MAIL': '/var/mail/cltbld', 05:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:53 INFO - 'MOZ_NO_REMOTE': '1', 05:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:53 INFO - 'NO_EM_RESTART': '1', 05:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:53 INFO - 'PWD': '/builds/slave/test', 05:38:53 INFO - 'SHELL': '/bin/bash', 05:38:53 INFO - 'SHLVL': '1', 05:38:53 INFO - 'TERM': 'linux', 05:38:53 INFO - 'TMOUT': '86400', 05:38:53 INFO - 'USER': 'cltbld', 05:38:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:53 INFO - '_': '/tools/buildbot/bin/python'} 05:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:53 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 05:38:53 INFO - Cleaning up... 05:38:53 INFO - Return code: 0 05:38:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:38:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:38:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:38:53 INFO - Using env: {'DISPLAY': ':0', 05:38:53 INFO - 'HOME': '/home/cltbld', 05:38:53 INFO - 'LANG': 'en_US.UTF-8', 05:38:53 INFO - 'LANGUAGE': 'en_US:en', 05:38:53 INFO - 'LOGNAME': 'cltbld', 05:38:53 INFO - 'MAIL': '/var/mail/cltbld', 05:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:53 INFO - 'MOZ_NO_REMOTE': '1', 05:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:53 INFO - 'NO_EM_RESTART': '1', 05:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:53 INFO - 'PWD': '/builds/slave/test', 05:38:53 INFO - 'SHELL': '/bin/bash', 05:38:53 INFO - 'SHLVL': '1', 05:38:53 INFO - 'TERM': 'linux', 05:38:53 INFO - 'TMOUT': '86400', 05:38:53 INFO - 'USER': 'cltbld', 05:38:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:53 INFO - '_': '/tools/buildbot/bin/python'} 05:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:54 INFO - Downloading/unpacking psutil>=0.7.1 05:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:56 INFO - Installing collected packages: psutil 05:38:56 INFO - Running setup.py install for psutil 05:38:56 INFO - building 'psutil._psutil_linux' extension 05:38:56 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 05:38:56 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 05:38:56 INFO - building 'psutil._psutil_posix' extension 05:38:56 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 05:38:56 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 05:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:38:56 INFO - Successfully installed psutil 05:38:56 INFO - Cleaning up... 05:38:56 INFO - Return code: 0 05:38:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:38:56 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')]} 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:56 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')]} 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38:56 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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:38:56 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 05:38:56 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 05:38:56 INFO - Using env: {'DISPLAY': ':0', 05:38:56 INFO - 'HOME': '/home/cltbld', 05:38:56 INFO - 'LANG': 'en_US.UTF-8', 05:38:56 INFO - 'LANGUAGE': 'en_US:en', 05:38:56 INFO - 'LOGNAME': 'cltbld', 05:38:56 INFO - 'MAIL': '/var/mail/cltbld', 05:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:56 INFO - 'MOZ_NO_REMOTE': '1', 05:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:56 INFO - 'NO_EM_RESTART': '1', 05:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:56 INFO - 'PWD': '/builds/slave/test', 05:38:56 INFO - 'SHELL': '/bin/bash', 05:38:56 INFO - 'SHLVL': '1', 05:38:56 INFO - 'TERM': 'linux', 05:38:56 INFO - 'TMOUT': '86400', 05:38:56 INFO - 'USER': 'cltbld', 05:38:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:56 INFO - '_': '/tools/buildbot/bin/python'} 05:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:38:58 INFO - Installing collected packages: mozsystemmonitor 05:38:58 INFO - Running setup.py install for mozsystemmonitor 05:38:58 INFO - Successfully installed mozsystemmonitor 05:38:58 INFO - Cleaning up... 05:38:58 INFO - Return code: 0 05:38:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:38: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')]} 05:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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')]} 05:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:38: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', '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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:38: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 blobuploader==1.2.4 05:38:58 INFO - Using env: {'DISPLAY': ':0', 05:38:58 INFO - 'HOME': '/home/cltbld', 05:38:58 INFO - 'LANG': 'en_US.UTF-8', 05:38:58 INFO - 'LANGUAGE': 'en_US:en', 05:38:58 INFO - 'LOGNAME': 'cltbld', 05:38:58 INFO - 'MAIL': '/var/mail/cltbld', 05:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:38:58 INFO - 'MOZ_NO_REMOTE': '1', 05:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:38:58 INFO - 'NO_EM_RESTART': '1', 05:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:38:58 INFO - 'PWD': '/builds/slave/test', 05:38:58 INFO - 'SHELL': '/bin/bash', 05:38:58 INFO - 'SHLVL': '1', 05:38:58 INFO - 'TERM': 'linux', 05:38:58 INFO - 'TMOUT': '86400', 05:38:58 INFO - 'USER': 'cltbld', 05:38:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:38:58 INFO - '_': '/tools/buildbot/bin/python'} 05:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:38:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:01 INFO - Downloading docopt-0.6.1.tar.gz 05:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:01 INFO - Running setup.py install for blobuploader 05:39:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:01 INFO - Running setup.py install for requests 05:39:02 INFO - Running setup.py install for docopt 05:39:02 INFO - Successfully installed blobuploader requests docopt 05:39:02 INFO - Cleaning up... 05:39:02 INFO - Return code: 0 05:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:02 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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:39:02 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 05:39:02 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 05:39:02 INFO - Using env: {'DISPLAY': ':0', 05:39:02 INFO - 'HOME': '/home/cltbld', 05:39:02 INFO - 'LANG': 'en_US.UTF-8', 05:39:02 INFO - 'LANGUAGE': 'en_US:en', 05:39:02 INFO - 'LOGNAME': 'cltbld', 05:39:02 INFO - 'MAIL': '/var/mail/cltbld', 05:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:02 INFO - 'MOZ_NO_REMOTE': '1', 05:39:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:02 INFO - 'NO_EM_RESTART': '1', 05:39:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:02 INFO - 'PWD': '/builds/slave/test', 05:39:02 INFO - 'SHELL': '/bin/bash', 05:39:02 INFO - 'SHLVL': '1', 05:39:02 INFO - 'TERM': 'linux', 05:39:02 INFO - 'TMOUT': '86400', 05:39:02 INFO - 'USER': 'cltbld', 05:39:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:02 INFO - '_': '/tools/buildbot/bin/python'} 05:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:02 INFO - Running setup.py (path:/tmp/pip-3557GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:02 INFO - Running setup.py (path:/tmp/pip-XpjzGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:02 INFO - Running setup.py (path:/tmp/pip-VZRg9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:02 INFO - Running setup.py (path:/tmp/pip-JcnBaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:02 INFO - Running setup.py (path:/tmp/pip-kE5bLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:02 INFO - Running setup.py (path:/tmp/pip-sRaZ2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:02 INFO - Running setup.py (path:/tmp/pip-4SqEYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:03 INFO - Running setup.py (path:/tmp/pip-_2iKWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:03 INFO - Running setup.py (path:/tmp/pip-8Rr4gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:03 INFO - Running setup.py (path:/tmp/pip-QTiPiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:03 INFO - Running setup.py (path:/tmp/pip-VIguad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:03 INFO - Running setup.py (path:/tmp/pip-zS_EF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:03 INFO - Running setup.py (path:/tmp/pip-bGlc3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:03 INFO - Running setup.py (path:/tmp/pip-KiN50r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:03 INFO - Running setup.py (path:/tmp/pip-U5xgGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:03 INFO - Running setup.py (path:/tmp/pip-Knm52d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:03 INFO - Running setup.py (path:/tmp/pip-Mf2WeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:03 INFO - Running setup.py install for manifestparser 05:39:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:03 INFO - Running setup.py install for mozcrash 05:39:03 INFO - Running setup.py install for mozdebug 05:39:04 INFO - Running setup.py install for mozdevice 05:39:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozfile 05:39:04 INFO - Running setup.py install for mozhttpd 05:39:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozinfo 05:39:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozInstall 05:39:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozleak 05:39:04 INFO - Running setup.py install for mozlog 05:39:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for moznetwork 05:39:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:04 INFO - Running setup.py install for mozprocess 05:39:05 INFO - Running setup.py install for mozprofile 05:39:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:05 INFO - Running setup.py install for mozrunner 05:39:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:05 INFO - Running setup.py install for mozscreenshot 05:39:05 INFO - Running setup.py install for moztest 05:39:05 INFO - Running setup.py install for mozversion 05:39:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:05 INFO - Cleaning up... 05:39:05 INFO - Return code: 0 05:39:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:05 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')]} 05:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:05 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')]} 05:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:05 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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:39:05 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 05:39:05 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 05:39:05 INFO - Using env: {'DISPLAY': ':0', 05:39:05 INFO - 'HOME': '/home/cltbld', 05:39:05 INFO - 'LANG': 'en_US.UTF-8', 05:39:05 INFO - 'LANGUAGE': 'en_US:en', 05:39:05 INFO - 'LOGNAME': 'cltbld', 05:39:05 INFO - 'MAIL': '/var/mail/cltbld', 05:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:05 INFO - 'MOZ_NO_REMOTE': '1', 05:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:05 INFO - 'NO_EM_RESTART': '1', 05:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:05 INFO - 'PWD': '/builds/slave/test', 05:39:05 INFO - 'SHELL': '/bin/bash', 05:39:05 INFO - 'SHLVL': '1', 05:39:05 INFO - 'TERM': 'linux', 05:39:05 INFO - 'TMOUT': '86400', 05:39:05 INFO - 'USER': 'cltbld', 05:39:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:05 INFO - '_': '/tools/buildbot/bin/python'} 05:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:05 INFO - Running setup.py (path:/tmp/pip-8wDiW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:05 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)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:05 INFO - Running setup.py (path:/tmp/pip-XvtP91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:05 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)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:05 INFO - Running setup.py (path:/tmp/pip-_5GWpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:05 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)) 05:39:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:05 INFO - Running setup.py (path:/tmp/pip-e6RiHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:06 INFO - Running setup.py (path:/tmp/pip-fpDQRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:06 INFO - Running setup.py (path:/tmp/pip-iTiqze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:06 INFO - Running setup.py (path:/tmp/pip-nS4_yM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:06 INFO - Running setup.py (path:/tmp/pip-6vXqv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:06 INFO - Running setup.py (path:/tmp/pip-EL2Ogi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:06 INFO - Running setup.py (path:/tmp/pip-ETfHRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:06 INFO - Running setup.py (path:/tmp/pip-MTC8_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:06 INFO - Running setup.py (path:/tmp/pip-KKVvU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:06 INFO - Running setup.py (path:/tmp/pip-LhaeeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:06 INFO - Running setup.py (path:/tmp/pip-AGSj7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:06 INFO - Running setup.py (path:/tmp/pip-24OwWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:06 INFO - Running setup.py (path:/tmp/pip-n2RAVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:06 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)) 05:39:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:06 INFO - Running setup.py (path:/tmp/pip-aezDi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:07 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)) 05:39:07 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)) 05:39:07 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)) 05:39:07 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)) 05:39:07 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)) 05:39:07 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)) 05:39:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:39:08 INFO - Downloading blessings-1.6.tar.gz 05:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:08 INFO - Installing collected packages: blessings 05:39:08 INFO - Running setup.py install for blessings 05:39:09 INFO - Successfully installed blessings 05:39:09 INFO - Cleaning up... 05:39:09 INFO - Return code: 0 05:39:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:09 INFO - Reading from file tmpfile_stdout 05:39:09 INFO - Current package versions: 05:39:09 INFO - argparse == 1.2.1 05:39:09 INFO - blessings == 1.6 05:39:09 INFO - blobuploader == 1.2.4 05:39:09 INFO - docopt == 0.6.1 05:39:09 INFO - manifestparser == 1.1 05:39:09 INFO - mozInstall == 1.12 05:39:09 INFO - mozcrash == 0.17 05:39:09 INFO - mozdebug == 0.1 05:39:09 INFO - mozdevice == 0.48 05:39:09 INFO - mozfile == 1.2 05:39:09 INFO - mozhttpd == 0.7 05:39:09 INFO - mozinfo == 0.9 05:39:09 INFO - mozleak == 0.1 05:39:09 INFO - mozlog == 3.1 05:39:09 INFO - moznetwork == 0.27 05:39:09 INFO - mozprocess == 0.22 05:39:09 INFO - mozprofile == 0.28 05:39:09 INFO - mozrunner == 6.11 05:39:09 INFO - mozscreenshot == 0.1 05:39:09 INFO - mozsystemmonitor == 0.0 05:39:09 INFO - moztest == 0.7 05:39:09 INFO - mozversion == 1.4 05:39:09 INFO - psutil == 3.1.1 05:39:09 INFO - requests == 1.2.3 05:39:09 INFO - wsgiref == 0.1.2 05:39:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:39:09 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 05:39:09 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 05:39:09 INFO - Using env: {'DISPLAY': ':0', 05:39:09 INFO - 'HOME': '/home/cltbld', 05:39:09 INFO - 'LANG': 'en_US.UTF-8', 05:39:09 INFO - 'LANGUAGE': 'en_US:en', 05:39:09 INFO - 'LOGNAME': 'cltbld', 05:39:09 INFO - 'MAIL': '/var/mail/cltbld', 05:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:09 INFO - 'MOZ_NO_REMOTE': '1', 05:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:09 INFO - 'NO_EM_RESTART': '1', 05:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:09 INFO - 'PWD': '/builds/slave/test', 05:39:09 INFO - 'SHELL': '/bin/bash', 05:39:09 INFO - 'SHLVL': '1', 05:39:09 INFO - 'TERM': 'linux', 05:39:09 INFO - 'TMOUT': '86400', 05:39:09 INFO - 'USER': 'cltbld', 05:39:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:09 INFO - '_': '/tools/buildbot/bin/python'} 05:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 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)) 05:39:09 INFO - Cleaning up... 05:39:09 INFO - Return code: 0 05:39:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:39:09 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 05:39:09 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 05:39:09 INFO - Using env: {'DISPLAY': ':0', 05:39:09 INFO - 'HOME': '/home/cltbld', 05:39:09 INFO - 'LANG': 'en_US.UTF-8', 05:39:09 INFO - 'LANGUAGE': 'en_US:en', 05:39:09 INFO - 'LOGNAME': 'cltbld', 05:39:09 INFO - 'MAIL': '/var/mail/cltbld', 05:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:09 INFO - 'MOZ_NO_REMOTE': '1', 05:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:09 INFO - 'NO_EM_RESTART': '1', 05:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:09 INFO - 'PWD': '/builds/slave/test', 05:39:09 INFO - 'SHELL': '/bin/bash', 05:39:09 INFO - 'SHLVL': '1', 05:39:09 INFO - 'TERM': 'linux', 05:39:09 INFO - 'TMOUT': '86400', 05:39:09 INFO - 'USER': 'cltbld', 05:39:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:09 INFO - '_': '/tools/buildbot/bin/python'} 05:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:09 INFO - Downloading/unpacking jsonschema 05:39:09 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 05:39:09 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 05:39:09 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 05:39:09 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 05:39:09 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 05:39:09 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 05:39:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:11 INFO - Downloading/unpacking functools32 (from jsonschema) 05:39:11 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 05:39:11 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 05:39:11 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 05:39:11 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 05:39:11 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 05:39:11 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 05:39:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:11 INFO - warning: no files found matching '*.txt' 05:39:11 INFO - no previously-included directories found matching 'build' 05:39:11 INFO - no previously-included directories found matching 'dist' 05:39:11 INFO - no previously-included directories found matching '.git*' 05:39:11 INFO - Installing collected packages: jsonschema, functools32 05:39:11 INFO - Running setup.py install for functools32 05:39:12 INFO - warning: no files found matching '*.txt' 05:39:12 INFO - no previously-included directories found matching 'build' 05:39:12 INFO - no previously-included directories found matching 'dist' 05:39:12 INFO - no previously-included directories found matching '.git*' 05:39:12 INFO - Successfully installed jsonschema functools32 05:39:12 INFO - Cleaning up... 05:39:12 INFO - Return code: 0 05:39:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:12 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 0x7f03e30adf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1af68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc3410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, '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': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', '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 05:39:12 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 05:39:12 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 05:39:12 INFO - Using env: {'DISPLAY': ':0', 05:39:12 INFO - 'HOME': '/home/cltbld', 05:39:12 INFO - 'LANG': 'en_US.UTF-8', 05:39:12 INFO - 'LANGUAGE': 'en_US:en', 05:39:12 INFO - 'LOGNAME': 'cltbld', 05:39:12 INFO - 'MAIL': '/var/mail/cltbld', 05:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:12 INFO - 'MOZ_NO_REMOTE': '1', 05:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:12 INFO - 'NO_EM_RESTART': '1', 05:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:12 INFO - 'PWD': '/builds/slave/test', 05:39:12 INFO - 'SHELL': '/bin/bash', 05:39:12 INFO - 'SHLVL': '1', 05:39:12 INFO - 'TERM': 'linux', 05:39:12 INFO - 'TMOUT': '86400', 05:39:12 INFO - 'USER': 'cltbld', 05:39:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:12 INFO - '_': '/tools/buildbot/bin/python'} 05:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:12 INFO - Downloading/unpacking flake8 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:39:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:39:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 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 05:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:39:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:14 INFO - no previously-included directories found matching 'docs/_build' 05:39:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:39:15 INFO - Running setup.py install for pep8 05:39:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:39:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:39:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:39:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:39:15 INFO - no previously-included directories found matching 'docs/_build' 05:39:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:39:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:39:15 INFO - Cleaning up... 05:39:15 INFO - Return code: 0 05:39:15 INFO - Running post-action listener: _resource_record_post_action 05:39:15 INFO - Running post-action listener: _start_resource_monitoring 05:39:15 INFO - Starting resource monitoring. 05:39:15 INFO - ##### 05:39:15 INFO - ##### Running install step. 05:39:15 INFO - ##### 05:39:15 INFO - Running pre-action listener: _resource_record_pre_action 05:39:15 INFO - Running main action method: install 05:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:15 INFO - Reading from file tmpfile_stdout 05:39:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:15 INFO - Reading from file tmpfile_stdout 05:39:15 INFO - Output received: 05:39:15 INFO - Usage: mozinstall [options] installer 05:39:15 INFO - Options: 05:39:15 INFO - -h, --help show this help message and exit 05:39:15 INFO - -d DEST, --destination=DEST 05:39:15 INFO - Directory to install application into. [default: 05:39:15 INFO - "/builds/slave/test"] 05:39:15 INFO - --app=APP Application being installed. [default: firefox] 05:39:15 INFO - mkdir: /builds/slave/test/build/application 05:39:15 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'] 05:39:15 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 05:39:29 INFO - Reading from file tmpfile_stdout 05:39:29 INFO - Output received: 05:39:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:39:29 INFO - Running post-action listener: _resource_record_post_action 05:39:29 INFO - ##### 05:39:29 INFO - ##### Running run-tests step. 05:39:29 INFO - ##### 05:39:29 INFO - Running pre-action listener: _resource_record_pre_action 05:39:29 INFO - Running main action method: run_tests 05:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:29 INFO - Python 2.7.3 05:39:29 INFO - Return code: 0 05:39:29 INFO - grabbing minidump binary from tooltool 05:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:39:29 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 0x1c52160>, '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 0x1c53060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c534f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:29 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 05:39:29 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 05:39:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:29 INFO - Return code: 0 05:39:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:39:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:39:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:39:30 INFO - Return code: 0 05:39:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:39:30 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:39:30 INFO - Using env: {'DISPLAY': ':0', 05:39:30 INFO - 'HOME': '/home/cltbld', 05:39:30 INFO - 'LANG': 'en_US.UTF-8', 05:39:30 INFO - 'LANGUAGE': 'en_US:en', 05:39:30 INFO - 'LOGNAME': 'cltbld', 05:39:30 INFO - 'MAIL': '/var/mail/cltbld', 05:39:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:30 INFO - 'MOZ_NO_REMOTE': '1', 05:39:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:39:30 INFO - 'NO_EM_RESTART': '1', 05:39:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:30 INFO - 'PWD': '/builds/slave/test', 05:39:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:30 INFO - 'SHELL': '/bin/bash', 05:39:30 INFO - 'SHLVL': '1', 05:39:30 INFO - 'TERM': 'linux', 05:39:30 INFO - 'TMOUT': '86400', 05:39:30 INFO - 'USER': 'cltbld', 05:39:30 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462797519.70920-53921241', 05:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:30 INFO - '_': '/tools/buildbot/bin/python'} 05:39:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:39:30 INFO - mozversion application_buildid: 20160509005545 05:39:30 INFO - mozversion application_changeset: fc51f034e4aca08b76934a832d7dc7db1954b9d2 05:39:30 INFO - mozversion application_display_name: Firefox 05:39:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:30 INFO - mozversion application_name: Firefox 05:39:30 INFO - mozversion application_remotingname: firefox 05:39:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:39:30 INFO - mozversion application_vendor: Mozilla 05:39:30 INFO - mozversion application_version: 47.0 05:39:30 INFO - mozversion platform_buildid: 20160509005545 05:39:30 INFO - mozversion platform_changeset: fc51f034e4aca08b76934a832d7dc7db1954b9d2 05:39:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:39:30 INFO - mozversion platform_version: 47.0 05:39:30 INFO - using testdate: 1462797570 05:39:30 INFO - actual date: 1462797570 05:39:30 INFO - starting webserver on 'localhost:33229' 05:39:30 INFO - SUITE-START | Running 2 tests 05:39:30 INFO - TEST-START | dromaeo_css 05:39:30 INFO - operating with platform_type : linux_ 05:39:30 INFO - Initialising browser for dromaeo_css test... 05:39:30 INFO - TEST-INFO | started process 10114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAToNCG/profile http://localhost:33229/getInfo.html) 05:39:34 INFO - PROCESS | 10114 | 05:39:34 INFO - PROCESS | 10114 | (process:10189): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:39:35 INFO - PROCESS | 10114 | __metrics Screen width/height:1600/1200 05:39:35 INFO - PROCESS | 10114 | colorDepth:24 05:39:35 INFO - PROCESS | 10114 | Browser inner width/height: 1024/697 05:39:35 INFO - PROCESS | 10114 | __metrics 05:39:36 ERROR - PROCESS | 10114 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:39:37 INFO - TEST-INFO | 10114: exit 0 05:39:37 INFO - Browser initialized. 05:39:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:37 INFO - TEST-INFO | started process 10239 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAToNCG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:38 INFO - PROCESS | 10239 | 05:39:38 INFO - PROCESS | 10239 | (process:10308): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:39:48 INFO - PROCESS | 10239 | RSS: Main: 149696512 05:39:48 INFO - PROCESS | 10239 | 05:40:38 INFO - PROCESS | 10239 | 1462797638610 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] 05:42:46 INFO - PROCESS | 10239 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33229/tests/dromaeo/cssquery-ext.html) 05:42:47 INFO - PROCESS | 10239 | RSS: Main: 153460736 05:42:47 INFO - PROCESS | 10239 | 05:45:49 INFO - PROCESS | 10239 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-ext.html (next: http://localhost:33229/tests/dromaeo/cssquery-jquery.html) 05:45:50 INFO - PROCESS | 10239 | RSS: Main: 152506368 05:45:50 INFO - PROCESS | 10239 | 05:48:51 INFO - PROCESS | 10239 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33229/tests/dromaeo/cssquery-mootools.html) 05:48:52 INFO - PROCESS | 10239 | RSS: Main: 151638016 05:48:52 INFO - PROCESS | 10239 | 05:51:53 INFO - PROCESS | 10239 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33229/tests/dromaeo/cssquery-prototype.html) 05:51:54 INFO - PROCESS | 10239 | RSS: Main: 152641536 05:51:54 INFO - PROCESS | 10239 | 05:54:56 INFO - PROCESS | 10239 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33229/tests/dromaeo/cssquery-yui.html) 05:54:57 INFO - PROCESS | 10239 | RSS: Main: 151146496 05:54:57 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | Cycle 1(1): loaded http://localhost:33229/tests/dromaeo/cssquery-yui.html (next: http://localhost:33229/tests/dromaeo/cssquery-dojo.html) 05:57:59 INFO - PROCESS | 10239 | RSS: Main: 155242496 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | __start_tp_report 05:57:59 INFO - PROCESS | 10239 | _x_x_mozilla_page_load 05:57:59 INFO - PROCESS | 10239 | _x_x_mozilla_page_load_details 05:57:59 INFO - PROCESS | 10239 | |i|pagename|runs| 05:57:59 INFO - PROCESS | 10239 | |0;dojo.html;3353.1281866714653;3383.08656662701;3396.60938992016;3417.41903876341;3448.0345503259095;5481.451854814517;5495.972520137394;5499.972500137499;5514.338279406466;5526.944730552698;5458.972705136469;5463.262459567957;5478.91781623276;5488;5519.254900588419;5004.874878128057;5016.423111342206;5058.367704036996;5088.389393272794;5103.872403189931;5037.370328708911;5050.924236136461;5058.291839142523;5094.821681241157;5116.616253780981;5128.820491282806;5156.329677141966;5171.508706672879;5173.172292433212;5198.012377648253;5029.094762942669;5035.144025515671;5068.974655126738;5080.441151473354;5085.440601533828;5042.722650254234;5044.218146187347;5101.642884998052;5112.9744351278005;5122.129238029544;5384.138537833927;5408.756605952742;5414.945850541483;5437.265969094161;5438.374586922476;5880.7353669085;5958.106284057426;6001.879962400728;6003.729832157564;6024.879502409927;6006.819795406145;6034.818955431344;6037.154798328237;6078.817635470943;6083.969580152115;5622.437756224344;5629.971850140764;5631.4087020863035;5637.9718101409235;5648.604597678123;5837.211976383134;6110.816675499742;6117.583823141572;6119.479844213202;6120.357362476965;5901.58688891782;5925.318588362394;5926.259217597801;5932.644041357532;5959.314678811906;5992.490638295793;5996.4603185713495;6003.549733769984;6008.819735407945;6014.0377539593455;5867.413258674099;5967.8209653710455;5968.104784282305;6029.065494848305;6077.513798896166;6014.879702405928;6047.092936059538;6050.697465126814;6054.727537260834;6056.697165141725;4587.839425620087;4593.655475839326;4600.171969045604;4601.12578610063;4626.583607475343;4078.2455245779624;4090.1001779608437;4131.049858532554;4153.792310384469;4174.290370636999;5613.775448981995;5708.571857110734;5726.885462290731;5790.565707571949;5810.360860305363;5983.282006159288;5986.281646202484;5987.820365389045;5993.910091348634;6001.5798894077;5564.916526252109;5694.174344719992;5704.543636509069;5709.600327977002;5749.597528172988;5109.616778741609;5134.101532231844;5138.537531622172;5139.794408223629;5161.354830646169;6252.187215661935;6257.468115210167;6258.624482530971;6268.373162683695;6275.403836635513;5966.134910438049;6016.2780466342565;6033.9698301508215;6070.484008859296;6100.328963814066;6201.162843016135;6202.2867370253;6214.223222097238;6222.28443728977;6244.812655620339;5898.174255604133;5898.587098903035;5905.911411328748;5912.881742365043;5935.643861368331;5866.853328666817;6000.699965001645;6032.939670603238;6070.332263451105;6072.271327440735;5805.390434004537;5829.562782791223;5846.239988801429;5849.824505264849;5858.121281807763;5704.286964129484;5777.046787280052;5830.5627077968475;5840;5840.707964601668;5720.399358067343;5796.21751063601;5809.477147056785;5827.1841942127285;5865.794697185578;5814.127880817911;5834.299884013945;5865.736041878211;5879.647221166743;5890.676012819336;5688.800891968926;5739.741711623071;5757;5759.65442073477;5842.853928651818 05:57:59 INFO - PROCESS | 10239 | |1;ext.html;511.55494719593935;547.9671219726816;566.0377358490567;578.485148218086;604.8971674815281;38771.80614096929;39147.21705565887;39444.60555394445;39489.21021579567;39681.404778928336;43421.7828910855;43567.34648980268;43616.34575481362;43782.12435751283;43873.56126438743;8747.518886461243;8941.865872011926;8947.105289471034;8956.776080597972;9014;8809.339299552526;8990.37067405282;8992.325575581825;8997.100289971017;9011.864822027675;9171.128742769426;9241.861372079424;9306.534673266344;9315.860262096074;9339.392939458947;9166.083391660848;9190.126937940919;9226.354155209137;9232.6306947722;9249.53752312385;8968.551572421353;9102.317326200562;9140.360174787767;9141.268698504104;9176.082391760838;42083.7895810522;42520.362194567104;42539;42544.3618345722;42553.1489370214;3557.484164796116;3658.9817050914576;3799.4490798834013;3853.4412510185866;4243.61807437329;31407.842960785278;31419.842900785578;31807.84096079505;32026.199345016328;32590.511142332885;4222.619964203236;4237.343211802176;4250.723702959298;4285.957140428587;4308.224519586473;278397;279702;282026;283103;283285;48576.27135592969;49263.261051084264;73138;74727.25272747311;74834.6258268716;48738;48808.26787598189;48999.75500122548;49429.75285123551;49460.50539494631;16860.409885653942;17014.659706805796;17137.657246854993;17154.31382744701;17158.142092895305;13243.801342979863;13542.864571354357;13599.86400135986;13610.387532561059;13615.863841361459;16448.424305149263;16471.91764041196;16513.33946642145;16656.08391538477;16667;6550.574212676161;6693.397594216543;6756.898646520306;6757.256701762803;6824.658767061627;1046.377405443775;1140.6121918547733;1151.050383433654;1196.3360335013977;1218.774526712561;29783.702162978094;29995.250118746768;30321;30741.69258307433;30989.380212395627;1141.6460897121754;1175.3594291111365;1195.946182421793;1237.3194742891374;1257.7107265329025;15765;15805.841941580667;15956.601084972968;15995.440159594358;16267.430639927547;318160;545411;546590;547174;814062;62498.68750656309;62898.37101629017;63491;63768.681156594845;64287.35712642907;1492.3433689176727;1518.840521745223;1524.3140586736013;1533.394309247841;1544.1584336536614;31696;32187.67812321847;32272.354552908342;32421.35157296794;32598.837005814818;50097.49902500928;50478.49521504738;50527.74736126443;50614.746926266605;50644.49355506398;251971;253899;255243;255571;255889;34569.82715086408;35503;35531.28937421289;35719.64280357163;36198.8190059048;46796;46917.2962405571;46976.29535557038;47289.52710472851;47440.7627961858;39673.603263966994;39824.402633961094;39999;40298.79850600728;40498.59501404948;39303.213935721695;39494.60505395024;39693.80153099216;40087;40371.59628403796;39562.406563900986;39671.20657586774;39780.40329395003;40096.59903400928;40307.79846100751;34378.312433751686;34742.13144671403;35162.29675406529;35163.29673406569;35689.46465803067;27250.454990900467;27735.30661733473;27942.580861287504;30345.696543034286;31498.212544685648 05:57:59 INFO - PROCESS | 10239 | |2;jquery.html;375.57372382346034;385.87441722051386;393.5277666799839;396.3400937439164;396.34998602292245;17386.391476298315;18826;18855;19294.32469863555;19379.99999999998;17649.82350176498;18148.546286342815;18168.818311816878;18316.633667326645;18566.628667426645;4302.5267220605865;5605.607607467479;5872.61827981182;5895.911561326584;5905.291365036202;4460.353248778925;6185.288691800455;6442.420182183626;6446.871062578745;6453.193350831146;6062.939370606282;6329.36706329368;6337.081123237128;6368.617882927016;6477.963525835868;6356.68216589171;6382.872342553146;6392.456641185505;6403.199600049994;6421.165248517709;5496.587755918322;5664.122061080539;5666.291713535808;5734.512566431858;5739.282589676291;22001.889990550106;22148.778512214994;22324.107035718553;22670.773292267197;22687.09251629933;2417.6857008588945;2449.5835707929696;2450.0444826517673;2716.9403932466353;2914.3588410549646;13506.392212350467;13905.930470347583;14009.08940918837;14119.294035298297;14277.071990320595;1869.560653246486;1885.7171424286466;1917.7890432052602;1921.2123029557815;2005.0776642744356;60826.391736082514;63785.36214637887;63996.36003639997;64495.355046449404;65674;10092.495375231356;10569.682909512727;10732.302400343953;10777.407242601575;10850.620228291971;15265.923670381799;15349.6162595936;15351.15568643713;15367.231638418034;15370.385184592715;8088.272055515032;8187.4678145920325;8294.212049855254;8299.751007469786;8354.081051084377;7929.167437419103;7939.603019848984;8008.7597372078935;8025.5585942773705;8057.194280571896;4634.165850146938;4722.598579120813;4724.527547245248;4749.572538471554;4784.138855006132;1924.8267655910756;1943.280986035176;1966.4887129346187;1985.9106340214726;1995.1520603743352;949.7435692363161;987.6543209876629;1027.6197806811529;1037.3205550364523;1053.6891616973012;15430;15535.611609709847;16854.57863553421;17262.309507619804;17687.73468397975;964.8890377606525;987.8863930648067;996.4220751963844;1032.2670903658336;1059.5496913811598;7623.733169339046;9754.365966212174;9789.706308810748;9791.314607977516;9795.461249631338;424725;431826;432589;433824;469820;77641;78552.21447785449;79871;80655.19344806594;81718;1098.7198264442516;1111.9444027798577;1119.0711709281277;1156.7628636129741;1163.116031815826;15919.68160636804;15970.60073498172;15987.760183597024;16079.678406431573;16405.097719625534;35262.64737352696;35969.28061438809;36377.81811090928;36674.44988325124;36734.081647959014;50970.49029509806;50994;51461.48538514716;51568.48431515787;51572.22641660303;8370.66517339324;8462.899823022968;8571.95714021426;8597.914020859711;8616.35377346689;10981.61564345276;12465.189762665397;12685.112042156961;12905.741885162432;13101.410436530188;10682.73293167677;10781.299215550964;10942.398168100832;11170;11200.327980321206;10794.352338859693;10974.670759876897;10980.560777569128;11275.379854108103;11388.886111138783;10949.616763413242;11062.889371106508;11151.832722509007;11250.324980501196;11682.24065435744;8373.790655233668;8393.118722534045;8458.788530286545;8487.745367638981;8502.107278735892;10120.848187277345;11304.943475282571;11474.541018359172;11485.310881346812;11537.82693259585 05:57:59 INFO - PROCESS | 10239 | |3;mootools.html;1604.310146636946;1607.3731244814521;1853.3142737187234;1927.8746881452696;1990.8009199080093;7371.778846634596;8126;8140.3894707896925;8418.326533877298;8434.746957591275;8060;8161.877571836427;8193.057798353191;8199.057108432533;8210.425270231086;2441.9389515262174;2470.481198948223;2477.6531285620026;2479.9008039678392;2482.7020757509126;2431.744666809986;2455.238875948453;2455.287966489716;2465.654808326836;2469.7283298837206;2359.917402890899;2363.3265914095227;2365.44412063165;2372.478054827935;2383.5232953409386;2424.842385244971;2451.9264422067276;2457.9016839326496;2462;2472.1471092473066;2445.400876785181;2455.0548039004934;2483.8882250298598;2486.4405508760565;2495.2015355086196;8471.576421178916;8472.110428405053;8484.02433720124;8489.108643592395;8498.78753031173;5244.8688782780355;5377.1665391863935;5379.193121031837;5384.273123128367;5389.110796718537;3221.291315910496;3226.8709251629907;3241.1248962780155;3290.7531935104726;3297.225152089257;987.284218941269;2019.1317733374642;2028.9391318260475;2079.1683326669304;2101.8843963582;11256.943715281372;11275.26710763806;11287;11333.320000799897;11379.089672826236;4430.689851710414;4526.0721552082405;4589.609883159968;4590.701604395704;4609.262517997171;9115.225205857576;9154.130357616015;9163.77090572741;9182.67860624875;9199.080091990747;5277.445868183785;5290.127129023745;5291.126964050888;5317.335333083364;5317.867053323698;4756.500567440438;4830.275458681155;4876.097921884463;4888.560029597354;4889.755512224375;3707.462417949382;3771.981140094282;3791.0711875590655;3795.8291876865055;3805.923881522354;1090.0679918669582;1093.9015488606065;1095.424901926495;1112.7496313329436;1118.0384869012642;1463.7292100961356;1464.9487267945572;1465.2893346726828;1489.47868246113;1498.685276092011;8060.073091594424;8101.027876654839;8120.390970677223;8130.3495720342235;8156.34749220061;498.7605949144431;510.3212727072984;515.8813472901254;516.5402791515554;517.4902720819989;6004.819855404345;6021.879562408727;6120.234970628671;6138.048602466625;6178.938210617836;9972.202223822222;10299.845502317472;10307.793844123076;10350.585976560853;10391.116755075753;10106.545205465625;10137.898621013843;10197.337173083726;10232.079112879877;10285.537150828231;8028.11690714021;8054.959725201336;8089.31240844523;8101.959490202511;8134.75595732129;7709;7720.3437707795465;7780.688772449265;7815.92184078152;7887.9605601971625;9055.773605659911;9245.76885577839;9350.485723285012;9436.622535098519;9476.85784713216;9437.150656440954;9440.575174117044;9571.042895710652;9605.663801766905;9645.42127472354;7028.789136325919;7200.927990720235;7706.422018348534;8027.598620068857;8039.196080391914;7950.840983180188;8002.799930001564;8014.759557213293;8058.556779376956;8065.637046333047;7191.856162876608;7347.33873951347;7374.483786135133;7437.851242975218;7499.475036747375;7161.248068952685;7197.280271972761;7205.891911621225;7307.67115479794;7341;7522.6614802335125;7579.848403032019;7606.239376062349;7619.580923049286;7655.732049378245;7141.571505709674;7177.677004534704;7187.425005999403;7247.4926755126635;7249.05762250904;7280.871464922945;7315.890261645973;7367.926320736939;7368.263173682589;7381 05:57:59 INFO - PROCESS | 10239 | |4;prototype.html;356.0191671943795;363.99636003639955;364.1696930997326;364.44604201613566;368.25612263228277;6342.746290148389;6344.3338449462835;6355.586886852358;6366.872662546746;6426.710798014089;6311.684415779204;6322.114903913456;6328.335524769902;6332.620042797424;6346.492280617551;4672.929906051412;4718.245080787075;4860.902781944359;4893.09477746618;4930.704157750529;4903.681260718042;4905.901881962359;4926.408830940274;4928.211486162215;4936.925946110811;4816.879578010543;4839.588634966032;4871.8782030449165;4873.5613794758465;4881.096997055538;4884.755762211875;4897.6326775491625;4899.216125419951;4900.166971614834;4910.091633047898;4339.349097635349;4342.5874541918465;4343.087951530151;4350.7607081610495;4351.28203846365;5927.110933359987;6009.969950150265;6055.2430946131735;6057.151998720183;6059.727312270914;5699.059655156894;5719.771209151629;5720.08478643415;5720.8855822883725;5729.455701708331;6720.092787473677;6723.495737819683;6724.327567243286;6731.057651928734;6740.224874139439;4752.310914917318;4760.619150467955;4762.071396077767;4762.857114286577;4771.522847715235;7007.089078419773;7012.614306213156;7013.859722805515;7020.578765274049;7027.648617569101;4812.302216178635;4916.041371932439;4918.1884988977135;4919.655624106278;4922.630802689812;4948.554630083309;4987.700737955734;4988;4988.700677959334;4997.700137991732;5697.259356283656;5705.315362156485;5706.744516206428;5707.514861236758;5728.083506638918;6745.763898263537;6798.286179951133;6799.898001529981;6801.285864984205;6807.65961701913;1747.4495533907034;1775.1922875092062;1775.9822401776075;1776.1740790532465;1779.4394765648779;1153.2042890405594;1170.7658468306372;1174.1018121137338;1177.4995626858552;1194.6774370919977;6494.772682956074;6525.706343214567;6549.345065493412;6554.246261679872;6579.539432239697;6957.443404527626;6979.511434199659;7014.508984371147;7015.684294206773;7023.33278338557;6407.551471397051;6625.204975402982;6633.635150066792;6639.668016599151;6645.734170633121;3816.5229346331707;3845.7692538447222;3850.0952276215066;3850.634189751969;3854.768713877176;7410.18487966334;7412.18465968743;7434.293742094493;7438.256174382518;7447.292507211806;7222.349988501061;7259.201487836333;7268.347053325499;7278.526895751759;7316.743913962986;7122.501424900311;7386.852262954818;7395.778126656209;7431.888521672179;7441.888371674429;7042.542234754725;7079.539829911039;7083.6812343443635;7101.893471598033;7111.466640002124;6965.303469652994;6979.092717946837;6994.2656021117045;6995.860082798417;7016.19313778922;7288.271172882669;7366.815829604303;7429.8142546436775;7432.665530051268;7433.962830185815;4749.168895443353;4784.856454306377;4786.0667169901535;4788.138135135569;4792.2092854678585;7037.261087585935;7080.610566418896;7095.042169307284;7104.786856394317;7107.680154393168;6787.694553745192;6852.6231057292325;6865.382115609619;6866.210385805496;6886.449084073362;6746.6626668665385;6861.1080559526945;6863.176418829772;6877.759278425231;6896.1035065443175;6646.468282537482;6654.83362915931;6655.035019922181;6666.933330666825;6680.966595166993;6869.278725733926;6893.414059804973;6897.965510172417;6904.344087311697;6905.930940690529;6640.966795165993;6678;6712.093867328043;6712.295209002984;6713.1944166700305 05:57:59 INFO - PROCESS | 10239 | |5;yui.html;840.4621042532776;890.4924193209869;928.4939707859218;939.6335429182618;947.1854205383373;13751.587452376432;13930.930345348272;13932.582022539314;14044.087134336287;14072.22602756848;13488.055836091478;13544.661383465418;13549.93225033876;13564.932175339134;13568.728625427486;693.0193775807239;916.3814425262955;927.6845872403381;938.8967213606497;940.3370623710268;948.8197242523898;950.5057370167509;955.9378640388353;957.2007373842815;957.6456711016933;1003.1723827842023;1003.362864580989;1004.8342023566103;1008.6016023670645;1008.8738907636546;987.8666380038675;989.3618615992681;989.5596459575492;994.0655783563427;996.8205722969863;736.7605528203302;739.6449704142042;741.5661837824879;742.3281929853491;742.9405647548183;13378.531751388655;13393.464261429532;13483.932580337134;13490.123141995837;13490.932545337211;14377.856221437756;14521.419143234258;14661.41354345825;14664.266786660732;14680.119192848464;11013.559457621686;11040.171987101;11061.612843550438;11069.667909962714;11088.501017454233;3925.9214815703526;3949.2299001694682;3969.28552860485;4013.6588389986887;4065.8576949806616;50015;50773.23840142401;50973.49026509724;51100.48899511032;51625.48374516244;10868.782624347468;11173.273737207055;11198.160137989684;11314;11493.080553555696;18933;19160.425187244404;19189.232430702894;19214.231430742613;19217.135228914733;7941.6029198539845;8097.514149151069;8165.265126138676;8315.625796839156;8447.070822209553;4583.72497650142;4638.744869032235;4654.743989080633;4679.923617567978;4739.3601863748645;3398.980305908218;3415.402304596735;3421.3328400962073;3427.725781937439;3440.4839274109086;619.8667286533417;625.8685676007998;668.1681306773098;679.0154276299386;679.8708245433451;696.6899729620371;724.6847621284758;746.3693179263514;747.1034758290074;776.2703059124404;8574.528400938008;9029.729108126767;9185.173334399937;9197.954010229905;9204.125608067223;674.3256743256743;722.5520177489885;730.8452644821169;750.6134340814485;754.1214485124877;3931.8427262909736;4010.4585880905706;4062.512498500199;4217.894552636148;4283.100548884707;56836.43163568394;57363.42636573665;57716.42283577195;57790.7110464445;58000;51464.22803657948;53357.733211333696;54129;54285.72857135689;54516.18225726617;47853.28220076632;47971.52028479671;48770.75614621904;49009.50990490049;49360.50639493559;7517.285857843496;7662.425318101054;7667.463277570517;7757.7672669819995;7782.143964163824;35782;36429;36782;37549.62450375461;37687.434688479145;41236.793816031925;43684.78157609192;45748.54251457576;45836.54163458456;47790;10664.413457259614;10769.892301077203;10912.508937097691;10915.290506117077;11086.168537359892;12156.270623762603;12377.133600647869;12416.503339866666;12499;12604.621861344174;11073.16951228645;11388.601398950997;11415.086793056369;11523.423828808694;12154.635360938832;11220.887791121984;11248.100151987657;11285.266457680225;11346.659600212008;11441.885581144083;11366.43167841588;11452.198346115692;11513.136514761594;11554.537818487166;11555.537778488766;9702.5148742564;9755.170810480904;9982.13399503722;10125.898741012496;10167.593296268067;9428;9822;9879.259055571005;9886.209103271578;9928.156106731009 05:57:59 INFO - PROCESS | 10239 | __end_tp_report 05:57:59 INFO - PROCESS | 10239 | __start_cc_report 05:57:59 INFO - PROCESS | 10239 | _x_x_mozilla_cycle_collect,335 05:57:59 INFO - PROCESS | 10239 | __end_cc_report 05:57:59 INFO - PROCESS | 10239 | __startTimestamp1462798679575__endTimestamp 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | ------- Summary: start ------- 05:57:59 INFO - PROCESS | 10239 | Number of tests: 6 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | [#0] dojo.html Cycles:165 Average:5565.87 Median:5805.39 stddev:616.64 (10.6%) stddev-sans-first:593.60 05:57:59 INFO - PROCESS | 10239 | Values: 3353.1 3383.1 3396.6 3417.4 3448.0 5481.5 5496.0 5500.0 5514.3 5526.9 5459.0 5463.3 5478.9 5488.0 5519.3 5004.9 5016.4 5058.4 5088.4 5103.9 5037.4 5050.9 5058.3 5094.8 5116.6 5128.8 5156.3 5171.5 5173.2 5198.0 5029.1 5035.1 5069.0 5080.4 5085.4 5042.7 5044.2 5101.6 5113.0 5122.1 5384.1 5408.8 5414.9 5437.3 5438.4 5880.7 5958.1 6001.9 6003.7 6024.9 6006.8 6034.8 6037.2 6078.8 6084.0 5622.4 5630.0 5631.4 5638.0 5648.6 5837.2 6110.8 6117.6 6119.5 6120.4 5901.6 5925.3 5926.3 5932.6 5959.3 5992.5 5996.5 6003.5 6008.8 6014.0 5867.4 5967.8 5968.1 6029.1 6077.5 6014.9 6047.1 6050.7 6054.7 6056.7 4587.8 4593.7 4600.2 4601.1 4626.6 4078.2 4090.1 4131.0 4153.8 4174.3 5613.8 5708.6 5726.9 5790.6 5810.4 5983.3 5986.3 5987.8 5993.9 6001.6 5564.9 5694.2 5704.5 5709.6 5749.6 5109.6 5134.1 5138.5 5139.8 5161.4 6252.2 6257.5 6258.6 6268.4 6275.4 5966.1 6016.3 6034.0 6070.5 6100.3 6201.2 6202.3 6214.2 6222.3 6244.8 5898.2 5898.6 5905.9 5912.9 5935.6 5866.9 6000.7 6032.9 6070.3 6072.3 5805.4 5829.6 5846.2 5849.8 5858.1 5704.3 5777.0 5830.6 5840.0 5840.7 5720.4 5796.2 5809.5 5827.2 5865.8 5814.1 5834.3 5865.7 5879.6 5890.7 5688.8 5739.7 5757.0 5759.7 5842.9 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | [#1] ext.html Cycles:180 Average:53642.33 Median:39737.10 stddev:106431.33 (267.8%) stddev-sans-first:106655.14 05:57:59 INFO - PROCESS | 10239 | Values: 511.6 548.0 566.0 578.5 604.9 38771.8 39147.2 39444.6 39489.2 39681.4 43421.8 43567.3 43616.3 43782.1 43873.6 8747.5 8941.9 8947.1 8956.8 9014.0 8809.3 8990.4 8992.3 8997.1 9011.9 9171.1 9241.9 9306.5 9315.9 9339.4 9166.1 9190.1 9226.4 9232.6 9249.5 8968.6 9102.3 9140.4 9141.3 9176.1 42083.8 42520.4 42539.0 42544.4 42553.1 3557.5 3659.0 3799.4 3853.4 4243.6 31407.8 31419.8 31807.8 32026.2 32590.5 4222.6 4237.3 4250.7 4286.0 4308.2 278397.0 279702.0 282026.0 283103.0 283285.0 48576.3 49263.3 73138.0 74727.3 74834.6 48738.0 48808.3 48999.8 49429.8 49460.5 16860.4 17014.7 17137.7 17154.3 17158.1 13243.8 13542.9 13599.9 13610.4 13615.9 16448.4 16471.9 16513.3 16656.1 16667.0 6550.6 6693.4 6756.9 6757.3 6824.7 1046.4 1140.6 1151.1 1196.3 1218.8 29783.7 29995.3 30321.0 30741.7 30989.4 1141.6 1175.4 1195.9 1237.3 1257.7 15765.0 15805.8 15956.6 15995.4 16267.4 318160.0 545411.0 546590.0 547174.0 814062.0 62498.7 62898.4 63491.0 63768.7 64287.4 1492.3 1518.8 1524.3 1533.4 1544.2 31696.0 32187.7 32272.4 32421.4 32598.8 50097.5 50478.5 50527.7 50614.7 50644.5 251971.0 253899.0 255243.0 255571.0 255889.0 34569.8 35503.0 35531.3 35719.6 36198.8 46796.0 46917.3 46976.3 47289.5 47440.8 39673.6 39824.4 39999.0 40298.8 40498.6 39303.2 39494.6 39693.8 40087.0 40371.6 39562.4 39671.2 39780.4 40096.6 40307.8 34378.3 34742.1 35162.3 35163.3 35689.5 27250.5 27735.3 27942.6 30345.7 31498.2 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | [#2] jquery.html Cycles:180 Average:26260.48 Median:35615.96 stddev:72005.66 (202.2%) stddev-sans-first:72181.42 05:57:59 INFO - PROCESS | 10239 | Values: 375.6 385.9 393.5 396.3 396.3 17386.4 18826.0 18855.0 19294.3 19380.0 17649.8 18148.5 18168.8 18316.6 18566.6 4302.5 5605.6 5872.6 5895.9 5905.3 4460.4 6185.3 6442.4 6446.9 6453.2 6062.9 6329.4 6337.1 6368.6 6478.0 6356.7 6382.9 6392.5 6403.2 6421.2 5496.6 5664.1 5666.3 5734.5 5739.3 22001.9 22148.8 22324.1 22670.8 22687.1 2417.7 2449.6 2450.0 2716.9 2914.4 13506.4 13905.9 14009.1 14119.3 14277.1 1869.6 1885.7 1917.8 1921.2 2005.1 60826.4 63785.4 63996.4 64495.4 65674.0 10092.5 10569.7 10732.3 10777.4 10850.6 15265.9 15349.6 15351.2 15367.2 15370.4 8088.3 8187.5 8294.2 8299.8 8354.1 7929.2 7939.6 8008.8 8025.6 8057.2 4634.2 4722.6 4724.5 4749.6 4784.1 1924.8 1943.3 1966.5 1985.9 1995.2 949.7 987.7 1027.6 1037.3 1053.7 15430.0 15535.6 16854.6 17262.3 17687.7 964.9 987.9 996.4 1032.3 1059.5 7623.7 9754.4 9789.7 9791.3 9795.5 424725.0 431826.0 432589.0 433824.0 469820.0 77641.0 78552.2 79871.0 80655.2 81718.0 1098.7 1111.9 1119.1 1156.8 1163.1 15919.7 15970.6 15987.8 16079.7 16405.1 35262.6 35969.3 36377.8 36674.4 36734.1 50970.5 50994.0 51461.5 51568.5 51572.2 8370.7 8462.9 8572.0 8597.9 8616.4 10981.6 12465.2 12685.1 12905.7 13101.4 10682.7 10781.3 10942.4 11170.0 11200.3 10794.4 10974.7 10980.6 11275.4 11388.9 10949.6 11062.9 11151.8 11250.3 11682.2 8373.8 8393.1 8458.8 8487.7 8502.1 10120.8 11304.9 11474.5 11485.3 11537.8 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | [#3] mootools.html Cycles:180 Average:5916.70 Median:5381.73 stddev:3038.30 (56.5%) stddev-sans-first:3029.53 05:57:59 INFO - PROCESS | 10239 | Values: 1604.3 1607.4 1853.3 1927.9 1990.8 7371.8 8126.0 8140.4 8418.3 8434.7 8060.0 8161.9 8193.1 8199.1 8210.4 2441.9 2470.5 2477.7 2479.9 2482.7 2431.7 2455.2 2455.3 2465.7 2469.7 2359.9 2363.3 2365.4 2372.5 2383.5 2424.8 2451.9 2457.9 2462.0 2472.1 2445.4 2455.1 2483.9 2486.4 2495.2 8471.6 8472.1 8484.0 8489.1 8498.8 5244.9 5377.2 5379.2 5384.3 5389.1 3221.3 3226.9 3241.1 3290.8 3297.2 987.3 2019.1 2028.9 2079.2 2101.9 11256.9 11275.3 11287.0 11333.3 11379.1 4430.7 4526.1 4589.6 4590.7 4609.3 9115.2 9154.1 9163.8 9182.7 9199.1 5277.4 5290.1 5291.1 5317.3 5317.9 4756.5 4830.3 4876.1 4888.6 4889.8 3707.5 3772.0 3791.1 3795.8 3805.9 1090.1 1093.9 1095.4 1112.7 1118.0 1463.7 1464.9 1465.3 1489.5 1498.7 8060.1 8101.0 8120.4 8130.3 8156.3 498.8 510.3 515.9 516.5 517.5 6004.8 6021.9 6120.2 6138.0 6178.9 9972.2 10299.8 10307.8 10350.6 10391.1 10106.5 10137.9 10197.3 10232.1 10285.5 8028.1 8055.0 8089.3 8102.0 8134.8 7709.0 7720.3 7780.7 7815.9 7888.0 9055.8 9245.8 9350.5 9436.6 9476.9 9437.2 9440.6 9571.0 9605.7 9645.4 7028.8 7200.9 7706.4 8027.6 8039.2 7950.8 8002.8 8014.8 8058.6 8065.6 7191.9 7347.3 7374.5 7437.9 7499.5 7161.2 7197.3 7205.9 7307.7 7341.0 7522.7 7579.8 7606.2 7619.6 7655.7 7141.6 7177.7 7187.4 7247.5 7249.1 7280.9 7315.9 7367.9 7368.3 7381.0 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | [#4] prototype.html Cycles:180 Average:5715.76 Median:6460.74 stddev:1720.64 (26.6%) stddev-sans-first:1677.78 05:57:59 INFO - PROCESS | 10239 | Values: 356.0 364.0 364.2 364.4 368.3 6342.7 6344.3 6355.6 6366.9 6426.7 6311.7 6322.1 6328.3 6332.6 6346.5 4672.9 4718.2 4860.9 4893.1 4930.7 4903.7 4905.9 4926.4 4928.2 4936.9 4816.9 4839.6 4871.9 4873.6 4881.1 4884.8 4897.6 4899.2 4900.2 4910.1 4339.3 4342.6 4343.1 4350.8 4351.3 5927.1 6010.0 6055.2 6057.2 6059.7 5699.1 5719.8 5720.1 5720.9 5729.5 6720.1 6723.5 6724.3 6731.1 6740.2 4752.3 4760.6 4762.1 4762.9 4771.5 7007.1 7012.6 7013.9 7020.6 7027.6 4812.3 4916.0 4918.2 4919.7 4922.6 4948.6 4987.7 4988.0 4988.7 4997.7 5697.3 5705.3 5706.7 5707.5 5728.1 6745.8 6798.3 6799.9 6801.3 6807.7 1747.4 1775.2 1776.0 1776.2 1779.4 1153.2 1170.8 1174.1 1177.5 1194.7 6494.8 6525.7 6549.3 6554.2 6579.5 6957.4 6979.5 7014.5 7015.7 7023.3 6407.6 6625.2 6633.6 6639.7 6645.7 3816.5 3845.8 3850.1 3850.6 3854.8 7410.2 7412.2 7434.3 7438.3 7447.3 7222.3 7259.2 7268.3 7278.5 7316.7 7122.5 7386.9 7395.8 7431.9 7441.9 7042.5 7079.5 7083.7 7101.9 7111.5 6965.3 6979.1 6994.3 6995.9 7016.2 7288.3 7366.8 7429.8 7432.7 7434.0 4749.2 4784.9 4786.1 4788.1 4792.2 7037.3 7080.6 7095.0 7104.8 7107.7 6787.7 6852.6 6865.4 6866.2 6886.4 6746.7 6861.1 6863.2 6877.8 6896.1 6646.5 6654.8 6655.0 6666.9 6681.0 6869.3 6893.4 6898.0 6904.3 6905.9 6641.0 6678.0 6712.1 6712.3 6713.2 05:57:59 INFO - PROCESS | 10239 | 05:57:59 INFO - PROCESS | 10239 | [#5] yui.html Cycles:180 Average:14311.54 Median:25210.13 stddev:16426.87 (65.2%) stddev-sans-first:16441.80 05:57:59 INFO - PROCESS | 10239 | Values: 840.5 890.5 928.5 939.6 947.2 13751.6 13930.9 13932.6 14044.1 14072.2 13488.1 13544.7 13549.9 13564.9 13568.7 693.0 916.4 927.7 938.9 940.3 948.8 950.5 955.9 957.2 957.6 1003.2 1003.4 1004.8 1008.6 1008.9 987.9 989.4 989.6 994.1 996.8 736.8 739.6 741.6 742.3 742.9 13378.5 13393.5 13483.9 13490.1 13490.9 14377.9 14521.4 14661.4 14664.3 14680.1 11013.6 11040.2 11061.6 11069.7 11088.5 3925.9 3949.2 3969.3 4013.7 4065.9 50015.0 50773.2 50973.5 51100.5 51625.5 10868.8 11173.3 11198.2 11314.0 11493.1 18933.0 19160.4 19189.2 19214.2 19217.1 7941.6 8097.5 8165.3 8315.6 8447.1 4583.7 4638.7 4654.7 4679.9 4739.4 3399.0 3415.4 3421.3 3427.7 3440.5 619.9 625.9 668.2 679.0 679.9 696.7 724.7 746.4 747.1 776.3 8574.5 9029.7 9185.2 9198.0 9204.1 674.3 722.6 730.8 750.6 754.1 3931.8 4010.5 4062.5 4217.9 4283.1 56836.4 57363.4 57716.4 57790.7 58000.0 51464.2 53357.7 54129.0 54285.7 54516.2 47853.3 47971.5 48770.8 49009.5 49360.5 7517.3 7662.4 7667.5 7757.8 7782.1 35782.0 36429.0 36782.0 37549.6 37687.4 41236.8 43684.8 45748.5 45836.5 47790.0 10664.4 10769.9 10912.5 10915.3 11086.2 12156.3 12377.1 12416.5 12499.0 12604.6 11073.2 11388.6 11415.1 11523.4 12154.6 11220.9 11248.1 11285.3 11346.7 11441.9 11366.4 11452.2 11513.1 11554.5 11555.5 9702.5 9755.2 9982.1 10125.9 10167.6 9428.0 9822.0 9879.3 9886.2 9928.2 05:57:59 INFO - PROCESS | 10239 | -------- Summary: end -------- 05:57:59 INFO - PROCESS | 10239 | 05:58:00 INFO - TEST-INFO | 10239: exit 0 05:58:00 INFO - TEST-OK | dromaeo_css | took 1109816ms 05:58:00 INFO - TEST-START | kraken 05:58:00 INFO - operating with platform_type : linux_ 05:58:00 INFO - Initialising browser for kraken test... 05:58:00 INFO - TEST-INFO | started process 10483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4LN9FQ/profile http://localhost:33229/getInfo.html) 05:58:04 INFO - PROCESS | 10483 | 05:58:04 INFO - PROCESS | 10483 | (process:10563): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:05 INFO - PROCESS | 10483 | __metrics Screen width/height:1600/1200 05:58:05 INFO - PROCESS | 10483 | colorDepth:24 05:58:05 INFO - PROCESS | 10483 | Browser inner width/height: 1024/697 05:58:05 INFO - PROCESS | 10483 | __metrics 05:58:06 ERROR - PROCESS | 10483 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:58:06 INFO - TEST-INFO | 10483: exit 0 05:58:06 INFO - Browser initialized. 05:58:06 INFO - Running cycle 1/1 for kraken test... 05:58:06 INFO - TEST-INFO | started process 10613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4LN9FQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:08 INFO - PROCESS | 10613 | 05:58:08 INFO - PROCESS | 10613 | (process:10679): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:58:18 INFO - PROCESS | 10613 | RSS: Main: 150110208 05:58:18 INFO - PROCESS | 10613 | 05:58:21 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:21 INFO - PROCESS | 10613 | RSS: Main: 153698304 05:58:21 INFO - PROCESS | 10613 | 05:58:24 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-dft) 05:58:25 INFO - PROCESS | 10613 | RSS: Main: 153894912 05:58:25 INFO - PROCESS | 10613 | 05:58:28 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-fft) 05:58:28 INFO - PROCESS | 10613 | RSS: Main: 154738688 05:58:28 INFO - PROCESS | 10613 | 05:58:30 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33229/tests/kraken/driver.html?testName=audio-oscillator) 05:58:31 INFO - PROCESS | 10613 | RSS: Main: 154656768 05:58:31 INFO - PROCESS | 10613 | 05:58:33 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33229/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:34 INFO - PROCESS | 10613 | RSS: Main: 153980928 05:58:34 INFO - PROCESS | 10613 | 05:58:37 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33229/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:37 INFO - PROCESS | 10613 | RSS: Main: 154247168 05:58:37 INFO - PROCESS | 10613 | 05:58:41 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33229/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:41 INFO - PROCESS | 10613 | RSS: Main: 154243072 05:58:41 INFO - PROCESS | 10613 | 05:58:44 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33229/tests/kraken/driver.html?testName=json-parse-financial) 05:58:45 INFO - PROCESS | 10613 | RSS: Main: 154394624 05:58:45 INFO - PROCESS | 10613 | 05:58:46 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33229/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:58:47 INFO - PROCESS | 10613 | RSS: Main: 154112000 05:58:47 INFO - PROCESS | 10613 | 05:58:48 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:58:49 INFO - PROCESS | 10613 | RSS: Main: 154046464 05:58:49 INFO - PROCESS | 10613 | 05:58:51 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:58:52 INFO - PROCESS | 10613 | RSS: Main: 154316800 05:58:52 INFO - PROCESS | 10613 | 05:58:54 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:58:55 INFO - PROCESS | 10613 | RSS: Main: 155095040 05:58:55 INFO - PROCESS | 10613 | 05:58:57 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:58:58 INFO - PROCESS | 10613 | RSS: Main: 155160576 05:58:58 INFO - PROCESS | 10613 | 05:58:59 INFO - PROCESS | 10613 | Cycle 1(1): loaded http://localhost:33229/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33229/tests/kraken/driver.html?testName=ai-astar) 05:59:00 INFO - PROCESS | 10613 | RSS: Main: 156651520 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | __start_tp_report 05:59:00 INFO - PROCESS | 10613 | _x_x_mozilla_page_load 05:59:00 INFO - PROCESS | 10613 | _x_x_mozilla_page_load_details 05:59:00 INFO - PROCESS | 10613 | |i|pagename|runs| 05:59:00 INFO - PROCESS | 10613 | |0;ai-astar;111;104;112;110;112;120;112;110;110;110 05:59:00 INFO - PROCESS | 10613 | |1;audio-beat-detection;156;126;157;167;128;155;162;134;168;127 05:59:00 INFO - PROCESS | 10613 | |2;audio-dft;162;163;163;161;163;163;166;164;166;162 05:59:00 INFO - PROCESS | 10613 | |3;audio-fft;76;76;76;158;76;76;76;76;165;76 05:59:00 INFO - PROCESS | 10613 | |4;audio-oscillator;93;92;151;93;92;93;149;93;93;143 05:59:00 INFO - PROCESS | 10613 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;117;117 05:59:00 INFO - PROCESS | 10613 | |6;imaging-darkroom;146;146;147;146;147;147;147;145;145;145 05:59:00 INFO - PROCESS | 10613 | |7;imaging-desaturate;96;96;95;97;97;96;96;96;96;96 05:59:00 INFO - PROCESS | 10613 | |8;json-parse-financial;60;54;62;56;55;57;57;55;57;63 05:59:00 INFO - PROCESS | 10613 | |9;json-stringify-tinderbox;65;66;63;64;64;64;64;65;65;65 05:59:00 INFO - PROCESS | 10613 | |10;stanford-crypto-aes;78;78;78;77;79;85;81;79;80;79 05:59:00 INFO - PROCESS | 10613 | |11;stanford-crypto-ccm;114;110;119;113;118;126;115;114;112;116 05:59:00 INFO - PROCESS | 10613 | |12;stanford-crypto-pbkdf2;148;143;148;144;143;135;135;156;143;146 05:59:00 INFO - PROCESS | 10613 | |13;stanford-crypto-sha256-iterative;67;67;70;67;70;66;65;66;65;66 05:59:00 INFO - PROCESS | 10613 | __end_tp_report 05:59:00 INFO - PROCESS | 10613 | __start_cc_report 05:59:00 INFO - PROCESS | 10613 | _x_x_mozilla_cycle_collect,795 05:59:00 INFO - PROCESS | 10613 | __end_cc_report 05:59:00 INFO - PROCESS | 10613 | __startTimestamp1462798740194__endTimestamp 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | ------- Summary: start ------- 05:59:00 INFO - PROCESS | 10613 | Number of tests: 14 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:3.90 (3.5%) stddev-sans-first:4.14 05:59:00 INFO - PROCESS | 10613 | Values: 111.0 104.0 112.0 110.0 112.0 120.0 112.0 110.0 110.0 110.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:156.50 stddev:17.23 (11.0%) stddev-sans-first:18.03 05:59:00 INFO - PROCESS | 10613 | Values: 156.0 126.0 157.0 167.0 128.0 155.0 162.0 134.0 168.0 127.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:1.64 (1.0%) stddev-sans-first:1.67 05:59:00 INFO - PROCESS | 10613 | Values: 162.0 163.0 163.0 161.0 163.0 163.0 166.0 164.0 166.0 162.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#3] audio-fft Cycles:10 Average:93.10 Median:76.00 stddev:36.09 (47.5%) stddev-sans-first:37.74 05:59:00 INFO - PROCESS | 10613 | Values: 76.0 76.0 76.0 158.0 76.0 76.0 76.0 76.0 165.0 76.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.00 stddev:26.62 (28.6%) stddev-sans-first:27.58 05:59:00 INFO - PROCESS | 10613 | Values: 93.0 92.0 151.0 93.0 92.0 93.0 149.0 93.0 93.0 143.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:59:00 INFO - PROCESS | 10613 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:59:00 INFO - PROCESS | 10613 | Values: 146.0 146.0 147.0 146.0 147.0 147.0 147.0 145.0 145.0 145.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:59:00 INFO - PROCESS | 10613 | Values: 96.0 96.0 95.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.06 (5.4%) stddev-sans-first:3.12 05:59:00 INFO - PROCESS | 10613 | Values: 60.0 54.0 62.0 56.0 55.0 57.0 57.0 55.0 57.0 63.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 05:59:00 INFO - PROCESS | 10613 | Values: 65.0 66.0 63.0 64.0 64.0 64.0 64.0 65.0 65.0 65.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.27 (2.9%) stddev-sans-first:2.35 05:59:00 INFO - PROCESS | 10613 | Values: 78.0 78.0 78.0 77.0 79.0 85.0 81.0 79.0 80.0 79.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:115.50 stddev:4.50 (3.9%) stddev-sans-first:4.73 05:59:00 INFO - PROCESS | 10613 | Values: 114.0 110.0 119.0 113.0 118.0 126.0 115.0 114.0 112.0 116.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:145.00 stddev:6.19 (4.3%) stddev-sans-first:6.40 05:59:00 INFO - PROCESS | 10613 | Values: 148.0 143.0 148.0 144.0 143.0 135.0 135.0 156.0 143.0 146.0 05:59:00 INFO - PROCESS | 10613 | 05:59:00 INFO - PROCESS | 10613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.90 05:59:00 INFO - PROCESS | 10613 | Values: 67.0 67.0 70.0 67.0 70.0 66.0 65.0 66.0 65.0 66.0 05:59:00 INFO - PROCESS | 10613 | -------- Summary: end -------- 05:59:00 INFO - PROCESS | 10613 | 05:59:01 INFO - TEST-INFO | 10613: exit 0 05:59:01 INFO - TEST-OK | kraken | took 60856ms 05:59:01 INFO - SUITE-END | took 1170s 05:59:01 INFO - Completed test suite (00:19:30) 05:59:01 INFO - javascript benchmark 05:59:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3353.1281866714653, 3383.08656662701, 3396.60938992016, 3417.41903876341, 3448.0345503259095, 5481.451854814517, 5495.972520137394, 5499.972500137499, 5514.338279406466, 5526.944730552698, 5458.972705136469, 5463.262459567957, 5478.91781623276, 5488.0, 5519.254900588419, 5004.874878128057, 5016.423111342206, 5058.367704036996, 5088.389393272794, 5103.872403189931, 5037.370328708911, 5050.924236136461, 5058.291839142523, 5094.821681241157, 5116.616253780981, 5128.820491282806, 5156.329677141966, 5171.508706672879, 5173.172292433212, 5198.012377648253, 5029.094762942669, 5035.144025515671, 5068.974655126738, 5080.441151473354, 5085.440601533828, 5042.722650254234, 5044.218146187347, 5101.642884998052, 5112.9744351278005, 5122.129238029544, 5384.138537833927, 5408.756605952742, 5414.945850541483, 5437.265969094161, 5438.374586922476, 5880.7353669085, 5958.106284057426, 6001.879962400728, 6003.729832157564, 6024.879502409927, 6006.819795406145, 6034.818955431344, 6037.154798328237, 6078.817635470943, 6083.969580152115, 5622.437756224344, 5629.971850140764, 5631.4087020863035, 5637.9718101409235, 5648.604597678123, 5837.211976383134, 6110.816675499742, 6117.583823141572, 6119.479844213202, 6120.357362476965, 5901.58688891782, 5925.318588362394, 5926.259217597801, 5932.644041357532, 5959.314678811906, 5992.490638295793, 5996.4603185713495, 6003.549733769984, 6008.819735407945, 6014.0377539593455, 5867.413258674099, 5967.8209653710455, 5968.104784282305, 6029.065494848305, 6077.513798896166, 6014.879702405928, 6047.092936059538, 6050.697465126814, 6054.727537260834, 6056.697165141725, 4587.839425620087, 4593.655475839326, 4600.171969045604, 4601.12578610063, 4626.583607475343, 4078.2455245779624, 4090.1001779608437, 4131.049858532554, 4153.792310384469, 4174.290370636999, 5613.775448981995, 5708.571857110734, 5726.885462290731, 5790.565707571949, 5810.360860305363, 5983.282006159288, 5986.281646202484, 5987.820365389045, 5993.910091348634, 6001.5798894077, 5564.916526252109, 5694.174344719992, 5704.543636509069, 5709.600327977002, 5749.597528172988, 5109.616778741609, 5134.101532231844, 5138.537531622172, 5139.794408223629, 5161.354830646169, 6252.187215661935, 6257.468115210167, 6258.624482530971, 6268.373162683695, 6275.403836635513, 5966.134910438049, 6016.2780466342565, 6033.9698301508215, 6070.484008859296, 6100.328963814066, 6201.162843016135, 6202.2867370253, 6214.223222097238, 6222.28443728977, 6244.812655620339, 5898.174255604133, 5898.587098903035, 5905.911411328748, 5912.881742365043, 5935.643861368331, 5866.853328666817, 6000.699965001645, 6032.939670603238, 6070.332263451105, 6072.271327440735, 5805.390434004537, 5829.562782791223, 5846.239988801429, 5849.824505264849, 5858.121281807763, 5704.286964129484, 5777.046787280052, 5830.5627077968475, 5840.0, 5840.707964601668, 5720.399358067343, 5796.21751063601, 5809.477147056785, 5827.1841942127285, 5865.794697185578, 5814.127880817911, 5834.299884013945, 5865.736041878211, 5879.647221166743, 5890.676012819336, 5688.800891968926, 5739.741711623071, 5757.0, 5759.65442073477, 5842.853928651818], "unit": "score", "name": "dojo.html", "value": 5526.211512061898}, {"lowerIsBetter": false, "replicates": [511.55494719593935, 547.9671219726816, 566.0377358490567, 578.485148218086, 604.8971674815281, 38771.80614096929, 39147.21705565887, 39444.60555394445, 39489.21021579567, 39681.404778928336, 43421.7828910855, 43567.34648980268, 43616.34575481362, 43782.12435751283, 43873.56126438743, 8747.518886461243, 8941.865872011926, 8947.105289471034, 8956.776080597972, 9014.0, 8809.339299552526, 8990.37067405282, 8992.325575581825, 8997.100289971017, 9011.864822027675, 9171.128742769426, 9241.861372079424, 9306.534673266344, 9315.860262096074, 9339.392939458947, 9166.083391660848, 9190.126937940919, 9226.354155209137, 9232.6306947722, 9249.53752312385, 8968.551572421353, 9102.317326200562, 9140.360174787767, 9141.268698504104, 9176.082391760838, 42083.7895810522, 42520.362194567104, 42539.0, 42544.3618345722, 42553.1489370214, 3557.484164796116, 3658.9817050914576, 3799.4490798834013, 3853.4412510185866, 4243.61807437329, 31407.842960785278, 31419.842900785578, 31807.84096079505, 32026.199345016328, 32590.511142332885, 4222.619964203236, 4237.343211802176, 4250.723702959298, 4285.957140428587, 4308.224519586473, 278397.0, 279702.0, 282026.0, 283103.0, 283285.0, 48576.27135592969, 49263.261051084264, 73138.0, 74727.25272747311, 74834.6258268716, 48738.0, 48808.26787598189, 48999.75500122548, 49429.75285123551, 49460.50539494631, 16860.409885653942, 17014.659706805796, 17137.657246854993, 17154.31382744701, 17158.142092895305, 13243.801342979863, 13542.864571354357, 13599.86400135986, 13610.387532561059, 13615.863841361459, 16448.424305149263, 16471.91764041196, 16513.33946642145, 16656.08391538477, 16667.0, 6550.574212676161, 6693.397594216543, 6756.898646520306, 6757.256701762803, 6824.658767061627, 1046.377405443775, 1140.6121918547733, 1151.050383433654, 1196.3360335013977, 1218.774526712561, 29783.702162978094, 29995.250118746768, 30321.0, 30741.69258307433, 30989.380212395627, 1141.6460897121754, 1175.3594291111365, 1195.946182421793, 1237.3194742891374, 1257.7107265329025, 15765.0, 15805.841941580667, 15956.601084972968, 15995.440159594358, 16267.430639927547, 318160.0, 545411.0, 546590.0, 547174.0, 814062.0, 62498.68750656309, 62898.37101629017, 63491.0, 63768.681156594845, 64287.35712642907, 1492.3433689176727, 1518.840521745223, 1524.3140586736013, 1533.394309247841, 1544.1584336536614, 31696.0, 32187.67812321847, 32272.354552908342, 32421.35157296794, 32598.837005814818, 50097.49902500928, 50478.49521504738, 50527.74736126443, 50614.746926266605, 50644.49355506398, 251971.0, 253899.0, 255243.0, 255571.0, 255889.0, 34569.82715086408, 35503.0, 35531.28937421289, 35719.64280357163, 36198.8190059048, 46796.0, 46917.2962405571, 46976.29535557038, 47289.52710472851, 47440.7627961858, 39673.603263966994, 39824.402633961094, 39999.0, 40298.79850600728, 40498.59501404948, 39303.213935721695, 39494.60505395024, 39693.80153099216, 40087.0, 40371.59628403796, 39562.406563900986, 39671.20657586774, 39780.40329395003, 40096.59903400928, 40307.79846100751, 34378.312433751686, 34742.13144671403, 35162.29675406529, 35163.29673406569, 35689.46465803067, 27250.454990900467, 27735.30661733473, 27942.580861287504, 30345.696543034286, 31498.212544685648], "unit": "score", "name": "ext.html", "value": 19803.527096849928}, {"lowerIsBetter": false, "replicates": [375.57372382346034, 385.87441722051386, 393.5277666799839, 396.3400937439164, 396.34998602292245, 17386.391476298315, 18826.0, 18855.0, 19294.32469863555, 19379.99999999998, 17649.82350176498, 18148.546286342815, 18168.818311816878, 18316.633667326645, 18566.628667426645, 4302.5267220605865, 5605.607607467479, 5872.61827981182, 5895.911561326584, 5905.291365036202, 4460.353248778925, 6185.288691800455, 6442.420182183626, 6446.871062578745, 6453.193350831146, 6062.939370606282, 6329.36706329368, 6337.081123237128, 6368.617882927016, 6477.963525835868, 6356.68216589171, 6382.872342553146, 6392.456641185505, 6403.199600049994, 6421.165248517709, 5496.587755918322, 5664.122061080539, 5666.291713535808, 5734.512566431858, 5739.282589676291, 22001.889990550106, 22148.778512214994, 22324.107035718553, 22670.773292267197, 22687.09251629933, 2417.6857008588945, 2449.5835707929696, 2450.0444826517673, 2716.9403932466353, 2914.3588410549646, 13506.392212350467, 13905.930470347583, 14009.08940918837, 14119.294035298297, 14277.071990320595, 1869.560653246486, 1885.7171424286466, 1917.7890432052602, 1921.2123029557815, 2005.0776642744356, 60826.391736082514, 63785.36214637887, 63996.36003639997, 64495.355046449404, 65674.0, 10092.495375231356, 10569.682909512727, 10732.302400343953, 10777.407242601575, 10850.620228291971, 15265.923670381799, 15349.6162595936, 15351.15568643713, 15367.231638418034, 15370.385184592715, 8088.272055515032, 8187.4678145920325, 8294.212049855254, 8299.751007469786, 8354.081051084377, 7929.167437419103, 7939.603019848984, 8008.7597372078935, 8025.5585942773705, 8057.194280571896, 4634.165850146938, 4722.598579120813, 4724.527547245248, 4749.572538471554, 4784.138855006132, 1924.8267655910756, 1943.280986035176, 1966.4887129346187, 1985.9106340214726, 1995.1520603743352, 949.7435692363161, 987.6543209876629, 1027.6197806811529, 1037.3205550364523, 1053.6891616973012, 15430.0, 15535.611609709847, 16854.57863553421, 17262.309507619804, 17687.73468397975, 964.8890377606525, 987.8863930648067, 996.4220751963844, 1032.2670903658336, 1059.5496913811598, 7623.733169339046, 9754.365966212174, 9789.706308810748, 9791.314607977516, 9795.461249631338, 424725.0, 431826.0, 432589.0, 433824.0, 469820.0, 77641.0, 78552.21447785449, 79871.0, 80655.19344806594, 81718.0, 1098.7198264442516, 1111.9444027798577, 1119.0711709281277, 1156.7628636129741, 1163.116031815826, 15919.68160636804, 15970.60073498172, 15987.760183597024, 16079.678406431573, 16405.097719625534, 35262.64737352696, 35969.28061438809, 36377.81811090928, 36674.44988325124, 36734.081647959014, 50970.49029509806, 50994.0, 51461.48538514716, 51568.48431515787, 51572.22641660303, 8370.66517339324, 8462.899823022968, 8571.95714021426, 8597.914020859711, 8616.35377346689, 10981.61564345276, 12465.189762665397, 12685.112042156961, 12905.741885162432, 13101.410436530188, 10682.73293167677, 10781.299215550964, 10942.398168100832, 11170.0, 11200.327980321206, 10794.352338859693, 10974.670759876897, 10980.560777569128, 11275.379854108103, 11388.886111138783, 10949.616763413242, 11062.889371106508, 11151.832722509007, 11250.324980501196, 11682.24065435744, 8373.790655233668, 8393.118722534045, 8458.788530286545, 8487.745367638981, 8502.107278735892, 10120.848187277345, 11304.943475282571, 11474.541018359172, 11485.310881346812, 11537.82693259585], "unit": "score", "name": "jquery.html", "value": 9027.693939749603}, {"lowerIsBetter": false, "replicates": [1604.310146636946, 1607.3731244814521, 1853.3142737187234, 1927.8746881452696, 1990.8009199080093, 7371.778846634596, 8126.0, 8140.3894707896925, 8418.326533877298, 8434.746957591275, 8060.0, 8161.877571836427, 8193.057798353191, 8199.057108432533, 8210.425270231086, 2441.9389515262174, 2470.481198948223, 2477.6531285620026, 2479.9008039678392, 2482.7020757509126, 2431.744666809986, 2455.238875948453, 2455.287966489716, 2465.654808326836, 2469.7283298837206, 2359.917402890899, 2363.3265914095227, 2365.44412063165, 2372.478054827935, 2383.5232953409386, 2424.842385244971, 2451.9264422067276, 2457.9016839326496, 2462.0, 2472.1471092473066, 2445.400876785181, 2455.0548039004934, 2483.8882250298598, 2486.4405508760565, 2495.2015355086196, 8471.576421178916, 8472.110428405053, 8484.02433720124, 8489.108643592395, 8498.78753031173, 5244.8688782780355, 5377.1665391863935, 5379.193121031837, 5384.273123128367, 5389.110796718537, 3221.291315910496, 3226.8709251629907, 3241.1248962780155, 3290.7531935104726, 3297.225152089257, 987.284218941269, 2019.1317733374642, 2028.9391318260475, 2079.1683326669304, 2101.8843963582, 11256.943715281372, 11275.26710763806, 11287.0, 11333.320000799897, 11379.089672826236, 4430.689851710414, 4526.0721552082405, 4589.609883159968, 4590.701604395704, 4609.262517997171, 9115.225205857576, 9154.130357616015, 9163.77090572741, 9182.67860624875, 9199.080091990747, 5277.445868183785, 5290.127129023745, 5291.126964050888, 5317.335333083364, 5317.867053323698, 4756.500567440438, 4830.275458681155, 4876.097921884463, 4888.560029597354, 4889.755512224375, 3707.462417949382, 3771.981140094282, 3791.0711875590655, 3795.8291876865055, 3805.923881522354, 1090.0679918669582, 1093.9015488606065, 1095.424901926495, 1112.7496313329436, 1118.0384869012642, 1463.7292100961356, 1464.9487267945572, 1465.2893346726828, 1489.47868246113, 1498.685276092011, 8060.073091594424, 8101.027876654839, 8120.390970677223, 8130.3495720342235, 8156.34749220061, 498.7605949144431, 510.3212727072984, 515.8813472901254, 516.5402791515554, 517.4902720819989, 6004.819855404345, 6021.879562408727, 6120.234970628671, 6138.048602466625, 6178.938210617836, 9972.202223822222, 10299.845502317472, 10307.793844123076, 10350.585976560853, 10391.116755075753, 10106.545205465625, 10137.898621013843, 10197.337173083726, 10232.079112879877, 10285.537150828231, 8028.11690714021, 8054.959725201336, 8089.31240844523, 8101.959490202511, 8134.75595732129, 7709.0, 7720.3437707795465, 7780.688772449265, 7815.92184078152, 7887.9605601971625, 9055.773605659911, 9245.76885577839, 9350.485723285012, 9436.622535098519, 9476.85784713216, 9437.150656440954, 9440.575174117044, 9571.042895710652, 9605.663801766905, 9645.42127472354, 7028.789136325919, 7200.927990720235, 7706.422018348534, 8027.598620068857, 8039.196080391914, 7950.840983180188, 8002.799930001564, 8014.759557213293, 8058.556779376956, 8065.637046333047, 7191.856162876608, 7347.33873951347, 7374.483786135133, 7437.851242975218, 7499.475036747375, 7161.248068952685, 7197.280271972761, 7205.891911621225, 7307.67115479794, 7341.0, 7522.6614802335125, 7579.848403032019, 7606.239376062349, 7619.580923049286, 7655.732049378245, 7141.571505709674, 7177.677004534704, 7187.425005999403, 7247.4926755126635, 7249.05762250904, 7280.871464922945, 7315.890261645973, 7367.926320736939, 7368.263173682589, 7381.0], "unit": "score", "name": "mootools.html", "value": 4826.184339386471}, {"lowerIsBetter": false, "replicates": [356.0191671943795, 363.99636003639955, 364.1696930997326, 364.44604201613566, 368.25612263228277, 6342.746290148389, 6344.3338449462835, 6355.586886852358, 6366.872662546746, 6426.710798014089, 6311.684415779204, 6322.114903913456, 6328.335524769902, 6332.620042797424, 6346.492280617551, 4672.929906051412, 4718.245080787075, 4860.902781944359, 4893.09477746618, 4930.704157750529, 4903.681260718042, 4905.901881962359, 4926.408830940274, 4928.211486162215, 4936.925946110811, 4816.879578010543, 4839.588634966032, 4871.8782030449165, 4873.5613794758465, 4881.096997055538, 4884.755762211875, 4897.6326775491625, 4899.216125419951, 4900.166971614834, 4910.091633047898, 4339.349097635349, 4342.5874541918465, 4343.087951530151, 4350.7607081610495, 4351.28203846365, 5927.110933359987, 6009.969950150265, 6055.2430946131735, 6057.151998720183, 6059.727312270914, 5699.059655156894, 5719.771209151629, 5720.08478643415, 5720.8855822883725, 5729.455701708331, 6720.092787473677, 6723.495737819683, 6724.327567243286, 6731.057651928734, 6740.224874139439, 4752.310914917318, 4760.619150467955, 4762.071396077767, 4762.857114286577, 4771.522847715235, 7007.089078419773, 7012.614306213156, 7013.859722805515, 7020.578765274049, 7027.648617569101, 4812.302216178635, 4916.041371932439, 4918.1884988977135, 4919.655624106278, 4922.630802689812, 4948.554630083309, 4987.700737955734, 4988.0, 4988.700677959334, 4997.700137991732, 5697.259356283656, 5705.315362156485, 5706.744516206428, 5707.514861236758, 5728.083506638918, 6745.763898263537, 6798.286179951133, 6799.898001529981, 6801.285864984205, 6807.65961701913, 1747.4495533907034, 1775.1922875092062, 1775.9822401776075, 1776.1740790532465, 1779.4394765648779, 1153.2042890405594, 1170.7658468306372, 1174.1018121137338, 1177.4995626858552, 1194.6774370919977, 6494.772682956074, 6525.706343214567, 6549.345065493412, 6554.246261679872, 6579.539432239697, 6957.443404527626, 6979.511434199659, 7014.508984371147, 7015.684294206773, 7023.33278338557, 6407.551471397051, 6625.204975402982, 6633.635150066792, 6639.668016599151, 6645.734170633121, 3816.5229346331707, 3845.7692538447222, 3850.0952276215066, 3850.634189751969, 3854.768713877176, 7410.18487966334, 7412.18465968743, 7434.293742094493, 7438.256174382518, 7447.292507211806, 7222.349988501061, 7259.201487836333, 7268.347053325499, 7278.526895751759, 7316.743913962986, 7122.501424900311, 7386.852262954818, 7395.778126656209, 7431.888521672179, 7441.888371674429, 7042.542234754725, 7079.539829911039, 7083.6812343443635, 7101.893471598033, 7111.466640002124, 6965.303469652994, 6979.092717946837, 6994.2656021117045, 6995.860082798417, 7016.19313778922, 7288.271172882669, 7366.815829604303, 7429.8142546436775, 7432.665530051268, 7433.962830185815, 4749.168895443353, 4784.856454306377, 4786.0667169901535, 4788.138135135569, 4792.2092854678585, 7037.261087585935, 7080.610566418896, 7095.042169307284, 7104.786856394317, 7107.680154393168, 6787.694553745192, 6852.6231057292325, 6865.382115609619, 6866.210385805496, 6886.449084073362, 6746.6626668665385, 6861.1080559526945, 6863.176418829772, 6877.759278425231, 6896.1035065443175, 6646.468282537482, 6654.83362915931, 6655.035019922181, 6666.933330666825, 6680.966595166993, 6869.278725733926, 6893.414059804973, 6897.965510172417, 6904.344087311697, 6905.930940690529, 6640.966795165993, 6678.0, 6712.093867328043, 6712.295209002984, 6713.1944166700305], "unit": "score", "name": "prototype.html", "value": 5159.430937588816}, {"lowerIsBetter": false, "replicates": [840.4621042532776, 890.4924193209869, 928.4939707859218, 939.6335429182618, 947.1854205383373, 13751.587452376432, 13930.930345348272, 13932.582022539314, 14044.087134336287, 14072.22602756848, 13488.055836091478, 13544.661383465418, 13549.93225033876, 13564.932175339134, 13568.728625427486, 693.0193775807239, 916.3814425262955, 927.6845872403381, 938.8967213606497, 940.3370623710268, 948.8197242523898, 950.5057370167509, 955.9378640388353, 957.2007373842815, 957.6456711016933, 1003.1723827842023, 1003.362864580989, 1004.8342023566103, 1008.6016023670645, 1008.8738907636546, 987.8666380038675, 989.3618615992681, 989.5596459575492, 994.0655783563427, 996.8205722969863, 736.7605528203302, 739.6449704142042, 741.5661837824879, 742.3281929853491, 742.9405647548183, 13378.531751388655, 13393.464261429532, 13483.932580337134, 13490.123141995837, 13490.932545337211, 14377.856221437756, 14521.419143234258, 14661.41354345825, 14664.266786660732, 14680.119192848464, 11013.559457621686, 11040.171987101, 11061.612843550438, 11069.667909962714, 11088.501017454233, 3925.9214815703526, 3949.2299001694682, 3969.28552860485, 4013.6588389986887, 4065.8576949806616, 50015.0, 50773.23840142401, 50973.49026509724, 51100.48899511032, 51625.48374516244, 10868.782624347468, 11173.273737207055, 11198.160137989684, 11314.0, 11493.080553555696, 18933.0, 19160.425187244404, 19189.232430702894, 19214.231430742613, 19217.135228914733, 7941.6029198539845, 8097.514149151069, 8165.265126138676, 8315.625796839156, 8447.070822209553, 4583.72497650142, 4638.744869032235, 4654.743989080633, 4679.923617567978, 4739.3601863748645, 3398.980305908218, 3415.402304596735, 3421.3328400962073, 3427.725781937439, 3440.4839274109086, 619.8667286533417, 625.8685676007998, 668.1681306773098, 679.0154276299386, 679.8708245433451, 696.6899729620371, 724.6847621284758, 746.3693179263514, 747.1034758290074, 776.2703059124404, 8574.528400938008, 9029.729108126767, 9185.173334399937, 9197.954010229905, 9204.125608067223, 674.3256743256743, 722.5520177489885, 730.8452644821169, 750.6134340814485, 754.1214485124877, 3931.8427262909736, 4010.4585880905706, 4062.512498500199, 4217.894552636148, 4283.100548884707, 56836.43163568394, 57363.42636573665, 57716.42283577195, 57790.7110464445, 58000.0, 51464.22803657948, 53357.733211333696, 54129.0, 54285.72857135689, 54516.18225726617, 47853.28220076632, 47971.52028479671, 48770.75614621904, 49009.50990490049, 49360.50639493559, 7517.285857843496, 7662.425318101054, 7667.463277570517, 7757.7672669819995, 7782.143964163824, 35782.0, 36429.0, 36782.0, 37549.62450375461, 37687.434688479145, 41236.793816031925, 43684.78157609192, 45748.54251457576, 45836.54163458456, 47790.0, 10664.413457259614, 10769.892301077203, 10912.508937097691, 10915.290506117077, 11086.168537359892, 12156.270623762603, 12377.133600647869, 12416.503339866666, 12499.0, 12604.621861344174, 11073.16951228645, 11388.601398950997, 11415.086793056369, 11523.423828808694, 12154.635360938832, 11220.887791121984, 11248.100151987657, 11285.266457680225, 11346.659600212008, 11441.885581144083, 11366.43167841588, 11452.198346115692, 11513.136514761594, 11554.537818487166, 11555.537778488766, 9702.5148742564, 9755.170810480904, 9982.13399503722, 10125.898741012496, 10167.593296268067, 9428.0, 9822.0, 9879.259055571005, 9886.209103271578, 9928.156106731009], "unit": "score", "name": "yui.html", "value": 6730.368003356363}], "name": "dromaeo_css", "value": 7410.335041516421}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 112.0, 110.0, 112.0, 120.0, 112.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 126.0, 157.0, 167.0, 128.0, 155.0, 162.0, 134.0, 168.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 163.0, 166.0, 164.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 76.0, 158.0, 76.0, 76.0, 76.0, 76.0, 165.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 151.0, 93.0, 92.0, 93.0, 149.0, 93.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [60.0, 54.0, 62.0, 56.0, 55.0, 57.0, 57.0, 55.0, 57.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 78.0, 77.0, 79.0, 85.0, 81.0, 79.0, 80.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.4}, {"lowerIsBetter": true, "replicates": [114.0, 110.0, 119.0, 113.0, 118.0, 126.0, 115.0, 114.0, 112.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [148.0, 143.0, 148.0, 144.0, 143.0, 135.0, 135.0, 156.0, 143.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 70.0, 67.0, 70.0, 66.0, 65.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1512.4}]} 05:59:01 INFO - Return code: 0 05:59:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:59:01 ERROR - # TBPL SUCCESS # 05:59:01 INFO - Running post-action listener: _resource_record_post_action 05:59:01 INFO - Running post-run listener: _resource_record_post_run 05:59:02 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 16384; Write bytes: 462958592; Read time: 28; Write time: 1052712 05:59:02 INFO - install - Wall time: 14s; CPU: 21.0%; Read bytes: 0; Write bytes: 249118720; Read time: 0; Write time: 756792 05:59:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 16384; Write bytes: 212959232; Read time: 28; Write time: 295232 05:59:02 INFO - Running post-run listener: _upload_blobber_files 05:59:02 INFO - Blob upload gear active. 05:59:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:02 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 05:59:02 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'] 05:59:02 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 05:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:03 INFO - (blobuploader) - WARNING - File uploaded to blobserver but failed uploading to Amazon S3. 05:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:03 INFO - (blobuploader) - INFO - Done attempting. 05:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:04 INFO - (blobuploader) - INFO - Done attempting. 05:59:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:04 INFO - Return code: 0 05:59:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/440db834d3e1464eebd09745ead18141b96af2d2bd7eff56e4211929f93f4f05ef5969820cf57fd4a9df67b90d8188fc49990a492e024a93242e56dc3b34f25a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd45be329e269a1bd72a6c6b4506a7f9ad676630bae4909192f4725534c9bd955b4be6c0305bedc61c9b6283d414bb036b23b27e4186a10d51f7ed806ee2a60f"} 05:59:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:04 INFO - Contents: 05:59:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/440db834d3e1464eebd09745ead18141b96af2d2bd7eff56e4211929f93f4f05ef5969820cf57fd4a9df67b90d8188fc49990a492e024a93242e56dc3b34f25a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd45be329e269a1bd72a6c6b4506a7f9ad676630bae4909192f4725534c9bd955b4be6c0305bedc61c9b6283d414bb036b23b27e4186a10d51f7ed806ee2a60f"} 05:59:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:04 INFO - Copying logs to upload dir... 05:59:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.363620 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-09 05:59:04.784229) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:59:04.793117) ========= 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=745a4373a2a16df560f216e000000264-1462797519.70920-53921241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/440db834d3e1464eebd09745ead18141b96af2d2bd7eff56e4211929f93f4f05ef5969820cf57fd4a9df67b90d8188fc49990a492e024a93242e56dc3b34f25a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd45be329e269a1bd72a6c6b4506a7f9ad676630bae4909192f4725534c9bd955b4be6c0305bedc61c9b6283d414bb036b23b27e4186a10d51f7ed806ee2a60f"} build_url:https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/EWijmSvnSMu5d-nG03i7PQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/440db834d3e1464eebd09745ead18141b96af2d2bd7eff56e4211929f93f4f05ef5969820cf57fd4a9df67b90d8188fc49990a492e024a93242e56dc3b34f25a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd45be329e269a1bd72a6c6b4506a7f9ad676630bae4909192f4725534c9bd955b4be6c0305bedc61c9b6283d414bb036b23b27e4186a10d51f7ed806ee2a60f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:59:04.817365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:59:04.817731) ========= 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=745a4373a2a16df560f216e000000264-1462797519.70920-53921241 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:59:04.901404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:59:04.901730) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:59:04.902050) ========= ========= Total master_lag: 0.16 =========